Arcade is working great locally, but doesn’t work remote. If I’m on my local network I can start games. If I switch to LTE I get “Error: An unknown error occurred.” Plex is working fine remote - I can stream music, moves, etc. Only Arcade doesn’t work remote. And, like I said, Arcade is working fine local.
Config:
- i7 10700
- Windows 10 21H1
- PMS 1.24.1.4931
- Plex Game Transcoder allowed through Windows firewall
- Plex Arcade working fine locally
- Client is Android
- Remote access for the server is enabled and working for everything but Arcade
EDIT: Removed server logs because I’m sure the problem is with the Android app and I hit the char limit for this post
EDIT:
The problem seems to be with the Android app. Looking at the logs from the app it appears that it is attempting a direct connection even though it isn’t on the same network:
08-27 09:03:58.286 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/:/timeline?bufferedTime=0&guid=plex%3A%2F%2Fgame%2F5fbe6917dcef38a0f8554077&key=%2Flibrary%2Fmetadata%2F56565&playbackTime=91&playQueueItemID=81818&ratingKey=56565&state=playing&time=91&token=...5kM6&X-Plex-Client-Identifier=c93287dc5fe56af1-com-plexapp-android&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:03:58.325 e: [PlexServerWebSocket] (ID: 23892173 | Server: PLEXBOX) Connection failed.
08-27 09:03:58.326 e: An exception occurred: java.net.SocketTimeoutException: failed to connect to /10.0.0.34 (port 32400) from /10.141.179.158 (port 39548) after 5000ms
08-27 09:03:58.326 e: Stacktrace: java.net.SocketTimeoutException: failed to connect to /10.0.0.34 (port 32400) from /10.141.179.158 (port 39548) after 5000ms
at libcore.io.IoBridge.connectErrno(IoBridge.java:191)
at libcore.io.IoBridge.connect(IoBridge.java:135)
at java.net.PlainSocketImpl.socketConnect(PlainSocketImpl.java:142)
at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:390)
at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:230)
at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:212)
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:436)
at java.net.Socket.connect(Socket.java:621)
at okhttp3.internal.platform.Platform.connectSocket(SourceFile:1)
I’m not sure why that would be. I can remote play other media no problem. I think there might be a bug in the Arcade module such that it always attempts a direct connect even when remote.
EDIT:
More testing and I think I see what’s going on, but if I’m right it is a bug and there’s nothing I can do. When I launch a game remote it tries to connect to the server’s local IP and fails. If I hit retry when the “Unknown Error” pops up it connects remotely and I can see the session established on my server dashboard and the ROM and game transcoder and streaming working. However, it shows 0bps as the connection speed and there’s no video or audio on my phone. I think what’s happening is that at the start of the Arcade session it attempts to connect to get an idea of available bandwidth; this fails and it is gets set to 0bps. Retry forces a reconnect and it works but the bandwidth value is never updated so a session is establish but no data is allowed to pass between the client and server. I think something in that ballpark is happening. Unfortunately mobile apps being black-boxes I can’t do anything further, which likely means this is just broken for now. I can try to reboot my phone and delete and reinstall the plex app, but other than that I don’t think there’s anything an end user can do here.
EDIT:
One more try. Rebooted phone, deleted plex and reinstalled it while on LTE - never connected to WIFI so the app never played anything locally. Tried to play a game. It doesn’t show the connection error or the direct play attempt so that may be a red herring. However, it still fails.
08-27 09:23:51.704 i: [UserAction] Click item Airwolf (/library/metadata/56582).
08-27 09:23:51.766 i: Creating PreplayActivity.
08-27 09:23:51.768 i: [Boot] PreplayActivity took 1ms to run create behaviours.
08-27 09:23:51.789 i: Resuming PreplayActivity.
08-27 09:23:51.877 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/library/metadata/56582?checkFiles=1&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:23:51.967 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/hubs/metadata/56582/related?count=10&excludeElements=Actor%2CCollection%2CCountry%2CDirector%2CGenre%2CLabel%2CMood%2CPart%2CProducer%2CRole%2CSimilar%2CWriter%2CPhoto%2CVast%2CTopic&excludeFields=summary%2Ctagline%2Cfile&includeAugmentations=1&includeEmpty=1&includeExternalMetadata=1&includeLibraryPlaylists=1&includeMeta=1&includeRecentChannels=1&includeStations=1&includeTrailers=1&includeTypeFirst=1&libraryHubsOnly=1&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:23:53.006 i: [OneApp] User can execute command without restrictions because they are entitled.
08-27 09:23:53.010 i: [PlayQueues] Creating delayed remote PQ.
08-27 09:23:53.040 i: [PlayerService] onCreate
08-27 09:23:53.040 i: [Player] Changing to use GameEngine for playback.
08-27 09:23:53.048 i: [MemoryOptimisationBehaviour] Reducing memory cache.
08-27 09:23:53.049 i: [InteractionBehaviour] Slept, reason: Startup.
08-27 09:23:53.049 i: [CurrentItemMetadataBehaviour] Fetching current item
08-27 09:23:53.050 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/library/metadata/56582?includeChapters=1&includeLoudnessRamps=1&includeMarkers=1&includeRelated=1&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:23:53.050 i: [GameButtonMapper] Loaded Nintendo Entertainment System platform for button mappings.
08-27 09:23:53.050 i: [Player][GameEngine] Opening Game...
08-27 09:23:53.052 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/game/:/transcode/start?offset=0.000&path=%2Flibrary%2Fmetadata%2F56582&session=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Identifier=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Platform=Android&X-Plex-Device=Surface%20Duo&X-Plex-Platform=Android&X-Plex-Platform-Version=10&X-Plex-Product=Plex%20for%20Android%20(Mobile)&X-Plex-Version=8.21.2.27212&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:23:53.096 i: Creating PlayerActivity.
08-27 09:23:53.097 i: [Activity] Resuming the application, attempting to download item and children.
08-27 09:23:53.101 i: [Boot] PlayerActivity took 5ms to run create behaviours.
08-27 09:23:53.111 i: Resuming PlayerActivity.
08-27 09:23:53.111 i: [PlayerActivity] Creating fragment
08-27 09:23:53.113 i: [Player][DimensionsLayout] Resizing: 100 x 100
08-27 09:23:53.115 i: [PictureInPictureBehaviour] Picture-in-picture is available and can be used.
08-27 09:23:53.135 i: [CurrentItemMetadataBehaviour] Fetched current item, success: true
08-27 09:23:53.167 i: [InteractionBehaviour] Woke up, reason: Interaction override added.
08-27 09:23:53.199 i: [Player][View] Layout has been measured with a size of 1350 x 1700 (1350 x 1700).
08-27 09:23:53.207 i: [GameSurface] Surface Changed, updating (width: 1350, height: 1700)
08-27 09:23:53.225 i: [SystemUIBehaviour] Hiding the system user-interface.
08-27 09:23:53.225 i: [SystemUIBehaviour] Showing the system user-interface.
08-27 09:23:53.289 i: [Player][View] Layout has been measured with a size of 1350 x 1800 (1350 x 1800).
08-27 09:23:53.290 i: [GameSurface] Surface Changed, updating (width: 1350, height: 1800)
08-27 09:23:54.612 i: [Player][GameEngine] Requested game to start, success: true
08-27 09:23:54.613 i: [Player][GameEngine] Connecting client (SessionID: 4d998eaf5b031e49399be51d871f66e83b24fc86d61de5884b6e51cd2c352370, PeerID: 1xI4ooOAfBNX5CfzglOQnR1fBVM)
08-27 09:23:54.615 i: [Player][GameEngine] Connection successful.
08-27 09:23:54.616 i: [GameSurface] Updating Dimensions (1350x1800)
08-27 09:23:54.616 i: [GameSurface] Failed to set dimensions: Unknown
08-27 09:23:54.617 i: [EngineEventManager] onPlaybackStarted: Delay-553215862
08-27 09:23:54.619 i: [EngineEventManager] onPlaybackStarted: Delay-553215862
08-27 09:23:54.620 i: [Player][Timeline] Playback started (or buffering), scheduling updates
08-27 09:23:54.628 i: [PlaybackTimeBehaviour] Initialising
08-27 09:23:54.628 i: [PlaybackTimeBehaviour] Starting stopwatch
08-27 09:23:54.628 i: [VideoAwakeBehaviour] Keep screen awake has been requested enabled for VideoAwakeBehaviour.
08-27 09:23:54.628 i: [VideoAwakeBehaviour] Keeping screen on
08-27 09:23:54.628 i: [TranscodeSession] Media choice updated
08-27 09:23:54.628 i: [DelayedPlayQueueBehaviour] Resolving Play Queue...
08-27 09:23:54.628 i: [DelayedRemotePlayQueue] Resolving delayed Play Queue...
08-27 09:23:54.628 i: [PlayQueueAPIHelperBase] No item path provided, will generate a new one
08-27 09:23:54.629 i: [PlaybackTimeBehaviour] Resuming stopwatch
08-27 09:23:54.629 i: [VideoAwakeBehaviour] Keep screen awake has been requested enabled for VideoAwakeBehaviour.
08-27 09:23:54.629 i: [TranscodeSession] Media choice updated
08-27 09:23:54.629 i: [WiFiLockBehaviour] Aquiring WiFi lock since playback was started.
08-27 09:23:54.629 i: Fetching [method:POST] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/playQueues?includeChapters=1&continuous=0&includeLoudnessRamps=1&repeat=0&type=game&shuffle=0&uri=server%3A%2F%2Fa2d2f57b19a0c11a823fb6d1ac39ae3eb6f79615%2Fcom.plexapp.plugins.library%2Flibrary%2Fmetadata%2F56582&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:23:54.629 i: [PictureInPictureBehaviour] Picture-in-picture is available and can be used.
08-27 09:23:54.629 i: [DelayedPlayQueueBehaviour] Resolving Play Queue...
08-27 09:23:54.629 i: [DelayedRemotePlayQueue] Resolving delayed Play Queue...
08-27 09:23:54.629 i: [PlayQueueAPIHelperBase] No item path provided, will generate a new one
08-27 09:23:54.630 i: Fetching [method:POST] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/playQueues?includeChapters=1&continuous=0&includeLoudnessRamps=1&repeat=0&type=game&shuffle=0&uri=server%3A%2F%2Fa2d2f57b19a0c11a823fb6d1ac39ae3eb6f79615%2Fcom.plexapp.plugins.library%2Flibrary%2Fmetadata%2F56582&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:23:54.630 i: [WiFiLockBehaviour] Aquiring WiFi lock since playback was started.
08-27 09:23:54.630 i: [Player] onPlaybackStarted
08-27 09:23:54.630 i: [PictureInPictureBehaviour] Picture-in-picture is available and can be used.
08-27 09:23:54.634 i: [Player] onPlaybackStarted
08-27 09:23:54.634 i: [Player][GameEngine] Encode: -518243368438751400000000.000000ms, Decode: 0.000000ms, Network: 0.000000ms
08-27 09:23:54.724 i: [PlayQueueAPIHelperBase] Result container=<MediaContainer mediaTagPrefix="/system/bundle/media/flags/" identifier="com.plexapp.plugins.library" playQueueVersion="1" playQueueID="1750" size="1" playQueueSourceURI="library://x/item/%2Flibrary%2Fmetadata%2F56582" playQueueShuffled="0" playQueueSelectedItemID="81824" playQueueSelectedMetadataItemID="56582" playQueueTotalCount="1" mediaTagVersion="1628744018" playQueueSelectedItemOffset="0" />
08-27 09:23:54.725 w: [RemotePlayQueue] Couldn't find item with PQ ID=null in current window.
08-27 09:23:54.725 w: [RemotePlayQueue] Couldn't find item with PQ ID=null in current window.
08-27 09:23:54.725 i: [DelayedPlayQueueBehaviour] New Play Queue: 1750
08-27 09:23:54.727 w: [Player][Timeline] player position was negative. Position time will be reported as 0.
08-27 09:23:54.728 i: [PlaybackTimeBehaviour] Time: 104 IsStarted: true
08-27 09:23:54.730 i: [PlayQueueAPIHelperBase] Result container=<MediaContainer mediaTagPrefix="/system/bundle/media/flags/" identifier="com.plexapp.plugins.library" playQueueVersion="1" playQueueID="1751" size="1" playQueueSourceURI="library://x/item/%2Flibrary%2Fmetadata%2F56582" playQueueShuffled="0" playQueueSelectedItemID="81825" playQueueSelectedMetadataItemID="56582" playQueueTotalCount="1" mediaTagVersion="1628744018" playQueueSelectedItemOffset="0" />
08-27 09:23:54.730 w: [RemotePlayQueue] Couldn't find item with PQ ID=null in current window.
08-27 09:23:54.731 w: [RemotePlayQueue] Couldn't find item with PQ ID=null in current window.
08-27 09:23:54.731 i: [DelayedPlayQueueBehaviour] New Play Queue: 1751
08-27 09:23:54.732 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/:/timeline?bufferedTime=0&guid=plex%3A%2F%2Fgame%2F5fbe6917dcef38a0f8555dd4&key=%2Flibrary%2Fmetadata%2F56582&playbackTime=104&playQueueItemID=81824&ratingKey=56582&state=playing&time=104&token=...5kM6&X-Plex-Client-Identifier=c93287dc5fe56af1-com-plexapp-android&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:23:55.633 e: [Player][GameEngine] Parsec has been disconnected.
08-27 09:23:55.634 i: [Player] Error reported: GamingClientError (null)
08-27 09:23:55.635 i: [Player][Timeline] Playback stopped (error: false)
08-27 09:23:55.635 w: [Player][Timeline] player position was negative. Position time will be reported as 0.
08-27 09:23:55.635 i: [PlaybackTimeBehaviour] Time: 1011 IsStarted: true
08-27 09:23:55.639 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/:/timeline?bufferedTime=0&guid=plex%3A%2F%2Fgame%2F5fbe6917dcef38a0f8555dd4&key=%2Flibrary%2Fmetadata%2F56582&playbackTime=1011&playQueueItemID=81825&ratingKey=56582&state=stopped&time=1011&token=...5kM6&X-Plex-Client-Identifier=c93287dc5fe56af1-com-plexapp-android&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:23:55.644 i: [TranscodeSession] Stopping...
08-27 09:23:55.644 i: [Player][Error] Displaying player error...
08-27 09:23:55.645 i: [DialogBehaviour] Showing dialog.
08-27 09:23:55.645 i: [TranscodeSession] Notifying server that we've stopped
08-27 09:23:55.650 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/game/:/transcode/universal/stop?path=%2Flibrary%2Fmetadata%2F56582&session=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Identifier=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Platform=Android&X-Plex-Device=Surface%20Duo&X-Plex-Platform=Android&X-Plex-Platform-Version=10&X-Plex-Product=Plex%20for%20Android%20(Mobile)&X-Plex-Version=8.21.2.27212&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:23:55.722 e: Error fetching https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/game/:/transcode/universal/stop?path=%2Flibrary%2Fmetadata%2F56582&session=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Identifier=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Platform=Android&X-Plex-Device=Surface%20Duo&X-Plex-Platform=Android&X-Plex-Platform-Version=10&X-Plex-Product=Plex%20for%20Android%20(Mobile)&X-Plex-Version=8.21.2.27212&X-Plex-Token=...tml>
08-27 09:24:00.791 i: [EngineEventManager] onPlaybackStopped: Closed
08-27 09:24:00.792 i: [Player][Timeline] Playback stopped (error: false)
08-27 09:24:00.792 w: [Player][Timeline] player position was negative. Position time will be reported as 0.
08-27 09:24:00.793 i: [PlaybackTimeBehaviour] Time: 6169 IsStarted: true
08-27 09:24:00.793 i: [PlaybackTimeBehaviour] Time: 6169 IsStarted: true
08-27 09:24:00.795 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/:/timeline?bufferedTime=0&guid=plex%3A%2F%2Fgame%2F5fbe6917dcef38a0f8555dd4&key=%2Flibrary%2Fmetadata%2F56582&playbackTime=6169&playQueueItemID=81825&ratingKey=56582&state=stopped&time=6169&token=...5kM6&X-Plex-Client-Identifier=c93287dc5fe56af1-com-plexapp-android&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:24:00.807 i: [PlaybackTimeBehaviour] Playback stopped, pausing stopwatch
08-27 09:24:00.807 i: [VideoAwakeBehaviour] Keep screen awake has been requested disabled for VideoAwakeBehaviour.
08-27 09:24:00.807 i: [VideoAwakeBehaviour] Disabling screen on
08-27 09:24:00.808 i: [TranscodeSession] Stopping...
08-27 09:24:00.808 i: [SleepTimerBehaviour] Sleep timer behaviour changed.
08-27 09:24:00.808 i: [WiFiLockBehaviour] Releasing WiFi lock since playback was stopped.
08-27 09:24:00.808 i: [TranscodeSession] Notifying server that we've stopped
08-27 09:24:00.808 i: [Player][GameEngine] Disconnecting...
08-27 09:24:00.808 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/game/:/transcode/universal/stop?path=%2Flibrary%2Fmetadata%2F56582&session=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Identifier=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Platform=Android&X-Plex-Device=Surface%20Duo&X-Plex-Platform=Android&X-Plex-Platform-Version=10&X-Plex-Product=Plex%20for%20Android%20(Mobile)&X-Plex-Version=8.21.2.27212&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:24:00.828 i: [PreplayViewModel] Refreshing metadata for Airwolf
08-27 09:24:00.832 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/library/metadata/56582?checkFiles=1&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:24:00.845 i: [Player][GameEngine] Opening Game...
08-27 09:24:00.846 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/game/:/transcode/start?offset=0.000&path=%2Flibrary%2Fmetadata%2F56582&session=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Identifier=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Platform=Android&X-Plex-Device=Surface%20Duo&X-Plex-Platform=Android&X-Plex-Platform-Version=10&X-Plex-Product=Plex%20for%20Android%20(Mobile)&X-Plex-Version=8.21.2.27212&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:24:00.856 i: [GameSurface] Surface Destroyed
08-27 09:24:00.857 i: [Player][DimensionsLayout] Resizing: 1350 x 759
08-27 09:24:00.874 e: Error fetching https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/game/:/transcode/universal/stop?path=%2Flibrary%2Fmetadata%2F56582&session=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Identifier=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Platform=Android&X-Plex-Device=Surface%20Duo&X-Plex-Platform=Android&X-Plex-Platform-Version=10&X-Plex-Product=Plex%20for%20Android%20(Mobile)&X-Plex-Version=8.21.2.27212&X-Plex-Token=...tml>
08-27 09:24:00.914 i: [GameSurface] Surface Changed, updating (width: 1350, height: 759)
08-27 09:24:01.120 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/hubs/metadata/56582/related?count=10&excludeElements=Actor%2CCollection%2CCountry%2CDirector%2CGenre%2CLabel%2CMood%2CPart%2CProducer%2CRole%2CSimilar%2CWriter%2CPhoto%2CVast%2CTopic&excludeFields=summary%2Ctagline%2Cfile&includeAugmentations=1&includeEmpty=1&includeExternalMetadata=1&includeLibraryPlaylists=1&includeMeta=1&includeRecentChannels=1&includeStations=1&includeTrailers=1&includeTypeFirst=1&libraryHubsOnly=1&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:24:01.659 i: [Player][GameEngine] Requested game to start, success: true
08-27 09:24:01.660 i: [Player][GameEngine] Connecting client (SessionID: 4d998eaf5b031e49399be51d871f66e83b24fc86d61de5884b6e51cd2c352370, PeerID: 1xI4ooOAfBNX5CfzglOQnR1fBVM)
08-27 09:24:01.663 i: [Player][GameEngine] Connection successful.
08-27 09:24:01.664 i: [GameSurface] Updating Dimensions (1350x759)
08-27 09:24:01.664 i: [GameSurface] Failed to set dimensions: Unknown
08-27 09:24:01.664 i: [EngineEventManager] onPlaybackStarted: Delay-553215862
08-27 09:24:01.665 i: [Player][Timeline] Playback started (or buffering), scheduling updates
08-27 09:24:01.665 i: [EngineEventManager] onPlaybackStarted: Delay-553215862
08-27 09:24:01.665 w: [Player][Timeline] player position was negative. Position time will be reported as 0.
08-27 09:24:01.665 i: [PlaybackTimeBehaviour] Time: 6184 IsStarted: false
08-27 09:24:01.666 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/:/timeline?bufferedTime=0&guid=plex%3A%2F%2Fgame%2F5fbe6917dcef38a0f8555dd4&key=%2Flibrary%2Fmetadata%2F56582&playbackTime=6184&playQueueItemID=81825&ratingKey=56582&state=playing&time=6184&token=...5kM6&X-Plex-Client-Identifier=c93287dc5fe56af1-com-plexapp-android&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:24:01.676 i: [PlaybackTimeBehaviour] Initialising
08-27 09:24:01.681 i: [PlaybackTimeBehaviour] Starting stopwatch
08-27 09:24:01.681 i: [VideoAwakeBehaviour] Keep screen awake has been requested enabled for VideoAwakeBehaviour.
08-27 09:24:01.682 i: [VideoAwakeBehaviour] Keeping screen on
08-27 09:24:01.682 i: [PlaybackTimeBehaviour] Resuming stopwatch
08-27 09:24:01.682 i: [VideoAwakeBehaviour] Keep screen awake has been requested enabled for VideoAwakeBehaviour.
08-27 09:24:01.682 i: [TranscodeSession] Media choice updated
08-27 09:24:01.683 i: [WiFiLockBehaviour] Aquiring WiFi lock since playback was started.
08-27 09:24:01.683 i: [PictureInPictureBehaviour] Picture-in-picture is available and can be used.
08-27 09:24:01.685 i: [TranscodeSession] Media choice updated
08-27 09:24:01.685 i: [Player] onPlaybackStarted
08-27 09:24:01.686 i: [WiFiLockBehaviour] Aquiring WiFi lock since playback was started.
08-27 09:24:01.686 i: [PictureInPictureBehaviour] Picture-in-picture is available and can be used.
08-27 09:24:01.686 i: [Player] onPlaybackStarted
08-27 09:24:01.687 i: [Player][GameEngine] Encode: -518243368438751400000000.000000ms, Decode: 0.000000ms, Network: 0.000000ms
08-27 09:24:02.685 i: [Player][GameEngine] Encode: 0.000000ms, Decode: 0.000000ms, Network: 0.000000ms
08-27 09:24:03.685 i: [Player][GameEngine] Encode: 0.000000ms, Decode: 865630781396121800000000000000.000000ms, Network: 0.000000ms
08-27 09:24:04.686 i: [Player][GameEngine] Encode: 0.000000ms, Decode: 0.000000ms, Network: 0.000000ms
08-27 09:24:05.916 i: [EngineEventManager] onPlaybackStopped: Closed
08-27 09:24:05.916 i: [Player][Timeline] Playback stopped (error: false)
08-27 09:24:05.917 w: [Player][Timeline] player position was negative. Position time will be reported as 0.
08-27 09:24:05.917 i: [PlaybackTimeBehaviour] Time: 4241 IsStarted: true
08-27 09:24:05.917 i: [PlaybackTimeBehaviour] Time: 4241 IsStarted: true
08-27 09:24:05.920 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/:/timeline?bufferedTime=0&guid=plex%3A%2F%2Fgame%2F5fbe6917dcef38a0f8555dd4&key=%2Flibrary%2Fmetadata%2F56582&playbackTime=4241&playQueueItemID=81825&ratingKey=56582&state=stopped&time=4241&token=...5kM6&X-Plex-Client-Identifier=c93287dc5fe56af1-com-plexapp-android&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:24:05.934 i: [PlaybackTimeBehaviour] Playback stopped, pausing stopwatch
08-27 09:24:05.934 i: [VideoAwakeBehaviour] Keep screen awake has been requested disabled for VideoAwakeBehaviour.
08-27 09:24:05.935 i: [VideoAwakeBehaviour] Disabling screen on
08-27 09:24:05.935 i: [TranscodeSession] Stopping...
08-27 09:24:05.935 i: [SleepTimerBehaviour] Sleep timer behaviour changed.
08-27 09:24:05.943 i: [WiFiLockBehaviour] Releasing WiFi lock since playback was stopped.
08-27 09:24:05.944 i: [TranscodeSession] Notifying server that we've stopped
08-27 09:24:05.944 i: [Player][GameEngine] Disconnecting...
08-27 09:24:05.944 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/game/:/transcode/universal/stop?path=%2Flibrary%2Fmetadata%2F56582&session=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Identifier=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Platform=Android&X-Plex-Device=Surface%20Duo&X-Plex-Platform=Android&X-Plex-Platform-Version=10&X-Plex-Product=Plex%20for%20Android%20(Mobile)&X-Plex-Version=8.21.2.27212&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:24:05.948 i: [MemoryOptimisationBehaviour] Expanding memory cache.
08-27 09:24:05.949 i: [VideoAwakeBehaviour] Keep screen awake has been requested disabled for VideoAwakeBehaviour.
08-27 09:24:05.992 i: [PreplayViewModel] Refreshing metadata for Airwolf
08-27 09:24:06.005 e: Error fetching https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/game/:/transcode/universal/stop?path=%2Flibrary%2Fmetadata%2F56582&session=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Identifier=c93287dc5fe56af1-com-plexapp-android&X-Plex-Client-Platform=Android&X-Plex-Device=Surface%20Duo&X-Plex-Platform=Android&X-Plex-Platform-Version=10&X-Plex-Product=Plex%20for%20Android%20(Mobile)&X-Plex-Version=8.21.2.27212&X-Plex-Token=...tml>
08-27 09:24:06.056 i: [PlayerService] onDestroy
08-27 09:24:06.070 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/library/metadata/56582?checkFiles=1&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:24:06.074 i: Resuming PreplayActivity.
08-27 09:24:06.190 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/hubs/metadata/56582/related?count=10&excludeElements=Actor%2CCollection%2CCountry%2CDirector%2CGenre%2CLabel%2CMood%2CPart%2CProducer%2CRole%2CSimilar%2CWriter%2CPhoto%2CVast%2CTopic&excludeFields=summary%2Ctagline%2Cfile&includeAugmentations=1&includeEmpty=1&includeExternalMetadata=1&includeLibraryPlaylists=1&includeMeta=1&includeRecentChannels=1&includeStations=1&includeTrailers=1&includeTypeFirst=1&libraryHubsOnly=1&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:24:06.815 i: [GameSurface] Surface Destroyed
08-27 09:24:07.332 i: [UserAction] Select menu item: Up.
08-27 09:24:07.339 i: [Download Item] Downloading item with uri server://a2d2f57b19a0c11a823fb6d1ac39ae3eb6f79615/com.plexapp.plugins.library/library/sections#10
08-27 09:24:07.341 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/library/sections?X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:24:07.444 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/library/sections/10?includeDetails=1&includeCollections=1&includeAdvanced=1&X-Plex-Token=...5kM6&X-Plex-Language=en-us
08-27 09:24:07.673 i: [device] Setting selected server to PLEXBOX version: 1.24.1.4931-1a38e63c6 owned: true home: false videoTranscode: true audioTranscode: true deletion: true class: null, presence false
08-27 09:24:07.693 i: Resuming UnoHomeActivity.
08-27 09:24:07.710 i: [device] Setting selected server to PLEXBOX version: 1.24.1.4931-1a38e63c6 owned: true home: false videoTranscode: true audioTranscode: true deletion: true class: null, presence false
08-27 09:24:07.724 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/library/sections/10/all?includeCollections=1&includeMeta=1&sort=titleSort&type=19&X-Plex-Token=...5kM6&X-Plex-Container-Start=0&X-Plex-Container-Size=10&X-Plex-Language=en-us
08-27 09:24:08.210 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/library/sections/10/all?includeCollections=1&sort=titleSort&type=19&X-Plex-Token=...5kM6&X-Plex-Container-Start=41&X-Plex-Container-Size=10&X-Plex-Language=en-us
08-27 09:24:08.354 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/library/sections/10/all?includeCollections=1&sort=titleSort&type=19&X-Plex-Token=...5kM6&X-Plex-Container-Start=51&X-Plex-Container-Size=10&X-Plex-Language=en-us
08-27 09:24:08.688 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/library/sections/10/all?includeCollections=1&sort=titleSort&type=19&X-Plex-Token=...5kM6&X-Plex-Container-Start=30&X-Plex-Container-Size=10&X-Plex-Language=en-us
08-27 09:24:08.785 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/library/sections/10/all?includeCollections=1&sort=titleSort&type=19&X-Plex-Token=...5kM6&X-Plex-Container-Start=40&X-Plex-Container-Size=10&X-Plex-Language=en-us
08-27 09:24:08.998 i: [UserAction] Select menu item: Up.
08-27 09:24:09.142 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/library/sections/10/all?includeCollections=1&sort=titleSort&type=19&X-Plex-Token=...5kM6&X-Plex-Container-Start=19&X-Plex-Container-Size=10&X-Plex-Language=en-us
08-27 09:24:09.252 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/library/sections/10/all?includeCollections=1&sort=titleSort&type=19&X-Plex-Token=...5kM6&X-Plex-Container-Start=29&X-Plex-Container-Size=10&X-Plex-Language=en-us
08-27 09:24:09.512 i: Fetching [method:GET] https://99-96-212-151.58765337bf2645e1ad0f7cbde2a84dbf.plex.direct:62317/library/sections/10/all?includeCollections=1&sort=titleSort&type=19&X-Plex-Token=...5kM6&X-Plex-Container-Start=10&X-Plex-Container-Size=10&X-Plex-Language=en-us
08-27 09:24:10.229 i: [UserAction] Drawer header action clicked: (Settings)
