Playback Terminated Conversion fail on RoKu

Server Version#: 1.25.2
Player Version#: 4.66.1
Ever since upgrading to “PlexMediaServer-1.25.2.5319-c43dc0277-x86_64.qpkg” on my Qnap many of my videos are stopping a few minutes before they’re done and showing the following message on RoKu: “Playback Terminated Conversion fail. The transcoder process crashed.”

I can’t find anywhere on Plex to submit this to support. Any help or guidance is much appreciated

TIA
Jim

@jimmacmillan

Right here is where you get support.

Please recreate the failure then download the logs ZIP file and attach it.

I’ll look and see what’s not working as expected

Server Log.zip (2.7 KB)
Thank you ChuckPa. I didn’t know that this is where to find tech support. Attached is the log after recreating the error.

Jim

Jim,
You grabbed the Plex/Web log

I need the server logs

Settings - Server - Troubleshooting (lower left corner) - Download Logs.

It will give you a zip file.

That’s what I need to see,

Thanks

Plex Media Server Logs_2021-12-28_21-36-29.zip (3.4 MB)
Oops. Here you go.

Thanks
Jim

ONE MORE REQUEST :slight_smile:

Turn DEBUG logging back on ?

It’s on by default. You turned it off.

I can’t see what’s happening without it.

This is all I get

Dec 28, 2021 20:08:33.105 [0x7fa820614b38] WARN - QueryParser: Invalid field 'contentDirectoryID' found, ignoring.
Dec 28, 2021 20:08:33.105 [0x7fa820614b38] WARN - QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Dec 28, 2021 20:08:59.609 [0x7fa81fb13b38] INFO - [Transcode/54158cad-2ee9-450f-8884-9402b2f1f789-174] CodecManager: starting EAE at "/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Library/tmp/pms-931732fd-df2f-4abd-9e19-1525b2e23251/EasyAudioEncoder"
Dec 28, 2021 20:09:04.580 [0x7fa81fb13b38] WARN - Overzealous client asked for end range of 2228223, content size is 2118196; we'll clip.
Dec 28, 2021 20:09:08.363 [0x7fa81fe79b38] WARN - Overzealous client asked for end range of 294911, content size is 61664; we'll clip.
Dec 28, 2021 20:09:08.365 [0x7fa81fb13b38] WARN - Overzealous client asked for end range of 589823, content size is 61664; we'll clip.
Dec 28, 2021 20:09:08.365 [0x7fa81fb13b38] WARN - Range could not be satisfied 294912 - 61663 (total size=61664)
Dec 28, 2021 20:09:08.366 [0x7fa82026ab38] WARN - Overzealous client asked for end range of 1179647, content size is 61664; we'll clip.
Dec 28, 2021 20:09:08.366 [0x7fa82026ab38] WARN - Range could not be satisfied 884736 - 61663 (total size=61664)
Dec 28, 2021 20:09:08.366 [0x7fa820614b38] WARN - Overzealous client asked for end range of 884735, content size is 61664; we'll clip.
Dec 28, 2021 20:09:08.366 [0x7fa820614b38] WARN - Range could not be satisfied 589824 - 61663 (total size=61664)
Dec 28, 2021 20:09:26.782 [0x7fa82018bb38] WARN - Overzealous client asked for end range of 2490367, content size is 2372372; we'll clip.
Dec 28, 2021 20:09:27.667 [0x7fa82026ab38] WARN - Overzealous client asked for end range of 1507327, content size is 1506444; we'll clip.
Dec 28, 2021 20:09:42.143 [0x7fa81fb13b38] WARN - Overzealous client asked for end range of 2228223, content size is 2215392; we'll clip.
Dec 28, 2021 20:09:47.475 [0x7fa82026ab38] WARN - Overzealous client asked for end range of 2686975, content size is 2464680; we'll clip.
Dec 28, 2021 20:09:53.903 [0x7fa81fe79b38] WARN - Overzealous client asked for end range of 2293759, content size is 2289652; we'll clip.
Dec 28, 2021 20:09:55.245 [0x7fa81fe79b38] WARN - Overzealous client asked for end range of 2359295, content size is 2152788; we'll clip.
Dec 28, 2021 20:10:28.742 [0x7fa820614b38] WARN - Overzealous client asked for end range of 2490367, content size is 2454716; we'll clip.
Dec 28, 2021 20:10:31.720 [0x7fa81fe79b38] WARN - Overzealous client asked for end range of 1048575, content size is 667212; we'll clip.
Dec 28, 2021 20:10:31.721 [0x7fa820614b38] WARN - Overzealous client asked for end range of 1572863, content size is 667212; we'll clip.
Dec 28, 2021 20:10:31.721 [0x7fa820614b38] WARN - Range could not be satisfied 1048576 - 667211 (total size=667212)
Dec 28, 2021 20:10:31.722 [0x7fa82026ab38] WARN - Overzealous client asked for end range of 2097151, content size is 667212; we'll clip.
Dec 28, 2021 20:10:31.722 [0x7fa82026ab38] WARN - Range could not be satisfied 1572864 - 667211 (total size=667212)
Dec 28, 2021 20:10:31.783 [0x7fa81fb13b38] WARN - Overzealous client asked for end range of 147455, content size is 61664; we'll clip.

which is pretty uninformative.

You’ll need to enable and then recreate

Should I set it for Verbose or Enabled?

Thanks
Jim

DEBUG ON, Keep VERBOSE OFF (too much info) – SAVE

then recreate and download again.

Plex Media Server Logs_2021-12-28_21-50-57.zip (3.5 MB)
How does this look?

Thanks
Jim

Looks much better thanks.

  1. In your app settings, DirectStream is disabled ?

  2. Is the tv allows MP3 audio only ? I’m a bit confused.

ratingKey=34319 url=, key=/library/metadata/34319, containerKey=, metadataId=34319, source=
Dec 28, 2021 21:50:40.780 [0x7fa81e7f2b38] DEBUG - [Now] User is jimmacmillan (ID: 1)
Dec 28, 2021 21:50:40.780 [0x7fa81e7f2b38] DEBUG - [Now] Device is Roku (Roku - Family Room).
Dec 28, 2021 21:50:40.780 [0x7fa81e7f2b38] DEBUG - [Now] Profile is Roku-7.x
Dec 28, 2021 21:50:40.780 [0x7fa81e7f2b38] DEBUG - [Now] Updated play state for /library/metadata/34319.
Dec 28, 2021 21:50:40.780 [0x7fa81e7f2b38] DEBUG - Statistics: (00c6c400b3e4ca02e4a1ebffa437097e) Reporting active playback in state 3 of type 4 (scrobble: 0) for account 1
Dec 28, 2021 21:50:40.781 [0x7fa81e7f2b38] DEBUG - Streaming Resource: Removing session 0x7fa821f334e8:00c6c400b3e4ca02e4a1ebffa437097e
Dec 28, 2021 21:50:40.782 [0x7fa8205e0b38] DEBUG - Completed: [192.168.1.195:57168] 200 GET /:/timeline?playbackTime=62033&time=3320000&state=stopped&ratingKey=34319&key=%2Flibrary%2Fmetadata%2F34319&col=0&row=0&context=home%3Ahub.continueWatching&duration=3514687&playQueueItemID=158802 (8 live) TLS GZIP 7ms 547 bytes (pipelined: 6)
Dec 28, 2021 21:50:40.796 [0x7fa81e815b38] DEBUG - Request: [192.168.1.195:57170 (Subnet)] GET /video/:/transcode/universal/stop?session=1e362286-7bcc-46a9-99ab-6de8b44b5e7c-5 (8 live) TLS GZIP Signed-in Token (jimmacmillan)
Dec 28, 2021 21:50:40.796 [0x7fa81e815b38] WARN - [Transcode] Got a request to stop a transcode session without a valid session GUID.
Dec 28, 2021 21:50:40.796 [0x7fa8205bdb38] DEBUG - Completed: [192.168.1.195:57170] 404 GET /video/:/transcode/universal/stop?session=1e362286-7bcc-46a9-99ab-6de8b44b5e7c-5 (8 live) TLS GZIP 0ms 379 bytes (pipelined: 1)
Dec 28, 2021 21:50:44.821 [0x7fa81f652b38] DEBUG - Request: [192.168.1.195:57168 (Subnet)] GET /library/metadata/34315/children?includeDetails=1&excludeFields=&excludeElements=&includeOnDeck=1 (8 live) TLS Page 0-9 GZIP Signed-in Token (jimmacmillan)
Dec 28, 2021 21:50:44.825 [0x7fa81fadeb38] DEBUG - Request: [192.168.1.195:57170 (Subnet)] GET /library/metadata/34315 (8 live) TLS GZIP Signed-in Token (jimmacmillan)
Dec 28, 2021 21:50:44.825 [0x7fa81f652b38] DEBUG - Setting container serialization range to [0, 9] (total=-1)
Dec 28, 2021 21:50:44.832 [0x7fa8205e0b38] DEBUG - Completed: [192.168.1.195:57170] 200 GET /library/metadata/34315 (8 live) TLS GZIP 7ms 882 bytes (pipelined: 2)
Dec 28, 2021 21:50:44.833 [0x7fa81f652b38] DEBUG - Setting container serialization range to [0, 9] (total=10)
Dec 28, 2021 21:50:44.835 [0x7fa8205e0b38] DEBUG - Completed: [192.168.1.195:57168] 200 GET /library/metadata/34315/children?includeDetails=1&excludeFields=&excludeElements=&includeOnDeck=1 (8 live) TLS GZIP Page 0-9 14ms 4670 bytes (pipelined: 7)
Dec 28, 2021 21:50:44.861 [0x7fa81eba8b38] DEBUG - Request: [192.168.1.195:57176 (Subnet)] GET /music/:/transcode/universal/start?protocol=http&session=1e362286-7bcc-46a9-99ab-6de8b44b5e7c-30&directStreamAudio=0&location=lan&path=%2Flibrary%2Fmetadata%2F34314%2Ftheme%2F1640464537%2Fmetadata&directPlay=0&directStream=0&audioBoost=-250 (9 live) TLS Signed-in Token (jimmacmillan)
Dec 28, 2021 21:50:44.861 [0x7fa81eba8b38] DEBUG - [Transcode] Found session GUID of 1e362286-7bcc-46a9-99ab-6de8b44b5e7c-30 in session start.
Dec 28, 2021 21:50:44.862 [0x7fa81eba8b38] DEBUG - [Transcode] TranscodeUniversalRequest: using profile Roku-7.x
Dec 28, 2021 21:50:44.862 [0x7fa81eba8b38] DEBUG - [Transcode] Downloading document http://127.0.0.1:32400/library/metadata/34314/theme/1640464537/metadata?checkFiles=1&includeBandwidths=1&offset=-1&X-Plex-Client-Capabilities=videoDecoders%3dh264%7bprofile%3ahigh%26resolution%3a1080%26level%3d41%7d%3baudioDecoders%3daac%7bchannels%3a2%7d%2cac3%7bchannels%3a6%7d%2ceac3%7bchannels%3a8%7d&X-Plex-Incomplete-Segments=1&X-Plex-Session-Identifier=00c6c400b3e4ca02e4a1ebffa437097e
Dec 28, 2021 21:50:44.868 [0x7fa81eba8b38] DEBUG - [Transcode] It took 0.000000 ms to retrieve 167 items.
Dec 28, 2021 21:50:44.869 [0x7fa81eba8b38] DEBUG - [Transcode] Calculated media file path for path [metadata://themes/tv.plex.agents.series_c0f3be470f9d43e4eb14ceb6ab0d14c9b54ff619]: ["/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Library/Plex Media Server/Metadata/TV Shows/d/09bd92db97d7df68c0b427a6ea94caeb36d0dd4.bundle/Contents/_combined/themes/tv.plex.agents.series_c0f3be470f9d43e4eb14ceb6ab0d14c9b54ff619"]
Dec 28, 2021 21:50:44.872 [0x7fa81eba8b38] DEBUG - [Transcode] Streaming Resource: Attempting to create AdHoc transcode session 00c6c400b3e4ca02e4a1ebffa437097e
Dec 28, 2021 21:50:44.872 [0x7fa81eba8b38] DEBUG - [Transcode] MDE: Selected protocol http; container: mp3
Dec 28, 2021 21:50:44.872 [0x7fa81eba8b38] DEBUG - [Transcode] MDE: analyzing media item 33958
Dec 28, 2021 21:50:44.872 [0x7fa81eba8b38] DEBUG - [Transcode] MDE: tv.plex.agents: Direct Play is disabled
Dec 28, 2021 21:50:44.872 [0x7fa81eba8b38] DEBUG - [Transcode] MDE: tv.plex.agents: Audio Direct Streaming is disabled, so video's audio stream will be transcoded
Dec 28, 2021 21:50:44.872 [0x7fa81eba8b38] DEBUG - [Transcode] MDE: Cannot direct stream audio stream due to profile or setting limitations
Dec 28, 2021 21:50:44.872 [0x7fa81eba8b38] DEBUG - [Transcode] MDE: tv.plex.agents: selected media 0 / 33958
Dec 28, 2021 21:50:44.873 [0x7fa81eba8b38] DEBUG - [Transcode] Streaming Resource: Added session 0x7fa81f8df818:00c6c400b3e4ca02e4a1ebffa437097e
Dec 28, 2021 21:50:44.873 [0x7fa81eba8b38] DEBUG - [Transcode] Streaming Resource: Reached Decision id=34354 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=33958 part=(id=34055 decision=transcode protocol=http streams=(Audio=(id=35833 decision=transcode bitrate=320 encoder=libmp3lame channels=2 rate=44100))))
Dec 28, 2021 21:50:44.873 [0x7fa81eba8b38] DEBUG - [Transcode] Cleaning directory for session 1e362286-7bcc-46a9-99ab-6de8b44b5e7c-30 ()
Dec 28, 2021 21:50:44.873 [0x7fa81eba8b38] DEBUG - [Transcode] Starting a transcode session 1e362286-7bcc-46a9-99ab-6de8b44b5e7c-30 at offset -1.0 (state=3)
Dec 28, 2021 21:50:44.874 [0x7fa81eba8b38] DEBUG - [Transcode] [Universal] Using local file path instead of URL: /share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Library/Plex Media Server/Metadata/TV Shows/d/09bd92db97d7df68c0b427a6ea94caeb36d0dd4.bundle/Contents/_combined/themes/tv.plex.agents.series_c0f3be470f9d43e4eb14ceb6ab0d14c9b54ff619
Dec 28, 2021 21:50:44.874 [0x7fa81eba8b38] DEBUG - [Transcode/JobRunner] Job running: FFMPEG_EXTERNAL_LIBS='/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Library/Plex\ Media\ Server/Codecs/fb9eae3-4185-linux-x86_64/' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Plex Transcoder' '-codec:0' 'mp3' '-analyzeduration' '20000000' '-probesize' '20000000' '-i' '/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Library/Plex Media Server/Metadata/TV Shows/d/09bd92db97d7df68c0b427a6ea94caeb36d0dd4.bundle/Contents/_combined/themes/tv.plex.agents.series_c0f3be470f9d43e4eb14ceb6ab0d14c9b54ff619' '-filter_complex' '[0:0] aresample=async=1:ocl='\''stereo'\'':rematrix_maxval=0.000000dB:osr=44100:rematrix_volume=-35.000000dB[0]' '-map' '[0]' '-codec:0' 'libmp3lame' '-q:0' '0' '-f' 'segment' '-segment_format' 'mp3' '-segment_time' '1' '-segment_header_filename' 'header' '-segment_start_number' '0' '-segment_list' 'http://127.0.0.1:32400/video/:/transcode/session/1e362286-7bcc-46a9-99ab-6de8b44b5e7c-30/7aa006ae-7370-43e2-a660-735abe7610b2/manifest?X-Plex-Http-Pipeline=infinite' '-segment_list_type' 'csv' '-segment_list_unfinished' '1' '-segment_list_size' '5' '-segment_list_separate_stream_times' '1' '-map_metadata' '-1' '-map_chapters' '-1' 'chunk-%05d' '-y' '-nostats' '-loglevel' 'quiet' '-loglevel_plex' 'error' '-progressurl' 'http://127.0.0.1:32400/video/:/transcode/session/1e362286-7bcc-46a9-99ab-6de8b44b5e7c-30/7aa006ae-7370-43e2-a660-735abe7610b2/progress'
Dec 28, 2021 21:50:44.874 [0x7fa81eba8b38] DEBUG - [Transcode/JobRunner] Jobs: Starting child process with pid 21298

This looks like the player settings are causing a problem. If so, I need to identify that so it can be fixed.

In the RoKu Plex app Settings screen I see that Allow Direct Stream currently has a check mark,

As far as the “Is the tv allows MP3 audio only” I’m not sure where to look?! In the RoKu app when I go to Settings/Streams/Audio I see that "English *DTS-HD MA 5.1) has a check mark.

Sounds like you have everytthing setup correctly.

What is the Roku connected to? It must be a limit of the TV / soundbar

It’s connected to a 65" LG OLED TV… Sound out is on the TV is HDMI ARC. It’s a Yamaha soundbar. FWIW the RoKu is connected via Ethernet (no WiFi).

I have the 48" LG C1 OLED. It supports EARC with proper cables.
The Roku will drive all the way up to EAC3 in my configuration (Roku → Onkyo TX-RZ AVR → LG TV).

You might want to look at the ARC / EARC and cabling to see if you can get EARC from it for the better sound quality at some point. The initial firmware for my LG only supported EARC on HDMI 2. They’ve since corrected that to be all ports.

I’m playing this movie now to see if I can also have it fail at the end.

Screenshot from 2021-12-29 00-35-51

I changed it over to the internal speakers on the TV. Still crashing in RoKu. Always near the end of the video.

ok… I’ll let mine play and see if I can make it fail.

I can fast forward to the end every time and press play the last few minutes and it will crash every time.

thanks. trying that now

Attached FWIW.
Capture

got it to fail.