Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Microsoft Holographic AppRemoting Runtime runtime version 2.8.1 #79

Open
gvindiol opened this issue Aug 18, 2022 · 3 comments
Open

Microsoft Holographic AppRemoting Runtime runtime version 2.8.1 #79

gvindiol opened this issue Aug 18, 2022 · 3 comments

Comments

@gvindiol
Copy link

gvindiol commented Aug 18, 2022 •
edited

I'm trying to switch a UE 5.0.3 Project over from using Windows Mixed Reality to the MicrosoftOpenXR Plugin and use holographic remoting. Currently, I'm able to use holographic remoting in the editor to test my project but when i package for windows development and run the application will crash.

arnocMain.exe SampleLevel -game "-HoloLensRemoting=192.168.1.71" -log

I Have OpenXR Tools for Windows Mixed Reality
Windows Mixed Reality Runtime version 111.2206.16002

[2022.08.18-05.13.12:783][  0]LogUObjectHash: Warning: Ambiguous search, could be Class /Script/OnlineSubsystemUtils.OnlineEngineInterfaceImpl or Class /Script/OnlineSubsystemUtils.OnlineEngineInterfaceImpl
[2022.08.18-05.13.12:783][  0]LogEngine: Initializing Engine...
[2022.08.18-05.13.12:783][  0]LogVaRest: UVaRestSubsystem::Initialize(24): VaRest subsystem initialized
[2022.08.18-05.13.12:784][  0]LogAOA: Warning: Current OpenXR runtime does not support Azure Object Anchors.  Requires XR_MSFT_SPATIAL_GRAPH_BRIDGE version 2.
[2022.08.18-05.13.13:390][  0]LogStats: UGameplayTagsManager::InitializeManager -  0.000 s
[2022.08.18-05.13.13:397][  0]LogInit: Initializing FReadOnlyCVARCache
[2022.08.18-05.13.13:397][  0]LogAudio: Display: Initializing Audio Device Manager...
[2022.08.18-05.13.13:398][  0]LogAudio: Display: Loading Default Audio Settings Objects...
[2022.08.18-05.13.13:398][  0]LogAudio: Display: No default SoundConcurrencyObject specified (or failed to load).
[2022.08.18-05.13.13:398][  0]LogAudio: Display: Registering Engine Module Parameter Interfaces...
[2022.08.18-05.13.13:399][  0]LogAudio: Display: Audio Device Manager Initialized
[2022.08.18-05.13.13:399][  0]LogAudio: Display: Creating Audio Device:                 Id: 1, Scope: Shared, Realtime: True
[2022.08.18-05.13.13:399][  0]LogAudioMixer: Display: Audio Mixer Platform Settings:
[2022.08.18-05.13.13:399][  0]LogAudioMixer: Display: 	Sample Rate:						  48000
[2022.08.18-05.13.13:400][  0]LogAudioMixer: Display: 	Callback Buffer Frame Size Requested: 256
[2022.08.18-05.13.13:400][  0]LogAudioMixer: Display: 	Callback Buffer Frame Size To Use:	  256
[2022.08.18-05.13.13:401][  0]LogAudioMixer: Display: 	Number of buffers to queue:			  7
[2022.08.18-05.13.13:402][  0]LogAudioMixer: Display: 	Max Channels (voices):				  0
[2022.08.18-05.13.13:402][  0]LogAudioMixer: Display: 	Number of Async Source Workers:		  0
[2022.08.18-05.13.13:403][  0]LogAudio: Display: AudioDevice MaxSources: 32
[2022.08.18-05.13.13:403][  0]LogAudio: Display: Audio Spatialization Plugin: None (built-in).
[2022.08.18-05.13.13:403][  0]LogAudio: Display: Audio Reverb Plugin: None (built-in).
[2022.08.18-05.13.13:404][  0]LogAudio: Display: Audio Occlusion Plugin: None (built-in).
[2022.08.18-05.13.13:406][  0]LogAudioDebug: Display: Lib vorbis DLL was dynamically loaded.
[2022.08.18-05.13.13:406][  0]LogAudioMixer: Display: Initializing audio mixer using platform API: 'XAudio2'
[2022.08.18-05.13.13:432][  0]LogAudioMixer: Display: Using Audio Hardware Device Speakers (Realtek(R) Audio)
[2022.08.18-05.13.13:432][  0]LogAudioMixer: Display: Initializing Sound Submixes...
[2022.08.18-05.13.13:433][  0]LogAudioMixer: Display: Creating Master Submix 'MasterSubmixDefault'
[2022.08.18-05.13.13:433][  0]LogAudioMixer: Display: Creating Master Submix 'MasterReverbSubmixDefault'
[2022.08.18-05.13.13:434][  0]LogAudioMixer: FMixerPlatformXAudio2::StartAudioStream() called. InstanceID=1
[2022.08.18-05.13.13:434][  0]LogAudioMixer: Display: Output buffers initialized: Frames=256, Channels=2, Samples=512, InstanceID=1
[2022.08.18-05.13.13:435][  0]LogAudioMixer: Display: Starting AudioMixerPlatformInterface::RunInternal(), InstanceID=1
[2022.08.18-05.13.13:435][  0]LogAudioMixer: Display: FMixerPlatformXAudio2::SubmitBuffer() called for the first time. InstanceID=1
[2022.08.18-05.13.13:435][  0]LogInit: FAudioDevice initialized.
[2022.08.18-05.13.13:436][  0]LogNetVersion: Set ProjectVersion to 1.0.0.0. Version Checksum will be recalculated on next use.
[2022.08.18-05.13.13:436][  0]LogInit: Texture streaming: Enabled
[2022.08.18-05.13.13:436][  0]LogCsvProfiler: Display: Metadata set : largeworldcoordinates="1"
[2022.08.18-05.13.13:451][  0]LogChaos: FPhysicsSolverBase::AsyncDt:-1.000000
[2022.08.18-05.13.13:451][  0]LogAudio: Display: Audio Device (ID: 1) registered with world 'Untitled'.
[2022.08.18-05.13.13:452][  0]LogSlate: Updating window title bar state: overlay mode, drag disabled, window buttons hidden, title bar hidden
[2022.08.18-05.13.13:454][  0]LogInit: Display: Game Engine Initialized.
[2022.08.18-05.13.13:454][  0]LogCUDA: Display: Initialising CUDA API...
[2022.08.18-05.13.13:463][  0]LogCUDA: Display: CUDA API initialised successfully.
[2022.08.18-05.13.13:463][  0]LogCUDA: Display: Found 1 CUDA capable devices.
[2022.08.18-05.13.13:463][  0]LogCUDA: Display: Found device 0 called "NVIDIA GeForce RTX 3060".
[2022.08.18-05.13.13:464][  0]LogCUDA: Display: Attempting to create CUDA context on GPU Device 0...
[2022.08.18-05.13.13:538][  0]LogCUDA: Display: Created CUDA context on device "NVIDIA GeForce RTX 3060".
[2022.08.18-05.13.13:555][  0]LogEncoderNVENC: Created D3D11 device for NVENC on 'NVIDIA GeForce RTX 3060'.
[2022.08.18-05.13.13:562][  0]LogStreaming: Warning: Failed to read file '../../../Engine/Plugins/Runtime/SunPosition/Resources/SunPosition.png' error.
[2022.08.18-05.13.13:562][  0]LogSlate: Could not find file for Slate resource: ../../../Engine/Plugins/Runtime/SunPosition/Resources/SunPosition.png
[2022.08.18-05.13.13:562][  0]LogInit: Display: Starting Game.
[2022.08.18-05.13.13:562][  0]LogNet: Browse: /Game/TestGame/Maps/NOC?Name=Player
[2022.08.18-05.13.13:562][  0]LogLoad: LoadMap: /Game/TestGame/Maps/NOC?Name=Player
[2022.08.18-05.13.13:563][  0]LogWorld: BeginTearingDown for /Temp/Untitled_0
[2022.08.18-05.13.13:563][  0]LogWorld: UWorld::CleanupWorld for Untitled, bSessionEnded=true, bCleanupResources=true
[2022.08.18-05.13.13:563][  0]LogSlate: InvalidateAllWidgets triggered.  All widgets were invalidated
[2022.08.18-05.13.13:565][  0]LogAudio: Display: Audio Device unregistered from world 'None'.
[2022.08.18-05.13.13:566][  0]LogUObjectHash: Compacting FUObjectHashTables data took   0.32ms
[2022.08.18-05.13.13:647][  0]LogAudio: Display: Audio Device (ID: 1) registered with world 'NOC'.
[2022.08.18-05.13.13:648][  0]LogChaos: FPhysicsSolverBase::AsyncDt:-1.000000
[2022.08.18-05.13.13:648][  0]LogAIModule: Creating AISystem for world NOC
[2022.08.18-05.13.13:649][  0]LogLoad: Game class is 'BP_CollaborativeViewer_GameMode_C'
[2022.08.18-05.13.13:650][  0]LogWorld: Bringing World /Game/TestGame/Maps/NOC.NOC up for play (max tick rate 0) at 2022.08.17-22.13.13
[2022.08.18-05.13.13:650][  0]LogWorld: Bringing up level for play took: 0.000706
[2022.08.18-05.13.13:651][  0]LogGameMode: Display: Match State Changed from EnteringMap to WaitingToStart
[2022.08.18-05.13.13:651][  0]LogGameState: Match State Changed from EnteringMap to WaitingToStart
[2022.08.18-05.13.13:652][  0]LogGameMode: Display: Match State Changed from WaitingToStart to InProgress
[2022.08.18-05.13.13:671][  0]LogSlate: New Slate User Created.  User Index 8, Is Virtual User: 1
[2022.08.18-05.13.13:671][  0]LogSlate: Slate User Registered.  User Index 8, Is Virtual User: 1
[2022.08.18-05.13.13:675][  0]LogGameState: Match State Changed from WaitingToStart to InProgress
[2022.08.18-05.13.13:675][  0]LogLoad: Took 0.112609 seconds to LoadMap(/Game/TestGame/Maps/NOC)
[2022.08.18-05.13.13:676][  0]LogSlate: Took 0.000262 seconds to synchronously load lazily loaded font '../../../Engine/Content/EngineFonts/Faces/RobotoBold.ufont' (160K)
[2022.08.18-05.13.13:677][  0]LogSlate: Took 0.000186 seconds to synchronously load lazily loaded font '../../../Engine/Content/EngineFonts/Faces/RobotoLight.ufont' (167K)
[2022.08.18-05.13.13:677][  0]LogSlate: Took 0.000220 seconds to synchronously load lazily loaded font '../../../Engine/Content/EngineFonts/Faces/RobotoRegular.ufont' (155K)
[2022.08.18-05.13.13:677][  0]LogViewport: Scene viewport resized to 1920x1200, mode WindowedFullscreen.
[2022.08.18-05.13.13:677][  0]LogStreaming: Display: Suspending async loading (1)
[2022.08.18-05.13.13:684][  0]LogStreaming: Display: Resuming async loading (0)
[2022.08.18-05.13.13:743][  0]LogSlate: Took 0.000319 seconds to synchronously load lazily loaded font '../../../Engine/Content/Slate/Fonts/Roboto-Regular.ttf' (155K)
[2022.08.18-05.13.13:784][  0]LogRHI: Display: ShaderPipelineCache: Paused Batching. 1
[2022.08.18-05.13.13:784][  0]LogPixelStreaming: PixelStreaming is disabled, provide `PixelStreamingIP` and `PixelStreamingPort` cmd-args to enable it
[2022.08.18-05.13.13:785][  0]LogPakFile: AllPaks IndexSizes: DirectoryHashSize=9598964, PathHashSize=16, EntriesSize=1142784, TotalSize=10741764
[2022.08.18-05.13.13:785][  0]LogRHI: Display: ShaderPipelineCache: Resumed Batching. 0
[2022.08.18-05.13.13:785][  0]LogRHI: Display: ShaderPipelineCache: Batching Resumed.
[2022.08.18-05.13.13:786][  0]LogInit: Display: Engine is initialized. Leaving FEngineLoop::Init()
[2022.08.18-05.13.13:786][  0]LogLoad: (Engine Initialization) Total time: 2.90 seconds
[2022.08.18-05.13.13:787][  0]LogHMD: HolographicRemotingPlugin::SetRemotingStatusText: Connected
[2022.08.18-05.13.13:788][  0]LogHMD: HolographicRemotingPlugin::SetRemotingStatusText: Disconnected: XR_REMOTING_DISCONNECT_REASON_DISCONNECT_REQUEST_MSFT (19)
[2022.08.18-05.13.13:788][  0]LogContentStreaming: Texture pool size now 1000 MB
[2022.08.18-05.13.13:798][  0]LogSlate: InvalidateAllWidgets triggered.  All widgets were invalidated
[2022.08.18-05.13.13:810][  0]LogSlate: Slate font cache was flushed
[2022.08.18-05.13.13:824][  1]LogSlate: Took 0.000209 seconds to synchronously load lazily loaded font '../../../Engine/Content/Slate/Fonts/Roboto-Regular.ttf' (155K)
[2022.08.18-05.13.13:825][  1]LogSlate: Took 0.000197 seconds to synchronously load lazily loaded font '../../../Engine/Content/EngineFonts/Faces/RobotoBold.ufont' (160K)
[2022.08.18-05.13.13:825][  2]LogEOS: [LogEOS] Updating Platform SDK Config, Time: 2.539560
[2022.08.18-05.13.13:888][ 28]LogSlate: Took 0.000197 seconds to synchronously load lazily loaded font '../../../Engine/Content/EngineFonts/Faces/RobotoRegular.ufont' (155K)
[2022.08.18-05.13.13:890][ 28]LogViewport: Display: Viewport MouseLockMode Changed, LockOnCapture -> DoNotLock
[2022.08.18-05.13.13:890][ 28]LogViewport: Display: Viewport MouseCaptureMode Changed, CapturePermanently_IncludingInitialMouseDown -> CaptureDuringMouseDown
[2022.08.18-05.13.14:259][269]LogEOS: [LogEOS] SDK Config Platform Update Request Successful, Time: 2.956574
[2022.08.18-05.13.14:261][269]LogEOS: Verbose: [LogEOSEcom] Purchase flow is disabled due to flags passed to EOS_Platform_Create
[2022.08.18-05.13.14:261][269]LogEOS: Verbose: [LogEOSP2P] Using Port Range 7777-7876 for P2P traffic
[2022.08.18-05.13.14:261][269]LogEOS: Verbose: [LogEOSP2P] UpdateConfiguration RtcCertificateMaxLifetimeMilliseconds not specified, using default value 10800000
[2022.08.18-05.13.14:262][269]LogEOS: [LogEOS] Updating Product SDK Config, Time: 2.973838
[2022.08.18-05.13.14:459][401]LogEOS: Verbose: [LogEOSConnect] ConnectClientAuthTask Success
[2022.08.18-05.13.14:476][414]LogEOS: [LogEOSAnalytics] Start Session (User: ...)
[2022.08.18-05.13.14:622][511]LogEOS: [LogEOS] SDK Config Product Update Request Successful, Time: 3.319283
[2022.08.18-05.13.14:623][511]LogEOS: Verbose: [LogEOSEcom] Purchase flow is disabled due to flags passed to EOS_Platform_Create
[2022.08.18-05.13.14:623][511]LogEOS: Verbose: [LogEOSP2P] Using Port Range 7777-7876 for P2P traffic
[2022.08.18-05.13.14:623][511]LogEOS: Verbose: [LogEOSP2P] UpdateConfiguration RtcCertificateMaxLifetimeMilliseconds not specified, using default value 10800000
[2022.08.18-05.13.14:625][511]LogEOS: [LogEOS] SDK Config Data - Watermark: 1963445314
[2022.08.18-05.13.14:625][511]LogEOS: [LogEOS] ScheduleNextSDKConfigDataUpdate - Time: 3.319283, Update Interval: 321.065094
[2022.08.18-05.13.15:875][383]LogHttp: Warning: 0000029CDA8F6050: invalid HTTP response code received. URL: http://localhost:1337/alpha/player/connect, HTTP code: 0, content length: 0, actual payload size: 0
[2022.08.18-05.13.15:877][383]LogHttp: Warning: 0000029CDA8F6050: request failed, libcurl error: 7 (Couldn't connect to server)
[2022.08.18-05.13.15:878][383]LogHttp: Warning: 0000029CDA8F6050: libcurl info message cache 0 (  Trying ::1...)
[2022.08.18-05.13.15:878][383]LogHttp: Warning: 0000029CDA8F6050: libcurl info message cache 1 (TCP_NODELAY set)
[2022.08.18-05.13.15:878][383]LogHttp: Warning: 0000029CDA8F6050: libcurl info message cache 2 (  Trying 127.0.0.1...)
[2022.08.18-05.13.15:879][383]LogHttp: Warning: 0000029CDA8F6050: libcurl info message cache 3 (TCP_NODELAY set)
[2022.08.18-05.13.15:879][383]LogHttp: Warning: 0000029CDA8F6050: libcurl info message cache 4 (connect to ::1 port 1337 failed: Connection refused)
[2022.08.18-05.13.15:879][383]LogHttp: Warning: 0000029CDA8F6050: libcurl info message cache 5 (connect to 127.0.0.1 port 1337 failed: Connection refused)
[2022.08.18-05.13.15:879][383]LogHttp: Warning: 0000029CDA8F6050: libcurl info message cache 6 (Failed to connect to localhost port 1337: Connection refused)
[2022.08.18-05.13.15:880][383]LogHttp: Warning: 0000029CDA8F6050: libcurl info message cache 7 (Closing connection 0)
[2022.08.18-05.13.16:286][663]LogBlueprintUserMessages: [BP_Collab_V_PlayerController_C_2147482494] Remoting Xr System
[2022.08.18-05.13.16:289][663]LogAOA: Warning: Current OpenXR runtime does not support Azure Object Anchors.  Requires XR_MSFT_SPATIAL_GRAPH_BRIDGE version 2.
[2022.08.18-05.13.16:332][663]LogHMD: SetSpectatorScreenMode(5).
[2022.08.18-05.13.16:334][663]LogStreaming: Display: Suspending async loading (1)
[2022.08.18-05.13.16:340][663]LogStreaming: Display: Resuming async loading (0)
[2022.08.18-05.13.16:342][664]LogHMD: Error: Failed to create all visibility mask meshes for device/views. Abandoning visibility mask.
[2022.08.18-05.13.16:342][664]LogRenderer: Warning: Resizing VR buffer to 2880 by 936
[2022.08.18-05.13.16:363][664]LogProfilingDebugging: Allocated a 1024 x 1024 texture for HMD canvas layer
[2022.08.18-05.13.16:364][664]LogHMD: FOpenXRHMD is requesting app exit.  CurrentSessionState: XR_SESSION_STATE_LOSS_PENDING
[2022.08.18-05.13.16:364][664]LogWindows: FPlatformMisc::RequestExit(0)
[2022.08.18-05.13.16:365][664]LogWindows: FPlatformMisc::RequestExitWithStatus(0, 0)
[2022.08.18-05.13.16:365][664]LogCore: Engine exit requested (reason: Win RequestExit)
[2022.08.18-05.13.16:366][664]LogStreaming: Display: Suspending async loading (1)
[2022.08.18-05.13.16:376][664]LogStreaming: Display: Resuming async loading (0)
[2022.08.18-05.13.16:388][665]LogCore: Engine exit requested (reason: EngineExit() was called; note: exit was already requested)
[2022.08.18-05.13.16:388][665]LogInit: Display: PreExit Game.
[2022.08.18-05.13.16:390][665]LogWorld: BeginTearingDown for /Game/TestGame/Maps/NOC
[2022.08.18-05.13.16:391][665]LogWorld: UWorld::CleanupWorld for NOC, bSessionEnded=true, bCleanupResources=true
[2022.08.18-05.13.16:391][665]LogSlate: InvalidateAllWidgets triggered.  All widgets were invalidated
[2022.08.18-05.13.17:393][665]LogAudio: Display: Beginning Audio Device Manager Shutdown (Module: AudioMixerXAudio2)...
[2022.08.18-05.13.17:393][665]LogAudio: Display: Destroying 1 Remaining Audio Device(s)...
[2022.08.18-05.13.17:393][665]LogAudio: Display: Audio Device unregistered from world 'NOC'.
[2022.08.18-05.13.17:394][665]LogAudioMixer: FMixerPlatformXAudio2::StopAudioStream() called. InstanceID=1
[2022.08.18-05.13.17:395][665]LogAudioMixer: FMixerPlatformXAudio2::StopAudioStream() called. InstanceID=1
[2022.08.18-05.13.17:398][665]LogAudio: Display: Audio Device Manager Shutdown
[2022.08.18-05.13.17:398][665]LogSlate: Request Window 'TestMain (64-bit Development PCD3D_SM5) ' being destroyed
[2022.08.18-05.13.17:398][665]LogStreaming: Display: Suspending async loading (1)
[2022.08.18-05.13.17:413][665]LogStreaming: Display: Resuming async loading (0)
[2022.08.18-05.13.17:415][665]LogSlate: Window 'TestMain (64-bit Development PCD3D_SM5) ' being destroyed
[2022.08.18-05.13.17:422][665]LogExit: Preparing to exit.
[2022.08.18-05.13.17:422][665]LogMoviePlayer: Shutting down movie player
[2022.08.18-05.13.17:423][665]LogEOS: [LogEOSFriends] Successfully closed a listener.
[2022.08.18-05.13.17:424][665]LogEOS: [LogEOSRTC] LibRTCCore: Shutting down LibRTC...
[2022.08.18-05.13.17:430][665]LogSlate: Updating window title bar state: overlay mode, drag disabled, window buttons hidden, title bar hidden
[2022.08.18-05.13.17:440][665]LogDemo: Cleaned up 0 splitscreen connections with owner deletion
[2022.08.18-05.13.17:441][665]LogTemp: Error: Attempted to release non-existent voice chat user!
[2022.08.18-05.13.17:443][665]LogExit: Game engine shut down
[2022.08.18-05.13.17:444][665]LogTemp: Error: Attempted to release non-existent voice chat user!
[2022.08.18-05.13.17:494][665]LogExit: Object subsystem successfully closed.
@gvindiol gvindiol mentioned this issue Sep 15, 2022
Closed
@fieldsJacksonG
Copy link
Contributor

I can repro this and am investigating

@fieldsJacksonG
Copy link
Contributor

fieldsJacksonG commented Sep 27, 2022 •
edited

I am still investigating, but you can try this to unblock yourself for now:
Change this line:

Microsoft-OpenXR-Unreal/MsftOpenXRGame/Plugins/MicrosoftOpenXR/Source/NuGetModule/packages.config

Line 6 in 8e3763b

<package id="Microsoft.Holographic.Remoting.OpenXr" version="2.8.0" targetFramework="native" />

To this:
<package id="Microsoft.Holographic.Remoting.OpenXr" version="2.8.1" targetFramework="native" />

Then delete the Plugins/MicrosoftOpenXR/Intermediate and Plugins/MicrosoftOpenXR/Binaries directories, regenerate your project's Visual Studio project files, and build your project again.

The remoting runtime and player should be backwards compatible, but the older version seems to be causing some of this issue. I am still investigating because I do occasionally still see this when using 2.8.1, and this should work with 2.8.0.

You may also be hitting this issue, which has some workarounds:
#84

@fieldsJacksonG
Copy link
Contributor

This has unfortunately stopped reproing for me for now, but here are some more things to check on your end:

  1. Is your firewall blocking the packaged exe, or any exe with the same name? You should have seen (and allowed) a firewall popup when you launch the application the first time.
  2. This could be an issue with the h265 license verification. You can try running your exe with "-RemotingCodec=h264" to force using h264 instead.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@fieldsJacksonG @gvindiol