NVIDIAGameWorks / rtx-remix

Combined repo for the RTX-Remix runtime
https://www.nvidia.com/en-us/geforce/rtx-remix/
MIT License
1.37k stars 69 forks source link

The Elder Scrolls 5: Skyrim UWM_REMIX_BRIDGE_REGISTER_THREADPROC_MSG handshake timeout. #97

Open Lobastiy opened 1 year ago

Lobastiy commented 1 year ago

Describe the bug

Attach logs!

TESV_d3d9.log

Details

``` info: Game: TESV.exe info: DXVK_Remix: v1.9.3 info: Found built-in config: info: Effective configuration: info: d3d9.customVendorId = 1002 info: positions info: indices info: texcoords info: geometrydescriptor info: positions info: indices info: geometrydescriptor info: Built-in extension providers: info: Win32 WSI info: OpenVR info: OpenXR info: OpenVR: could not open registry key, status 2 info: OpenVR: Failed to locate module info: Enabled instance extensions: info: VK_KHR_get_physical_device_properties2 info: VK_KHR_get_surface_capabilities2 info: VK_KHR_surface info: VK_KHR_win32_surface info: Enabled Layer Names: info: D3D9: VK_FORMAT_D16_UNORM_S8_UINT -> VK_FORMAT_D24_UNORM_S8_UINT info: NVIDIA GeForce RTX 3060 Laptop GPU: info: Driver: 531.41.0 info: Vulkan: 1.3.236 info: Memory Heap[0]: info: Size: 6009 MiB info: Flags: 0x1 info: Memory Type[1]: Property Flags = 0x1 info: Memory Type[4]: Property Flags = 0x7 info: Memory Heap[1]: info: Size: 8053 MiB info: Flags: 0x0 info: Memory Type[0]: Property Flags = 0x0 info: Memory Type[2]: Property Flags = 0x6 info: Memory Type[3]: Property Flags = 0xe info: D3D9: VK_FORMAT_D16_UNORM_S8_UINT -> VK_FORMAT_D24_UNORM_S8_UINT info: Intel(R) Iris(R) Xe Graphics: info: Driver: 0.404.3413 info: Vulkan: 1.3.224 info: Memory Heap[0]: info: Size: 8053 MiB info: Flags: 0x1 info: Memory Type[0]: Property Flags = 0x1 info: Memory Type[1]: Property Flags = 0x7 info: Memory Type[2]: Property Flags = 0xf info: Process set as DPI aware info: Detected GPU device ID is 0x2520, vendor ID is 0x10de info: Device properties: info: Device name: : NVIDIA GeForce RTX 3060 Laptop GPU info: Driver version : 531.41.0 info: Enabled device extensions: info: VK_EXT_4444_formats info: VK_EXT_conservative_rasterization info: VK_EXT_custom_border_color info: VK_EXT_depth_clip_enable info: VK_EXT_extended_dynamic_state info: VK_EXT_full_screen_exclusive info: VK_EXT_memory_priority info: VK_EXT_opacity_micromap info: VK_EXT_robustness2 info: VK_EXT_shader_demote_to_helper_invocation info: VK_EXT_shader_viewport_index_layer info: VK_EXT_transform_feedback info: VK_EXT_vertex_attribute_divisor info: VK_KHR_acceleration_structure info: VK_KHR_buffer_device_address info: VK_KHR_create_renderpass2 info: VK_KHR_deferred_host_operations info: VK_KHR_depth_stencil_resolve info: VK_KHR_draw_indirect_count info: VK_KHR_driver_properties info: VK_KHR_image_format_list info: VK_KHR_pipeline_library info: VK_KHR_push_descriptor info: VK_KHR_ray_query info: VK_KHR_ray_tracing_pipeline info: VK_KHR_sampler_mirror_clamp_to_edge info: VK_KHR_shader_float16_int8 info: VK_KHR_shader_float_controls info: VK_KHR_swapchain info: VK_KHR_synchronization2 info: VK_NVX_binary_import info: VK_NVX_image_view_handle info: VK_NV_low_latency info: VK_NV_ray_tracing_invocation_reorder info: Device features: info: robustBufferAccess : 1 info: fullDrawIndexUint32 : 1 info: imageCubeArray : 1 info: independentBlend : 1 info: geometryShader : 1 info: tessellationShader : 0 info: sampleRateShading : 1 info: dualSrcBlend : 0 info: logicOp : 0 info: multiDrawIndirect : 0 info: drawIndirectFirstInstance : 0 info: depthClamp : 1 info: depthBiasClamp : 1 info: fillModeNonSolid : 1 info: depthBounds : 1 info: multiViewport : 1 info: samplerAnisotropy : 1 info: textureCompressionBC : 1 info: occlusionQueryPrecise : 1 info: pipelineStatisticsQuery : 1 info: vertexPipelineStoresAndAtomics : 1 info: fragmentStoresAndAtomics : 0 info: shaderImageGatherExtended : 0 info: shaderStorageImageExtendedFormats : 0 info: shaderStorageImageReadWithoutFormat : 0 info: shaderStorageImageWriteWithoutFormat : 1 info: shaderClipDistance : 1 info: shaderCullDistance : 1 info: shaderFloat64 : 0 info: shaderInt64 : 0 info: variableMultisampleRate : 0 info: hostQueryReset : 1 info: VK_EXT_4444_formats info: formatA4R4G4B4 : 1 info: formatA4B4G4R4 : 1 info: VK_EXT_custom_border_color info: customBorderColors : 1 info: customBorderColorWithoutFormat : 1 info: VK_EXT_depth_clip_enable info: depthClipEnable : 1 info: VK_EXT_extended_dynamic_state info: extendedDynamicState : 1 info: VK_EXT_memory_priority info: memoryPriority : 1 info: VK_EXT_robustness2 info: robustBufferAccess2 : 1 info: robustImageAccess2 : 0 info: nullDescriptor : 1 info: VK_EXT_shader_demote_to_helper_invocation info: shaderDemoteToHelperInvocation : 1 info: VK_EXT_transform_feedback info: transformFeedback : 1 info: geometryStreams : 0 info: VK_EXT_vertex_attribute_divisor info: vertexAttributeInstanceRateDivisor : 1 info: vertexAttributeInstanceRateZeroDivisor : 1 info: VK_KHR_buffer_device_address info: bufferDeviceAddress : 1 info: Queue families: info: Graphics : 0 info: Transfer : 1 info: Async Compute : 2 info: DXVK: Read 0 valid state cache entries info: DXVK: Using 5 compiler threads info: [GameCapturer] DXVK_RTX_CAPTURE_ENABLE_ON_FRAME: warn: [GameCapturer] LSS USD Plugins failed to load. warn: Cannot find rtx-remix\mods\ under current directory: D:\Games\The Elder Scrolls 5.Skyrim.Legendary Edition.v 1.9.32.0.8 + 3 DLC info: Automatic Graphics Preset in use (Set rtx.graphicsPreset to something other than Auto use a non-automatic preset) info: NVIDIA Ampere architecture detected, setting default graphics settings to High info: Automatic Raytrace Mode Preset in use (Set rtx.raytraceModePreset to something other than Auto use a non-automatic preset) info: NVIDIA architecture detected, setting default raytrace modes to Trace Ray (GBuffer/Indirect Integrate) and Ray Query (Direct Integrate) info: [RTX info] Opacity Micromap: supported info: [RTX info] Shader Execution Reordering: not supported info: [RTX info] Shader Execution Reordering: disabled info: CPU supports SIMD: AVX2 info: D3D9DeviceEx::ResetSwapChain: info: Requested Presentation Parameters info: - Width: 1280 info: - Height: 720 info: - Format: D3D9Format::X8R8G8B8 info: - Auto Depth Stencil: false info: ^ Format: D3D9Format::D24S8 info: - Windowed: true info: Presenter: Actual swap chain properties: info: Format: VK_FORMAT_B8G8R8A8_UNORM info: Present mode: VK_PRESENT_MODE_IMMEDIATE_KHR info: Buffer size: 1280x720 info: Image count: 2 info: Exclusive FS: 2 info: No winproc detected, initiating bridge message channel for: 00000000000D0912 warn: Message channel UWM_REMIX_BRIDGE_REGISTER_THREADPROC_MSG handshake timeout. Retrying... warn: Message channel UWM_REMIX_BRIDGE_REGISTER_THREADPROC_MSG handshake timeout. Retrying... warn: Message channel UWM_REMIX_BRIDGE_REGISTER_THREADPROC_MSG handshake timeout. Retrying... warn: Message channel UWM_REMIX_BRIDGE_REGISTER_THREADPROC_MSG handshake timeout. Retrying... warn: Message channel UWM_REMIX_BRIDGE_REGISTER_THREADPROC_MSG handshake timeout. Retrying... warn: Message channel UWM_REMIX_BRIDGE_REGISTER_THREADPROC_MSG handshake timeout. Retrying... warn: Message channel UWM_REMIX_BRIDGE_REGISTER_THREADPROC_MSG handshake timeout. Retrying... info: Message channel UWM_REMIX_BRIDGE_REGISTER_THREADPROC_MSG established. ```

d3d9.log

Details

``` [18:00:20.714] info: No default config found for: D:\Games\The Elder Scrolls 5.Skyrim.Legendary Edition.v 1.9.32.0.8 + 3 DLC\TESV.exe [18:00:20.714] info: Trying to open config file: D:\Games\The Elder Scrolls 5.Skyrim.Legendary Edition.v 1.9.32.0.8 + 3 DLC\.trex\bridge.conf [18:00:20.714] info: Found user config file: D:\Games\The Elder Scrolls 5.Skyrim.Legendary Edition.v 1.9.32.0.8 + 3 DLC\.trex\bridge.conf [18:00:20.714] info: Effective configuration: [18:00:20.714] info: client.shaderVersion = 3.0 [18:00:20.714] info: client.serverCrashFallback = True [18:00:20.714] info: debugWindowEnabled = True [18:00:20.714] info: Using shared heap for textures. [18:00:20.714] info: Using shared heap for static buffers. [18:00:20.714] info: Using shared heap for dynamic buffers. [18:00:20.714] info: ================== [18:00:20.714] info: NVIDIA RTX Remix Bridge Client [18:00:20.714] info: ================== [18:00:20.714] info: Version: remix-0.1.1-2-gdc825b6 [18:00:20.714] info: Loaded d3d9.dll from D:\Games\The Elder Scrolls 5.Skyrim.Legendary Edition.v 1.9.32.0.8 + 3 DLC\TESV.exe [18:00:20.729] info: DirectInput8 hook attached. [18:00:20.729] info: DirectInput hook attached. [18:00:20.729] info: Initializing new shared memory object. [18:00:20.776] info: Shared memory: [ClientChannel_9c69adbd-6a7d-4127-add1-1b4281b86563] created and initialized successfully! [18:00:20.776] info: Initializing new shared memory object. [18:00:20.792] info: Shared memory: [ServerChannel_9c69adbd-6a7d-4127-add1-1b4281b86563] created and initialized successfully! [18:00:20.792] info: Initializing new shared memory object. [18:00:20.792] info: Shared memory: [SharedDataHeap_meta_9c69adbd-6a7d-4127-add1-1b4281b86563] created and initialized successfully! [18:00:20.792] info: Initializing new shared memory object. [18:00:20.885] info: Shared memory: [SharedDataHeap_data_0_9c69adbd-6a7d-4127-add1-1b4281b86563] created and initialized successfully! [18:00:20.885] info: Initializing new shared memory object. [18:00:20.979] info: Shared memory: [SharedDataHeap_data_1_9c69adbd-6a7d-4127-add1-1b4281b86563] created and initialized successfully! [18:00:21.902] info: Launching server with GUID 9c69adbd-6a7d-4127-add1-1b4281b86563 [18:00:21.905] info: Sending SYN command, waiting for ACK from server... [18:00:22.097] info: Ack received! Handshake completed! Telling server to continue waiting for commands... [18:00:22.097] info: Server crash recovery enabled [18:00:22.270] info: Creating a thread-safe D3D9 device. [18:00:22.270] debug: Creating Device... [18:00:22.271] debug: ...server-side D3D9 device creation command sent... [18:00:22.271] debug: ...waiting for create device ack response from server... [18:00:23.915] debug: ...create device response received from server... [18:00:23.938] debug: ...server-side D3D9 device successfully created... [18:00:23.949] debug: ...Device successfully created! ```

NvRemixBridge.log

Details

``` [18:26:31.400] info: No default config found for: D:\Games\The Elder Scrolls 5.Skyrim.Legendary Edition.v 1.9.32.0.8 + 3 DLC\TESV.exe [18:26:31.401] info: Trying to open config file: D:\Games\The Elder Scrolls 5.Skyrim.Legendary Edition.v 1.9.32.0.8 + 3 DLC\.trex\bridge.conf [18:26:31.401] info: Found user config file: D:\Games\The Elder Scrolls 5.Skyrim.Legendary Edition.v 1.9.32.0.8 + 3 DLC\.trex\bridge.conf [18:26:31.402] info: Effective configuration: [18:26:31.402] info: client.shaderVersion = 4.0 [18:26:31.402] info: client.serverCrashFallback = True [18:26:31.402] info: debugWindowEnabled = True [18:26:31.403] info: Using shared heap for textures. [18:26:31.403] info: Using shared heap for static buffers. [18:26:31.403] info: Using shared heap for dynamic buffers. [18:26:31.404] info: ================== [18:26:31.404] info: NVIDIA RTX Remix Bridge Server [18:26:31.404] info: ================== [18:26:31.404] info: Version: remix-0.1.1-2-gdc825b6 [18:26:31.404] info: Running in x64 mode! [18:26:31.406] info: Launched server with GUID 7fdbe3ec-e260-4d10-a706-f79472867675 [18:26:31.406] info: Shared memory: [ClientChannel_7fdbe3ec-e260-4d10-a706-f79472867675] created and initialized successfully! [18:26:31.406] debug: CreateSemaphore returned existing semaphore by the same name ClientDataQueue. [18:26:31.406] info: Shared memory: [ServerChannel_7fdbe3ec-e260-4d10-a706-f79472867675] created and initialized successfully! [18:26:31.406] debug: CreateSemaphore returned existing semaphore by the same name ServerDataQueue. [18:26:31.406] info: Shared memory: [SharedDataHeap_meta_7fdbe3ec-e260-4d10-a706-f79472867675] created and initialized successfully! [18:26:31.407] info: Shared memory: [SharedDataHeap_data_0_7fdbe3ec-e260-4d10-a706-f79472867675] created and initialized successfully! [18:26:31.407] info: Shared memory: [SharedDataHeap_data_1_7fdbe3ec-e260-4d10-a706-f79472867675] created and initialized successfully! [18:26:31.408] debug: CreateSemaphore returned existing semaphore by the same name Present. [18:26:31.408] info: Server started up, waiting for connection from client... [18:26:31.408] info: Registering exit callback in case client exits unexpectedly. [18:26:31.409] info: Registering message channel for asynchronous message handling. [18:26:31.409] info: Initializing D3D9... [18:26:31.409] info: Message channel MessageChannelServer established. [18:26:31.574] info: D3D9 interface object creation succeeded! [18:26:31.575] info: Loaded D3D9 from D:\Games\The Elder Scrolls 5.Skyrim.Legendary Edition.v 1.9.32.0.8 + 3 DLC\.trex\d3d9.dll [18:26:31.575] info: Version of d3d9 loaded is DXVK [18:26:31.575] info: Sync request received, sending ACK response... [18:26:31.575] info: Done! Now waiting for client to consume the response... [18:26:31.576] info: Handshake completed! Now waiting for incoming commands... [18:26:31.746] info: No leaked objects dicovered at Direct3D module eviction. [18:26:33.113] info: Server side D3D9 Device created successfully! [18:26:33.114] debug: Sending CreateDevice ack response back to client. [18:26:43.266] err: The client process has unexpectedly exited, shutting down server as well! [18:26:44.145] info: Command processing loop finished, cleaning up and exiting... [18:26:44.160] info: Shutdown cleanup successful, exiting now! [18:26:44.160] info: [Uptime]: 12s ```

To Reproduce Steps to reproduce the behavior:

  1. Download specified version
  2. Extract to the location of TESV.exe
  3. Move bridge.conf to .trex folder
  4. In bridge.conf set client.shaderVersion to 3.0 and remove #
  5. Launch TESV.exe
  6. The application should not respond
  7. Close and open TESV_d3d9.log
  8. We see that a handshake attempt is being made, but it ends due to timeout

Expected

The game will start

Lobastiy commented 1 year ago

Appears with any graphics settings

jhaapasa commented 1 year ago

If the game does not support fixed function rendering mode, you probably won't see any sensible rendering results. Remix should not early exit or crash however, and ideally you would be able to at least tag the UI, so we're filing an internal ticket.

Rmurray2006 commented 1 year ago

it crashes on regular remix, you have to use the dkvx fork and configure it right but it still has problems getting the models but its doable but you're going to have to capture stuff every second because most of the game is models and textures. if you use the remix discord you can see we've been working on skyrim LE and oblivion.

Lobastiy commented 1 year ago

Can you share with link to Remix server?

it crashes on regular remix, you have to use the dkvx fork and configure it right but it still has problems getting the models but its doable but you're going to have to capture stuff every second because most of the game is models and textures. if you use the remix discord you can see we've been working on skyrim LE and oblivion.

Rmurray2006 commented 1 year ago

Can you share with link to Remix server?

it crashes on regular remix, you have to use the dkvx fork and configure it right but it still has problems getting the models but its doable but you're going to have to capture stuff every second because most of the game is models and textures. if you use the remix discord you can see we've been working on skyrim LE and oblivion.

https://discord.gg/tHYbHfNC

NV-LL commented 5 months ago

Hello! Will you please test this on the latest release and let us know if the issue persists? Thank you!