search

ValveSoftware / openvr

OpenVR SDK
http://steamvr.com
BSD 3-Clause "New" or "Revised" License
6.12k stars 1.28k forks source link

Custom Device Driver causes Compositor error #880

Closed SamRelativeDimensions closed 6 years ago

SamRelativeDimensions commented 6 years ago

Hi all,

Whilst creating a custom device driver (single controller, no HMD) and opening SteamVR, I'm getting a compositor crash that I'm unable to resolve.

The SteamVR window has a generic 400 compositor error, and the main Steam window shows a window with Error 306 "SteamVR failed to initialized for unknown reasons. (Error: Shared IPC Compositor Connect Failed (306))".

Below is the vrcompositor.txt log when opening SteamVR.

Sun Sep 09 2018 12:57:55.378 - //=====================================================================================================================
Sun Sep 09 2018 12:57:55.378 - VR compositor (v1533664367) starting up
Sun Sep 09 2018 12:57:55.378 - RuntimePath : C:\Program Files (x86)\Steam\steamapps\common\SteamVR\
Sun Sep 09 2018 12:57:55.421 - Events created
Sun Sep 09 2018 12:57:55.439 - Initializing generic graphics device resources...
Sun Sep 09 2018 12:57:55.439 - Headset is using direct mode
Sun Sep 09 2018 12:57:55.511 - ****************************************** Begin GPU speed ******************************************
Sun Sep 09 2018 12:57:55.774 - MeasureGpuMegaPixelsPerSecond(): Returning 365 MP/sec. Total CPU time 0.26 seconds.
Sun Sep 09 2018 12:57:55.799 - GPU Vendor: "NVIDIA GeForce GTX 980" GPU Driver: "24.21.13.9882"
Sun Sep 09 2018 12:57:58.801 - Resetting GPU data due to GPU change. Was "" driver "". Is now "NVIDIA GeForce GTX 980" driver "24.21.13.9882"
Sun Sep 09 2018 12:57:58.801 - GPU speed from average of 1 median samples: 365
Sun Sep 09 2018 12:57:58.801 - HMD driver recommended: 1344x1600 90.0Hz HiddenArea(0.00%) = 387 MP/sec
Sun Sep 09 2018 12:57:58.801 - GPU speed being set at first generation HMD resolution 382 MP/sec
Sun Sep 09 2018 12:57:58.801 - New render target scale = 0.98 = 1330x1584. Total CPU time 3.29 seconds.
Sun Sep 09 2018 12:57:58.801 - ******************************************* End GPU speed *******************************************
Sun Sep 09 2018 12:57:58.801 - Loading fonts/debug.spritefont
Sun Sep 09 2018 12:57:58.803 - Creating samplers
Sun Sep 09 2018 12:57:58.803 - Creating util resources
Sun Sep 09 2018 12:57:58.803 - Creating/Updating distortion surfaces
Sun Sep 09 2018 12:57:58.803 - Failed to compute distortion parameters! 0/2401
Sun Sep 09 2018 12:57:58.803 - Failed to create distortion surfaces
Sun Sep 09 2018 12:57:58.803 - Failed to init graphics device
Sun Sep 09 2018 12:57:58.805 - Failed to initialize compositor
Sun Sep 09 2018 12:57:58.805 - Failed to start compositor: VRInitError_Compositor_Failed

And in the main vrserver.txt log:

Sun Sep 09 2018 12:57:55.070 - ================================================================================================
Sun Sep 09 2018 12:57:55.070 - ================================================================================================
Sun Sep 09 2018 12:57:55.074 - Setting shared memory namespace, but it is already set to 10260. Process is NOT running
Sun Sep 09 2018 12:57:55.074 - Setting shared memory namespace to 15292
Sun Sep 09 2018 12:57:55.075 - VR server (v1533664367) starting up with config=C:\Program Files (x86)\Steam\config
Sun Sep 09 2018 12:57:55.075 - VRServer will wait for VRMonitor before exiting
Sun Sep 09 2018 12:57:55.080 - [Settings] Load Default Json Settings from C:\Program Files (x86)\Steam\steamapps\common\SteamVR\resources\settings\default.vrsettings
Sun Sep 09 2018 12:57:55.080 - [Settings] Load Default Json Settings from C:\Program Files (x86)\Steam\steamapps\common\SteamVR\drivers\htc\resources\settings\default.vrsettings
Sun Sep 09 2018 12:57:55.081 - [Settings] Load Default Json Settings from C:\Program Files (x86)\Steam\steamapps\common\SteamVR\drivers\lighthouse\resources\settings\default.vrsettings
Sun Sep 09 2018 12:57:55.081 - [Settings] Load Default Json Settings from C:\Program Files\VRGO\vrgochair\resources\settings\default.vrsettings
Sun Sep 09 2018 12:57:55.081 - [Settings] Load Default Json Settings from C:\Program Files (x86)\Steam\steamapps\common\SteamVR\drivers\null\resources\settings\default.vrsettings
Sun Sep 09 2018 12:57:55.082 - [Settings] Load Json Settings from C:\Program Files (x86)\Steam\config\steamvr.vrsettings
Sun Sep 09 2018 12:57:55.086 - Enabling direct mode for NVIDIA [Vid=0xD222 Pid=0xAA01]...
Sun Sep 09 2018 12:57:55.087 - Success!
Sun Sep 09 2018 12:57:55.090 - C:\Program Files (x86)\Steam\config\steamapps.vrmanifest - App steam.app.234630 was already described in manifest c:\program files (x86)\steam\config\steamapps.vrmanifest. Skipping
Sun Sep 09 2018 12:57:55.090 - C:\Program Files (x86)\Steam\config\steamapps.vrmanifest - App steam.app.342180 was already described in manifest c:\program files (x86)\steam\config\steamapps.vrmanifest. Skipping
Sun Sep 09 2018 12:57:55.090 - C:\Program Files (x86)\Steam\config\steamapps.vrmanifest - App steam.app.412740 was already described in manifest c:\program files (x86)\steam\config\steamapps.vrmanifest. Skipping
Sun Sep 09 2018 12:57:55.090 - C:\Program Files (x86)\Steam\config\steamapps.vrmanifest - App steam.app.451520 was already described in manifest c:\program files (x86)\steam\config\steamapps.vrmanifest. Skipping
Sun Sep 09 2018 12:57:55.090 - C:\Program Files (x86)\Steam\config\steamapps.vrmanifest - App steam.app.469610 was already described in manifest c:\program files (x86)\steam\config\steamapps.vrmanifest. Skipping
Sun Sep 09 2018 12:57:55.090 - C:\Program Files (x86)\Steam\config\steamapps.vrmanifest - App steam.app.496240 was already described in manifest c:\program files (x86)\steam\config\steamapps.vrmanifest. Skipping
Sun Sep 09 2018 12:57:55.090 - C:\Program Files (x86)\Steam\config\steamapps.vrmanifest - App steam.app.611660 was already described in manifest c:\program files (x86)\steam\config\steamapps.vrmanifest. Skipping
Sun Sep 09 2018 12:57:55.090 - C:\Program Files (x86)\Steam\config\steamapps.vrmanifest - App steam.app.617830 was already described in manifest c:\program files (x86)\steam\config\steamapps.vrmanifest. Skipping
Sun Sep 09 2018 12:57:55.103 - Add Json firmware manifest from {htc}/firmware/manifest.vrfirmware
Sun Sep 09 2018 12:57:55.103 - New Connect message from C:\Program Files (x86)\Steam\steamapps\common\SteamVR\bin\win64\vrmonitor.exe (VRApplication_VRMonitor) (Args: -nokillprocess) 668  - RECONNECT
Sun Sep 09 2018 12:57:55.103 - Add Json firmware manifest from {lighthouse}/firmware/manifest.vrfirmware
Sun Sep 09 2018 12:57:55.104 - [Web] Starting web server on port localhost:8998
Sun Sep 09 2018 12:57:55.104 - [Web Bluetooth Controller] Controller Init.
Sun Sep 09 2018 12:57:55.104 - [Web Bluetooth Controller] Controller disabled at startup.
Sun Sep 09 2018 12:57:55.112 - Setting app openvr.component.vrmonitor PID to 668
Sun Sep 09 2018 12:57:55.113 -   driver gamepad implements interfaces IVRSettings_002 ITrackedDeviceServerDriver_005 IVRDisplayComponent_002 IVRDriverDirectModeComponent_005 IVRCameraComponent_002 IServerTrackedDeviceProvider_004 IVRWatchdogProvider_001 IVRVirtualDisplay_002 IVRDriverManager_001 IVRResources_001 IVRCompositorPluginProvider_001 
Sun Sep 09 2018 12:57:55.113 - Loaded server driver gamepad (IServerTrackedDeviceProvider_004) from C:\Program Files (x86)\Steam\steamapps\common\SteamVR\drivers\gamepad\bin\win64\driver_gamepad.dll
Sun Sep 09 2018 12:57:55.114 - Driver gamepad has no suitable devices.
Sun Sep 09 2018 12:57:55.124 - lighthouse: Attached HID Devices:
Sun Sep 09 2018 12:57:55.124 - lighthouse:     No devices
Sun Sep 09 2018 12:57:55.124 -   driver lighthouse implements interfaces IVRSettings_002 ITrackedDeviceServerDriver_005 IVRDisplayComponent_002 IVRDriverDirectModeComponent_005 IVRCameraComponent_002 IServerTrackedDeviceProvider_004 IVRWatchdogProvider_001 IVRVirtualDisplay_002 IVRDriverManager_001 IVRResources_001 IVRCompositorPluginProvider_001 
Sun Sep 09 2018 12:57:55.125 - Loaded server driver lighthouse (IServerTrackedDeviceProvider_004) from C:\Program Files (x86)\Steam\steamapps\common\SteamVR\drivers\lighthouse\bin\win64\driver_lighthouse.dll
Sun Sep 09 2018 12:57:55.125 - Driver lighthouse has no suitable devices.
Sun Sep 09 2018 12:57:55.170 - oculus: [CAPI] LibOVR module is located at C:\Program Files\Oculus\Support\oculus-runtime\LibOVRRT64_1.dll
Sun Sep 09 2018 12:57:55.172 - oculus: Connected to the server running version (prod = 1).1.30.0(build = 666747) feature version = 0. Client runs version (prod = 1).1.30.0(build = 0) feature version = 0
Sun Sep 09 2018 12:57:55.222 - oculus: [HMDState] Using default profile default
Sun Sep 09 2018 12:57:55.222 - oculus: IAD changed to 64.9mm
Sun Sep 09 2018 12:57:55.222 - oculus: Creating factory
Sun Sep 09 2018 12:57:55.289 - oculus: Initialized Oculus device WMHD314B50014Z
Sun Sep 09 2018 12:57:55.289 - Driver 'oculus' started activation of tracked device with serial number 'WMHD314B50014Z'
Sun Sep 09 2018 12:57:55.289 -   driver oculus implements interfaces IVRSettings_002 ITrackedDeviceServerDriver_005 IVRDisplayComponent_002 IVRDriverDirectModeComponent_005 IVRCameraComponent_002 IServerTrackedDeviceProvider_004 IVRWatchdogProvider_001 IVRVirtualDisplay_002 IVRDriverManager_001 IVRResources_001 IVRCompositorPluginProvider_001 
Sun Sep 09 2018 12:57:55.289 - Loaded server driver oculus (IServerTrackedDeviceProvider_004) from C:\Program Files (x86)\Steam\steamapps\common\SteamVR\drivers\oculus\bin\win64\driver_oculus.dll
Sun Sep 09 2018 12:57:55.295 - Active HMD set to oculus.WMHD314B50014Z
Sun Sep 09 2018 12:57:55.295 - Using display adapter luid: 75508
Sun Sep 09 2018 12:57:55.295 - Initialized EyeToHead Left Translation -0.032451 0.000000 0.000000 
Sun Sep 09 2018 12:57:55.295 - Initialized EyeToHead Right Translation 0.032451 0.000000 0.000000 
Sun Sep 09 2018 12:57:55.296 - DXGI thread failed to get SDL display index
Sun Sep 09 2018 12:57:55.296 - Adding controller type to rift
Sun Sep 09 2018 12:57:55.297 - Driver 'oculus' finished adding tracked device with serial number 'WMHD314B50014Z'
Sun Sep 09 2018 12:57:55.298 - vrgochair: vrgochair: Creating Controller DriverSun Sep 09 2018 12:57:55.298 - vrgochair: vrgochair: Post- Creating Controller DriverSun Sep 09 2018 12:57:55.298 - Driver 'vrgochair' started activation of tracked device with serial number 'VRGO_1234'
Sun Sep 09 2018 12:57:55.298 -   driver vrgochair implements interfaces IVRSettings_002 ITrackedDeviceServerDriver_005 IVRDisplayComponent_002 IVRDriverDirectModeComponent_005 IVRCameraComponent_002 IServerTrackedDeviceProvider_004 IVRWatchdogProvider_001 IVRVirtualDisplay_002 IVRDriverManager_001 IVRResources_001 IVRCompositorPluginProvider_001 
Sun Sep 09 2018 12:57:55.298 - Loaded server driver vrgochair (IServerTrackedDeviceProvider_004) from C:\Program Files\VRGO\vrgochair\bin\win64\driver_vrgochair.dll
Sun Sep 09 2018 12:57:55.299 - Adding controller type to vrgochair_controller
Sun Sep 09 2018 12:57:55.299 - Driver 'vrgochair' finished adding tracked device with serial number 'VRGO_1234'
Sun Sep 09 2018 12:57:55.299 - Processing message VRMsg_Connect from vrmonitor (668) took 0.196 seconds
Sun Sep 09 2018 12:57:55.299 - New Connect message from C:\Program Files (x86)\Steam\Steam.exe (VRApplication_Overlay) (Args: ) 24060 
Sun Sep 09 2018 12:57:55.308 - Creating builtin app for C:\Program Files (x86)\Steam\Steam.exe (VRApplication_Overlay)
Sun Sep 09 2018 12:57:55.308 - Setting app system.generated.steam.exe PID to 24060
Sun Sep 09 2018 12:57:55.308 - Enabling legacy input for system.generated.steam.exe
Sun Sep 09 2018 12:57:55.309 - App system.generated.steam.exe (rift) loaded fallback binding file file:///C:/Program Files (x86)/Steam/steamapps/common/SteamVR/drivers/oculus/resources/input/legacy_bindings_rift.json
Sun Sep 09 2018 12:57:55.309 - App system.generated.steam.exe (vrgochair_controller) loaded fallback binding file file:///C:/Program Files/VRGO/vrgochair/resources/input/vrgochair_controller_legacy_bindings.json
Sun Sep 09 2018 12:57:55.309 - Using existing HMD oculus.WMHD314B50014Z
Sun Sep 09 2018 12:57:55.309 - Processing message VRMsg_Connect from Steam (24060) took 0.0104 seconds
Sun Sep 09 2018 12:57:55.398 - New Connect message from C:\Program Files (x86)\Steam\steamapps\common\SteamVR\bin\win32\vrcompositor.exe (VRApplication_Background) (Args: ) 10920 
Sun Sep 09 2018 12:57:55.407 - Setting app openvr.component.vrcompositor PID to 10920
Sun Sep 09 2018 12:57:55.410 - App openvr.component.vrcompositor (rift) loaded fallback binding file file:///C:/Program Files (x86)/Steam/steamapps/common/SteamVR/resources/config/vrcompositor_bindings_generic_hmd.json
Sun Sep 09 2018 12:57:55.410 - App openvr.component.vrcompositor (vrgochair_controller) loaded fallback binding file file:///C:/Program Files (x86)/Steam/steamapps/common/SteamVR/resources/config/vrcompositor_bindings_generic.json
Sun Sep 09 2018 12:57:55.410 - Using existing HMD oculus.WMHD314B50014Z
Sun Sep 09 2018 12:57:55.410 - Processing message VRMsg_Connect from vrcompositor (10920) took 0.0121 seconds
Sun Sep 09 2018 12:57:55.692 - Process vrcompositor (10920) disconnected (Thread(0x00000278ECC05110/0x000)
Sun Sep 09 2018 12:57:55.692 - Process Steam (24060) disconnected (Thread(0x00000278ECC05C50/0x000)
Sun Sep 09 2018 12:57:55.692 - Process vrmonitor (668) disconnected (Thread(0x00000278EA201640/0x000)

It would be great if someone could let me know why this is occurring, perhaps there is a property that I've not set somewhere without realising, but I've seen nothing in the guides.

Thanks

TheDeveloperGuy commented 6 years ago

Looks like your driver DLL is crashing (ie. causing an unhandled exception).