Server Version#: 1.19.1.2621 custom domain (but not in my control), docker on non-standard port.
Player Version#: 7.31.0.16542
As requested by @DaveBinM in a related Android TV thread (An error occurred while attempting to play this video. Please try restarting both the Plex Media Server and this app - #249 by DaveBinM) I’m creating a new thread.
PLEASE LET ME KNOW IF THERE ARE ANY OTHER LOGS OR DETAILS I CAN PROVIDE TO HELP WITH THIS.
Issue: Consistently (but not always) on Android phone/tablet versions over 7.29, when playing media that has been played fine before, I get the error “An error occurred while attempting to play this video. Please try restarting both the Plex Media Server and this app”.
This does not happen 100% of the time, sometimes if swipe away the app, toggle airplane mode, and go back in, sometimes it works. When it works then I can play 2-3 media files and then it all goes kaput again. iOS, web, and an Android device running 6.17 all work fine (except the Android cannot cast to Chromecast for the “Sorry! Something went wrong error” which also doesn’t appear solved either?) This tells me it’s specific to Android 7.2x/7.30/7.31 versions, seeing as there are people also having issues with FireTV and others, looks like it’s all Android having issues with this.
Other threads have suggested:
“Terminate Paused Streams” set to 0
no effect
Adding custom domain details including certificate location and key
cannot be done, and if I may point out was not an issue until recently, and not an issue with other devices/OSes
Using the old player/disabling new player
not an option since I don’t know when but a while…
Disabling AC3 or other audio codecs as needed
tried all versions, no effect
Changing H264 Max level to disabled/something other than default
no effect, tried all versions.
LOGS:
App logs in full attached, interesting to note that there are Java errors in the app indicating the demuxer was having issues.
04-05 01:28:10.041 e: Stacktrace: com.google.android.exoplayer2.r: [Open]com.plexapp.plex.ff.data.FFException: Demuxer failed to open input.
at com.google.android.exoplayer2.v.handleMessage(SourceFile:29)
at android.os.Handler.dispatchMessage(Handler.java:98)
at android.os.Looper.loop(Looper.java:154)
at android.os.HandlerThread.run(HandlerThread.java:61)
Caused by: [Open]com.plexapp.plex.ff.data.FFException: Demuxer failed to open input.
at com.plexapp.plex.ff.FFDemuxer.open(SourceFile:31)
at com.plexapp.plex.ff.source.FFLoadable.load(SourceFile:3)
at com.google.android.exoplayer2.y0.a0$d.run(SourceFile:4)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1133)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:607)
at java.lang.Thread.run(Thread.java:762)
04-05 01:28:10.042 e: [Player][ExoPlayer] Playback error detected
04-05 01:28:10.043 e: An exception occurred: com.google.android.exoplayer2.r: [Open]com.plexapp.plex.ff.data.FFException: Demuxer failed to open input.
04-05 01:28:10.049 e: Stacktrace: com.google.android.exoplayer2.r: [Open]com.plexapp.plex.ff.data.FFException: Demuxer failed to open input.
at com.google.android.exoplayer2.v.handleMessage(SourceFile:29)
at android.os.Handler.dispatchMessage(Handler.java:98)
at android.os.Looper.loop(Looper.java:154)
at android.os.HandlerThread.run(HandlerThread.java:61)
Caused by: [Open]com.plexapp.plex.ff.data.FFException: Demuxer failed to open input.
at com.plexapp.plex.ff.FFDemuxer.open(SourceFile:31)
at com.plexapp.plex.ff.source.FFLoadable.load(SourceFile:3)
at com.google.android.exoplayer2.y0.a0$d.run(SourceFile:4)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1133)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:607)
at java.lang.Thread.run(Thread.java:762)
Server logs below, also interesting to note that CUDA could not be loaded, and that the server is having issues with HW transcoding (I’ve turned that off before too, no difference, and the server I’m on allows for HW transcode, plus the issues are only related to Android not iOS etc)
Apr 04, 2020 23:40:55.321 [0x7f7feca4d700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:40:55.321 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:37757 (WAN)] GET /library/metadata/5780?asyncAugmentMetadata=1&checkFiles=1&includeExternalMetadata=1&includeExtras=1&includeRelated=1&includeRelatedCount=0&includeReviews=1 (6 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:40:55.328 [0x7f7f65ffb700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 04, 2020 23:40:55.328 [0x7f7f65ffb700] DEBUG - Selecting best audio stream for part ID 9327 (autoselect: 0 language: en)
Apr 04, 2020 23:40:55.328 [0x7f7f65ffb700] DEBUG - We're going to try to auto-select a subtitle.
Apr 04, 2020 23:40:55.328 [0x7f7f65ffb700] DEBUG - Audio Stream: 30301, Subtitle Stream: -1
Apr 04, 2020 23:40:55.328 [0x7f7f65ffb700] DEBUG - Activity: registered new activity 3042709d-b105-4f38-b862-9046b92f42c7 - Refreshing
Apr 04, 2020 23:40:55.329 [0x7f7fc8ff9700] DEBUG - Activity: updated activity 3042709d-b105-4f38-b862-9046b92f42c7 - completed 0.0% - Refreshing
Apr 04, 2020 23:40:55.329 [0x7f7fe57fa700] DEBUG - Augment: Completed episode augmentation in 0.0 sec.
Apr 04, 2020 23:40:55.329 [0x7f7fc8ff9700] DEBUG - Activity: Ended activity 3042709d-b105-4f38-b862-9046b92f42c7.
Apr 04, 2020 23:40:55.331 [0x7f7feca4d700] DEBUG - Completed: [87.122.218.26:37757] 200 GET /library/metadata/5780?asyncAugmentMetadata=1&checkFiles=1&includeExternalMetadata=1&includeExtras=1&includeRelated=1&includeRelatedCount=0&includeReviews=1 (7 live) TLS GZIP 9ms 1613 bytes (pipelined: 1)
Apr 04, 2020 23:40:55.405 [0x7f7feca4d700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:40:55.406 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:37761 (WAN)] GET /:/websockets/notifications (8 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:40:55.406 [0x7f7f65ffb700] DEBUG - WebSocket: Performing handshake from origin
Apr 04, 2020 23:40:55.406 [0x7f7f65ffb700] DEBUG - Beginning read from WebSocket
Apr 04, 2020 23:40:55.463 [0x7f7feca4d700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:40:55.463 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:37767 (WAN)] GET /library/metadata/5564?asyncAugmentMetadata=1&includeExternalMetadata=1&includeExtras=1&includeRelated=1&includeRelatedCount=0&includeReviews=1 (8 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:40:55.467 [0x7f7f65ffb700] DEBUG - Activity: registered new activity 03cf89e2-50f0-42d3-84c6-f6c3ed62846c - Refreshing
Apr 04, 2020 23:40:55.467 [0x7f7fb2ffd700] DEBUG - Activity: updated activity 03cf89e2-50f0-42d3-84c6-f6c3ed62846c - completed 0.0% - Refreshing
Apr 04, 2020 23:40:55.467 [0x7f7fb2ffd700] DEBUG - Activity: Ended activity 03cf89e2-50f0-42d3-84c6-f6c3ed62846c.
Apr 04, 2020 23:40:55.467 [0x7f7feca4d700] DEBUG - Completed: [87.122.218.26:37767] 200 GET /library/metadata/5564?asyncAugmentMetadata=1&includeExternalMetadata=1&includeExtras=1&includeRelated=1&includeRelatedCount=0&includeReviews=1 (8 live) TLS GZIP 3ms 943 bytes (pipelined: 1)
Apr 04, 2020 23:40:55.578 [0x7f7fe7fff700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:40:55.578 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:37757 (WAN)] GET /library/metadata/augmentations/68?wait=1 (8 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:40:55.579 [0x7f7fe7fff700] DEBUG - Completed: [87.122.218.26:37757] 200 GET /library/metadata/augmentations/68?wait=1 (8 live) TLS GZIP 0ms 397 bytes (pipelined: 2)
Apr 04, 2020 23:40:56.414 [0x7f7feca4d700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:40:56.415 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:37767 (WAN)] GET /library/metadata/5780?includeChapters=1&includeLoudnessRamps=1&includeRelated=1 (8 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:40:56.418 [0x7f7f65ffb700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 04, 2020 23:40:56.418 [0x7f7f65ffb700] DEBUG - Selecting best audio stream for part ID 9327 (autoselect: 0 language: en)
Apr 04, 2020 23:40:56.418 [0x7f7f65ffb700] DEBUG - We're going to try to auto-select a subtitle.
Apr 04, 2020 23:40:56.418 [0x7f7f65ffb700] DEBUG - Audio Stream: 30301, Subtitle Stream: -1
Apr 04, 2020 23:40:56.419 [0x7f7feca4d700] DEBUG - Completed: [87.122.218.26:37767] 200 GET /library/metadata/5780?includeChapters=1&includeLoudnessRamps=1&includeRelated=1 (8 live) TLS GZIP 4ms 1468 bytes (pipelined: 2)
Apr 04, 2020 23:40:56.449 [0x7f7fe7fff700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:40:56.449 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:37757 (WAN)] GET /video/:/transcode/universal/decision?audioBoost=180&autoAdjustQuality=0&directPlay=0&directStream=0&directStreamAudio=0&fastSeek=1&hasMDE=1&location=wan&maxVideoBitrate=200000&mediaBufferSize=74944&mediaIndex=0&partIndex=0&path=%2Flibrary%2Fmetadata%2F5780&protocol=*&session=a0d76813c271e911-com-plexapp-android&subtitleSize=100&videoBitrate=200000&videoQuality=100&videoResolution=3840x2160 (8 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:40:56.449 [0x7f7f65ffb700] DEBUG - Found session GUID of a0d76813c271e911-com-plexapp-android in session start.
Apr 04, 2020 23:40:56.450 [0x7f7f65ffb700] DEBUG - TranscodeUniversalRequest: using augmented profile Android
Apr 04, 2020 23:40:56.450 [0x7f7f65ffb700] DEBUG - Downloading document http://127.0.0.1:32400/library/metadata/5780?includeBandwidths=1&offset=-1&X-Plex-Incomplete-Segments=1&X-Plex-Session-Identifier=a0d76813c271e911-com-plexapp-android
Apr 04, 2020 23:40:56.450 [0x7f7f65ffb700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:40:56.455 [0x7f7f65ffb700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 04, 2020 23:40:56.455 [0x7f7f65ffb700] DEBUG - Selecting best audio stream for part ID 9327 (autoselect: 0 language: en)
Apr 04, 2020 23:40:56.455 [0x7f7f65ffb700] DEBUG - We're going to try to auto-select a subtitle.
Apr 04, 2020 23:40:56.455 [0x7f7f65ffb700] DEBUG - Audio Stream: 30301, Subtitle Stream: -1
Apr 04, 2020 23:40:56.456 [0x7f7f65ffb700] DEBUG - Codecs: testing h264_nvenc (encoder)
Apr 04, 2020 23:40:56.456 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: testing API nvenc
Apr 04, 2020 23:40:56.457 [0x7f7f65ffb700] ERROR - [FFMPEG] - Cannot load libcuda.so.1
Apr 04, 2020 23:40:56.457 [0x7f7f65ffb700] ERROR - [FFMPEG] - Could not dynamically load CUDA
Apr 04, 2020 23:40:56.457 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Apr 04, 2020 23:40:56.457 [0x7f7f65ffb700] DEBUG - Codecs: testing h264 (decoder) with hwdevice vaapi
Apr 04, 2020 23:40:56.457 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: testing API vaapi
Apr 04, 2020 23:40:56.457 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Generic error in an external library
Apr 04, 2020 23:40:56.457 [0x7f7f65ffb700] DEBUG - Codecs: testing h264 (decoder) with hwdevice nvdec
Apr 04, 2020 23:40:56.457 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: testing API nvdec
Apr 04, 2020 23:40:56.457 [0x7f7f65ffb700] ERROR - [FFMPEG] - Cannot load libcuda.so.1
Apr 04, 2020 23:40:56.457 [0x7f7f65ffb700] ERROR - [FFMPEG] - Could not dynamically load CUDA
Apr 04, 2020 23:40:56.457 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Apr 04, 2020 23:40:56.457 [0x7f7f65ffb700] DEBUG - Scaled up video bitrate to 1345Kbps based on 1.500000x fudge factor.
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - MDE: Selected protocol hls; container: mpegts
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - MDE: analyzing media item 9148
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - MDE: E19 - The Show: Direct Play is disabled
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - MDE: E19 - The Show: media must be transcoded in order to use the hls protocol
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - MDE: E19 - The Show: no direct play video profile exists for http/mkv/h264
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - MDE: E19 - The Show: no direct play video profile exists for http/mkv/h264/aac
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - MDE: E19 - The Show: Direct Streaming is disabled, so video stream will be transcoded
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - MDE: E19 - The Show: no remuxable profile found, so video stream will be transcoded
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - Codecs: testing h264_nvenc (encoder)
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: testing API nvenc
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] ERROR - [FFMPEG] - Cannot load libcuda.so.1
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] ERROR - [FFMPEG] - Could not dynamically load CUDA
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - MDE: Cannot direct stream video stream due to profile or setting limitations
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - Codecs: testing h264 (decoder) with hwdevice vaapi
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: testing API vaapi
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Generic error in an external library
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - Codecs: testing h264 (decoder) with hwdevice nvdec
Apr 04, 2020 23:40:56.458 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: testing API nvdec
Apr 04, 2020 23:40:56.459 [0x7f7f65ffb700] ERROR - [FFMPEG] - Cannot load libcuda.so.1
Apr 04, 2020 23:40:56.459 [0x7f7f65ffb700] ERROR - [FFMPEG] - Could not dynamically load CUDA
Apr 04, 2020 23:40:56.459 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Apr 04, 2020 23:40:56.459 [0x7f7f65ffb700] DEBUG - Scaled up video bitrate to 1345Kbps based on 1.500000x fudge factor.
Apr 04, 2020 23:40:56.459 [0x7f7f65ffb700] DEBUG - MDE: E19 - The Show: Audio Direct Streaming is disabled, so video's audio stream will be transcoded
Apr 04, 2020 23:40:56.459 [0x7f7f65ffb700] DEBUG - MDE: Cannot direct stream audio stream due to profile or setting limitations
Apr 04, 2020 23:40:56.459 [0x7f7f65ffb700] DEBUG - MDE: Bluey (2018) - S2 E19 - The Show: selected media 0 / 9148
Apr 04, 2020 23:40:56.459 [0x7f7f65ffb700] DEBUG - Streaming Resource: Adding session 0x7f7fcc134f10:a0d76813c271e911-com-plexapp-android which is using 1684kbps of WAN bandwidth. Used is now 1684kbps
Apr 04, 2020 23:40:56.459 [0x7f7f65ffb700] DEBUG - Streaming Resource: Adding session 0x7f7fcc134f10:a0d76813c271e911-com-plexapp-android which is using transcoder slot. Used slots is now 1
Apr 04, 2020 23:40:56.459 [0x7f7f65ffb700] DEBUG - Streaming Resource: Added session 0x7f7fcc134f10:a0d76813c271e911-com-plexapp-android
Apr 04, 2020 23:40:56.459 [0x7f7f65ffb700] DEBUG - Streaming Resource: Reached Decision id=5780 codes=(General=1001,Direct play not available; Conversion OK. Direct Play=3000,App cannot direct play this item. Direct play is disabled. Transcode=1001,Direct play not available; Conversion OK.) media=(id=9148 part=(id=9327 decision=transcode container=mpegts protocol=hls streams=(Video=(id=30300 decision=transcode bitrate=1345 encoder=libx264 width=1024 height=576) Audio=(id=30301 decision=transcode bitrate=258 encoder=aac channels=2 rate=44100))))
Apr 04, 2020 23:40:56.460 [0x7f7fe7fff700] DEBUG - Completed: [87.122.218.26:37757] 200 GET /video/:/transcode/universal/decision?audioBoost=180&autoAdjustQuality=0&directPlay=0&directStream=0&directStreamAudio=0&fastSeek=1&hasMDE=1&location=wan&maxVideoBitrate=200000&mediaBufferSize=74944&mediaIndex=0&partIndex=0&path=%2Flibrary%2Fmetadata%2F5780&protocol=*&session=a0d76813c271e911-com-plexapp-android&subtitleSize=100&videoBitrate=200000&videoQuality=100&videoResolution=3840x2160 (8 live) TLS GZIP 11ms 1419 bytes (pipelined: 3)
Apr 04, 2020 23:41:01.289 [0x7f7fe7fff700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:01.289 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:37767 (WAN)] GET /video/:/transcode/universal/decision?audioBoost=180&autoAdjustQuality=0&directPlay=0&directStream=0&directStreamAudio=0&fastSeek=1&hasMDE=1&location=wan&maxVideoBitrate=200000&mediaBufferSize=209664&mediaIndex=0&partIndex=0&path=%2Flibrary%2Fmetadata%2F5780&protocol=*&session=a0d76813c271e911-com-plexapp-android&subtitleSize=100&videoBitrate=200000&videoQuality=100&videoResolution=3840x2160 (8 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:01.289 [0x7f7f65ffb700] DEBUG - Found session GUID of a0d76813c271e911-com-plexapp-android in session start.
Apr 04, 2020 23:41:01.290 [0x7f7f65ffb700] DEBUG - TranscodeUniversalRequest: using augmented profile Android
Apr 04, 2020 23:41:01.290 [0x7f7f65ffb700] DEBUG - Downloading document http://127.0.0.1:32400/library/metadata/5780?includeBandwidths=1&offset=-1&X-Plex-Incomplete-Segments=1&X-Plex-Session-Identifier=a0d76813c271e911-com-plexapp-android
Apr 04, 2020 23:41:01.291 [0x7f7f65ffb700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:01.295 [0x7f7f65ffb700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 04, 2020 23:41:01.295 [0x7f7f65ffb700] DEBUG - Selecting best audio stream for part ID 9327 (autoselect: 0 language: en)
Apr 04, 2020 23:41:01.295 [0x7f7f65ffb700] DEBUG - We're going to try to auto-select a subtitle.
Apr 04, 2020 23:41:01.295 [0x7f7f65ffb700] DEBUG - Audio Stream: 30301, Subtitle Stream: -1
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - Codecs: testing h264_nvenc (encoder)
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: testing API nvenc
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] ERROR - [FFMPEG] - Cannot load libcuda.so.1
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] ERROR - [FFMPEG] - Could not dynamically load CUDA
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - Codecs: testing h264 (decoder) with hwdevice vaapi
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: testing API vaapi
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Generic error in an external library
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - Codecs: testing h264 (decoder) with hwdevice nvdec
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: testing API nvdec
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] ERROR - [FFMPEG] - Cannot load libcuda.so.1
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] ERROR - [FFMPEG] - Could not dynamically load CUDA
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - Scaled up video bitrate to 1345Kbps based on 1.500000x fudge factor.
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - MDE: Selected protocol hls; container: mpegts
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - MDE: analyzing media item 9148
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - MDE: E19 - The Show: Direct Play is disabled
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - MDE: E19 - The Show: media must be transcoded in order to use the hls protocol
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - MDE: E19 - The Show: no direct play video profile exists for http/mkv/h264
Apr 04, 2020 23:41:01.296 [0x7f7f65ffb700] DEBUG - MDE: E19 - The Show: no direct play video profile exists for http/mkv/h264/aac
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - MDE: E19 - The Show: Direct Streaming is disabled, so video stream will be transcoded
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - MDE: E19 - The Show: no remuxable profile found, so video stream will be transcoded
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - Codecs: testing h264_nvenc (encoder)
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: testing API nvenc
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] ERROR - [FFMPEG] - Cannot load libcuda.so.1
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] ERROR - [FFMPEG] - Could not dynamically load CUDA
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - MDE: Cannot direct stream video stream due to profile or setting limitations
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - Codecs: testing h264 (decoder) with hwdevice vaapi
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: testing API vaapi
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Generic error in an external library
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - Codecs: testing h264 (decoder) with hwdevice nvdec
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: testing API nvdec
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] ERROR - [FFMPEG] - Cannot load libcuda.so.1
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] ERROR - [FFMPEG] - Could not dynamically load CUDA
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - Scaled up video bitrate to 1345Kbps based on 1.500000x fudge factor.
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - MDE: E19 - The Show: Audio Direct Streaming is disabled, so video's audio stream will be transcoded
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - MDE: Cannot direct stream audio stream due to profile or setting limitations
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - MDE: Bluey (2018) - S2 E19 - The Show: selected media 0 / 9148
Apr 04, 2020 23:41:01.297 [0x7f7f65ffb700] DEBUG - Streaming Resource: Reached Decision id=5780 codes=(General=1001,Direct play not available; Conversion OK. Direct Play=3000,App cannot direct play this item. Direct play is disabled. Transcode=1001,Direct play not available; Conversion OK.) media=(id=9148 part=(id=9327 decision=transcode container=mpegts protocol=hls streams=(Video=(id=30300 decision=transcode bitrate=1345 encoder=libx264 width=1024 height=576) Audio=(id=30301 decision=transcode bitrate=258 encoder=aac channels=2 rate=44100))))
Apr 04, 2020 23:41:01.299 [0x7f7fe7fff700] DEBUG - Completed: [87.122.218.26:37767] 200 GET /video/:/transcode/universal/decision?audioBoost=180&autoAdjustQuality=0&directPlay=0&directStream=0&directStreamAudio=0&fastSeek=1&hasMDE=1&location=wan&maxVideoBitrate=200000&mediaBufferSize=209664&mediaIndex=0&partIndex=0&path=%2Flibrary%2Fmetadata%2F5780&protocol=*&session=a0d76813c271e911-com-plexapp-android&subtitleSize=100&videoBitrate=200000&videoQuality=100&videoResolution=3840x2160 (8 live) TLS GZIP 9ms 1419 bytes (pipelined: 3)
Apr 04, 2020 23:41:02.620 [0x7f7feca4d700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:02.621 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:53273 (WAN)] GET /:/prefs (12 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:02.626 [0x7f7feca4d700] DEBUG - Completed: [87.122.218.26:53273] 200 GET /:/prefs (12 live) TLS GZIP 5ms 7837 bytes (pipelined: 1)
Apr 04, 2020 23:41:02.642 [0x7f7fe7fff700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:02.642 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:53277 (WAN)] GET /accounts/1 (12 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:02.643 [0x7f7fe7fff700] DEBUG - Completed: [87.122.218.26:53277] 200 GET /accounts/1 (12 live) TLS GZIP 0ms 598 bytes (pipelined: 1)
Apr 04, 2020 23:41:02.646 [0x7f7feca4d700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:02.646 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:53278 (WAN)] GET /myplex/account (12 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:02.647 [0x7f7feca4d700] DEBUG - Completed: [87.122.218.26:53278] 200 GET /myplex/account (12 live) TLS GZIP 0ms 2695 bytes (pipelined: 1)
Apr 04, 2020 23:41:02.651 [0x7f7fe7fff700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:02.651 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:53279 (WAN)] GET /system/:/prefs (12 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:02.651 [0x7f7f65ffb700] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/:/prefs
Apr 04, 2020 23:41:02.651 [0x7f7f65ffb700] DEBUG - HTTP requesting GET http://127.0.0.1:40911/system/:/prefs
Apr 04, 2020 23:41:02.658 [0x7f7f65ffb700] DEBUG - HTTP 200 response from GET http://127.0.0.1:40911/system/:/prefs
Apr 04, 2020 23:41:02.658 [0x7f7f65ffb700] DEBUG - [com.plexapp.system] HTTP reply status 200, with 418 bytes of content.
Apr 04, 2020 23:41:02.658 [0x7f7fe7fff700] DEBUG - Completed: [87.122.218.26:53279] 200 GET /system/:/prefs (12 live) TLS GZIP 7ms 813 bytes (pipelined: 1)
Apr 04, 2020 23:41:02.759 [0x7f7fe7fff700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:02.759 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:53281 (WAN)] GET /:/websockets/notifications?filters=log (13 live) TLS Signed-in Token (wogfella)
Apr 04, 2020 23:41:02.759 [0x7f7f65ffb700] DEBUG - WebSocket: Performing handshake from origin https://app.plex.tv
Apr 04, 2020 23:41:02.759 [0x7f7f65ffb700] DEBUG - Beginning read from WebSocket
Apr 04, 2020 23:41:02.782 [0x7f7fe7fff700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:02.783 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:53273 (WAN)] GET /activities (13 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:02.783 [0x7f7fe7fff700] DEBUG - Completed: [87.122.218.26:53273] 200 GET /activities (13 live) TLS GZIP 0ms 429 bytes (pipelined: 2)
Apr 04, 2020 23:41:07.561 [0x7f7feca4d700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:07.561 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:37757 (WAN)] GET /library/metadata/5780?asyncAugmentMetadata=1&checkFiles=1&includeExternalMetadata=1&includeExtras=1&includeRelated=1&includeRelatedCount=0&includeReviews=1 (13 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:07.567 [0x7f7fb2ffd700] DEBUG - Augment: Deleting 12 expired augmentations.
Apr 04, 2020 23:41:07.569 [0x7f7f65ffb700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Apr 04, 2020 23:41:07.569 [0x7f7f65ffb700] DEBUG - Selecting best audio stream for part ID 9327 (autoselect: 0 language: en)
Apr 04, 2020 23:41:07.569 [0x7f7f65ffb700] DEBUG - We're going to try to auto-select a subtitle.
Apr 04, 2020 23:41:07.569 [0x7f7f65ffb700] DEBUG - Audio Stream: 30301, Subtitle Stream: -1
Apr 04, 2020 23:41:07.570 [0x7f7f65ffb700] DEBUG - Activity: registered new activity 99f790d5-fd5f-4572-bbc0-cb99a4568c5a - Refreshing
Apr 04, 2020 23:41:07.571 [0x7f7fb27fc700] DEBUG - Activity: updated activity 99f790d5-fd5f-4572-bbc0-cb99a4568c5a - completed 0.0% - Refreshing
Apr 04, 2020 23:41:07.571 [0x7f7fe57fa700] DEBUG - Augment: Completed episode augmentation in 0.0 sec.
Apr 04, 2020 23:41:07.571 [0x7f7fb27fc700] DEBUG - Activity: Ended activity 99f790d5-fd5f-4572-bbc0-cb99a4568c5a.
Apr 04, 2020 23:41:07.571 [0x7f7fe7fff700] DEBUG - Completed: [87.122.218.26:37757] 200 GET /library/metadata/5780?asyncAugmentMetadata=1&checkFiles=1&includeExternalMetadata=1&includeExtras=1&includeRelated=1&includeRelatedCount=0&includeReviews=1 (13 live) TLS GZIP 10ms 1613 bytes (pipelined: 4)
Apr 04, 2020 23:41:07.592 [0x7f7feca4d700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:07.592 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:37767 (WAN)] GET /library/metadata/5564?asyncAugmentMetadata=1&includeExternalMetadata=1&includeExtras=1&includeRelated=1&includeRelatedCount=0&includeReviews=1 (13 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:07.599 [0x7f7f65ffb700] DEBUG - Activity: registered new activity e9616ad1-0506-4566-bb1a-b84f79016df0 - Refreshing
Apr 04, 2020 23:41:07.600 [0x7f7fe77fe700] DEBUG - Activity: updated activity e9616ad1-0506-4566-bb1a-b84f79016df0 - completed 0.0% - Refreshing
Apr 04, 2020 23:41:07.600 [0x7f7fe77fe700] DEBUG - Activity: Ended activity e9616ad1-0506-4566-bb1a-b84f79016df0.
Apr 04, 2020 23:41:07.601 [0x7f7feca4d700] DEBUG - Completed: [87.122.218.26:37767] 200 GET /library/metadata/5564?asyncAugmentMetadata=1&includeExternalMetadata=1&includeExtras=1&includeRelated=1&includeRelatedCount=0&includeReviews=1 (13 live) TLS GZIP 8ms 943 bytes (pipelined: 4)
Apr 04, 2020 23:41:07.656 [0x7f7fe7fff700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:07.656 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:37757 (WAN)] GET /library/metadata/augmentations/70?wait=1 (13 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:07.656 [0x7f7fe7fff700] DEBUG - Completed: [87.122.218.26:37757] 200 GET /library/metadata/augmentations/70?wait=1 (13 live) TLS GZIP 0ms 397 bytes (pipelined: 5)
Apr 04, 2020 23:41:07.811 [0x7f7feca4d700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:07.811 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:37794 (WAN)] GET /:/websockets/notifications (14 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:07.811 [0x7f7f65ffb700] DEBUG - WebSocket: Performing handshake from origin
Apr 04, 2020 23:41:07.811 [0x7f7f65ffb700] DEBUG - Beginning read from WebSocket
Apr 04, 2020 23:41:10.422 [0x7f7fe7fff700] DEBUG - WebSocket: client initiated close
Apr 04, 2020 23:41:10.422 [0x7f7feca4d700] DEBUG - NotificationStream: Removing because of close
Apr 04, 2020 23:41:10.451 [0x7f7fe7fff700] DEBUG - handleStreamRead code 2: End of file
Apr 04, 2020 23:41:10.451 [0x7f7fe7fff700] DEBUG - Completed after connection close: [87.122.218.26:53281] -3 GET /:/websockets/notifications?filters=log (14 live) TLS 7692ms 7561 bytes
Apr 04, 2020 23:41:10.493 [0x7f7feca4d700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:10.494 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:53277 (WAN)] GET /accounts/1 (13 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:10.494 [0x7f7fe7fff700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:10.494 [0x7f7fcaffd700] DEBUG - Request: [87.122.218.26:53278 (WAN)] GET /myplex/account (13 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:10.494 [0x7f7fe7fff700] DEBUG - Completed: [87.122.218.26:53277] 200 GET /accounts/1 (13 live) TLS GZIP 0ms 598 bytes (pipelined: 2)
Apr 04, 2020 23:41:10.494 [0x7f7feca4d700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:10.495 [0x7f7f65ffb700] DEBUG - Request: [87.122.218.26:53273 (WAN)] GET /:/prefs (13 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:10.495 [0x7f7feca4d700] DEBUG - Completed: [87.122.218.26:53278] 200 GET /myplex/account (13 live) TLS GZIP 0ms 2695 bytes (pipelined: 2)
Apr 04, 2020 23:41:10.495 [0x7f7fe7fff700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:10.495 [0x7f7fcaffd700] DEBUG - Request: [87.122.218.26:53279 (WAN)] GET /system/:/prefs (13 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:10.495 [0x7f7fcaffd700] DEBUG - [com.plexapp.system] Sending command over HTTP (GET): /system/:/prefs
Apr 04, 2020 23:41:10.496 [0x7f7fcaffd700] DEBUG - HTTP requesting GET http://127.0.0.1:40911/system/:/prefs
Apr 04, 2020 23:41:10.501 [0x7f7fe7fff700] DEBUG - Completed: [87.122.218.26:53273] 200 GET /:/prefs (13 live) TLS GZIP 6ms 7837 bytes (pipelined: 3)
Apr 04, 2020 23:41:10.505 [0x7f7fcaffd700] DEBUG - HTTP 200 response from GET http://127.0.0.1:40911/system/:/prefs
Apr 04, 2020 23:41:10.505 [0x7f7fcaffd700] DEBUG - [com.plexapp.system] HTTP reply status 200, with 418 bytes of content.
Apr 04, 2020 23:41:10.505 [0x7f7fe7fff700] DEBUG - Completed: [87.122.218.26:53279] 200 GET /system/:/prefs (13 live) TLS GZIP 9ms 813 bytes (pipelined: 2)
Apr 04, 2020 23:41:11.930 [0x7f7fe7fff700] DEBUG - Auth: authenticated user 1 as wogfella
Apr 04, 2020 23:41:11.930 [0x7f7fcaffd700] DEBUG - Request: [87.122.218.26:53284 (WAN)] GET /diagnostics/logs (14 live) TLS GZIP Signed-in Token (wogfella)
Apr 04, 2020 23:41:11.930 [0x7f7fcaffd700] DEBUG - Diagnostics: Building logfile zip
device_logs.txt (107.6 KB)
EDIT: cleared up formatting and added logs (who knew attachments were hard?)

