04:01:51.760 {INFO}    [OVRServer] Starting Oculus Runtime Service OVRServer [Stable Runtime] (Release) 1.3.1.207417 -- 04/05/16 20:35:30 -4H
04:01:51.760 {INFO}    [OVRServer] PC UpTime = 1574500 milliseconds
04:01:51.761 {INFO}    [Log] [DisplayManager] Beginning display system analysis...
04:01:51.761 {INFO}    [Log] [DisplayManager] OS Version: 6.3.9600.17415, Windows 8.1
04:01:51.761 {INFO}    [Log] [DisplayManager] Enumerating installed display drivers
04:01:51.761 {INFO}    [Log] [DisplayManager] NVidia driver found. Installed version: 10.18.13.6472  Required version: 10.18.13.6191  (OK)
04:01:51.761 {INFO}    [Log] [DisplayManager] Microsoft default driver found.
04:01:51.761 {INFO}    [Log] [DisplayManager] Microsoft software (WARP) device found.
04:01:51.761 {INFO}    [Log] [DisplayManager] Enumerating display adapters and DirectDisplay extensions
04:01:51.761 {INFO}    [Log] [DisplayManager] NVidia adapter found, analyzing...
04:01:51.762 {INFO}    [Log] [DisplayManager] Checking that it's not hybrid graphics...
04:01:51.762 {INFO}    [Log] [DisplayManager] Not hybrid graphics
04:01:51.762 {INFO}    [Log] [DisplayManager] DirectDisplay extension not loaded yet, loading now...
04:01:51.762 {INFO}    [Log] [DisplayManager] NVidia adapter passed all checks, and is usable for VR.
04:01:51.762 {INFO}    [Log] [DisplayManager] Failed to communicate GPU priority readiness with service launcher. err=2
04:01:51.762 {INFO}    [Log] [DisplayManager] Display system analysis complete.
04:01:51.763 {INFO}    [Log] [DisplayManager] Using display system: Direct Display
04:01:52.782 {INFO}    [OAF] Checking C:\Program Files (x86)\Oculus\Support\oculus-runtime\OculusAppFramework.dll
04:01:52.783 {INFO}    [Camera:General] Starting message pump
04:01:52.828 {INFO}    [OAF] Starting...
04:01:52.828 {INFO}    [OAFServer] Initializing
04:01:52.829 {INFO}    [Input]  PC Unlocked.
04:01:52.829 {INFO}    [Log] OVR::DeviceManager - initialized.
04:01:52.829 {INFO}    [Log] OVR::DeviceManagerThread - running (ThreadId=0x1878).
04:01:52.834 {INFO}    [GamePad] Loaded XInput library 'xinput1_4'
04:01:52.834 {INFO}    [GamePad] Loaded XInput library API that provides XBox Home button state
04:01:52.834 {INFO}    [GamePad] Loaded XInputGetBatteryInformation API
04:01:52.834 {INFO}    [Tracking:Manager] Entering tracking thread
04:01:52.836 {INFO}    [USBHID] No Oculus devices are enumerating
04:01:52.836 {INFO}    [FirmwareVersions] Reading firmware file: C:\Program Files (x86)\Oculus\Support\oculus-runtime\Firmware/firmware.zip
04:01:52.837 {INFO}    [USBHID] No Oculus devices are enumerating
04:01:52.840 {INFO}    [HW:Enumeration] Performing initial camera enumeration
04:01:52.841 {INFO}    [HW:Enumeration] 0 trackers detected
04:01:52.841 {INFO}    [HW:Enumeration] Enumerating HMD devices
04:01:52.845 {INFO}    [HW:Enumeration] Usable/Total HMD sensors: 0/0, Displays: 0
04:01:52.847 {INFO}    [HW:Enumeration] Connected devices: 0 cam
04:01:52.908 {!ERROR!} [OAF ERROR] core\JsonUtil.cpp(65) : Failed to parse manifest JSON data (1971038)
04:01:52.908 {INFO}    [HardwareManager] Starting with a fresh device cache
04:01:52.926 {INFO}    [AudioConfiguration] OUT "Rift Audio"         Speakers (2- Realtek High Definition Audio)
04:01:52.927 {INFO}    [AudioConfiguration] IN  "Rift Audio"         Line (WsAudio_Device(1))
04:01:52.927 {INFO}    [FastIpc] Listening at "OAF_IPC"
04:01:52.927 {INFO}    [Registry] Failed to read registry key value length for key Sandbox, it probably hasn't been set.
04:01:52.927 {INFO}    [Registry] Failed to read sandbox url, or it wasn't set.
04:01:52.927 {INFO}    [Registry] Failed to read registry key value length for key HttpProxyOverride, it probably hasn't been set.
04:01:52.927 {INFO}    [OAFServer] RunServer...
04:01:52.927 {INFO}    [LifeCycle] pcLockedEvent() Start
04:01:52.927 {INFO}    [LifeCycle] PC Locked: false
04:01:52.927 {INFO}    [LifeCycle] Inactive Focus: 0 (Unknown)
04:01:52.927 {INFO}    [LifeCycle] Already Focused: 0 (Unknown)
04:01:52.927 {INFO}    [LifeCycle] pcLockedEvent() End
04:01:52.928 {INFO}    [PerfLog] Purging perf log files older than 5 days.
04:01:53.333 {INFO}    [Server] OAF is requesting focus change to pid: 0 (no process, blank screen)
04:01:53.333 {INFO}    [PackageManager] Checking manifest: oculus-client.json
04:01:53.333 {WARNING} [ApplicationPackage] Constructing fake binary from manifest data for oculus-client, version 1.3.1.203425
04:01:53.334 {INFO}    [PackageManager] Checking manifest: oculus-compat.json
04:01:53.334 {WARNING} [ApplicationPackage] Constructing fake binary from manifest data for oculus-compat, version 1.3.1.202298
04:01:53.334 {INFO}    [PackageManager] Checking manifest: oculus-diagnostics.json
04:01:53.334 {WARNING} [ApplicationPackage] Constructing fake binary from manifest data for oculus-diagnostics, version 1.3.1.203037
04:01:53.334 {INFO}    [PackageManager] Checking manifest: oculus-dreamdeck-nux.json
04:01:53.334 {WARNING} [ApplicationPackage] Constructing fake binary from manifest data for oculus-dreamdeck-nux, version 15
04:01:53.334 {INFO}    [PackageManager] Checking manifest: oculus-drivers.json
04:01:53.334 {WARNING} [ApplicationPackage] Constructing fake binary from manifest data for oculus-drivers, version 1.3.0.196773
04:01:53.334 {INFO}    [PackageManager] Checking manifest: oculus-home.json
04:01:53.335 {WARNING} [ApplicationPackage] Constructing fake binary from manifest data for oculus-home, version 1.3.1.204427-ovrplugin-203660
04:01:53.335 {INFO}    [PackageManager] Checking manifest: oculus-librarian.json
04:01:53.335 {WARNING} [ApplicationPackage] Constructing fake binary from manifest data for oculus-librarian, version 1.3.1.202867
04:01:53.335 {INFO}    [PackageManager] Checking manifest: oculus-overlays.json
04:01:53.335 {WARNING} [ApplicationPackage] Constructing fake binary from manifest data for oculus-overlays, version 1.3.1.203527
04:01:53.335 {INFO}    [PackageManager] Checking manifest: oculus-redistributable-installer.json
04:01:53.335 {WARNING} [ApplicationPackage] Constructing fake binary from manifest data for oculus-redistributable-installer, version 1.3.1.202298
04:01:53.335 {INFO}    [PackageManager] Checking manifest: oculus-runtime.json
04:01:53.335 {WARNING} [ApplicationPackage] Constructing fake binary from manifest data for oculus-runtime, version 1.3.1.207417
04:01:53.336 {INFO}    [Init] Initialization finished.
04:01:53.336 {INFO}    [HardwareManager] Obstruction changed: vrHardware
04:02:21.603 {INFO}    [FastIpc] Connected clientID 2
04:02:21.603 {INFO}    [PackageManager] Package oculus-client was sideloaded
04:02:21.603 {INFO}    [ApplicationPackage] Unable to find corresponding library item for package oculus-client
04:02:22.484 {INFO}    [LifeCycle] skyline_ready_cb() Start
04:02:22.484 {INFO}    [LifeCycle] oculus-client init with pid: 4128 (Unknown)
04:02:22.484 {INFO}    [LifeCycle] Adding Core Tracker: 4128 (oculus-client)
04:02:22.484 {INFO}    [LifeCycleAppTracker] Init from package: 4128 (oculus-client)
04:02:22.484 {WARNING} [LifeCycle] Could not launch app because HMD is not ready: oculus-home
04:02:22.484 {WARNING} [LifeCycle] Could not launch app because HMD is not ready: oculus-overlays
04:02:22.484 {INFO}    [LifeCycleAppTracker] IPC Ready: 4128 (oculus-client)
04:02:22.484 {INFO}    [LifeCycle] skyline_ready_cb() End
04:02:22.485 {INFO}    [HardwareManager] Obstruction changed: vrHardware
04:02:22.616 {INFO}    [Skyline] [section_exit] { full_path: , origin_app_name: skyline, sub_section: ,  }
04:02:22.616 {INFO}    [Skyline] [section_entry] { full_path: /, origin_app_name: skyline, section_name: , sub_section: ,  }
04:02:22.664 {INFO}    [LifeCycle] get_proxy_url_cb() Start
04:02:22.664 {INFO}    [LifeCycle] get_proxy_url_cb() End
04:02:42.099 {INFO}    [Skyline] [section_exit] { full_path: /, origin_app_name: skyline, section_name: , sub_section: ,  }
04:02:42.099 {INFO}    [Skyline] [section_entry] { full_path: /log-in, origin_app_name: skyline, section_name: log-in, sub_section: ,  }
04:02:52.891 {INFO}    [HW:Enumeration] Connected devices: 0 cam
04:02:54.269 {INFO}    [PackageManager] Checking package: oculus-overlays (961317437278561)
04:02:54.269 {INFO}    [CoreAppReleaseChannels] Initial release channel: LIVE
04:02:54.269 {INFO}    [PackageManager] Checking package: oculus-client (519080484913803)
04:02:54.269 {INFO}    [PackageManager] Checking package: oculus-compat (1522986184659833)
04:02:54.269 {INFO}    [PackageManager] Checking package: oculus-librarian (386768564867197)
04:02:54.269 {INFO}    [PackageManager] Checking package: oculus-diagnostics (827064807402789)
04:02:54.269 {INFO}    [PackageManager] Checking package: oculus-redistributable-installer (1190954377597673)
04:02:54.269 {INFO}    [PackageManager] Checking package: oculus-dreamdeck-nux (919445174798085)
04:02:54.269 {INFO}    [PackageManager] Checking package: oculus-drivers (670216293113998)
04:02:54.269 {INFO}    [PackageManager] Checking package: oculus-home (1033760676635835)
04:02:54.269 {INFO}    [PackageManager] Checking package: oculus-runtime (572698886195608)
04:02:54.270 {INFO}    [PackageManager] Checking package: oculus-overlays (961317437278561)
04:02:54.270 {INFO}    [PackageManager] Checking package: oculus-client (519080484913803)
04:02:54.270 {INFO}    [PackageManager] Checking package: oculus-compat (1522986184659833)
04:02:54.270 {INFO}    [PackageManager] Checking package: oculus-librarian (386768564867197)
04:02:54.270 {INFO}    [PackageManager] Checking package: oculus-diagnostics (827064807402789)
04:02:54.270 {INFO}    [PackageManager] Checking package: oculus-redistributable-installer (1190954377597673)
04:02:54.270 {INFO}    [PackageManager] Checking package: oculus-dreamdeck-nux (919445174798085)
04:02:54.270 {INFO}    [PackageManager] Checking package: oculus-drivers (670216293113998)
04:02:54.270 {INFO}    [PackageManager] Checking package: oculus-home (1033760676635835)
04:02:54.270 {INFO}    [PackageManager] Checking package: oculus-runtime (572698886195608)
04:02:54.271 {INFO}    [LifeCycle] get_proximity_sensor_cb() Start
04:02:54.271 {INFO}    [LifeCycle] get_proximity_sensor_cb() End
04:02:54.271 {INFO}    [LifeCycle] get_actual_location_cb() Start
04:02:54.271 {INFO}    [LifeCycle] get_actual_location_cb() End
04:02:54.533 {INFO}    [PackageManager] No new version for oculus-home
04:02:54.533 {INFO}    [PackageManager] No new version for oculus-redistributable-installer
04:02:54.533 {INFO}    [PackageManager] No new version for oculus-compat
04:02:54.533 {INFO}    [PackageManager] No new version for oculus-librarian
04:02:54.533 {INFO}    [PackageManager] No new version for oculus-client
04:02:54.533 {INFO}    [PackageManager] No new version for oculus-runtime
04:02:54.533 {INFO}    [PackageManager] No new version for oculus-drivers
04:02:54.533 {INFO}    [PackageManager] No new version for oculus-diagnostics
04:02:54.533 {INFO}    [PackageManager] No new version for oculus-dreamdeck-nux
04:02:54.533 {INFO}    [PackageManager] No new version for oculus-overlays
04:02:54.533 {INFO}    [PackageManager] No pending packages to install.
04:02:54.537 {INFO}    [PackageManager] No core updates needed.
04:02:54.537 {INFO}    [PackageManager] Updates check finished.
04:02:54.592 {INFO}    [PackageManager] No pending packages to install.
04:02:54.592 {INFO}    [PackageManager] No core updates needed.
04:02:54.593 {INFO}    [Package] oculus-dreamdeck_assets downloading update
04:02:54.595 {INFO}    [Package] oculus-lost_assets downloading update
04:02:54.596 {INFO}    [Package] playful-luckys-tale_assets downloading update
04:02:54.596 {INFO}    [PackageManager] Updates check finished.
04:02:54.606 {INFO}    [PackageManager] No pending packages to install.
04:02:54.606 {INFO}    [PackageManager] No core updates needed.
04:02:54.606 {INFO}    [PackageManager] Updates check finished.
04:02:54.655 {INFO}    [PackageManager] No new version for oculus-home
04:02:54.655 {INFO}    [PackageManager] No new version for oculus-redistributable-installer
04:02:54.655 {INFO}    [PackageManager] No new version for oculus-compat
04:02:54.655 {INFO}    [PackageManager] No new version for oculus-librarian
04:02:54.655 {INFO}    [PackageManager] No new version for oculus-client
04:02:54.655 {INFO}    [PackageManager] No new version for oculus-runtime
04:02:54.655 {INFO}    [PackageManager] No new version for oculus-drivers
04:02:54.655 {INFO}    [PackageManager] No new version for oculus-diagnostics
04:02:54.655 {INFO}    [PackageManager] No new version for oculus-dreamdeck-nux
04:02:54.655 {INFO}    [PackageManager] No new version for oculus-overlays
04:02:54.655 {INFO}    [PackageManager] No pending packages to install.
04:02:54.655 {INFO}    [PackageManager] No core updates needed.
04:02:54.655 {INFO}    [PackageManager] Updates check finished.
04:02:54.731 {INFO}    [Skyline] [oculus_waterfall] { flow: nux, origin_app_name: skyline, progression: auto, step: launched,  }
04:02:54.741 {INFO}    [Skyline] [section_exit] { full_path: /log-in, origin_app_name: skyline, section_name: log-in, sub_section: ,  }
04:02:54.741 {INFO}    [Skyline] [section_entry] { full_path: /nux/account-details/payments, origin_app_name: skyline, section_name: nux, sub_section: account-details,  }
04:02:54.749 {INFO}    [Profile] Allow Unknown App Changed: true
04:02:54.809 {INFO}    [PackageManager] Package oculus-dreamdeck_assets download finished.
04:02:54.809 {INFO}    [Package] Running OVRLibrarian install-package "C:\Program Files (x86)\Oculus\/Downloads/oculus-dreamdeck_assets/20/oculus-dreamdeck_assets.zip" "C:\Program Files (x86)\Oculus\/Downloads/oculus-dreamdeck_assets.sig"
04:02:54.809 {INFO}    [os/file] Launching app with path [C:\Program Files (x86)\Oculus\Support\oculus-librarian\OVRLibrarian.exe], args [install-package "C:\Program Files (x86)\Oculus\/Downloads/oculus-dreamdeck_assets/20/oculus-dreamdeck_assets.zip" "C:\Program Files (x86)\Oculus\/Downloads/oculus-dreamdeck_assets.sig"], launchDir [false], detached [false]
04:02:54.810 {INFO}    [os/file] Waiting for pid 1476
04:02:54.824 {INFO}    [PackageManager] Package oculus-lost_assets download finished.
04:02:54.846 {INFO}    [FBNS Manager] Registered push token {"add_push_token":{"__typename":"AddPushTokenResponsePayload","client_mutation_id":"4827","token":{"__typename":"PushToken","app_version":"1.3.1.207417","device_id":"544f3d11-f9c1-4daa-bf38-9040d190fad2","id":"948781378574017","os_version":"5.0","owner":{"__typename":"User","alias":"dtaggart","id":"839903669461789","name":null},"push_token":"{\"k\":\"eyJwbiI6ImNvbS5vY3VsdXMucGxhdGZvcm0iLCJkaSI6IjU0NGYzZDExLWY5YzEtNGRhYS1iZjM4LTkwNDBkMTkwZmFkMiIsImFpIjo1NjczMTAyMDM0MTUwNTIsImNrIjoiMTA3OTk5OTIxNTY5MzMwMiJ9\",\"v\":0,\"t\":\"fbns-b64\"}","token_app":{"__typename":"CoreApplication","display_name":"OculusSetup.exe","id":"1582076955407037"}}}}
04:02:54.866 {INFO}    [PackageManager] Package playful-luckys-tale_assets download finished.
04:02:54.883 {INFO}    [os/file] Done waiting for pid 1476
04:02:54.883 {INFO}    [ApplicationPackage] App oculus-librarian has exited
04:02:54.883 {INFO}    [PackageManager] Package oculus-dreamdeck_assets finished installing. Success? true
04:02:54.883 {INFO}    [Package] Running OVRLibrarian install-package "C:\Program Files (x86)\Oculus\/Downloads/oculus-lost_assets/20/oculus-lost_assets.zip" "C:\Program Files (x86)\Oculus\/Downloads/oculus-lost_assets.sig"
04:02:54.883 {INFO}    [os/file] Launching app with path [C:\Program Files (x86)\Oculus\Support\oculus-librarian\OVRLibrarian.exe], args [install-package "C:\Program Files (x86)\Oculus\/Downloads/oculus-lost_assets/20/oculus-lost_assets.zip" "C:\Program Files (x86)\Oculus\/Downloads/oculus-lost_assets.sig"], launchDir [false], detached [false]
04:02:54.884 {INFO}    [PackageManager] Started installing something from queue.
04:02:54.884 {INFO}    [os/file] Waiting for pid 2276
04:02:54.884 {INFO}    [PackageManager] No core updates needed.
04:02:54.884 {INFO}    [PackageManager] Updates check finished.
04:02:54.885 {INFO}    [PackageManager] No core updates needed.
04:02:54.885 {INFO}    [PackageManager] Updates check finished.
04:02:54.905 {INFO}    [Platform Notification List] Notification type unsupported: oculus_push_token_registration
04:02:54.949 {INFO}    [os/file] Done waiting for pid 2276
04:02:54.949 {INFO}    [ApplicationPackage] App oculus-librarian has exited
04:02:54.949 {INFO}    [PackageManager] Package oculus-lost_assets finished installing. Success? true
04:02:54.949 {INFO}    [Package] Running OVRLibrarian install-package "C:\Program Files (x86)\Oculus\/Downloads/playful-luckys-tale_assets/25/playful-luckys-tale_assets.zip" "C:\Program Files (x86)\Oculus\/Downloads/playful-luckys-tale_assets.sig"
04:02:54.949 {INFO}    [os/file] Launching app with path [C:\Program Files (x86)\Oculus\Support\oculus-librarian\OVRLibrarian.exe], args [install-package "C:\Program Files (x86)\Oculus\/Downloads/playful-luckys-tale_assets/25/playful-luckys-tale_assets.zip" "C:\Program Files (x86)\Oculus\/Downloads/playful-luckys-tale_assets.sig"], launchDir [false], detached [false]
04:02:54.950 {INFO}    [PackageManager] Started installing something from queue.
04:02:54.950 {INFO}    [os/file] Waiting for pid 10164
04:02:54.950 {INFO}    [PackageManager] No core updates needed.
04:02:54.950 {INFO}    [PackageManager] Updates check finished.
04:02:54.952 {INFO}    [PackageManager] No core updates needed.
04:02:54.952 {INFO}    [PackageManager] Updates check finished.
04:02:55.018 {INFO}    [os/file] Done waiting for pid 10164
04:02:55.018 {INFO}    [ApplicationPackage] App oculus-librarian has exited
04:02:55.018 {INFO}    [PackageManager] Package playful-luckys-tale_assets finished installing. Success? true
04:02:55.019 {INFO}    [PackageManager] No pending packages to install.
04:02:55.019 {INFO}    [PackageManager] No core updates needed.
04:02:55.019 {INFO}    [PackageManager] Updates check finished.
04:02:55.019 {INFO}    [PackageManager] No pending packages to install.
04:02:55.019 {INFO}    [PackageManager] No core updates needed.
04:02:55.019 {INFO}    [PackageManager] Updates check finished.
04:02:55.020 {INFO}    [PackageManager] No pending packages to install.
04:02:55.020 {INFO}    [PackageManager] No core updates needed.
04:02:55.020 {INFO}    [PackageManager] Updates check finished.
04:03:04.745 {INFO}    [Skyline] [oculus_waterfall] { flow: nux, origin_app_name: skyline, progression: skip, step: payments,  }
04:03:04.749 {INFO}    [Skyline] [section_exit] { full_path: /nux/account-details/payments, origin_app_name: skyline, section_name: nux, sub_section: account-details,  }
04:03:04.749 {INFO}    [Skyline] [section_entry] { full_path: /nux/hardware-setup/intro, origin_app_name: skyline, section_name: nux, sub_section: hardware-setup,  }
04:03:08.356 {INFO}    [Skyline] [oculus_waterfall] { flow: nux, origin_app_name: skyline, progression: continue, step: hardware_setup_intro,  }
04:03:08.360 {INFO}    [Skyline] [section_exit] { full_path: /nux/hardware-setup/intro, origin_app_name: skyline, section_name: nux, sub_section: hardware-setup,  }
04:03:08.360 {INFO}    [Skyline] [section_entry] { full_path: /nux/hardware-setup/lens-care, origin_app_name: skyline, section_name: nux, sub_section: hardware-setup,  }
04:03:11.036 {INFO}    [Skyline] [oculus_waterfall] { flow: nux, origin_app_name: skyline, progression: continue, step: lens-care,  }
04:03:11.039 {INFO}    [Skyline] [section_exit] { full_path: /nux/hardware-setup/lens-care, origin_app_name: skyline, section_name: nux, sub_section: hardware-setup,  }
04:03:11.039 {INFO}    [Skyline] [section_entry] { full_path: /nux/hardware-setup/connect-rift, origin_app_name: skyline, section_name: nux, sub_section: hardware-setup,  }
04:03:52.933 {INFO}    [HW:Enumeration] Connected devices: 0 cam
04:04:06.670 {INFO}    [USBHID] DBT_DEVICEREMOVECOMPLETE
04:04:06.672 {INFO}    [USBHID] No Oculus devices are enumerating
04:04:06.672 {INFO}    [USBHID] DBT_DEVICEREMOVECOMPLETE
04:04:06.674 {INFO}    [USBHID] No Oculus devices are enumerating
04:04:06.674 {INFO}    [USBHID] DBT_DEVICEREMOVECOMPLETE
04:04:06.676 {INFO}    [USBHID] No Oculus devices are enumerating
04:04:06.676 {INFO}    [USBHID] DBT_DEVICEREMOVECOMPLETE
04:04:06.677 {INFO}    [USBHID] No Oculus devices are enumerating
04:04:06.943 {INFO}    [HW:Enumeration] Enumerating HMD devices
04:04:06.946 {INFO}    [HW:Enumeration] Usable/Total HMD sensors: 0/0, Displays: 0
04:04:32.132 {INFO}    [USBHID] DBT_DEVICEARRIVAL
04:04:32.134 {INFO}    [USBHID] No Oculus devices are enumerating
04:04:32.134 {INFO}    [USBHID] DBT_DEVICEARRIVAL
04:04:32.136 {INFO}    [USBHID] No Oculus devices are enumerating
04:04:32.136 {INFO}    [USBHID] DBT_DEVICEARRIVAL
04:04:32.137 {INFO}    [USBHID] No Oculus devices are enumerating
04:04:32.137 {INFO}    [USBHID] DBT_DEVICEARRIVAL
04:04:32.138 {INFO}    [USBHID] No Oculus devices are enumerating
04:04:46.901 {INFO}    [USBHID] DBT_DEVICEARRIVAL
04:04:46.904 {INFO}    [USBHID] 1 Oculus devices are enumerating:
04:04:46.904 {INFO}    [USBHID] 1 : Rift DK2 Serial:H1DEM346KHC8K410C100 Vid/Pid:10291/33 Version:212 \\?\hid#vid_2833&pid_0021#8&17dee87&0&0000#{4d1e55b2-f16f-11cf-88cb-001111000030}
04:04:46.978 {INFO}    [HW:Enumeration] Enumerating HMD devices
04:04:46.985 {INFO}    [Log] OVR::Win32::HIDDevice - Opened '\\?\hid#vid_2833&pid_0021#8&17dee87&0&0000#{4d1e55b2-f16f-11cf-88cb-001111000030}'
                    Manufacturer:'Oculus VR, Inc.'  Product:'Rift DK2'  Serial#:'H1DEM346KHC8K410C100'  Version:'212', Speed:'300'
04:04:46.985 {INFO}    [Log] HIDDevice USB Host: USB Host Info: type:0x30, vid:0x8086, pid:0x8c31, driver:Microsoft/6.3.9600.17797, speed:0x0300, indirection:2
04:04:47.016 {INFO}    [DeviceEvent] HMD [208WKJ00ZHMG] Attached 0 
04:04:47.016 {INFO}    [HardwareManager] HMD 208WKJ00ZHMG got attached event with error code 0
04:04:47.017 {WARNING} [FirmwareVersions] Main firmware for attached HMD was not found on disk - Vid/Pid:10291/33 version 530
04:04:47.017 {WARNING} [FirmwareVersions] HMD version check disabled: Firmware for this HMD was not found in the archive
04:04:47.017 {INFO}    [HW:Enumeration] Usable/Total HMD sensors: 1/1, Displays: 0
04:04:53.025 {INFO}    [HW:Enumeration] Connected devices: 0 cam
04:05:30.184 {INFO}    [Camera:General] OS Callback: sensor plugged in
04:05:30.184 {INFO}    [Camera:General] Device name: \\?\USB#VID_2833&PID_0201&MI_00#7&1936f5e4&0&0000#{0b6cce76-2100-4c02-919e-01555ecba665}
04:05:30.552 {INFO}    [HW:Enumeration] Re-enumerating cameras due to hardware change
04:05:30.603 {INFO}    [HW:Enumeration] 1 trackers detected
04:05:30.603 {INFO}    [HW:Enumeration] Trying to connect to tracker 218WKJ00ZHMG
04:05:30.701 {INFO}    [DeviceEvent] SENSOR [218WKJ00ZHMG] Attached 0 
04:05:30.701 {INFO}    [HardwareManager] Tracker 218WKJ00ZHMG got attached event with error code 0
04:05:30.702 {INFO}    [Camera:General] 218WKJ00ZHMG: USB Host Info: USB Host Info: type:0x30, vid:0x8086, pid:0x8c31, driver:Microsoft/6.3.9600.17797, speed:0x0300, indirection:1
04:05:30.702 {INFO}    [FirmwareVersions] Device does not need firmware updates. We have only released new firmware for the CB2+ trackers
04:05:31.105 {INFO}    [HW:Enumeration] Tracker opened successfully
04:05:31.105 {INFO}    [DeviceEvent] SENSOR [218WKJ00ZHMG] Connected 0 
04:05:31.105 {INFO}    [HW:Enumeration] Enumerating HMD devices
04:05:31.105 {INFO}    [HardwareManager] Tracker 218WKJ00ZHMG got connected event with error code 0
04:05:31.113 {WARNING} [FirmwareVersions] Main firmware for attached HMD was not found on disk - Vid/Pid:10291/33 version 530
04:05:31.113 {WARNING} [FirmwareVersions] HMD version check disabled: Firmware for this HMD was not found in the archive
04:05:31.113 {INFO}    [HW:Enumeration] Usable/Total HMD sensors: 1/1, Displays: 0
04:05:53.132 {INFO}    [HW:Enumeration] Connected devices: 1 cam
04:06:39.036 {INFO}    [Log] [DisplayManager] OnTopologyChanged
04:06:40.166 {INFO}    [HW:Enumeration] Enumerating HMD devices
04:06:40.172 {WARNING} [FirmwareVersions] Main firmware for attached HMD was not found on disk - Vid/Pid:10291/33 version 530
04:06:40.172 {WARNING} [FirmwareVersions] HMD version check disabled: Firmware for this HMD was not found in the archive
04:06:40.172 {INFO}    [HW:Enumeration] Usable/Total HMD sensors: 1/1, Displays: 1
04:06:40.176 {INFO}    [DeviceEvent] HMD [208WKJ00ZHMG] AttachedHDMI 0 
04:06:40.176 {INFO}    [HW:Enumeration] HMD connected
04:06:40.176 {INFO}    [HardwareManager] HMD 208WKJ00ZHMG got attachedHDMI event with error code 0
04:06:40.177 {INFO}    [HardwareManager] Obstruction changed: nothing
04:06:40.177 {INFO}    [LifeCycle] HMD Health Update: true
04:06:40.177 {INFO}    [LifeCycle] Launching Package: oculus-home
04:06:40.177 {INFO}    [os/file] Launching app with path [C:\Program Files (x86)\Oculus\Support\oculus-home\OculusVR.exe], args [-screen-fullscreen 0 -screen-width 800 -screen-height 600 -silent-crashes -oculus-mutex oculus-home-mutex -hideWindow -logFile C:\Users\Dustin\AppData\LocalLow\Oculus\Home\logs\Unity_2016-04-16_04.06.40.txt], launchDir [false], detached [false]
04:06:40.179 {INFO}    [Log] Spud file C:\Users\Dustin\AppData\Local\Oculus\Spud\HMD_208WKJ00ZHMG.spud not found, proceeding without it. This is normal.
04:06:40.179 {INFO}    [HW:HmdSensor] Setting LED state: false
04:06:40.182 {INFO}    [os/file] Waiting for pid 9984
04:06:40.182 {INFO}    [LifeCycle] Adding Core Tracker: 9984 (oculus-home)
04:06:40.182 {INFO}    [LifeCycleAppTracker] Init from package: 9984 (oculus-home)
04:06:40.182 {INFO}    [LifeCycle] Launching Package: oculus-overlays
04:06:40.182 {INFO}    [os/file] Launching app with path [C:\Program Files (x86)\Oculus\Support\oculus-overlays\oculus-overlays.exe], args [], launchDir [false], detached [false]
04:06:40.183 {INFO}    [LifeCycle] Adding Core Tracker: 3608 (oculus-overlays)
04:06:40.183 {INFO}    [os/file] Waiting for pid 3608
04:06:40.183 {INFO}    [LifeCycleAppTracker] Init from package: 3608 (oculus-overlays)
04:06:40.199 {INFO}    [FastIpc] Connected clientID 3
04:06:40.199 {INFO}    [LifeCycle] overlays_ready_cb() Start
04:06:40.199 {INFO}    [LifeCycle] oculus-overlays init with pid: 3608 (oculus-overlays)
04:06:40.199 {INFO}    [LifeCycle] oculus-overlays already initialized.
04:06:40.199 {INFO}    [LifeCycleAppTracker] IPC Ready: 3608 (oculus-overlays)
04:06:40.199 {INFO}    [LifeCycle] overlays_ready_cb() End
04:06:40.220 {INFO}    [Log] BruteMatcher: Model 40 points, SampleRadius 5.0 deg, 10590 samples, 286 triangles
04:06:40.220 {INFO}    [Log] BruteMatcher: Model 0 points, SampleRadius 5.0 deg, 0 samples, 0 triangles
04:06:40.246 {INFO}    [HW:HmdSensor] Leaving idle mode
04:06:40.269 {INFO}    [LifeCycle] motionSensorEvent() Start
04:06:40.269 {INFO}    [LifeCycle] HMD Moving: true
04:06:40.269 {INFO}    [LifeCycle] Screen On, Good Morning
04:06:40.269 {INFO}    [LifeCycle] Already Focused: 0 (Unknown)
04:06:40.269 {INFO}    [LifeCycle] motionSensorEvent() End
04:06:40.316 {WARNING} [Server] Setting connection focus to pid: 3608, file: (side-loaded app), but no window handle exists
04:06:40.316 {INFO}    [DeviceEvent] HMD [208WKJ00ZHMG] Connected 0 
04:06:40.316 {INFO}    [HardwareManager] HMD 208WKJ00ZHMG got connected event with error code 0
04:06:40.317 {WARNING} [Server] Setting connection focus to pid: 3608, file: (side-loaded app), but no window handle exists
04:06:40.321 {INFO}    [LifeCycle] registerPid() Start
04:06:40.321 {INFO}    [LifeCycle] Register Pid: 3608 (oculus-overlays)
04:06:40.321 {INFO}    [LifeCycle] Registering PID: 3608 (oculus-overlays)
04:06:40.321 {INFO}    [LifeCycle] Overlays registered again.
04:06:40.321 {INFO}    [LifeCycleAppTracker] VR Ready: 3608 (oculus-overlays)
04:06:40.321 {INFO}    [LifeCycleAppTracker] Package oculus-overlays took 138 milliseconds to become ready
04:06:40.321 {INFO}    [LifeCycle] registerPid() End
04:06:40.325 {INFO}    [HW:HmdSensor] Entering idle mode
04:06:40.353 {WARNING} [Server] Setting connection focus to pid: 3608, file: (side-loaded app), but no window handle exists
04:06:40.353 {INFO}    [LifeCycle] registerPid() Start
04:06:40.353 {INFO}    [LifeCycle] Register Pid: 9984 (oculus-home)
04:06:40.353 {INFO}    [LifeCycle] Registering PID: 9984 (oculus-home)
04:06:40.353 {INFO}    [LifeCycle] Home registered again.
04:06:40.353 {INFO}    [LifeCycle] registerPid() End
04:06:40.356 {WARNING} [Server] Setting connection focus to pid: 3608, file: (side-loaded app), but no window handle exists
04:06:40.356 {INFO}    [Server] Connection closed for pid: 9984, file: (side-loaded app)
04:06:40.357 {WARNING} [Server] Setting connection focus to pid: 3608, file: (side-loaded app), but no window handle exists
04:06:40.357 {INFO}    [Server] Connection destroyed for pid: 9984, file: (side-loaded app)
04:06:40.414 {INFO}    [Log] [VirtualDisplay] Initializing compositor in ATW mode.
04:06:40.414 {INFO}    [Log] [EnablePriorityBoost] Attempting to boost priority via disabling preemption.
04:06:40.414 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:40.414 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:40.415 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:40.415 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:40.415 {INFO}    [Log] [SwapChain] Created swapchain of type 'DirectDisplaySwapChain' provided by 'NVidia'
04:06:40.415 {INFO}    [Log] [DirectDisplaySwapChain] Initialize
04:06:40.417 {!ERROR!} [Log] [NVDirectDisplay] AcquireExclusive failed: Invalid configuration
04:06:40.418 {!ERROR!} [Errors] OVR Error:
  Code: -3000 -- ovrError_Initialize
  System error: -2005270527 (887a0001) -- The application made a call that is invalid. Either the parameters of the call or the state of some object was incorrect.
Enable the D3D debug layer in order to see details via debug messages.
  Description: Failed to obtain exclusive access of direct display
  OVRTime: 1863.319517
  Time: 2016-04-16 04:06:40 [417:538:400]

04:06:40.418 {INFO}    [Log] [EnablePriorityBoost] Attempting to restore normal system preemption behavior.
04:06:40.418 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:40.418 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:40.419 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:40.419 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:40.424 {!ERROR!} [Overlays] [overlays_failed] { message: Failed to init texture,  }
04:06:40.487 {INFO}    [os/file] Done waiting for pid 3608
04:06:40.487 {INFO}    [Server] Connection closed for pid: 3608, file: (side-loaded app)
04:06:40.487 {WARNING} [ApplicationPackage] App oculus-overlays has exited with error: 4294967295
04:06:40.487 {INFO}    [Server] Connection destroyed for pid: 3608, file: (side-loaded app)
04:06:40.487 {!ERROR!} [OAF ERROR] LifeCycle\LifeCycleAppTracker.cpp(123) : App exited unexpectedly: oculus-overlays (1971039)
04:06:40.487 {INFO}    [LifeCycle] Removing Core Tracker: 3608 (oculus-overlays)
04:06:40.487 {INFO}    [LifeCycle] App exited unexpectedly: App exited unexpectedly: oculus-overlays (1971039)
04:06:40.487 {WARNING} [LifeCycle] Core app exited too quickly, not restarting.
04:06:40.487 {INFO}    [PackageManager] No pending packages to install.
04:06:40.487 {INFO}    [PackageManager] No core updates needed.
04:06:40.487 {INFO}    [PackageManager] Updates check finished.
04:06:40.825 {INFO}    [HW:Enumeration] Enumerating HMD devices
04:06:40.831 {WARNING} [FirmwareVersions] Main firmware for attached HMD was not found on disk - Vid/Pid:10291/33 version 530
04:06:40.831 {WARNING} [FirmwareVersions] HMD version check disabled: Firmware for this HMD was not found in the archive
04:06:40.831 {INFO}    [HW:Enumeration] Usable/Total HMD sensors: 1/1, Displays: 1
04:06:41.511 {WARNING} [Server] Setting connection focus to pid: 9984, file: (side-loaded app), but no window handle exists
04:06:41.512 {INFO}    [LifeCycle] registerPid() Start
04:06:41.512 {INFO}    [LifeCycle] Register Pid: 9984 (oculus-home)
04:06:41.512 {INFO}    [LifeCycle] Registering PID: 9984 (oculus-home)
04:06:41.512 {INFO}    [LifeCycle] Home registered again.
04:06:41.512 {INFO}    [LifeCycle] registerPid() End
04:06:41.523 {INFO}    [Log] [VirtualDisplay] Initializing compositor in ATW mode.
04:06:41.523 {INFO}    [Log] [EnablePriorityBoost] Attempting to boost priority via disabling preemption.
04:06:41.524 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.524 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.524 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.525 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.525 {INFO}    [Log] [SwapChain] Created swapchain of type 'DirectDisplaySwapChain' provided by 'NVidia'
04:06:41.525 {INFO}    [Log] [DirectDisplaySwapChain] Initialize
04:06:41.527 {!ERROR!} [Log] [NVDirectDisplay] AcquireExclusive failed: Invalid configuration
04:06:41.527 {!ERROR!} [Errors] OVR Error:
  Code: -3000 -- ovrError_Initialize
  System error: -2005270527 (887a0001) -- The application made a call that is invalid. Either the parameters of the call or the state of some object was incorrect.
Enable the D3D debug layer in order to see details via debug messages.
  Description: Failed to obtain exclusive access of direct display
  OVRTime: 1864.428626
  Time: 2016-04-16 04:06:41 [527:327:500]

04:06:41.527 {INFO}    [Log] [EnablePriorityBoost] Attempting to restore normal system preemption behavior.
04:06:41.527 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.527 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.528 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.528 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.545 {INFO}    [Log] [VirtualDisplay] Initializing compositor in ATW mode.
04:06:41.545 {INFO}    [Log] [EnablePriorityBoost] Attempting to boost priority via disabling preemption.
04:06:41.545 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.545 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.546 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.546 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.547 {INFO}    [Log] [SwapChain] Created swapchain of type 'DirectDisplaySwapChain' provided by 'NVidia'
04:06:41.547 {INFO}    [Log] [DirectDisplaySwapChain] Initialize
04:06:41.549 {!ERROR!} [Log] [NVDirectDisplay] AcquireExclusive failed: Invalid configuration
04:06:41.549 {!ERROR!} [Errors] OVR Error:
  Code: -3000 -- ovrError_Initialize
  System error: -2005270527 (887a0001) -- The application made a call that is invalid. Either the parameters of the call or the state of some object was incorrect.
Enable the D3D debug layer in order to see details via debug messages.
  Description: Failed to obtain exclusive access of direct display
  OVRTime: 1864.450895
  Time: 2016-04-16 04:06:41 [549:342:900]

04:06:41.549 {INFO}    [Log] [EnablePriorityBoost] Attempting to restore normal system preemption behavior.
04:06:41.549 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.550 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.550 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.550 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.566 {INFO}    [Log] [VirtualDisplay] Initializing compositor in ATW mode.
04:06:41.566 {INFO}    [Log] [EnablePriorityBoost] Attempting to boost priority via disabling preemption.
04:06:41.566 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.566 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.567 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.567 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.567 {INFO}    [Log] [SwapChain] Created swapchain of type 'DirectDisplaySwapChain' provided by 'NVidia'
04:06:41.567 {INFO}    [Log] [DirectDisplaySwapChain] Initialize
04:06:41.569 {!ERROR!} [Log] [NVDirectDisplay] AcquireExclusive failed: Invalid configuration
04:06:41.569 {!ERROR!} [Errors] OVR Error:
  Code: -3000 -- ovrError_Initialize
  System error: -2005270527 (887a0001) -- The application made a call that is invalid. Either the parameters of the call or the state of some object was incorrect.
Enable the D3D debug layer in order to see details via debug messages.
  Description: Failed to obtain exclusive access of direct display
  OVRTime: 1864.470659
  Time: 2016-04-16 04:06:41 [569:357:100]

04:06:41.569 {INFO}    [Log] [EnablePriorityBoost] Attempting to restore normal system preemption behavior.
04:06:41.569 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.569 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.570 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.570 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.586 {INFO}    [Log] [VirtualDisplay] Initializing compositor in ATW mode.
04:06:41.586 {INFO}    [Log] [EnablePriorityBoost] Attempting to boost priority via disabling preemption.
04:06:41.586 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.587 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.587 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.587 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.588 {INFO}    [Log] [SwapChain] Created swapchain of type 'DirectDisplaySwapChain' provided by 'NVidia'
04:06:41.588 {INFO}    [Log] [DirectDisplaySwapChain] Initialize
04:06:41.589 {!ERROR!} [Log] [NVDirectDisplay] AcquireExclusive failed: Invalid configuration
04:06:41.589 {!ERROR!} [Errors] OVR Error:
  Code: -3000 -- ovrError_Initialize
  System error: -2005270527 (887a0001) -- The application made a call that is invalid. Either the parameters of the call or the state of some object was incorrect.
Enable the D3D debug layer in order to see details via debug messages.
  Description: Failed to obtain exclusive access of direct display
  OVRTime: 1864.491107
  Time: 2016-04-16 04:06:41 [589:371:400]

04:06:41.589 {INFO}    [Log] [EnablePriorityBoost] Attempting to restore normal system preemption behavior.
04:06:41.590 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.590 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.590 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.591 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.606 {INFO}    [Log] [VirtualDisplay] Initializing compositor in ATW mode.
04:06:41.606 {INFO}    [Log] [EnablePriorityBoost] Attempting to boost priority via disabling preemption.
04:06:41.606 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.607 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.607 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.607 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.608 {INFO}    [Log] [SwapChain] Created swapchain of type 'DirectDisplaySwapChain' provided by 'NVidia'
04:06:41.608 {INFO}    [Log] [DirectDisplaySwapChain] Initialize
04:06:41.609 {!ERROR!} [Log] [NVDirectDisplay] AcquireExclusive failed: Invalid configuration
04:06:41.610 {!ERROR!} [Errors] OVR Error:
  Code: -3000 -- ovrError_Initialize
  System error: -2005270527 (887a0001) -- The application made a call that is invalid. Either the parameters of the call or the state of some object was incorrect.
Enable the D3D debug layer in order to see details via debug messages.
  Description: Failed to obtain exclusive access of direct display
  OVRTime: 1864.511350
  Time: 2016-04-16 04:06:41 [609:385:600]

04:06:41.610 {INFO}    [Log] [EnablePriorityBoost] Attempting to restore normal system preemption behavior.
04:06:41.610 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.610 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.611 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.611 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.626 {INFO}    [Log] [VirtualDisplay] Initializing compositor in ATW mode.
04:06:41.626 {INFO}    [Log] [EnablePriorityBoost] Attempting to boost priority via disabling preemption.
04:06:41.626 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.627 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.627 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.627 {INFO}    [Log] [EnablePriorityBoost] Boosting priority via disabling preemption for NVIDIA GeForce GTX 980.
04:06:41.628 {INFO}    [Log] [SwapChain] Created swapchain of type 'DirectDisplaySwapChain' provided by 'NVidia'
04:06:41.628 {INFO}    [Log] [DirectDisplaySwapChain] Initialize
04:06:41.630 {!ERROR!} [Log] [NVDirectDisplay] AcquireExclusive failed: Invalid configuration
04:06:41.630 {!ERROR!} [Errors] OVR Error:
  Code: -3000 -- ovrError_Initialize
  System error: -2005270527 (887a0001) -- The application made a call that is invalid. Either the parameters of the call or the state of some object was incorrect.
Enable the D3D debug layer in order to see details via debug messages.
  Description: Failed to obtain exclusive access of direct display
  OVRTime: 1864.531899
  Time: 2016-04-16 04:06:41 [630:400:700]

04:06:41.630 {INFO}    [Log] [EnablePriorityBoost] Attempting to restore normal system preemption behavior.
04:06:41.630 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.631 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.631 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:41.631 {INFO}    [Log] [EnablePriorityBoost] Restoring normal system preemption behavior NVIDIA GeForce GTX 980.
04:06:43.506 {INFO}    [FastIpc] Connected clientID 4
04:06:43.507 {INFO}    [LifeCycle] home_ready_cb() Start
04:06:43.507 {INFO}    [LifeCycle] oculus-home init with pid: 9984 (oculus-home)
04:06:43.507 {INFO}    [LifeCycle] oculus-home already initialized.
04:06:43.507 {INFO}    [LifeCycleAppTracker] IPC Ready: 9984 (oculus-home)
04:06:43.507 {INFO}    [LifeCycle] home_ready_cb() End
04:06:43.527 {INFO}    [LifeCycle] get_actual_location_cb() Start
04:06:43.527 {INFO}    [LifeCycle] get_actual_location_cb() End
04:06:43.576 {WARNING} [Home] [Init] { message: Home did not shut itself down last run.,  }
04:06:52.908 {INFO}    [PackageManager] Checking package: oculus-overlays (961317437278561)
04:06:52.908 {INFO}    [PackageManager] Checking package: oculus-client (519080484913803)
04:06:52.908 {INFO}    [PackageManager] Checking package: oculus-compat (1522986184659833)
04:06:52.908 {INFO}    [PackageManager] Checking package: oculus-librarian (386768564867197)
04:06:52.908 {INFO}    [PackageManager] Checking package: oculus-diagnostics (827064807402789)
04:06:52.908 {INFO}    [PackageManager] Checking package: oculus-redistributable-installer (1190954377597673)
04:06:52.908 {INFO}    [PackageManager] Checking package: oculus-dreamdeck-nux (919445174798085)
04:06:52.908 {INFO}    [PackageManager] Checking package: oculus-drivers (670216293113998)
04:06:52.908 {INFO}    [PackageManager] Checking package: oculus-home (1033760676635835)
04:06:52.908 {INFO}    [PackageManager] Checking package: oculus-runtime (572698886195608)
04:06:53.219 {INFO}    [PackageManager] No pending packages to install.
04:06:53.219 {INFO}    [PackageManager] No core updates needed.
04:06:53.219 {INFO}    [PackageManager] Updates check finished.
04:06:53.279 {INFO}    [PackageManager] No new version for oculus-home
04:06:53.279 {INFO}    [PackageManager] No new version for oculus-redistributable-installer
04:06:53.279 {INFO}    [PackageManager] No new version for oculus-compat
04:06:53.279 {INFO}    [PackageManager] No new version for oculus-librarian
04:06:53.279 {INFO}    [PackageManager] No new version for oculus-client
04:06:53.279 {INFO}    [PackageManager] No new version for oculus-runtime
04:06:53.279 {INFO}    [PackageManager] No new version for oculus-drivers
04:06:53.279 {INFO}    [PackageManager] No new version for oculus-diagnostics
04:06:53.279 {INFO}    [PackageManager] No new version for oculus-dreamdeck-nux
04:06:53.279 {INFO}    [PackageManager] No new version for oculus-overlays
04:06:53.279 {INFO}    [PackageManager] No pending packages to install.
04:06:53.279 {INFO}    [PackageManager] No core updates needed.
04:06:53.279 {INFO}    [PackageManager] Updates check finished.
04:06:53.350 {INFO}    [HW:Enumeration] Connected devices: hmd, 1 cam
04:06:55.228 {INFO}    [LifeCycle] motionSensorEvent() Start
04:06:55.228 {INFO}    [LifeCycle] HMD Moving: false
04:06:55.228 {INFO}    [LifeCycle] motionSensorEvent() End
04:06:58.762 {INFO}    [LifeCycle] get_home_memory_usage() Start
04:06:58.762 {INFO}    [LifeCycle] get_home_memory_usage() End
04:07:02.638 {INFO}    [Skyline] [oculus_waterfall] { flow: nux, origin_app_name: skyline, progression: skip, step: connect-rift,  }
04:07:02.653 {INFO}    [Skyline] [oculus_waterfall] { flow: nux, origin_app_name: skyline, progression: auto, step: firmware-update,  }
04:07:02.655 {INFO}    [Skyline] [section_exit] { full_path: /nux/hardware-setup/connect-rift, origin_app_name: skyline, section_name: nux, sub_section: hardware-setup,  }
04:07:02.655 {INFO}    [Skyline] [section_entry] { full_path: /nux/hardware-setup/wake-remote, origin_app_name: skyline, section_name: nux, sub_section: hardware-setup,  }
04:07:04.794 {INFO}    [Skyline] [oculus_waterfall] { flow: nux, origin_app_name: skyline, progression: skip, step: wake-remote,  }
04:07:04.798 {INFO}    [Skyline] [section_exit] { full_path: /nux/hardware-setup/wake-remote, origin_app_name: skyline, section_name: nux, sub_section: hardware-setup,  }
04:07:04.798 {INFO}    [Skyline] [section_entry] { full_path: /nux/hardware-setup/setup-controller, origin_app_name: skyline, section_name: nux, sub_section: hardware-setup,  }
04:07:07.532 {INFO}    [HardwareManager] Adding NUX Step: "DONE" (null)
04:07:07.532 {INFO}    [LifeCycle] Nux Updated: DONE
04:07:07.545 {INFO}    [HardwareManager] New NUX Step: DONE
04:07:07.547 {INFO}    [Skyline] [oculus_waterfall] { flow: nux, origin_app_name: skyline, progression: skip, step: setup-controller,  }
04:07:07.647 {INFO}    [Skyline] [oculus_waterfall] { flow: nux, origin_app_name: skyline, progression: auto, step: product-registration,  }
04:07:07.675 {INFO}    [Skyline] [section_exit] { full_path: /nux/hardware-setup/setup-controller, origin_app_name: skyline, section_name: nux, sub_section: hardware-setup,  }
04:07:07.675 {INFO}    [Skyline] [section_entry] { full_path: /nux/vr/welcome-back, origin_app_name: skyline, section_name: nux, sub_section: vr,  }
04:07:07.675 {INFO}    [Skyline] [oculus_waterfall] { flow: nux, origin_app_name: skyline, progression: auto, step: product-registration,  }
04:07:07.678 {INFO}    [Skyline] [section_exit] { full_path: /nux/vr/welcome-back, origin_app_name: skyline, section_name: nux, sub_section: vr,  }
04:07:07.678 {INFO}    [Skyline] [section_entry] { full_path: /nux/vr/welcome-back, origin_app_name: skyline, section_name: nux, sub_section: vr,  }
04:07:10.931 {INFO}    [Skyline] [oculus_waterfall] { flow: nux, origin_app_name: skyline, progression: continue, step: vr-welcome-back,  }
04:07:10.935 {INFO}    [Skyline] [section_exit] { full_path: /nux/vr/welcome-back, origin_app_name: skyline, section_name: nux, sub_section: vr,  }
04:07:10.935 {INFO}    [Skyline] [section_entry] { full_path: /store, origin_app_name: skyline, section_name: store, sub_section: ,  }
04:07:13.846 {INFO}    [LifeCycle] get_home_memory_usage() Start
04:07:13.846 {INFO}    [LifeCycle] get_home_memory_usage() End
04:07:17.387 {INFO}    [Skyline] [section_exit] { full_path: /store, origin_app_name: skyline, section_name: store, sub_section: ,  }
04:07:17.387 {INFO}    [Skyline] [section_entry] { full_path: /store/app/909129545868758, origin_app_name: skyline, section_name: store, sub_section: app,  }
04:07:19.764 {INFO}    [Skyline] [section_exit] { full_path: /store/app/909129545868758, origin_app_name: skyline, section_name: store, sub_section: app,  }
04:07:19.764 {INFO}    [Skyline] [section_entry] { full_path: /store, origin_app_name: skyline, section_name: store, sub_section: ,  }
04:07:21.011 {INFO}    [Skyline] [section_entry] { full_path: , origin_app_name: skyline, section_name: notifications, sub_section: ,  }
04:07:23.821 {INFO}    [Skyline] [section_exit] { full_path: /store, origin_app_name: skyline, section_name: store, sub_section: ,  }
04:07:23.821 {INFO}    [Skyline] [section_entry] { full_path: /settings/account, origin_app_name: skyline, section_name: settings, sub_section: account,  }
04:07:24.330 {INFO}    [Skyline] [section_exit] { full_path: , origin_app_name: skyline, section_name: notifications, sub_section: ,  }
04:07:25.699 {INFO}    [Skyline] [section_exit] { full_path: /settings/account, origin_app_name: skyline, section_name: settings, sub_section: account,  }
04:07:25.699 {INFO}    [Skyline] [section_entry] { full_path: /settings/devices, origin_app_name: skyline, section_name: settings, sub_section: devices,  }
04:07:28.846 {INFO}    [LifeCycle] get_home_memory_usage() Start
04:07:28.846 {INFO}    [LifeCycle] get_home_memory_usage() End
04:07:43.848 {INFO}    [LifeCycle] get_home_memory_usage() Start
04:07:43.848 {INFO}    [LifeCycle] get_home_memory_usage() End
04:07:53.393 {INFO}    [HW:Enumeration] Connected devices: hmd, 1 cam
04:07:58.848 {INFO}    [LifeCycle] get_home_memory_usage() Start
04:07:58.848 {INFO}    [LifeCycle] get_home_memory_usage() End
04:08:13.848 {INFO}    [LifeCycle] get_home_memory_usage() Start
04:08:13.848 {INFO}    [LifeCycle] get_home_memory_usage() End
04:08:28.849 {INFO}    [LifeCycle] get_home_memory_usage() Start
04:08:28.849 {INFO}    [LifeCycle] get_home_memory_usage() End
04:08:36.302 {INFO}    [Skyline] [section_exit] { full_path: /settings/devices, origin_app_name: skyline, section_name: settings, sub_section: devices,  }
04:08:36.302 {INFO}    [Skyline] [section_entry] { full_path: /settings/general, origin_app_name: skyline, section_name: settings, sub_section: general,  }
04:08:38.239 {INFO}    [Skyline] [section_exit] { full_path: /settings/general, origin_app_name: skyline, section_name: settings, sub_section: general,  }
04:08:38.239 {INFO}    [Skyline] [section_entry] { full_path: /settings/beta, origin_app_name: skyline, section_name: settings, sub_section: beta,  }
04:08:43.851 {INFO}    [LifeCycle] get_home_memory_usage() Start
04:08:43.851 {INFO}    [LifeCycle] get_home_memory_usage() End
04:08:45.226 {INFO}    [LifeCycle] restart_service_cb() Start
04:08:45.226 {!ERROR!} [LifeCycle] User manually restarted the service.
04:08:45.226 {INFO}    [LifeCycle] restart_service_cb() End
04:08:46.222 {INFO}    [OAF] Stopping...
04:08:46.222 {INFO}    [OAFServer] TearDown
04:08:46.236 {WARNING} [Server] Setting connection focus to pid: 9984, file: (side-loaded app), but no window handle exists
04:08:46.236 {INFO}    [Server] Connection closed for pid: 9984, file: (side-loaded app)
04:08:46.237 {INFO}    [Server] Connection destroyed for pid: 9984, file: (side-loaded app)
04:08:46.241 {INFO}    [HardwarePairing] Requesting pairing thread to stop
04:08:46.241 {INFO}    [HardwarePairing] Pairing thread stopped
04:08:46.242 {INFO}    [Log] [AppFocusObserver] Reacting to destroy notification (WM_DESTROY).
04:08:46.431 {INFO}    [Tracking:Manager] Leaving tracking thread
04:08:46.431 {INFO}    [Log] Writing logged data to ...
04:08:46.431 {INFO}    [Log] Can't open log data file 
04:08:46.432 {INFO}    [Log] OVR::SensorDevice - Closed '\\?\hid#vid_2833&pid_0021#8&17dee87&0&0000#{4d1e55b2-f16f-11cf-88cb-001111000030}'
04:08:46.432 {INFO}    [HW:Enumeration] Tracker destruction triggering re-enumeration
04:08:46.432 {INFO}    [Log] OVR::Win32::HIDDevice - Closed '\\?\hid#vid_2833&pid_0021#8&17dee87&0&0000#{4d1e55b2-f16f-11cf-88cb-001111000030}'
04:08:46.432 {INFO}    [Log] OVR::DeviceManager - shutting down.
04:08:46.434 {INFO}    [Log] OVR::DeviceManagerThread - exiting (ThreadId=0x1878).
04:08:46.436 {INFO}    [GamePad] Leaving VR Mode: Restoring old XBox Home Button settings
04:08:46.436 {INFO}    [Camera:General] Stopping message pump