Consistent Transcode Errors

Plex Media Server Desktops & Laptops
1

Server Version#: 1.16.0.1226 (although, this was happening with the previous server version as well. I updated the server in attempt to fix the issue. )
Player Version#: This is happening when attempting to transcode to any client. I’ve seen this error crop up so far with the Android client and the Roku client.

Earlier this week I got some reports that streams were freezing. I typically don’t do a lot of transcoding, so I hadn’t experienced the issue myself. However, I noticed a frozen stream on an Amazon Fire tablet my daughter was watching, so I decided to investigate to see if there were any issues on the server. Lo and behold there are a ton of errors every time a stream is transcoded. I did a lot of Google searching and the consensus is that this error is related to locked files. The fix is to disable anti-virus searching the folder. However, this is on a linux server and there shouldn’t be anything locking this directory. The temporary transcode folder was originally located on a mounted storage (local). I tried moving it back to the SSD where the PMS install dir is, but I get the same errors.

This is the error message:

Caught exception trying to stream file: /mnt/media2/cache/Transcode/Sessions/plex-transcode-d3f07d6b7ca72581-com-plexapp-android-129f6f97-cbe1-4410-acae-d30cbbe5376e/media-00125.ts: write: protocol is shutdown

Recent log is attached.

Plex Media Server.log (74.3 KB)

2

Unfortunately, since you turned off DEBUG logging (doesn’t consume any more space if on or off), I can’t see what happened to help remedy.

Please turn DEBUG on, keeping VERBOSE off and recreate.

3

Will do. I’ll reply back with an updated log.

4

Collect the ZIP please?

Settings - Server - Troubleshooting - Download Logs.

It’s a lot easier for both of us.

5

Thanks for taking a look. I switched to debug log level and tried to replicate the error (by transcoding a few files), but I’m not seeing a similar error message now. Let me know what you think.

Plex Media Server Logs_2019-06-24_11-24-14.zip (1.1 MB)

6

Thank you for the logs. I see them in context now.

The logs show me the transcoder was running, filling the player’s buffer, then the player stopped playback / lost connection. (this isn’t clear)

What is clear “Protocol is shutdown” tells me the TCP/IP connection is gone (other end)

Jun 24, 2019 11:18:30.336 [0x7f078a7fc700] DEBUG - Auth: authenticated user 23647934 as Laguermo
Jun 24, 2019 11:18:30.337 [0x7f0770ff9700] DEBUG - Request: [205.197.219.74:57057 (WAN)] GET /:/timeline?ratingKey=2860&key=%2Flibrary%2Fmetadata%2F2860&playbackTime=3091129&playQueueItemID=22820&state=paused&hasMDE=1&time=3200000&duration=3553000 (20 live) TLS GZIP Signed-in Token (Laguermo)
Jun 24, 2019 11:18:30.337 [0x7f0770ff9700] DEBUG - Client [sock3zxqzzh4wmuxh3lj1c3d] reporting timeline state paused, progress of 3200000/3553000ms for guid=, ratingKey=2860 url=, key=/library/metadata/2860, containerKey=, metadataId=2860, source=
Jun 24, 2019 11:18:30.337 [0x7f0770ff9700] DEBUG - [Now] User is Laguermo (ID: 23647934)
Jun 24, 2019 11:18:30.337 [0x7f0770ff9700] DEBUG - [Now] Device is Konvergo (DESKTOP-DT4HFOL).
Jun 24, 2019 11:18:30.337 [0x7f0770ff9700] DEBUG - [Now] Profile is Konvergo
Jun 24, 2019 11:18:30.337 [0x7f0770ff9700] DEBUG - [Now] Updated play state for /library/metadata/2860.
Jun 24, 2019 11:18:30.338 [0x7f0770ff9700] DEBUG - Statistics: (9zv6qdq451uj6adzm9r4quxr) Reporting active playback in state 1 of type 4 (scrobble: 0) for account 23647934
Jun 24, 2019 11:18:30.339 [0x7f078a7fc700] DEBUG - Completed: [205.197.219.74:57057] 200 GET /:/timeline?ratingKey=2860&key=%2Flibrary%2Fmetadata%2F2860&playbackTime=3091129&playQueueItemID=22820&state=paused&hasMDE=1&time=3200000&duration=3553000 (20 live) TLS GZIP 2ms 491 bytes (pipelined: 4235)
Jun 24, 2019 11:18:30.347 [0x7f078a7fc700] DEBUG - Auth: authenticated user 1 as thomasandrew@gmail.com
Jun 24, 2019 11:18:30.348 [0x7f06baffd700] DEBUG - Request: [192.168.0.18:58758 (Subnet)] GET /status/sessions (21 live) TLS Signed-in Token (thomasandrew@gmail.com)
Jun 24, 2019 11:18:30.348 [0x7f06baffd700] DEBUG - [Now] Adding 3 sessions.
Jun 24, 2019 11:18:30.349 [0x7f078a7fc700] DEBUG - Completed: [192.168.0.18:58758] 200 GET /status/sessions (21 live) TLS 1ms 28920 bytes (pipelined: 1)
Jun 24, 2019 11:18:31.592 [0x7f0717fff700] DEBUG - Request: [67.214.249.11:40901 (WAN)] GET /video/:/transcode/universal/session/7e8522d592f14afc-com-plexapp-android/base/00102.ts (21 live) TLS Signed-in
Jun 24, 2019 11:18:31.592 [0x7f0717fff700] DEBUG - Asked for segment 102 from session.
Jun 24, 2019 11:18:31.592 [0x7f0717fff700] DEBUG - Returning segment 102 from session
Jun 24, 2019 11:18:31.592 [0x7f0717fff700] DEBUG - Content-Length of /mnt/media2/cache/Transcode/Sessions/plex-transcode-7e8522d592f14afc-com-plexapp-android-6fc31f02-c15f-4b41-9f38-b98dc201bf95/media-00102.ts is 1143416.
Jun 24, 2019 11:18:31.592 [0x7f0717fff700] ERROR - Caught exception trying to stream file: /mnt/media2/cache/Transcode/Sessions/plex-transcode-7e8522d592f14afc-com-plexapp-android-6fc31f02-c15f-4b41-9f38-b98dc201bf95/media-00102.ts: write: protocol is shutdown
7

I am using a non-standard port. Would that cause an issue like this?

8

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