Unable to Play any video content on latest plex server using web browser or app

m3ld4r10n · December 11, 2023, 5:40pm

Server Version#: 1.32.8.7639-fb6452ebf
Player Version#:
<If providing server logs please do NOT turn on verbose logging, only debug logging should be enabled>

Greetings to all Plexonians,

I can’t play any video. Seems to stall. I’ve been drilling down into the debug logs, trying my hardest to understand them, looking through other forum posts and using google to see if there is anything remotely similar. But I haven’t found anything.

My setup is relatively simple:

Plex is running on Ubuntu 22 as a VM on ESXi.
I have Openvpn running on another VM with exclusive access to the Plex VM.
The host has two 1GB NIC’s, negotiating happily at 1GBit to a router/firewall.

That’s it.

The communication between the two VM’s happens over a software/virtual switch. There’s no bottle neck there. Tested. 1Gbit/1Gbit

The VM connection to the internet - quite respectable 160Mbit/30Mbit, and ample.

The communication over the VPN to my laptop/phone has been tested as well. Super nice.

It’s been running like that for years fault free and very happy.

But now, it’s not happy.

So, after exhausing google and the forums i:

tried playing over https using port 443 instead of 32400 without VPN
tried using plex proxy
tried running lower quality - the lowest quality sort of works
tried a removing all settings for bandwidth management, QoS, transcoder on fastest setting etc…
reinstalled Plex on the VM,
reinstalled ESXi - which shows a desperate person!
played the video on another VM on same subnet and it appeared to work reasonably well

If you read these logs and have any clues or ideas, please throw them my way. I would love to keep using Plex if I can get it working again.

Here’s me playing the video:


Dec 11, 2023 17:09:21.613 [140178169023288] Debug — Completed: [172.16.1.15:56347] 200 POST /playQueues?type=video&continuous=1&uri=server%3A%2F%2Fe764513e47761e368a00ab4c55a9cec3f1f13229%2Fcom.plexapp.plugins.library%2Flibrary%2Fmetadata%2F729&repeat=0&own=1&includeChapters=1&includeMarkers=1&includeGeolocation=1&includeExternalMedia=1 (7 live) #20f2 TLS GZIP 32ms 4053 bytes (pipelined: 3)
Dec 11, 2023 17:09:21.894 [140178079988536] Debug — Request: [172.16.1.15:56347 (Subnet)] GET /library/metadata/729?Accept-Language=en-GB&includeConcerts=1&includeExtras=1&includeOnDeck=1&includePopularLeaves=1&includePreferences=1&includeChapters=1&includeStations=1&includeMarkers=1&includeExternalMedia=1&asyncAugmentMetadata=1&checkFiles=1 (7 live) #2153 TLS GZIP Signed-in Token (DAGGGER) (Firefox)
Dec 11, 2023 17:09:21.898 [140178079988536] Debug — We're going to try to auto-select an audio stream for account 1.
Dec 11, 2023 17:09:21.898 [140178079988536] Debug — Selecting best audio stream for part ID 704 (language: en)
Dec 11, 2023 17:09:21.898 [140178079988536] Debug — We're going to try to auto-select a subtitle.
Dec 11, 2023 17:09:21.898 [140178079988536] Debug — Audio Stream: 3225, Subtitle Stream: -1
Dec 11, 2023 17:09:21.901 [140178169023288] Debug — Completed: [172.16.1.15:56347] 200 GET /library/metadata/729?Accept-Language=en-GB&includeConcerts=1&includeExtras=1&includeOnDeck=1&includePopularLeaves=1&includePreferences=1&includeChapters=1&includeStations=1&includeMarkers=1&includeExternalMedia=1&asyncAugmentMetadata=1&checkFiles=1 (7 live) #2153 TLS GZIP 6ms 1956 bytes (pipelined: 4)
Dec 11, 2023 17:09:22.022 [140178095905592] Debug — Request: [172.16.1.15:56347 (Subnet)] GET /video/:/transcode/universal/decision?hasMDE=1&path=%2Flibrary%2Fmetadata%2F729&mediaIndex=0&partIndex=0&protocol=dash&fastSeek=1&directPlay=0&directStream=1&subtitleSize=100&audioBoost=700&location=lan&addDebugOverlay=0&autoAdjustQuality=0&directStreamAudio=1&mediaBufferSize=102400&session=yd2chsjbeual9m2pqwy4pqku&subtitles=burn&Accept-Language=en-GB (7 live) #2161 TLS GZIP Signed-in Token (DAGGGER) (Firefox)
Dec 11, 2023 17:09:22.022 [140178095905592] Debug — [Req#2161/Transcode] Found session GUID of yd2chsjbeual9m2pqwy4pqku in session start.
Dec 11, 2023 17:09:22.022 [140178095905592] Debug — [Req#2161/Transcode] TranscodeUniversalRequest: adapting profile with augmentation data: append-transcode-target-codec(type=videoProfile&context=streaming&audioCodec=aac&protocol=dash)
Dec 11, 2023 17:09:22.022 [140178095905592] Debug — [Req#2161/Transcode] TranscodeUniversalRequest: using augmented profile Firefox
Dec 11, 2023 17:09:22.022 [140178095905592] Debug — [Req#2161/Transcode] Downloading document http://127.0.0.1:32400/library/metadata/729?includeBandwidths=1&offset=-1&X-Plex-Incomplete-Segments=1&X-Plex-Session-Identifier=dqfd9v9idpk4xo2tbr1u4q8y
Dec 11, 2023 17:09:22.026 [140178095905592] Debug — [Req#2161/Transcode] We're going to try to auto-select an audio stream for account 1.
Dec 11, 2023 17:09:22.026 [140178095905592] Debug — [Req#2161/Transcode] Selecting best audio stream for part ID 704 (language: en)
Dec 11, 2023 17:09:22.026 [140178095905592] Debug — [Req#2161/Transcode] We're going to try to auto-select a subtitle.
Dec 11, 2023 17:09:22.026 [140178095905592] Debug — [Req#2161/Transcode] Audio Stream: 3225, Subtitle Stream: -1
Dec 11, 2023 17:09:22.027 [140178095905592] Debug — [Req#2161/Transcode] MDE: Selected protocol dash; container: mp4
Dec 11, 2023 17:09:22.027 [140178095905592] Debug — [Req#2161/Transcode] MDE: analyzing media item 704
Dec 11, 2023 17:09:22.027 [140178095905592] Debug — [Req#2161/Transcode] MDE: E1 - One Ocean: Direct Play is disabled
Dec 11, 2023 17:09:22.027 [140178095905592] Debug — [Req#2161/Transcode] MDE: E1 - One Ocean: media must be transcoded in order to use the dash protocol
Dec 11, 2023 17:09:22.027 [140178095905592] Debug — [Req#2161/Transcode] MDE: E1 - One Ocean: no direct play video profile exists for http/mkv/h264
Dec 11, 2023 17:09:22.027 [140178095905592] Debug — [Req#2161/Transcode] MDE: E1 - One Ocean: no direct play video profile exists for http/mkv/h264/ac3
Dec 11, 2023 17:09:22.027 [140178095905592] Debug — [Req#2161/Transcode] One Ocean - audio.channels limitation applies: 6 > 2
Dec 11, 2023 17:09:22.027 [140178095905592] Debug — [Req#2161/Transcode] One Ocean - audio.channels limitation applies: 6 > 2
Dec 11, 2023 17:09:22.027 [140178095905592] Debug — [Req#2161/Transcode] MDE: Cannot direct stream audio stream due to profile or setting limitations
Dec 11, 2023 17:09:22.027 [140178095905592] Debug — [Req#2161/Transcode] MDE: Blue Planet II - S1 E1 - One Ocean: selected media 0 / 704
Dec 11, 2023 17:09:22.027 [140178095905592] Debug — [Req#2161/Transcode] Streaming Resource: Added session 0x7f7dc4df7038:dqfd9v9idpk4xo2tbr1u4q8y
Dec 11, 2023 17:09:22.027 [140178095905592] Debug — [Req#2161/Transcode] Streaming Resource: Reached Decision id=729 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=704 part=(id=704 decision=transcode container=mp4 protocol=dash streams=(Video=(id=3223 decision=copy width=1280 height=720) Audio=(id=3225 decision=transcode bitrate=256 encoder=aac channels=2 rate=48000))))
Dec 11, 2023 17:09:22.028 [140178169023288] Debug — Completed: [172.16.1.15:56347] 200 GET /video/:/transcode/universal/decision?hasMDE=1&path=%2Flibrary%2Fmetadata%2F729&mediaIndex=0&partIndex=0&protocol=dash&fastSeek=1&directPlay=0&directStream=1&subtitleSize=100&audioBoost=700&location=lan&addDebugOverlay=0&autoAdjustQuality=0&directStreamAudio=1&mediaBufferSize=102400&session=yd2chsjbeual9m2pqwy4pqku&subtitles=burn&Accept-Language=en-GB (7 live) #2161 TLS GZIP 6ms 1755 bytes (pipelined: 5)
Dec 11, 2023 17:09:22.037 [140178121202488] Debug — Request: [172.16.1.15:56346 (Subnet)] GET /:/timeline?ratingKey=729&key=%2Flibrary%2Fmetadata%2F729&playbackTime=0&playQueueItemID=449&state=playing&hasMDE=1&context=home%3Ahub.continueWatching&row=0&col=0&time=0&duration=3472000 (7 live) #2095 TLS GZIP Signed-in Token (DAGGGER) (Firefox)
Dec 11, 2023 17:09:22.038 [140178121202488] Debug — [Req#2095] Client [dqfd9v9idpk4xo2tbr1u4q8y] reporting timeline state playing, progress of 0/3472000ms for guid=, playbackTime=0ms ratingKey=729 url=, key=/library/metadata/729, containerKey=, metadataId=729, source=
Dec 11, 2023 17:09:22.043 [140178121202488] Debug — [Req#2095] We're going to try to auto-select an audio stream for account 1.
Dec 11, 2023 17:09:22.043 [140178121202488] Debug — [Req#2095] Selecting best audio stream for part ID 704 (language: en)
Dec 11, 2023 17:09:22.043 [140178121202488] Debug — [Req#2095] We're going to try to auto-select a subtitle.
Dec 11, 2023 17:09:22.043 [140178121202488] Debug — [Req#2095] Audio Stream: 3225, Subtitle Stream: -1
Dec 11, 2023 17:09:22.044 [140178121202488] Debug — [Req#2095] [Now] User is DAGGGER (ID: 1)
Dec 11, 2023 17:09:22.044 [140178121202488] Debug — [Req#2095] [Now] Device is Firefox (Firefox).
Dec 11, 2023 17:09:22.044 [140178121202488] Debug — [Req#2095] [Now] Profile is Firefox
Dec 11, 2023 17:09:22.044 [140178121202488] Debug — [Req#2095] [Now] Updated play state for /library/metadata/729.
Dec 11, 2023 17:09:22.045 [140178121202488] Debug — [Req#2095] Statistics: (hukgabuavfsc3nies7y0cizm) Reporting active playback in state 0 of type 4 (scrobble: 0) for account 1
Dec 11, 2023 17:09:22.051 [140178169023288] Debug — Completed: [172.16.1.15:56346] 200 GET /:/timeline?ratingKey=729&key=%2Flibrary%2Fmetadata%2F729&playbackTime=0&playQueueItemID=449&state=playing&hasMDE=1&context=home%3Ahub.continueWatching&row=0&col=0&time=0&duration=3472000 (7 live) #2095 TLS GZIP 13ms 456 bytes (pipelined: 2)
Dec 11, 2023 17:09:22.133 [140178145413944] Debug — Request: [172.16.1.15:56347 (Subnet)] GET /status/sessions (7 live) #2190 TLS GZIP Signed-in Token (DAGGGER) (Firefox)
Dec 11, 2023 17:09:22.133 [140178145413944] Debug — [Req#2190] [Now] Adding 1 sessions.
Dec 11, 2023 17:09:22.134 [140178079988536] Debug — Request: [172.16.1.15:56346 (Subnet)] GET /playQueues/55?repeat=0&own=1&includeChapters=1&includeMarkers=1&includeGeolocation=1&includeExternalMedia=1 (7 live) #21b1 TLS GZIP Signed-in Token (DAGGGER) (Firefox)
Dec 11, 2023 17:09:22.134 [140178079988536] Debug — [Req#21b1] PlayQueue: total generated: 7, before cursor: 0, after cursor: 6
Dec 11, 2023 17:09:22.134 [140178079988536] Debug — [Req#21b1] PlayQueue: No need to refresh, active window is operational.
Dec 11, 2023 17:09:22.136 [140178169023288] Debug — Completed: [172.16.1.15:56347] 200 GET /status/sessions (7 live) #2190 TLS GZIP 3ms 1725 bytes (pipelined: 6)
Dec 11, 2023 17:09:22.142 [140178079988536] Debug — [Req#21b1] PlayQueue: Client hukgabuavfsc3nies7y0cizm requested ownership of play queue 55, but already had it.
Dec 11, 2023 17:09:22.143 [140178079988536] Debug — We're going to try to auto-select an audio stream for account 1.
Dec 11, 2023 17:09:22.143 [140178079988536] Debug — Selecting best audio stream for part ID 704 (language: en)
Dec 11, 2023 17:09:22.143 [140178079988536] Debug — We're going to try to auto-select a subtitle.
Dec 11, 2023 17:09:22.143 [140178079988536] Debug — Audio Stream: 3225, Subtitle Stream: -1
Dec 11, 2023 17:09:22.145 [140178079988536] Debug — We're going to try to auto-select an audio stream for account 1.
Dec 11, 2023 17:09:22.145 [140178079988536] Debug — Selecting best audio stream for part ID 705 (language: en)
Dec 11, 2023 17:09:22.145 [140178079988536] Debug — We're going to try to auto-select a subtitle.
Dec 11, 2023 17:09:22.145 [140178079988536] Debug — Audio Stream: 3228, Subtitle Stream: -1
Dec 11, 2023 17:09:22.148 [140178079988536] Debug — We're going to try to auto-select an audio stream for account 1.
Dec 11, 2023 17:09:22.148 [140178079988536] Debug — Selecting best audio stream for part ID 706 (language: en)
Dec 11, 2023 17:09:22.148 [140178079988536] Debug — We're going to try to auto-select a subtitle.
Dec 11, 2023 17:09:22.148 [140178079988536] Debug — Audio Stream: 3231, Subtitle Stream: -1
Dec 11, 2023 17:09:22.150 [140178079988536] Debug — We're going to try to auto-select an audio stream for account 1.
Dec 11, 2023 17:09:22.150 [140178079988536] Debug — Selecting best audio stream for part ID 707 (language: en)
Dec 11, 2023 17:09:22.150 [140178079988536] Debug — We're going to try to auto-select a subtitle.
Dec 11, 2023 17:09:22.150 [140178079988536] Debug — Audio Stream: 3234, Subtitle Stream: -1
Dec 11, 2023 17:09:22.151 [140178079988536] Debug — We're going to try to auto-select an audio stream for account 1.
Dec 11, 2023 17:09:22.151 [140178079988536] Debug — Selecting best audio stream for part ID 708 (language: en)
Dec 11, 2023 17:09:22.151 [140178079988536] Debug — We're going to try to auto-select a subtitle.
Dec 11, 2023 17:09:22.151 [140178079988536] Debug — Audio Stream: 3237, Subtitle Stream: -1
Dec 11, 2023 17:09:22.153 [140178079988536] Debug — We're going to try to auto-select an audio stream for account 1.
Dec 11, 2023 17:09:22.153 [140178079988536] Debug — Selecting best audio stream for part ID 709 (language: en)
Dec 11, 2023 17:09:22.153 [140178079988536] Debug — We're going to try to auto-select a subtitle.
Dec 11, 2023 17:09:22.153 [140178079988536] Debug — Audio Stream: 3240, Subtitle Stream: -1
Dec 11, 2023 17:09:22.155 [140178079988536] Debug — We're going to try to auto-select an audio stream for account 1.
Dec 11, 2023 17:09:22.155 [140178079988536] Debug — Selecting best audio stream for part ID 710 (language: en)
Dec 11, 2023 17:09:22.155 [140178079988536] Debug — We're going to try to auto-select a subtitle.
Dec 11, 2023 17:09:22.155 [140178079988536] Debug — Audio Stream: 3243, Subtitle Stream: -1
Dec 11, 2023 17:09:22.157 [140178169023288] Debug — Completed: [172.16.1.15:56346] 200 GET /playQueues/55?repeat=0&own=1&includeChapters=1&includeMarkers=1&includeGeolocation=1&includeExternalMedia=1 (7 live) #21b1 TLS GZIP 23ms 3923 bytes (pipelined: 3)
Dec 11, 2023 17:09:22.198 [140178121202488] Debug — Request: [172.16.1.15:56347 (Subnet)] GET /web/js/chunk-9112-144b5069ea5850c1a67b-plex-4.116.1.34633-acaef50.js (7 live) #21bc TLS GZIP Signed-in
Dec 11, 2023 17:09:22.198 [140178121202488] Debug — [Req#21bc] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/js/chunk-9112-144b5069ea5850c1a67b-plex-4.116.1.34633-acaef50.js"
Dec 11, 2023 17:09:22.198 [140178121202488] Debug — Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/js/chunk-9112-144b5069ea5850c1a67b-plex-4.116.1.34633-acaef50.js is 7179 (of total: 7179).
Dec 11, 2023 17:09:22.198 [140178166913848] Debug — Completed: [172.16.1.15:56347] 200 GET /web/js/chunk-9112-144b5069ea5850c1a67b-plex-4.116.1.34633-acaef50.js (7 live) #21bc TLS GZIP 0ms 7179 bytes (pipelined: 7)
Dec 11, 2023 17:09:22.246 [140178145413944] Debug — Request: [172.16.1.15:56346 (Subnet)] GET /web/js/chunk-1123-b7f65e78bd5c2c18e3ad-plex-4.116.1.34633-acaef50.js (10 live) #21f9 TLS GZIP Signed-in
Dec 11, 2023 17:09:22.246 [140178145413944] Debug — [Req#21f9] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/js/chunk-1123-b7f65e78bd5c2c18e3ad-plex-4.116.1.34633-acaef50.js"
Dec 11, 2023 17:09:22.246 [140178145413944] Debug — Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/js/chunk-1123-b7f65e78bd5c2c18e3ad-plex-4.116.1.34633-acaef50.js is 404637 (of total: 404637).
Dec 11, 2023 17:09:22.302 [140178079988536] Debug — Request: [172.16.1.15:56350 (Subnet)] GET /status/sessions (10 live) #2089 TLS GZIP Signed-in Token (DAGGGER) (Firefox)
Dec 11, 2023 17:09:22.303 [140178079988536] Debug — [Req#2089] [Now] Adding 1 sessions.
Dec 11, 2023 17:09:22.303 [140178169023288] Debug — Completed: [172.16.1.15:56350] 200 GET /status/sessions (10 live) #2089 TLS GZIP 1ms 1725 bytes (pipelined: 1)
Dec 11, 2023 17:09:23.838 [140178166913848] Debug — Completed: [172.16.1.15:56346] 200 GET /web/js/chunk-1123-b7f65e78bd5c2c18e3ad-plex-4.116.1.34633-acaef50.js (10 live) #21f9 TLS GZIP 1591ms 404637 bytes (pipelined: 4)
Dec 11, 2023 17:09:24.018 [140178145413944] Debug — [Req#2208/Transcode/bvshd3j235s9te9kq4qvp6u9/790568dd-fd18-4207-b6a9-91e327d56142] Transcoder segment range: 0 - 27 (27)
Dec 11, 2023 17:09:24.550 [140178095905592] Debug — Request: [172.16.1.15:56346 (Subnet)] GET /video/:/transcode/universal/start.mpd?hasMDE=1&path=%2Flibrary%2Fmetadata%2F729&mediaIndex=0&partIndex=0&protocol=dash&fastSeek=1&directPlay=0&directStream=1&subtitleSize=100&audioBoost=700&location=lan&addDebugOverlay=0&autoAdjustQuality=0&directStreamAudio=1&mediaBufferSize=102400&session=yd2chsjbeual9m2pqwy4pqku&subtitles=burn&Accept-Language=en-GB (10 live) #221d TLS GZIP Signed-in Token (DAGGGER) (Firefox)
Dec 11, 2023 17:09:24.550 [140178095905592] Debug — [Req#221d/Transcode] Found session GUID of yd2chsjbeual9m2pqwy4pqku in session start.
Dec 11, 2023 17:09:24.550 [140178095905592] Debug — [Req#221d/Transcode] TranscodeUniversalRequest: adapting profile with augmentation data: append-transcode-target-codec(type=videoProfile&context=streaming&audioCodec=aac&protocol=dash)
Dec 11, 2023 17:09:24.550 [140178095905592] Debug — [Req#221d/Transcode] TranscodeUniversalRequest: using augmented profile Firefox
Dec 11, 2023 17:09:24.550 [140178095905592] Debug — [Req#221d/Transcode] Downloading document http://127.0.0.1:32400/library/metadata/729?checkFiles=1&includeBandwidths=1&offset=-1&X-Plex-Incomplete-Segments=1&X-Plex-Session-Identifier=dqfd9v9idpk4xo2tbr1u4q8y
Dec 11, 2023 17:09:24.554 [140178095905592] Debug — [Req#221d/Transcode] We're going to try to auto-select an audio stream for account 1.
Dec 11, 2023 17:09:24.554 [140178095905592] Debug — [Req#221d/Transcode] Selecting best audio stream for part ID 704 (language: en)
Dec 11, 2023 17:09:24.554 [140178095905592] Debug — [Req#221d/Transcode] We're going to try to auto-select a subtitle.
Dec 11, 2023 17:09:24.554 [140178095905592] Debug — [Req#221d/Transcode] Audio Stream: 3225, Subtitle Stream: -1
Dec 11, 2023 17:09:24.555 [140178095905592] Debug — [Req#221d/Transcode] Found session GUID of yd2chsjbeual9m2pqwy4pqku in session start.
Dec 11, 2023 17:09:24.555 [140178095905592] Debug — [Req#221d/Transcode] Cleaning directory for session yd2chsjbeual9m2pqwy4pqku ()
Dec 11, 2023 17:09:24.555 [140178095905592] Debug — [Req#221d/Transcode] Starting a transcode session yd2chsjbeual9m2pqwy4pqku at offset -1.0 (state=3)
Dec 11, 2023 17:09:24.556 [140178095905592] Debug — [Req#221d/Transcode] [Universal] Using local file path instead of URL: /media/remote-drives/silo/television/Blue.Planet.II.S01.720p.BluRay.DD5.1.x264-NTb/Blue.Planet.II.S01E01.720p.BluRay.DD5.1.x264-NTb.mkv
Dec 11, 2023 17:09:24.556 [140178095905592] Debug — [Req#221d/Transcode/JobRunner] Job running: FFMPEG_EXTERNAL_LIBS='/media/local-drives/plex-data/meta/Plex\ Media\ Server/Codecs/90a317c-4653-linux-x86_64/' X_PLEX_TOKEN=xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx "/usr/lib/plexmediaserver/Plex Transcoder" -codec:0 h264 -codec:2 ac3 -noaccurate_seek -analyzeduration 20000000 -probesize 20000000 -i /media/remote-drives/silo/television/Blue.Planet.II.S01.720p.BluRay.DD5.1.x264-NTb/Blue.Planet.II.S01E01.720p.BluRay.DD5.1.x264-NTb.mkv -map 0:0 -metadata:s:0 language=eng -codec:0 copy -filter_complex "[0:2] aresample=async=1:ochl='stereo':rematrix_maxval=60.000000dB:osr=48000[0]" -map "[0]" -metadata:s:1 language=eng -codec:1 aac -b:1 256k -f dash -seg_duration 5 -dash_segment_type mp4 -init_seg_name 'init-stream$RepresentationID$.m4s' -media_seg_name 'chunk-stream$RepresentationID$-$Number%05d$.m4s' -window_size 5 -delete_removed false -skip_to_segment 1 -time_delta 0.0625 -manifest_name "http://127.0.0.1:32400/video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/manifest?X-Plex-Http-Pipeline=infinite" -avoid_negative_ts disabled -map_metadata -1 -map_chapters -1 dash -start_at_zero -copyts -vsync cfr -y -nostats -loglevel quiet -loglevel_plex error -progressurl http://127.0.0.1:32400/video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress
Dec 11, 2023 17:09:24.556 [140178095905592] Debug — [Req#221d/Transcode/JobRunner] In directory: "/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-yd2chsjbeual9m2pqwy4pqku-10cd908b-368c-4498-8e94-79a61e1c9e33"
Dec 11, 2023 17:09:24.556 [140178095905592] Debug — [Req#221d/Transcode/JobRunner] Jobs: Starting child process with pid 496394
Dec 11, 2023 17:09:24.561 [140178121202488] Debug — Request: [127.0.0.1:42280 (Loopback)] PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress?status=startup (11 live) #2220 Signed-in Token (DAGGGER) (range: bytes=0-) 
Dec 11, 2023 17:09:24.561 [140178166913848] Debug — Completed: [127.0.0.1:42280] 204 PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress?status=startup (11 live) #2220 0ms 203 bytes (pipelined: 1) (range: bytes=0-) 
Dec 11, 2023 17:09:24.564 [140178145413944] Debug — Request: [127.0.0.1:42280 (Loopback)] PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress?status=startup (11 live) #224a Signed-in Token (DAGGGER) (range: bytes=0-) 
Dec 11, 2023 17:09:24.565 [140178169023288] Debug — Completed: [127.0.0.1:42280] 204 PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress?status=startup (11 live) #224a 0ms 203 bytes (pipelined: 2) (range: bytes=0-) 
Dec 11, 2023 17:09:24.565 [140178079988536] Debug — Request: [127.0.0.1:42280 (Loopback)] PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress?status=opening (11 live) #224f Signed-in Token (DAGGGER) (range: bytes=0-) 
Dec 11, 2023 17:09:24.565 [140178166913848] Debug — Completed: [127.0.0.1:42280] 204 PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress?status=opening (11 live) #224f 0ms 203 bytes (pipelined: 3) (range: bytes=0-) 
Dec 11, 2023 17:09:24.566 [140178121202488] Debug — Request: [127.0.0.1:42280 (Loopback)] PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress?status=opened (11 live) #2254 Signed-in Token (DAGGGER) (range: bytes=0-) 
Dec 11, 2023 17:09:24.566 [140178166913848] Debug — Completed: [127.0.0.1:42280] 204 PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress?status=opened (11 live) #2254 0ms 203 bytes (pipelined: 4) (range: bytes=0-) 
Dec 11, 2023 17:09:24.567 [140178145413944] Debug — Request: [127.0.0.1:42280 (Loopback)] PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress/stream?index=0&id=0&codec=h264&type=video (11 live) #2259 Signed-in Token (DAGGGER) (range: bytes=0-) 
Dec 11, 2023 17:09:24.567 [140178166913848] Debug — Completed: [127.0.0.1:42280] 200 PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress/stream?index=0&id=0&codec=h264&type=video (11 live) #2259 0ms 195 bytes (pipelined: 5) (range: bytes=0-) 
Dec 11, 2023 17:09:24.567 [140178079988536] Debug — Request: [127.0.0.1:42280 (Loopback)] PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress/stream?index=2&id=0&codec=ac3&type=audio (11 live) #225e Signed-in Token (DAGGGER) (range: bytes=0-) 
Dec 11, 2023 17:09:24.567 [140178169023288] Debug — Completed: [127.0.0.1:42280] 200 PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress/stream?index=2&id=0&codec=ac3&type=audio (11 live) #225e 0ms 195 bytes (pipelined: 6) (range: bytes=0-) 
Dec 11, 2023 17:09:24.590 [140178121202488] Debug — Request: [127.0.0.1:42280 (Loopback)] PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress/streamDetail?index=0&id=0&codec=h264&type=video&profile=High&language=eng&width=1280&height=720&interlaced=0&level=41&frameRate=25.000&disp_default=1 (11 live) #2263 Signed-in Token (DAGGGER) (range: bytes=0-) 
Dec 11, 2023 17:09:24.590 [140178166913848] Debug — Completed: [127.0.0.1:42280] 200 PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress/streamDetail?index=0&id=0&codec=h264&type=video&profile=High&language=eng&width=1280&height=720&interlaced=0&level=41&frameRate=25.000&disp_default=1 (11 live) #2263 0ms 195 bytes (pipelined: 7) (range: bytes=0-) 
Dec 11, 2023 17:09:24.590 [140178145413944] Debug — Request: [127.0.0.1:42280 (Loopback)] PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress/streamDetail?index=1&id=0&codec=subrip&type=subtitle&language=eng (11 live) #2268 Signed-in Token (DAGGGER) (range: bytes=0-) 
Dec 11, 2023 17:09:24.591 [140178169023288] Debug — Completed: [127.0.0.1:42280] 200 PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress/streamDetail?index=1&id=0&codec=subrip&type=subtitle&language=eng (11 live) #2268 0ms 195 bytes (pipelined: 8) (range: bytes=0-) 
Dec 11, 2023 17:09:24.591 [140178079988536] Debug — Request: [127.0.0.1:42280 (Loopback)] PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress/streamDetail?index=2&id=0&codec=ac3&type=audio&bitrate=640000&language=eng&channels=6&layout=5.1%28side%29&sampleRate=48000&disp_default=1 (11 live) #226d Signed-in Token (DAGGGER) (range: bytes=0-) 
Dec 11, 2023 17:09:24.591 [140178166913848] Debug — Completed: [127.0.0.1:42280] 200 PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress/streamDetail?index=2&id=0&codec=ac3&type=audio&bitrate=640000&language=eng&channels=6&layout=5.1%28side%29&sampleRate=48000&disp_default=1 (11 live) #226d 0ms 195 bytes (pipelined: 9) (range: bytes=0-) 
Dec 11, 2023 17:09:24.593 [140178121202488] Debug — Request: [127.0.0.1:42280 (Loopback)] PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress?duration=3472.032000 (11 live) #2272 Signed-in Token (DAGGGER) (range: bytes=0-) 
Dec 11, 2023 17:09:24.593 [140178166913848] Debug — Completed: [127.0.0.1:42280] 204 PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress?duration=3472.032000 (11 live) #2272 0ms 203 bytes (pipelined: 10) (range: bytes=0-) 
Dec 11, 2023 17:09:24.593 [140178095905592] Debug — [Req#221d/Transcode] Started session successfully: yd2chsjbeual9m2pqwy4pqku
Dec 11, 2023 17:09:24.593 [140178145413944] Debug — Request: [127.0.0.1:42280 (Loopback)] PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress?width=1280&height=720 (11 live) #2277 Signed-in Token (DAGGGER) (range: bytes=0-) 
Dec 11, 2023 17:09:24.594 [140178166913848] Debug — Completed: [127.0.0.1:42280] 206 PUT /video/:/transcode/session/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33/progress?width=1280&height=720 (11 live) #2277 0ms 355 bytes (pipelined: 11) (range: bytes=0-) 
Dec 11, 2023 17:09:24.594 [140178169023288] Debug — Completed: [172.16.1.15:56346] 200 GET /video/:/transcode/universal/start.mpd?hasMDE=1&path=%2Flibrary%2Fmetadata%2F729&mediaIndex=0&partIndex=0&protocol=dash&fastSeek=1&directPlay=0&directStream=1&subtitleSize=100&audioBoost=700&location=lan&addDebugOverlay=0&autoAdjustQuality=0&directStreamAudio=1&mediaBufferSize=102400&session=yd2chsjbeual9m2pqwy4pqku&subtitles=burn&Accept-Language=en-GB (11 live) #221d TLS GZIP 44ms 955 bytes (pipelined: 5)
Dec 11, 2023 17:09:24.701 [140178121202488] Debug — Request: [172.16.1.15:56346 (Subnet)] GET /status/sessions (11 live) #2285 TLS GZIP Signed-in Token (DAGGGER) (Firefox)
Dec 11, 2023 17:09:24.701 [140178145413944] Debug — Request: [172.16.1.15:56347 (Subnet)] GET /status/sessions (11 live) #2203 TLS GZIP Signed-in Token (DAGGGER) (Firefox)
Dec 11, 2023 17:09:24.702 [140178145413944] Debug — [Req#2203] [Now] Adding 1 sessions.
Dec 11, 2023 17:09:24.702 [140178121202488] Debug — [Req#2285] [Now] Adding 1 sessions.
Dec 11, 2023 17:09:24.703 [140178169023288] Debug — Completed: [172.16.1.15:56347] 200 GET /status/sessions (11 live) #2203 TLS GZIP 1ms 1725 bytes (pipelined: 8)
Dec 11, 2023 17:09:24.703 [140178166913848] Debug — Completed: [172.16.1.15:56346] 200 GET /status/sessions (11 live) #2285 TLS GZIP 1ms 1725 bytes (pipelined: 6)
Dec 11, 2023 17:09:25.007 [140178095905592] Debug — [Req#2247/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Transcoder segment range: 0 - 0 (0)
Dec 11, 2023 17:09:25.209 [140178121202488] Debug — [Req#2298/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Transcoder segment range: 0 - 1 (1)
Dec 11, 2023 17:09:25.526 [140178095905592] Debug — Request: [172.16.1.15:56346 (Subnet)] GET /video/:/transcode/universal/session/yd2chsjbeual9m2pqwy4pqku/1/header (11 live) #2294 TLS GZIP Signed-in
Dec 11, 2023 17:09:25.526 [140178095905592] Debug — [Req#2294/Transcode/yd2chsjbeual9m2pqwy4pqku] Exists("/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-yd2chsjbeual9m2pqwy4pqku-10cd908b-368c-4498-8e94-79a61e1c9e33/init-stream1.m4s") => 1
Dec 11, 2023 17:09:25.526 [140178095905592] Debug — Content-Length of /media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-yd2chsjbeual9m2pqwy4pqku-10cd908b-368c-4498-8e94-79a61e1c9e33/init-stream1.m4s is 765 (of total: 765).
Dec 11, 2023 17:09:25.526 [140178166913848] Debug — Completed: [172.16.1.15:56346] 200 GET /video/:/transcode/universal/session/yd2chsjbeual9m2pqwy4pqku/1/header (11 live) #2294 TLS GZIP 0ms 765 bytes (pipelined: 7)
Dec 11, 2023 17:09:25.606 [140178121202488] Debug — Request: [172.16.1.15:56346 (Subnet)] GET /video/:/transcode/universal/session/yd2chsjbeual9m2pqwy4pqku/1/0.m4s (11 live) #22a8 TLS GZIP Signed-in
Dec 11, 2023 17:09:25.606 [140178121202488] Debug — [Req#22a8/Transcode/yd2chsjbeual9m2pqwy4pqku] Asked for segment 0 from session.
Dec 11, 2023 17:09:25.606 [140178121202488] Debug — [Req#22a8/Transcode/yd2chsjbeual9m2pqwy4pqku] Returning segment 0 from session
Dec 11, 2023 17:09:25.606 [140178121202488] Debug — Content-Length of /media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-yd2chsjbeual9m2pqwy4pqku-10cd908b-368c-4498-8e94-79a61e1c9e33/init-stream1.m4s,/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-yd2chsjbeual9m2pqwy4pqku-10cd908b-368c-4498-8e94-79a61e1c9e33/chunk-stream1-00001.m4s is 319753 (of total: 319753).
Dec 11, 2023 17:09:25.765 [140178095905592] Debug — [Req#229d/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Transcoder segment range: 0 - 2 (2)
Dec 11, 2023 17:09:26.133 [140178121202488] Debug — [Req#22b5/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Transcoder segment range: 0 - 3 (3)
Dec 11, 2023 17:09:26.281 [140178095905592] Debug — [Req#22ba/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Transcoder segment range: 0 - 4 (4)
Dec 11, 2023 17:09:26.502 [140178145413944] Debug — Request: [172.16.1.15:56347 (Subnet)] GET /video/:/transcode/universal/session/yd2chsjbeual9m2pqwy4pqku/0/header (11 live) #2291 TLS GZIP Signed-in
Dec 11, 2023 17:09:26.502 [140178145413944] Debug — [Req#2291/Transcode/yd2chsjbeual9m2pqwy4pqku] Exists("/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-yd2chsjbeual9m2pqwy4pqku-10cd908b-368c-4498-8e94-79a61e1c9e33/init-stream0.m4s") => 1
Dec 11, 2023 17:09:26.502 [140178145413944] Debug — Content-Length of /media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-yd2chsjbeual9m2pqwy4pqku-10cd908b-368c-4498-8e94-79a61e1c9e33/init-stream0.m4s is 816 (of total: 816).
Dec 11, 2023 17:09:26.502 [140178169023288] Debug — Completed: [172.16.1.15:56347] 200 GET /video/:/transcode/universal/session/yd2chsjbeual9m2pqwy4pqku/0/header (11 live) #2291 TLS GZIP 0ms 816 bytes (pipelined: 9)
Dec 11, 2023 17:09:26.597 [140178079988536] Debug — Request: [172.16.1.15:56347 (Subnet)] GET /video/:/transcode/universal/session/yd2chsjbeual9m2pqwy4pqku/0/0.m4s (11 live) #22c9 TLS GZIP Signed-in
Dec 11, 2023 17:09:26.597 [140178079988536] Debug — [Req#22c9/Transcode/yd2chsjbeual9m2pqwy4pqku] Asked for segment 0 from session.
Dec 11, 2023 17:09:26.597 [140178079988536] Debug — [Req#22c9/Transcode/yd2chsjbeual9m2pqwy4pqku] Returning segment 0 from session
Dec 11, 2023 17:09:26.597 [140178079988536] Debug — Content-Length of /media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-yd2chsjbeual9m2pqwy4pqku-10cd908b-368c-4498-8e94-79a61e1c9e33/init-stream0.m4s,/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-yd2chsjbeual9m2pqwy4pqku-10cd908b-368c-4498-8e94-79a61e1c9e33/chunk-stream0-00001.m4s is 10484081 (of total: 10484081).
Dec 11, 2023 17:09:26.655 [140178095905592] Debug — [Req#22bf/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Transcoder segment range: 0 - 5 (5)
Dec 11, 2023 17:09:26.997 [140178121202488] Debug — [Req#22d5/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Transcoder segment range: 0 - 6 (6)
Dec 11, 2023 17:09:27.083 [140178079988536] Debug — [Req#22da/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Transcoder segment range: 0 - 7 (7)
Dec 11, 2023 17:09:27.200 [140178145413944] Debug — [Req#22de/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Transcoder segment range: 0 - 8 (8)
Dec 11, 2023 17:09:27.632 [140178079988536] Debug — [Req#22e3/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Transcoder segment range: 0 - 9 (9)
Dec 11, 2023 17:09:27.635 [140178095905592] Debug — [Req#22e2/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Session yd2chsjbeual9m2pqwy4pqku (4) is throttling
Dec 11, 2023 17:09:27.635 [140178145413944] Debug — [Req#22f0/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Throttle - Going into sloth mode.
Dec 11, 2023 17:09:28.862 [140178169023288] Debug — Completed: [172.16.1.15:56346] 200 GET /video/:/transcode/universal/session/yd2chsjbeual9m2pqwy4pqku/1/0.m4s (9 live) #22a8 TLS GZIP 3255ms 319753 bytes (pipelined: 8)
Dec 11, 2023 17:09:29.518 [140178121202488] Debug — Request: [172.16.1.15:56346 (Subnet)] GET /video/:/transcode/universal/session/yd2chsjbeual9m2pqwy4pqku/1/1.m4s (9 live) #22fd TLS GZIP Signed-in
Dec 11, 2023 17:09:29.518 [140178121202488] Debug — [Req#22fd/Transcode/yd2chsjbeual9m2pqwy4pqku] Asked for segment 1 from session.
Dec 11, 2023 17:09:29.518 [140178121202488] Debug — [Req#22fd/Transcode/yd2chsjbeual9m2pqwy4pqku] Returning segment 1 from session
Dec 11, 2023 17:09:29.518 [140178121202488] Debug — Content-Length of /media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-yd2chsjbeual9m2pqwy4pqku-10cd908b-368c-4498-8e94-79a61e1c9e33/init-stream1.m4s,/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-yd2chsjbeual9m2pqwy4pqku-10cd908b-368c-4498-8e94-79a61e1c9e33/chunk-stream1-00002.m4s is 148267 (of total: 148267).
Dec 11, 2023 17:09:29.760 [140178079988536] Debug — [Req#2300/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Session yd2chsjbeual9m2pqwy4pqku (4) is unthrottling
Dec 11, 2023 17:09:29.760 [140178095905592] Debug — [Req#230e/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Throttle - Getting back to work.
Dec 11, 2023 17:09:29.953 [140178121202488] Debug — [Req#22ea/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Transcoder segment range: 0 - 10 (10)
Dec 11, 2023 17:09:30.065 [140178079988536] Debug — [Req#2315/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Transcoder segment range: 0 - 11 (11)
Dec 11, 2023 17:09:30.086 [140178166913848] Debug — Completed: [172.16.1.15:56346] 200 GET /video/:/transcode/universal/session/yd2chsjbeual9m2pqwy4pqku/1/1.m4s (9 live) #22fd TLS GZIP 568ms 148267 bytes (pipelined: 9)
Dec 11, 2023 17:09:30.127 [140178095905592] Debug — [Req#2319/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Transcoder segment range: 0 - 12 (12)
Dec 11, 2023 17:09:30.160 [140178145413944] Debug — [Req#2311/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Session yd2chsjbeual9m2pqwy4pqku (4) is throttling
Dec 11, 2023 17:09:30.161 [140178121202488] Debug — [Req#2326/Transcode/yd2chsjbeual9m2pqwy4pqku/10cd908b-368c-4498-8e94-79a61e1c9e33] Throttle - Going into sloth mode.
Dec 11, 2023 17:09:35.376 [140178109614904] Debug — Shutting down idle session bvshd3j235s9te9kq4qvp6u9 (idle time is 180 seconds)
Dec 11, 2023 17:09:35.376 [140178109614904] Debug — Killing job.
Dec 11, 2023 17:09:35.376 [140178109614904] Debug — Signalling job ID 496362 with 9
Dec 11, 2023 17:09:35.376 [140178109614904] Debug — Job was already killed, not killing again.
Dec 11, 2023 17:09:35.376 [140178109614904] Debug — Stopping transcode session bvshd3j235s9te9kq4qvp6u9
Dec 11, 2023 17:09:35.376 [140178093796152] Debug — Cleaning directory for session bvshd3j235s9te9kq4qvp6u9 (/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-bvshd3j235s9te9kq4qvp6u9-790568dd-fd18-4207-b6a9-91e327d56142)
Dec 11, 2023 17:09:35.378 [140178109614904] Debug — Whacked session bvshd3j235s9te9kq4qvp6u9, 1 remaining.
Dec 11, 2023 17:09:35.378 [140178109614904] Debug — Killed 1 idle sessions out of a total of 2.
Dec 11, 2023 17:09:35.379 [140178173831992] Debug — Jobs: '/usr/lib/plexmediaserver/Plex Transcoder' exit code for process 496362 is -9 (signal: Killed)
Dec 11, 2023 17:09:35.431 [140178093796152] Debug — Cleaning directory for session bvshd3j235s9te9kq4qvp6u9 (/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-bvshd3j235s9te9kq4qvp6u9-790568dd-fd18-4207-b6a9-91e327d56142)
Dec 11, 2023 17:09:35.565 [140178145413944] Debug — Request: [172.16.1.15:56346 (Subnet)] GET /status/sessions (8 live) #231d TLS GZIP Signed-in Token (DAGGGER) (Firefox)
Dec 11, 2023 17:09:35.565 [140178145413944] Debug — [Req#231d] [Now] Adding 1 sessions.
Dec 11, 2023 17:09:35.566 [140178121202488] Debug — Request: [172.16.1.15:56350 (Subnet)] GET /status/sessions (8 live) #2213 TLS GZIP Signed-in Token (DAGGGER) (Firefox)
Dec 11, 2023 17:09:35.566 [140178121202488] Debug — [Req#2213] [Now] Adding 1 sessions.
Dec 11, 2023 17:09:35.567 [140178166913848] Debug — Completed: [172.16.1.15:56346] 200 GET /status/sessions (8 live) #231d TLS GZIP 1ms 1725 bytes (pipelined: 10)
Dec 11, 2023 17:09:35.567 [140178166913848] Debug — Completed: [172.16.1.15:56350] 200 GET /status/sessions (8 live) #2213 TLS GZIP 1ms 1725 bytes (pipelined: 2)
Dec 11, 2023 17:09:37.750 [140178166913848] Debug — Failed to stream media, client probably disconnected after 2130736 bytes: 32 - Broken pipe
Dec 11, 2023 17:09:37.750 [140178166913848] Debug — Completed after connection close: [172.16.1.15:56347] 200 GET /video/:/transcode/universal/session/yd2chsjbeual9m2pqwy4pqku/0/0.m4s (8 live) #22c9 TLS GZIP 11152ms 2130736 bytes (pipelined: 10)

Thanks!

sielbear · December 12, 2023, 4:53am

I’m seeing similar issues on my remote server - cannot play ANYTHING. Like the bandwidth is artificially capped. High bitrate videos max at 10 - 15 Mbps. Running a speedtest from plex I get 800 / 900 Mbps down / up. Bandwidth is NOT the issue. Side note - Emby playing fine. ONLY plex affected. Ubuntu 22. 04.

m3ld4r10n · December 14, 2023, 9:30pm

Hey sielbear,

Yeah I’m really glad to read I’m not the only person. Honestly, I’m completely stumped. I cannot for the life of me work out why this is happening.

I thought a reinstall would have done the trick as a last ditch attempt but nope.

No issues with the vpn, it works well, but Plex is dying.

Is there any form of official support channel for plex pass subscribers?

I’d love someone from support to assist me on this. Does seem to be related only to plex.

ChuckPa · December 14, 2023, 11:05pm

Need to know:
– Kernel version ?
– Native / Container while IN the VM ?
PMS DEBUG logs ZIP file which captures this is best
– It also provides the above info (unless using Container )

m3ld4r10n · December 25, 2023, 3:15pm

Hi Chuck,

To answer your Q’s:

[1]
Linux media 5.15.0-91-generic #101-Ubuntu SMP Tue Nov 14 13:30:08 UTC 2023 x86_64 x86_64 x86_64 GNU/Linux

And yes, it’s simply Ubuntu Linux virtualised so the Plex app, in that sense, is natively installed.

[2]
Uploading: Plex Media Server Logs_2023-12-25_15-11-09.zip…

Think it’s an issue solely linked to Direct Play?

ChuckPa · December 25, 2023, 9:08pm

Virtualized – which hypervisior ? – What’s passed through ?
You clicked send before your logs finished uploading. Would you try again ?

fredriksn · December 25, 2023, 9:45pm

Same problem here. Any way to find out if they know of the bug and are looking into fixing it?

ChuckPa · December 25, 2023, 10:07pm

I don’t see ANY server logs here so I don’t even know what’s happening.

Until I do, there’s nothing to be said

I have KabyLake , GeminiLake, JasperLake, Xeon, and ARMv8 CPUs.

I need to see logs because I used Plex/web almost exclusively when testing
I can test on LG, Shield, Roku , and Amazon as well

m3ld4r10n · December 31, 2023, 3:50pm

Hi @ChuckPa,

Thanks for your patience. As a Seafarer I do not always have the luxury of internet access. When I do i make the most of it.

Here attached at the server logs.
Plex Media Server Logs_2023-12-31_15-47-04.zip (4.3 MB)

I did a speed test to make sure I had ample throughput prior to trying to play a video just now.

I had it in Direct Stream, original quality 8.3M, it buffered, played 5 seconds, then stalled indefinitely.

I have checked there was enough throughput.

I accessed the Plex Web using Firefox on the Laptop, MacOS, latest.

Thanks

ChuckPa · December 31, 2023, 4:20pm

@m3ld4r10n

FireFox can be weird at times; so much so that I’ve stopped using it because it’s unpredictable.

Your logs show me that PMS is working perfectly and that FireFox just stalls out
It’s doing DirectStream (6 → 2 channel audio conversion)

Dec 25, 2023 15:09:19.262 [140686260996920] DEBUG - Completed: [172.16.10.2:59590] 200 GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/1/1.m4s (17 live) #17193 TLS GZIP 690ms 148267 bytes (pipelined: 10)
Dec 25, 2023 15:09:19.327 [140686148352824] DEBUG - [Req#1719f/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 10 (10)
Dec 25, 2023 15:09:19.442 [140686136539960] DEBUG - [Req#171a2/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 11 (11)
Dec 25, 2023 15:09:19.508 [140686157585208] DEBUG - [Req#171a5/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 12 (12)
Dec 25, 2023 15:09:19.670 [140686168202040] DEBUG - [Req#171a7/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 13 (13)
Dec 25, 2023 15:09:19.791 [140686138649400] DEBUG - [Req#171a9/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 14 (14)
Dec 25, 2023 15:09:19.848 [140686148352824] DEBUG - [Req#171ab/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 15 (15)
Dec 25, 2023 15:09:20.255 [140686136539960] DEBUG - [Req#171ad/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 16 (16)
Dec 25, 2023 15:09:20.381 [140686157585208] DEBUG - [Req#171b0/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 17 (17)
Dec 25, 2023 15:09:20.474 [140686168202040] DEBUG - [Req#171b2/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 18 (18)
Dec 25, 2023 15:09:20.569 [140686138649400] DEBUG - [Req#171b5/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 19 (19)
Dec 25, 2023 15:09:20.658 [140686148352824] DEBUG - [Req#171b7/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 20 (20)
Dec 25, 2023 15:09:20.740 [140686140758840] DEBUG - [Req#171b9/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 21 (21)
Dec 25, 2023 15:09:21.046 [140686157585208] DEBUG - [Req#171bb/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 22 (22)
Dec 25, 2023 15:09:21.482 [140686138649400] DEBUG - [Req#171c2/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17Dec 25, 2023 15:09:19.262 [140686260996920] DEBUG - Completed: [172.16.10.2:59590] 200 GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/1/1.m4s (17 live) #17193 TLS GZIP 690ms 148267 bytes (pipelined: 10)
Dec 25, 2023 15:09:19.327 [140686148352824] DEBUG - [Req#1719f/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 10 (10)
Dec 25, 2023 15:09:19.442 [140686136539960] DEBUG - [Req#171a2/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 11 (11)
Dec 25, 2023 15:09:19.508 [140686157585208] DEBUG - [Req#171a5/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 12 (12)
Dec 25, 2023 15:09:19.670 [140686168202040] DEBUG - [Req#171a7/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 13 (13)
Dec 25, 2023 15:09:19.791 [140686138649400] DEBUG - [Req#171a9/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 14 (14)
Dec 25, 2023 15:09:19.848 [140686148352824] DEBUG - [Req#171ab/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 15 (15)
Dec 25, 2023 15:09:20.255 [140686136539960] DEBUG - [Req#171ad/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 16 (16)
Dec 25, 2023 15:09:20.381 [140686157585208] DEBUG - [Req#171b0/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 17 (17)
Dec 25, 2023 15:09:20.474 [140686168202040] DEBUG - [Req#171b2/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 18 (18)
Dec 25, 2023 15:09:20.569 [140686138649400] DEBUG - [Req#171b5/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 19 (19)
Dec 25, 2023 15:09:20.658 [140686148352824] DEBUG - [Req#171b7/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 20 (20)
Dec 25, 2023 15:09:20.740 [140686140758840] DEBUG - [Req#171b9/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 21 (21)
Dec 25, 2023 15:09:21.046 [140686157585208] DEBUG - [Req#171bb/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 22 (22)
Dec 25, 2023 15:09:21.482 [140686138649400] DEBUG - [Req#171c2/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 23 (23)
Dec 25, 2023 15:09:21.712 [140686140758840] DEBUG - [Req#171c5/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 24 (24)
Dec 25, 2023 15:09:21.856 [140686136539960] DEBUG - [Req#171c7/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 25 (25)
Dec 25, 2023 15:09:22.003 [140686146243384] DEBUG - [Req#171c9/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 26 (26)
Dec 25, 2023 15:09:22.396 [140686168202040] DEBUG - [Req#171cc/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 27 (27)
Dec 25, 2023 15:09:22.868 [140686157585208] DEBUG - [Req#171ce/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 28 (28)
Dec 25, 2023 15:09:23.224 [140686168202040] DEBUG - [Req#171d1/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 29 (29)
Dec 25, 2023 15:09:23.537 [140686140758840] DEBUG - [Req#171d4/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 30 (30)
Dec 25, 2023 15:09:23.819 [140686136539960] DEBUG - [Req#171d7/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 31 (31)
Dec 25, 2023 15:09:24.245 [140686138649400] DEBUG - [Req#171d9/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 32 (32)
Dec 25, 2023 15:09:24.695 [140686136539960] DEBUG - [Req#171dc/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 33 (33)
Dec 25, 2023 15:09:25.103 [140686148352824] DEBUG - [Req#171df/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 34 (34)
Dec 25, 2023 15:09:25.559 [140686157585208] DEBUG - [Req#171e2/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 35 (35)
Dec 25, 2023 15:09:25.950 [140686140758840] DEBUG - [Req#171e5/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 36 (36)
Dec 25, 2023 15:09:26.440 [140686157585208] DEBUG - [Req#171ec/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 37 (37)
Dec 25, 2023 15:09:26.649 [140686258887480] DEBUG - Failed to stream media, client probably disconnected after 1704752 bytes: 32 - Broken pipe
Dec 25, 2023 15:09:26.649 [140686258887480] DEBUG - Completed after connection close: [172.16.10.2:59591] 200 GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/0/0.m4s (17 live) #17187 TLS GZIP 10124ms 1704752 bytes (pipelined: 5)
Dec 25, 2023 15:09:26.929 [140686140758840] DEBUG - [Req#171ee/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 38 (38)
Dec 25, 2023 15:09:27.293 [140686157585208] DEBUG - Request: [172.16.10.2:59590 (WAN)] GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/0/0.m4s (16 live) #171a1 TLS GZIP Signed-in
Dec 25, 2023 15:09:27.293 [140686157585208] DEBUG - [Req#171a1/Transcode/3hfbq6wrnd84ifvjquddjduq] Asked for segment 0 from session.
Dec 25, 2023 15:09:27.293 [140686157585208] DEBUG - [Req#171a1/Transcode/3hfbq6wrnd84ifvjquddjduq] Returning segment 0 from session
Dec 25, 2023 15:09:27.293 [140686157585208] DEBUG - Content-Length of /media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-3hfbq6wrnd84ifvjquddjduq-be2ca17e-5aef-4382-ad8b-6917166c3dbf/init-stream0.m4s,/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-3hfbq6wrnd84ifvjquddjduq-be2ca17e-5aef-4382-ad8b-6917166c3dbf/chunk-stream0-00001.m4s is 10484081 (of total: 10484081).
Dec 25, 2023 15:09:27.379 [140686146243384] DEBUG - [Req#171f2/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 39 (39)
Dec 25, 2023 15:09:27.442 [140686168202040] DEBUG - [Req#171f4/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Session 3hfbq6wrnd84ifvjquddjduq (4) is throttling
Dec 25, 2023 15:09:27.442 [140686138649400] DEBUG - [Req#171f7/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Throttle - Going into sloth mode.
Dec 25, 2023 15:09:37.408 [140686258887480] DEBUG - Failed to stream media, client probably disconnected after 1671984 bytes: 32 - Broken pipe
Dec 25, 2023 15:09:37.408 [140686258887480] DEBUG - Completed after connection close: [172.16.10.2:59590] 200 GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/0/0.m4s (5 live) #171a1 TLS GZIP 10115ms 1671984 bytes (pipelined: 11)
Dec 25, 2023 15:09:40.601 [140686136539960] DEBUG - Request: [172.16.10.2:59659 (WAN)] GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/0/0.m4s (5 live) #171f5 TLS GZIP Signed-in
Dec 25, 2023 15:09:40.601 [140686136539960] DEBUG - [Req#171f5/Transcode/3hfbq6wrnd84ifvjquddjduq] Asked for segment 0 from session.
Dec 25, 2023 15:09:40.601 [140686136539960] DEBUG - [Req#171f5/Transcode/3hfbq6wrnd84ifvjquddjduq] Returning segment 0 from session
Dec 25, 2023 15:09:40.601 [140686136539960] DEBUG - Content-Length of /media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-3hfbq6wrnd84ifvjquddjduq-be2ca17e-5aef-4382-ad8b-6917166c3dbf/init-stream0.m4s,/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-3hfbq6wrnd84ifvjquddjduq-be2ca17e-5aef-4382-ad8b-6917166c3dbf/chunk-stream0-00001.m4s is 10484081 (of total: 10484081).
Dec 25, 2023 15:09:43.178 [140686136539960] DEBUG - Request: [172.16.10.2:59663 (WAN)] GET /web/index.html (6 live) #17226 TLS GZIP Signed-in
Dec 25, 2023 15:09:43.178 [140686136539960] DEBUG - [Req#17226] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/index.html"
Dec 25, 2023 15:09:43.178 [140686136539960] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/index.html is 12417 (of total: 12417).
Dec 25, 2023 15:09:43.178 [140686260996920] DEBUG - Completed: [172.16.10.2:59663] 200 GET /web/index.html (6 live) #17226 TLS GZIP 0ms 12417 bytes (pipelined: 1)
Dec 25, 2023 15:09:43.609 [140686168202040] DEBUG - Request: [172.16.10.2:59663 (WAN)] GET /web/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.css (6 live) #17231 TLS GZIP Signed-in
Dec 25, 2023 15:09:43.609 [140686168202040] DEBUG - [Req#17231] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.css"
Dec 25, 2023 15:09:43.609 [140686168202040] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.css is 82380 (of total: 82380).
Dec 25, 2023 15:09:43.725 [140686258887480] DEBUG - Completed: [172.16.10.2:59663] 200 GET /web/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.css (9 live) #17231 TLS GZIP 115ms 82380 bytes (pipelined: 2)
Dec 25, 2023 15:09:43.845 [140686136539960] DEBUG - Request: [172.16.10.2:59665 (WAN)] GET /web/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.css (9 live) #17233 TLS GZIP Signed-in
Dec 25, 2023 15:09:43.845 [140686136539960] DEBUG - [Req#17233] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.css"
Dec 25, 2023 15:09:43.845 [140686136539960] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.css is 461427 (of total: 461427).
Dec 25, 2023 15:09:43.863 [140686157585208] DEBUG - Request: [172.16.10.2:59667 (WAN)] GET /web/js/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.js (9 live) #17230 TLS GZIP Signed-in
Dec 25, 2023 15:09:43.863 [140686157585208] DEBUG - [Req#17230] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/js/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.js"
Dec 25, 2023 15:09:43.863 [140686157585208] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/js/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.js is 3241408 (of total: 3241408).
Dec 25, 2023 15:09:44.005 [140686146243384] DEBUG - Request: [172.16.10.2:59666 (WAN)] GET /web/js/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.js (9 live) #17234 TLS GZIP Signed-in
Dec 25, 2023 15:09:44.005 [140686146243384] DEBUG - [Req#17234] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/js/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.js"
Dec 25, 2023 15:09:44.005 [140686146243384] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/js/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.js is 1769888 (of total: 1769888).
Dec 25, 2023 15:09:44.376 [140686258887480] DEBUG - Completed: [172.16.10.2:59665] 200 GET /web/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.css (9 live) #17233 TLS GZIP 531ms 461427 bytes (pipelined: 1)
Dec 25, 2023 15:09:46.516 [140686140758840] DEBUG - Request: [172.16.10.2:59665 (WAN)] GET /web/static/icon-ipad@2x.png (9 live) #17239 TLS GZIP Signed-in
Dec 25, 2023 15:09:46.517 [140686140758840] DEBUG - [Req#17239] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/static/icon-ipad@2x.png"
Dec 25, 2023 15:09:46.517 [140686136539960] DEBUG - Request: [172.16.10.2:59663 (WAN)] GET /web/favicon.ico (9 live) #17236 TLS GZIP Signed-in
Dec 25, 2023 15:09:46.517 [140686140758840] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/static/icon-ipad@2x.png is 14211 (of total: 14211).
Dec 25, 2023 15:09:46.517 [140686136539960] DEBUG - [Req#17236] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/favicon.ico"
Dec 25, 2023 15:09:46.517 [140686136539960] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/favicon.ico is 5430 (of total: 5430).
Dec 25, 2023 15:09:46.517 [140686258887480] DEBUG - Completed: [172.16.10.2:59665] 200 GET /web/static/icon-ipad@2x.png (9 live) #17239 TLS GZIP 0ms 14211 bytes (pipelined: 2)
Dec 25, 2023 15:09:46.517 [140686260996920] DEBUG - Completed: [172.16.10.2:59663] 200 GET /web/favicon.ico (9 live) #17236 TLS GZIP 0ms 5430 bytes (pipelined: 3)
Dec 25, 2023 15:09:49.824 [140686260996920] DEBUG - Completed: [172.16.10.2:59666] 200 GET /web/js/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.js (9 live) #17234 TLS GZIP 5819ms 1769888 bytes (pipelined: 1)
Dec 25, 2023 15:09:50.558 [140686258887480] DEBUG - Failed to stream media, client probably disconnected after 1622832 bytes: 32 - Broken pipe
Dec 25, 2023 15:09:50.558 [140686258887480] DEBUG - Completed after connection close: [172.16.10.2:59659] 200 GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/0/0.m4s (9 live) #171f5 TLS GZIP 9957ms 1622832 bytes (pipelined: 1)
Dec 25, 2023 15:09:56.721 [140686157585208] DEBUG - Request: [172.16.10.2:59681 (WAN)] GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/0/0.m4s (9 live) #17235 TLS GZIP Signed-in
Dec 25, 2023 15:09:56.721 [140686157585208] DEBUG - [Req#17235/Transcode/3hfbq6wrnd84ifvjquddjduq] Asked for segment 0 from session.
Dec 25, 2023 15:09:56.721 [140686157585208] DEBUG - [Req#17235/Transcode/3hfbq6wrnd84ifvjquddjduq] Returning segment 0 from session
Dec 25, 2023 15:09:56.721 [140686157585208] DEBUG - Content-Length of /media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-3hfbq6wrnd84ifvjquddjduq-be2ca17e-5aef-4382-ad8b-6917166c3dbf/init-stream0.m4s,/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-3hfbq6wrnd84ifvjquddjduq-be2ca17e-5aef-4382-ad8b-6917166c3dbf/chunk-stream0-00001.m4s is 10484081 (of total: 10484081).
Dec 25, 2023 15:09:57.972 [140686260996920] DEBUG - Completed: [172.16.10.2:59667] 200 GET /web/js/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.js (9 live) #17230 TLS GZIP 14108ms 3241408 bytes (pipelined: 1)
Dec 25, 2023 15:10:02.868 [140686140758840] DEBUG - Request: [172.16.10.2:59667 (WAN)] GET /web/translations/en-GB.json (9 live) #17265 TLS GZIP Signed-in
Dec 25, 2023 15:10:02.868 [140686140758840] DEBUG - [Req#17265] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/translations/en-GB.json"
Dec 25, 2023 15:10:02.868 [140686140758840] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/translations/en-GB.json is 15570 (of total: 15570).
Dec 25, 2023 15:10:02.868 [140686258887480] DEBUG - Completed: [172.16.10.2:59667] 200 GET /web/translations/en-GB.json (9 live) #17265 TLS GZIP 0ms 15570 bytes (pipelined: 2)
Dec 25, 2023 15:10:05.268 [140686258887480] DEBUG - Request: [172.16.10.2:59667 (WAN)] GET /media/providers (9 live) #17274 TLS GZIP Signed-in
Dec 25, 2023 15:10:05.268 [140686258887480] DEBUG - Completed: [172.16.10.2:59667] 401 GET /media/providers (9 live) #17274 TLS GZIP 0ms 357 bytes
Dec 25, 2023 15:10:05.268 [140686260996920] DEBUG - Request: [172.16.10.2:59666 (WAN)] GET / (9 live) #1724a TLS GZIP Signed-in
Dec 25, 2023 15:10:05.269 [140686260996920] DEBUG - Completed: [172.16.10.2:59666] 401 GET / (9 live) #1724a TLS GZIP 0ms 435 bytes
Dec 25, 2023 15:10:05.381 [140686168202040] DEBUG - Request: [172.16.10.2:59665 (WAN)] GET /identity (8 live) #17242 TLS GZIP Signed-in
Dec 25, 2023 15:10:05.381 [140686260996920] DEBUG - Completed: [172.16.10.2:59665] 200 GET /identity (8 live) #17242 TLS GZIP 0ms 479 bytes (pipelined: 3)
Dec 25, 2023 15:10:05.555 [140686140758840] DEBUG - Request: [172.16.10.2:59665 (WAN)] GET /media/providers (8 live) #1727d TLS GZIP Signed-in Token (m3ld4r10n) (Firefox)
Dec 25, 2023 15:10:05.558 [140686260996920] DEBUG - Completed: [172.16.10.2:59665] 200 GET /media/providers (8 live) #1727d TLS GZIP 2ms 5394 bytes (pipelined: 4)
Dec 25, 2023 15:10:05.806 [140686157585208] DEBUG - Request: [172.16.10.2:59665 (WAN)] GET /status/sessions (8 live) #1727f TLS GZIP Signed-in Token (m3ld4r10n) (Firefox)
Dec 25, 2023 15:10:05.806 [140686157585208] DEBUG - [Req#1727f] [Now] Adding 1 sessions.
Dec 25, 2023 15:10:05.807 [140686260996920] DEBUG - Completed: [172.16.10.2:59665] 200 GET /status/sessions (8 live) #1727f TLS GZIP 1ms 1716 bytes (pipelined: 5)
Dec 25, 2023 15:10:05.817 [140686146243384] DEBUG - Request: [172.16.10.2:59663 (WAN)] GET /:/prefs (8 live) #17243 TLS GZIP Signed-in Token (m3ld4r10n) (Firefox)
Dec 25, 2023 15:10:05.821 [140686258887480] DEBUG - Completed: [172.16.10.2:59663] 200 GET /:/prefs (8 live) #17243 TLS GZIP 4ms 8966 bytes (pipelined: 4)
Dec 25, 2023 15:10:05.929 [140686138649400] DEBUG - Request: [172.16.10.2:59665 (WAN)] GET /updater/status (8 live) #17280 TLS GZIP Signed-in Token (m3ld4r10n) (Firefox)
Dec 25, 2023 15:10:05.929 [140686260996920] DEBUG - Completed: [172.16.10.2:59665] 200 GET /updater/status (8 live) #17280 TLS GZIP 0ms 440 bytes (pipelined: 6)
Dec 25, 2023 15:10:06.025 [140686136539960] DEBUG - Request: [172.16.10.2:59683 (WAN)] GET /media/providers (8 live) #17262 TLS GZIP Signed-in Token (m3ld4r10n) (Firefox)
Dec 25, 2023 15:10:06.028 [140686258887480] DEBUG - Completed: [172.16.10.2:59683] 200 GET /media/providers (10 live) #17262 TLS GZIP 2ms 5524 bytes (pipelined: 1)
Dec 25, 2023 15:10:06.056 [140686168202040] DEBUG - Request: [172.16.10.2:59665 (WAN)] PUT /updater/check?download=0 (10 live) #17283 TLS GZIP Signed-in Token (m3ld4r10n) (Firefox)
Dec 25, 2023 15:10:06.057 [140686168202040] DEBUG - [Req#17283] AutoUpdate: requesting check endpoint: /updater/products/5/check.xml?build=linux-x86_64&channel=16&distribution=debian&version=1.32.8.7639-fb6452ebf, download: NO
Dec 25, 2023 15:10:06.057 [140686168202040] DEBUG - [Req#17283] Downloading document https://plex.tv/updater/products/5/check.xml?build=linux-x86_64&channel=16&distribution=debian&version=1.32.8.7639-fb6452ebf
Dec 25, 2023 15:10:06.057 [140686168202040] DEBUG - [Req#17283/HCl#431] HTTP requesting GET https://plex.tv/updater/products/5/check.xml?build=linux-x86_64&channel=16&distribution=debian&version=1.32.8.7639-fb6452ebf
Dec 25, 2023 15:10:06.185 [140686225066808] DEBUG - [HttpClient/HCl#431] HTTP/2.0 (0.1s) 200 response from GET https://plex.tv/updater/products/5/check.xml?build=linux-x86_64&channel=16&distribution=debian&version=1.32.8.7639-fb6452ebf
Dec 25, 2023 15:10:06.186 [140686168202040] INFO - [Req#17283] AutoUpdate: no updates available
Dec 25, 2023 15:10:06.186 [140686260996920] DEBUG - Completed: [172.16.10.2:59665] 200 PUT /updater/check?download=0 (10 live) #17283 TLS GZIP 129ms 325 bytes (pipelined: 7)
Dec 25, 2023 15:10:06.321 [140686140758840] DEBUG - Request: [172.16.10.2:59689 (WAN)] GET /:/websockets/notifications (10 live) #17284 TLS GZIP Signed-in Token (m3ld4r10n) (Firefox)
Dec 25, 2023 15:10:06.321 [140686140758840] DEBUG - WebSocket: Performing handshake from origin https://172.16.1.5:32400
Dec 25, 2023 15:10:06.321 [140686140758840] DEBUG - Beginning read from WebSocket
Dec 25, 2023 15:10:06.462 [140686258887480] DEBUG - Failed to stream media, client probably disconnected after 2343728 bytes: 104 - Connection reset by peer
Dec 25, 2023 15:10:06.462 [140686258887480] DEBUG - Completed after connection close: [172.16.10.2:59681] 200 GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/0/0.m4s (10 live) #17235 TLS GZIP 9741ms 2343728 bytes (pipelined: 1)e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 23 (23)
Dec 25, 2023 15:09:21.712 [140686140758840] DEBUG - [Req#171c5/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 24 (24)
Dec 25, 2023 15:09:21.856 [140686136539960] DEBUG - 
Dec 25, 2023 15:09:26.649 [140686258887480] DEBUG - Failed to stream media, client probably disconnected after 1704752 bytes: 32 - Broken pipe
Dec 25, 2023 15:09:26.649 [140686258887480] DEBUG - Completed after connection close: [172.16.10.2:59591] 200 GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/0/0.m4s (17 live) #17187 TLS GZIP 10124ms 1704752 bytes (pipelined: 5)
Dec 25, 2023 15:09:26.929 [140686140758840] DEBUG - [Req#171ee/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 38 (38)
Dec 25, 2023 15:09:27.293 [140686157585208] DEBUG - Request: [172.16.10.2:59590 (WAN)] GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/0/0.m4s (16 live) #171a1 TLS GZIP Signed-in
Dec 25, 2023 15:09:27.293 [140686157585208] DEBUG - [Req#171a1/Transcode/3hfbq6wrnd84ifvjquddjduq] Asked for segment 0 from session.
Dec 25, 2023 15:09:27.293 [140686157585208] DEBUG - [Req#171a1/Transcode/3hfbq6wrnd84ifvjquddjduq] Returning segment 0 from session
Dec 25, 2023 15:09:27.293 [140686157585208] DEBUG - Content-Length of /media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-3hfbq6wrnd84ifvjquddjduq-be2ca17e-5aef-4382-ad8b-6917166c3dbf/init-stream0.m4s,/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-3hfbq6wrnd84ifvjquddjduq-be2ca17e-5aef-4382-ad8b-6917166c3dbf/chunk-stream0-00001.m4s is 10484081 (of total: 10484081).
Dec 25, 2023 15:09:27.379 [140686146243384] DEBUG - [Req#171f2/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Transcoder segment range: 0 - 39 (39)
Dec 25, 2023 15:09:27.442 [140686168202040] DEBUG - [Req#171f4/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Session 3hfbq6wrnd84ifvjquddjduq (4) is throttling
Dec 25, 2023 15:09:27.442 [140686138649400] DEBUG - [Req#171f7/Transcode/3hfbq6wrnd84ifvjquddjduq/be2ca17e-5aef-4382-ad8b-6917166c3dbf] Throttle - Going into sloth mode.
Dec 25, 2023 15:09:37.408 [140686258887480] DEBUG - Failed to stream media, client probably disconnected after 1671984 bytes: 32 - Broken pipe
Dec 25, 2023 15:09:37.408 [140686258887480] DEBUG - Completed after connection close: [172.16.10.2:59590] 200 GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/0/0.m4s (5 live) #171a1 TLS GZIP 10115ms 1671984 bytes (pipelined: 11)
Dec 25, 2023 15:09:40.601 [140686136539960] DEBUG - Request: [172.16.10.2:59659 (WAN)] GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/0/0.m4s (5 live) #171f5 TLS GZIP Signed-in
Dec 25, 2023 15:09:40.601 [140686136539960] DEBUG - [Req#171f5/Transcode/3hfbq6wrnd84ifvjquddjduq] Asked for segment 0 from session.
Dec 25, 2023 15:09:40.601 [140686136539960] DEBUG - [Req#171f5/Transcode/3hfbq6wrnd84ifvjquddjduq] Returning segment 0 from session
Dec 25, 2023 15:09:40.601 [140686136539960] DEBUG - Content-Length of /media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-3hfbq6wrnd84ifvjquddjduq-be2ca17e-5aef-4382-ad8b-6917166c3dbf/init-stream0.m4s,/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-3hfbq6wrnd84ifvjquddjduq-be2ca17e-5aef-4382-ad8b-6917166c3dbf/chunk-stream0-00001.m4s is 10484081 (of total: 10484081).
Dec 25, 2023 15:09:43.178 [140686136539960] DEBUG - Request: [172.16.10.2:59663 (WAN)] GET /web/index.html (6 live) #17226 TLS GZIP Signed-in
Dec 25, 2023 15:09:43.178 [140686136539960] DEBUG - [Req#17226] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/index.html"
Dec 25, 2023 15:09:43.178 [140686136539960] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/index.html is 12417 (of total: 12417).
Dec 25, 2023 15:09:43.178 [140686260996920] DEBUG - Completed: [172.16.10.2:59663] 200 GET /web/index.html (6 live) #17226 TLS GZIP 0ms 12417 bytes (pipelined: 1)
Dec 25, 2023 15:09:43.609 [140686168202040] DEBUG - Request: [172.16.10.2:59663 (WAN)] GET /web/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.css (6 live) #17231 TLS GZIP Signed-in
Dec 25, 2023 15:09:43.609 [140686168202040] DEBUG - [Req#17231] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.css"
Dec 25, 2023 15:09:43.609 [140686168202040] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.css is 82380 (of total: 82380).
Dec 25, 2023 15:09:43.725 [140686258887480] DEBUG - Completed: [172.16.10.2:59663] 200 GET /web/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.css (9 live) #17231 TLS GZIP 115ms 82380 bytes (pipelined: 2)
Dec 25, 2023 15:09:43.845 [140686136539960] DEBUG - Request: [172.16.10.2:59665 (WAN)] GET /web/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.css (9 live) #17233 TLS GZIP Signed-in
Dec 25, 2023 15:09:43.845 [140686136539960] DEBUG - [Req#17233] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.css"
Dec 25, 2023 15:09:43.845 [140686136539960] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.css is 461427 (of total: 461427).
Dec 25, 2023 15:09:43.863 [140686157585208] DEBUG - Request: [172.16.10.2:59667 (WAN)] GET /web/js/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.js (9 live) #17230 TLS GZIP Signed-in
Dec 25, 2023 15:09:43.863 [140686157585208] DEBUG - [Req#17230] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/js/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.js"
Dec 25, 2023 15:09:43.863 [140686157585208] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/js/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.js is 3241408 (of total: 3241408).
Dec 25, 2023 15:09:44.005 [140686146243384] DEBUG - Request: [172.16.10.2:59666 (WAN)] GET /web/js/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.js (9 live) #17234 TLS GZIP Signed-in
Dec 25, 2023 15:09:44.005 [140686146243384] DEBUG - [Req#17234] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/js/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.js"
Dec 25, 2023 15:09:44.005 [140686146243384] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/js/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.js is 1769888 (of total: 1769888).
Dec 25, 2023 15:09:44.376 [140686258887480] DEBUG - Completed: [172.16.10.2:59665] 200 GET /web/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.css (9 live) #17233 TLS GZIP 531ms 461427 bytes (pipelined: 1)
Dec 25, 2023 15:09:46.516 [140686140758840] DEBUG - Request: [172.16.10.2:59665 (WAN)] GET /web/static/icon-ipad@2x.png (9 live) #17239 TLS GZIP Signed-in
Dec 25, 2023 15:09:46.517 [140686140758840] DEBUG - [Req#17239] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/static/icon-ipad@2x.png"
Dec 25, 2023 15:09:46.517 [140686136539960] DEBUG - Request: [172.16.10.2:59663 (WAN)] GET /web/favicon.ico (9 live) #17236 TLS GZIP Signed-in
Dec 25, 2023 15:09:46.517 [140686140758840] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/static/icon-ipad@2x.png is 14211 (of total: 14211).
Dec 25, 2023 15:09:46.517 [140686136539960] DEBUG - [Req#17236] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/favicon.ico"
Dec 25, 2023 15:09:46.517 [140686136539960] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/favicon.ico is 5430 (of total: 5430).
Dec 25, 2023 15:09:46.517 [140686258887480] DEBUG - Completed: [172.16.10.2:59665] 200 GET /web/static/icon-ipad@2x.png (9 live) #17239 TLS GZIP 0ms 14211 bytes (pipelined: 2)
Dec 25, 2023 15:09:46.517 [140686260996920] DEBUG - Completed: [172.16.10.2:59663] 200 GET /web/favicon.ico (9 live) #17236 TLS GZIP 0ms 5430 bytes (pipelined: 3)
Dec 25, 2023 15:09:49.824 [140686260996920] DEBUG - Completed: [172.16.10.2:59666] 200 GET /web/js/7723-7723-62a8513ca7c1d99e5273-plex-4.116.1.34633-acaef50.js (9 live) #17234 TLS GZIP 5819ms 1769888 bytes (pipelined: 1)
Dec 25, 2023 15:09:50.558 [140686258887480] DEBUG - Failed to stream media, client probably disconnected after 1622832 bytes: 32 - Broken pipe
Dec 25, 2023 15:09:50.558 [140686258887480] DEBUG - Completed after connection close: [172.16.10.2:59659] 200 GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/0/0.m4s (9 live) #171f5 TLS GZIP 9957ms 1622832 bytes (pipelined: 1)
Dec 25, 2023 15:09:56.721 [140686157585208] DEBUG - Request: [172.16.10.2:59681 (WAN)] GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/0/0.m4s (9 live) #17235 TLS GZIP Signed-in
Dec 25, 2023 15:09:56.721 [140686157585208] DEBUG - [Req#17235/Transcode/3hfbq6wrnd84ifvjquddjduq] Asked for segment 0 from session.
Dec 25, 2023 15:09:56.721 [140686157585208] DEBUG - [Req#17235/Transcode/3hfbq6wrnd84ifvjquddjduq] Returning segment 0 from session
Dec 25, 2023 15:09:56.721 [140686157585208] DEBUG - Content-Length of /media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-3hfbq6wrnd84ifvjquddjduq-be2ca17e-5aef-4382-ad8b-6917166c3dbf/init-stream0.m4s,/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-3hfbq6wrnd84ifvjquddjduq-be2ca17e-5aef-4382-ad8b-6917166c3dbf/chunk-stream0-00001.m4s is 10484081 (of total: 10484081).
Dec 25, 2023 15:09:57.972 [140686260996920] DEBUG - Completed: [172.16.10.2:59667] 200 GET /web/js/main-179-d655df7e0f4b1d14d605-plex-4.116.1.34633-acaef50.js (9 live) #17230 TLS GZIP 14108ms 3241408 bytes (pipelined: 1)
Dec 25, 2023 15:10:02.868 [140686140758840] DEBUG - Request: [172.16.10.2:59667 (WAN)] GET /web/translations/en-GB.json (9 live) #17265 TLS GZIP Signed-in
Dec 25, 2023 15:10:02.868 [140686140758840] DEBUG - [Req#17265] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/translations/en-GB.json"
Dec 25, 2023 15:10:02.868 [140686140758840] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-fb6452ebf/WebClient.bundle/Contents/Resources/translations/en-GB.json is 15570 (of total: 15570).
Dec 25, 2023 15:10:02.868 [140686258887480] DEBUG - Completed: [172.16.10.2:59667] 200 GET /web/translations/en-GB.json (9 live) #17265 TLS GZIP 0ms 15570 bytes (pipelined: 2)
Dec 25, 2023 15:10:05.268 [140686258887480] DEBUG - Request: [172.16.10.2:59667 (WAN)] GET /media/providers (9 live) #17274 TLS GZIP Signed-in
Dec 25, 2023 15:10:05.268 [140686258887480] DEBUG - Completed: [172.16.10.2:59667] 401 GET /media/providers (9 live) #17274 TLS GZIP 0ms 357 bytes
Dec 25, 2023 15:10:05.268 [140686260996920] DEBUG - Request: [172.16.10.2:59666 (WAN)] GET / (9 live) #1724a TLS GZIP Signed-in
Dec 25, 2023 15:10:05.269 [140686260996920] DEBUG - Completed: [172.16.10.2:59666] 401 GET / (9 live) #1724a TLS GZIP 0ms 435 bytes
Dec 25, 2023 15:10:05.381 [140686168202040] DEBUG - Request: [172.16.10.2:59665 (WAN)] GET /identity (8 live) #17242 TLS GZIP Signed-in
Dec 25, 2023 15:10:05.381 [140686260996920] DEBUG - Completed: [172.16.10.2:59665] 200 GET /identity (8 live) #17242 TLS GZIP 0ms 479 bytes (pipelined: 3)
Dec 25, 2023 15:10:05.555 [140686140758840] DEBUG - Request: [172.16.10.2:59665 (WAN)] GET /media/providers (8 live) #1727d TLS GZIP Signed-in Token (m3ld4r10n) (Firefox)
Dec 25, 2023 15:10:05.558 [140686260996920] DEBUG - Completed: [172.16.10.2:59665] 200 GET /media/providers (8 live) #1727d TLS GZIP 2ms 5394 bytes (pipelined: 4)
Dec 25, 2023 15:10:05.806 [140686157585208] DEBUG - Request: [172.16.10.2:59665 (WAN)] GET /status/sessions (8 live) #1727f TLS GZIP Signed-in Token (m3ld4r10n) (Firefox)
Dec 25, 2023 15:10:05.806 [140686157585208] DEBUG - [Req#1727f] [Now] Adding 1 sessions.
Dec 25, 2023 15:10:05.807 [140686260996920] DEBUG - Completed: [172.16.10.2:59665] 200 GET /status/sessions (8 live) #1727f TLS GZIP 1ms 1716 bytes (pipelined: 5)
Dec 25, 2023 15:10:05.817 [140686146243384] DEBUG - Request: [172.16.10.2:59663 (WAN)] GET /:/prefs (8 live) #17243 TLS GZIP Signed-in Token (m3ld4r10n) (Firefox)
Dec 25, 2023 15:10:05.821 [140686258887480] DEBUG - Completed: [172.16.10.2:59663] 200 GET /:/prefs (8 live) #17243 TLS GZIP 4ms 8966 bytes (pipelined: 4)
Dec 25, 2023 15:10:05.929 [140686138649400] DEBUG - Request: [172.16.10.2:59665 (WAN)] GET /updater/status (8 live) #17280 TLS GZIP Signed-in Token (m3ld4r10n) (Firefox)
Dec 25, 2023 15:10:05.929 [140686260996920] DEBUG - Completed: [172.16.10.2:59665] 200 GET /updater/status (8 live) #17280 TLS GZIP 0ms 440 bytes (pipelined: 6)
Dec 25, 2023 15:10:06.025 [140686136539960] DEBUG - Request: [172.16.10.2:59683 (WAN)] GET /media/providers (8 live) #17262 TLS GZIP Signed-in Token (m3ld4r10n) (Firefox)
Dec 25, 2023 15:10:06.028 [140686258887480] DEBUG - Completed: [172.16.10.2:59683] 200 GET /media/providers (10 live) #17262 TLS GZIP 2ms 5524 bytes (pipelined: 1)
Dec 25, 2023 15:10:06.056 [140686168202040] DEBUG - Request: [172.16.10.2:59665 (WAN)] PUT /updater/check?download=0 (10 live) #17283 TLS GZIP Signed-in Token (m3ld4r10n) (Firefox)
Dec 25, 2023 15:10:06.057 [140686168202040] DEBUG - [Req#17283] AutoUpdate: requesting check endpoint: /updater/products/5/check.xml?build=linux-x86_64&channel=16&distribution=debian&version=1.32.8.7639-fb6452ebf, download: NO
Dec 25, 2023 15:10:06.057 [140686168202040] DEBUG - [Req#17283] Downloading document https://plex.tv/updater/products/5/check.xml?build=linux-x86_64&channel=16&distribution=debian&version=1.32.8.7639-fb6452ebf
Dec 25, 2023 15:10:06.057 [140686168202040] DEBUG - [Req#17283/HCl#431] HTTP requesting GET https://plex.tv/updater/products/5/check.xml?build=linux-x86_64&channel=16&distribution=debian&version=1.32.8.7639-fb6452ebf
Dec 25, 2023 15:10:06.185 [140686225066808] DEBUG - [HttpClient/HCl#431] HTTP/2.0 (0.1s) 200 response from GET https://plex.tv/updater/products/5/check.xml?build=linux-x86_64&channel=16&distribution=debian&version=1.32.8.7639-fb6452ebf
Dec 25, 2023 15:10:06.186 [140686168202040] INFO - [Req#17283] AutoUpdate: no updates available
Dec 25, 2023 15:10:06.186 [140686260996920] DEBUG - Completed: [172.16.10.2:59665] 200 PUT /updater/check?download=0 (10 live) #17283 TLS GZIP 129ms 325 bytes (pipelined: 7)
Dec 25, 2023 15:10:06.321 [140686140758840] DEBUG - Request: [172.16.10.2:59689 (WAN)] GET /:/websockets/notifications (10 live) #17284 TLS GZIP Signed-in Token (m3ld4r10n) (Firefox)
Dec 25, 2023 15:10:06.321 [140686140758840] DEBUG - WebSocket: Performing handshake from origin https://172.16.1.5:32400
Dec 25, 2023 15:10:06.321 [140686140758840] DEBUG - Beginning read from WebSocket
Dec 25, 2023 15:10:06.462 [140686258887480] DEBUG - Failed to stream media, client probably disconnected after 2343728 bytes: 104 - Connection reset by peer
Dec 25, 2023 15:10:06.462 [140686258887480] DEBUG - Completed after connection close: [172.16.10.2:59681] 200 GET /video/:/transcode/universal/session/3hfbq6wrnd84ifvjquddjduq/0/0.m4s (10 live) #17235 TLS GZIP 9741ms 2343728 bytes (pipelined: 1)

Can you try with Safari or Chromium ?

m3ld4r10n · January 2, 2024, 12:55pm

Hi Chuck,

I have to say, I’m really quite impressed by your ability to decipher those logs. Well done!

I’m attaching another ZIP now from the server. I’ve logged in, both with Opera and Safari and my gut feeling is I had the same issue on both.

Plex Media Server Logs_2024-01-02_12-52-20.zip (4.5 MB)

I am quite keen to understand what you see this time.

ChuckPa · January 2, 2024, 5:35pm

@m3ld4r10n

Ok, what did you do to it? LOL

It’s transcoding just as it should but both FireFox and Safari fail / get disconnected.

Is your WiFi slow ?

Here you can see the transcoder running and building up the output buffer.
It goes into sloth mode (slow) because the client (safari / firefox) isn’t coming to get the data.

You see where PMS detects the terminated connection (closed tab/window) and shuts down the playback.

Jan 02, 2024 12:49:36.661 [140686148352824] DEBUG - [Req#1ef19/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 10 (10)
Jan 02, 2024 12:49:36.771 [140686083119928] DEBUG - [Req#1ef1b/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 11 (11)
Jan 02, 2024 12:49:36.832 [140686120291128] DEBUG - [Req#1ef1d/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 12 (12)
Jan 02, 2024 12:49:36.946 [140686157585208] DEBUG - [Req#1ef1f/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 13 (13)
Jan 02, 2024 12:49:36.979 [140686131878712] DEBUG - [Req#1ef22/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 14 (14)
Jan 02, 2024 12:49:37.032 [140686148352824] DEBUG - [Req#1ef24/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 15 (15)
Jan 02, 2024 12:49:37.420 [140686083119928] DEBUG - [Req#1ef26/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 16 (16)
Jan 02, 2024 12:49:37.539 [140686134430520] DEBUG - [Req#1ef28/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 17 (17)
Jan 02, 2024 12:49:37.630 [140686157585208] DEBUG - [Req#1ef2b/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 18 (18)
Jan 02, 2024 12:49:37.722 [140686131878712] DEBUG - [Req#1ef2d/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 19 (19)
Jan 02, 2024 12:49:37.807 [140686148352824] DEBUG - [Req#1ef2f/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 20 (20)
Jan 02, 2024 12:49:37.887 [140686083119928] DEBUG - [Req#1ef31/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 21 (21)
Jan 02, 2024 12:49:38.177 [140686134430520] DEBUG - [Req#1ef33/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 22 (22)
Jan 02, 2024 12:49:38.580 [140686131878712] DEBUG - [Req#1ef36/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 23 (23)
Jan 02, 2024 12:49:38.800 [140686148352824] DEBUG - [Req#1ef3d/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 24 (24)
Jan 02, 2024 12:49:38.936 [140686134430520] DEBUG - [Req#1ef3f/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 25 (25)
Jan 02, 2024 12:49:39.075 [140686157585208] DEBUG - [Req#1ef42/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 26 (26)
Jan 02, 2024 12:49:39.447 [140686131878712] DEBUG - [Req#1ef44/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 27 (27)
Jan 02, 2024 12:49:39.878 [140686083119928] DEBUG - [Req#1ef46/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 28 (28)
Jan 02, 2024 12:49:40.213 [140686131878712] DEBUG - [Req#1ef49/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 29 (29)
Jan 02, 2024 12:49:40.506 [140686083119928] DEBUG - [Req#1ef4c/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 30 (30)
Jan 02, 2024 12:49:40.831 [140686120291128] DEBUG - [Req#1ef4f/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 31 (31)
Jan 02, 2024 12:49:41.254 [140686148352824] DEBUG - [Req#1ef51/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 32 (32)
Jan 02, 2024 12:49:41.681 [140686120291128] DEBUG - [Req#1ef54/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 33 (33)
Jan 02, 2024 12:49:42.065 [140686083119928] DEBUG - [Req#1ef57/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 34 (34)
Jan 02, 2024 12:49:42.502 [140686134430520] DEBUG - [Req#1ef5c/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 35 (35)
Jan 02, 2024 12:49:42.862 [140686157585208] DEBUG - [Req#1ef5f/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 36 (36)
Jan 02, 2024 12:49:43.326 [140686120291128] DEBUG - [Req#1ef61/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 37 (37)
Jan 02, 2024 12:49:43.792 [140686157585208] DEBUG - [Req#1ef64/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 38 (38)
Jan 02, 2024 12:49:43.964 [140686260996920] DEBUG - Failed to stream media, client probably disconnected after 8160048 bytes: 104 - Connection reset by peer
Jan 02, 2024 12:49:43.964 [140686260996920] DEBUG - Completed after connection close: [172.16.1.15:65472] 200 GET /video/:/transcode/universal/session/woeonkjmsidmsy1zftcmvp38/0/0.m4s (13 live) #1eeff TLS GZIP 10000ms 8160048 bytes (pipelined: 22)
Jan 02, 2024 12:49:44.208 [140686120291128] DEBUG - [Req#1ef6b/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 39 (39)
Jan 02, 2024 12:49:44.453 [140686157585208] DEBUG - [Req#1ef6d/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Session woeonkjmsidmsy1zftcmvp38 (4) is throttling
Jan 02, 2024 12:49:44.453 [140686131878712] DEBUG - [Req#1ef71/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Throttle - Going into sloth mode.
Jan 02, 2024 12:49:44.724 [140686148352824] DEBUG - Request: [172.16.1.15:65479 (Subnet)] GET /video/:/transcode/universal/session/woeonkjmsidmsy1zftcmvp38/0/0.m4s (12 live) #1ef08 TLS GZIP Signed-in
Jan 02, 2024 12:49:44.724 [140686148352824] DEBUG - [Req#1ef08/Transcode/woeonkjmsidmsy1zftcmvp38] Asked for segment 0 from session.
Jan 02, 2024 12:49:44.724 [140686148352824] DEBUG - [Req#1ef08/Transcode/woeonkjmsidmsy1zftcmvp38] Returning segment 0 from session
Jan 02, 2024 12:49:44.724 [140686148352824] DEBUG - Content-Length of /media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-woeonkjmsidmsy1zftcmvp38-cecdc2c1-b36f-48fa-819b-cac1676d20d9/init-stream0.m4s,/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-woeonkjmsidmsy1zftcmvp38-cecdc2c1-b36f-48fa-819b-cac1676d20d9/chunk-stream0-00001.m4s is 10484081 (of total: 10484081).
Jan 02, 2024 12:49:54.857 [140686260996920] DEBUG - Failed to stream media, client probably disconnected after 7111472 bytes: 32 - Broken pipe
Jan 02, 2024 12:49:54.857 [140686260996920] DEBUG - Completed after connection close: [172.16.1.15:65479] 200 GET /video/:/transcode/universal/session/woeonkjmsidmsy1zftcmvp38/0/0.m4s (5 live) #1ef08 TLS GZIP 10133ms 7111472 bytes (pipelined: 20)
Jan 02, 2024 12:49:56.805 [140686148352824] DEBUG - Request: [172.16.1.15:65497 (Subnet)] GET /video/:/transcode/universal/session/woeonkjmsidmsy1zftcmvp38/0/0.m4s (5 live) #1ef6f TLS GZIP Signed-in
Jan 02, 2024 12:49:56.805 [140686148352824] DEBUG - [Req#1ef6f/Transcode/woeonkjmsidmsy1zftcmvp38] Asked for segment 0 from session.
Jan 02, 2024 12:49:56.805 [140686148352824] DEBUG - [Req#1ef6f/Transcode/woeonkjmsidmsy1zftcmvp38] Returning segment 0 from session
Jan 02, 2024 12:49:56.805 [140686148352824] DEBUG - Content-Length of /media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-woeonkjmsidmsy1zftcmvp38-cecdc2c1-b36f-48fa-819b-cac1676d20d9/init-stream0.m4s,/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-woeonkjmsidmsy1zftcmvp38-cecdc2c1-b36f-48fa-819b-cac1676d20d9/chunk-stream0-00001.m4s is 10484081 (of total: 10484081).
Jan 02, 2024 12:50:06.365 [140686120291128] DEBUG - [Req#1ef9a/Transcode/woeonkjmsidmsy1zftcmvp38/cecdc2c1-b36f-48fa-819b-cac1676d20d9] Transcoder segment range: 0 - 40 (40)
Jan 02, 2024 12:50:06.681 [140686260996920] DEBUG - Failed to stream media, client probably disconnected after 6275888 bytes: 32 - Broken pipe
Jan 02, 2024 12:50:06.682 [140686260996920] DEBUG - Completed after connection close: [172.16.1.15:65497] 200 GET /video/:/transcode/universal/session/woeonkjmsidmsy1zftcmvp38/0/0.m4s (5 live) #1ef6f TLS GZIP 9876ms 6275888 bytes (pipelined: 1)
Jan 02, 2024 12:50:11.344 [140686157585208] DEBUG - Request: [172.16.1.15:65518 (Subnet)] GET /video/:/transcode/universal/session/woeonkjmsidmsy1zftcmvp38/0/0.m4s (5 live) #1efb5 TLS GZIP Signed-in
Jan 02, 2024 12:50:11.344 [140686157585208] DEBUG - [Req#1efb5/Transcode/woeonkjmsidmsy1zftcmvp38] Asked for segment 0 from session.
Jan 02, 2024 12:50:11.344 [140686157585208] DEBUG - [Req#1efb5/Transcode/woeonkjmsidmsy1zftcmvp38] Returning segment 0 from session
Jan 02, 2024 12:50:11.345 [140686157585208] DEBUG - Content-Length of /media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-woeonkjmsidmsy1zftcmvp38-cecdc2c1-b36f-48fa-819b-cac1676d20d9/init-stream0.m4s,/media/local-drives/plex-data/tmp/Transcode/Sessions/plex-transcode-woeonkjmsidmsy1zftcmvp38-cecdc2c1-b36f-48fa-819b-cac1676d20d9/chunk-stream0-00001.m4s is 10484081 (of total: 10484081).
Jan 02, 2024 12:50:21.246 [140686258887480] DEBUG - Failed to stream media, client probably disconnected after 7832368 bytes: 32 - Broken pipe
Jan 02, 2024 12:50:21.246 [140686258887480] DEBUG - Completed after connection close: [172.16.1.15:65518] 200 GET /video/:/transcode/universal/session/woeonkjmsidmsy1zftcmvp38/0/0.m4s (5 live) #1efb5 TLS GZIP 9902ms 7832368 bytes (pipelined: 1)
Jan 02, 2024 12:50:25.064 [140686131878712] DEBUG - Request: [172.16.1.15:49168 (Subnet)] GET /:/timeline?ratingKey=729&key=%2Flibrary%2Fmetadata%2F729&playbackTime=0&playQueueItemID=594&state=paused&hasMDE=1&context=home%3Ahub.continueWatching&row=0&col=1&time=0&duration=3472000 (5 live) #1efc6 TLS GZIP Signed-in Token (m3ld4r10n) (Safari)
Jan 02, 2024 12:50:25.065 [140686131878712] DEBUG - [Req#1efc6] Client [vgfk4qwovxknxqb0jr271ov6] reporting timeline state paused, progress of 0/3472000ms for guid=, playbackTime=0ms ratingKey=729 url=, key=/library/metadata/729, containerKey=, metadataId=729, source=

m3ld4r10n · January 3, 2024, 4:04pm

Ha ha ha!

I haven’t, to my knowledge, done anything. But I’m glad you got some humour out of it.

As I said in the original post, I’ve even tried reinstallations.

I’m on the site of the plex server’s Hyp today so I tested over LAN and it played no issue at all just now.

But, seizing on your idea of slow WIFI I’ve done some more speed tests.

I’ve logged into a VPN at a datacentre and I will attempt to play the stream, from the plex server here, over HTTPS to there, then from there to my laptop here - that makes sense?

Plex Server (Site1) > HTTPS > Data Centre (Site2) > VPN > Laptop (Site1).

Here’s the speedtest from laptop to Datacentre:

Here’s the speedtest from the Plex server:

Should be good enough for a single 8M stream, right? Unfortunately same issue.

Anyway, that test failed. So I tried another method.

Tethered to my phone (speed test attached) and then tried to stream over HTTPS. Worked with direct steaming on Safari and Firefox - with some buffering..

Following on from this I reconnected to Site1 VPN (an OpenVPN Access Server running on a VM with plenty of resources!.. Failed again. VPN now showing much throughput.

Then tried the VPN built into a router, same result - with failed stream.

Then tried Site2 VPN in netherlands accessing plex over https. Failed.

I’m at a bit of a loss really. Everything I’m seeing says it should be working. But it’s not. But at least from this I guess we can conclude the issue is overhwlmingly something to do with VPNs?

Just to be sure I tried an L2TP over IPSEC to Site2 then HTTPS to Plex at Site1 and it failed again… So… Really not sure how to find the bottle neck at this point. It’s way beyond me. But i changed nothing in my setups.

ChuckPa · January 3, 2024, 4:35pm

This is starting to sound very much like another user I just helped.

His situation:

Server hosted in NL.
His location - Western Oz.
I could play from his server without issue
His playbacks always stuttered / failed

The server was moved from NL → Taiwan (Closer to him)

Playback became choppy for me
Playback worked flawlessly for him.

Possible ?

system · April 2, 2024, 4:36pm

This topic was automatically closed 90 days after the last reply. New replies are no longer allowed.

Topic		Replies	Views
Plex Media Server performance issue Plex Media Server server-synology	16	1257	July 14, 2020
No longer able to play video on server build 1.16.1.1291 Desktops & Laptops server-windows	3	420	September 29, 2019
Endless transcoding/buffering Desktops & Laptops server-linux	40	1554	June 14, 2020
Why does my server need to transcode/convert files? NAS & Devices server-linux	29	313	April 15, 2022
New Mac Plex app doesn't properly trigger transcoding when indirectly streaming Desktop Players player-mac	27	26742	January 14, 2020

Unable to Play any video content on latest plex server using web browser or app

Related topics