Didn’t restart the shield. The Shield tv was on the hole time & haven’t restarted it since way before then. That time stamp 20:38:10 is exactly where buffering appeared on screen. At the same time I checked PMS through the web app & it says that Plex PMS was offline/unreachable. Like I said, this only happens when transcoding, Direct playing content is flawless. Disabling Hardware Accelerator fixes the issue, But is x3 slower.I can reproduce this 100% of the time with any content that needs to be transcoded.
That was a conversion that failed. I’m not sure but based on the time, I was still at work, which would mean it was WiFi but not a local connection.
I actually coincidently had my shield record something so I could try syncing again a few minutes ago to see if the issue still persists.
I’m making do with a Linux server for the time being.
Also, on my shield now I’m recording OTA vs a HD Homerun Prime for the server. Which is what I used before on the shield.
I posted this same issue in my own thread and no replies., same on going concern all night with the same sad support.
Having the same problem as described. Syncing stops after about 10 minutes and the process seems to kill itself (the sync job just disappears). I have attached my logs which hopefully give some information.
Plex Media Server Logs_2018-08-02_09-35-54.zip (3.8 MB)
Edit:
Transcoder - Maximum simultaneous video transcode (Unlimited)
Network - Remote streams allowed per user (Unlimited)
Remote Access - Limit remote stream bitrate (8 Mbps 1080p)
Settings / server / remote access - Internet upload speed (50 Mbps)
something is stopping the Plex Media Server process and restarting it. Could be the android OS or some changes came in with Oreo
Will need to get logcat logs so will need to see if it can be reproduced inhouse
Could you get me the smallest sample mkv file that reproduce the issue. You can use mkvtoolsnix to split the mkv into - say 30 minute files and then let me have one of them - once you can confirm the issue arises with it and get me logs for it.
Would also need to know the full details about the nVidia Shield device including the nVidia shield model and Shield OS version and any other info
To provide a clip please upload to dropbox or similar service and send me link by Private Message
Looks similar to @miguelt678 logs. I will add your logs to the issue i raised with the development team
Thanks for the prompt. I have replied to your topic. Your issue was windows update bug introduced by Microsoft on the 10th July and fixed with another update on the 16th July. Most users with that problem were on this forum thread [Windows 10 Update KB4338819 issue] Conversion Failed. The transcoder exited due to an error
Ive noticed that when it first starts to buffer on screen, Then checking the PMS log for the exact same time stamp that the buffering accrued at 2:20am, Its saying that “hardware transcoding: enabled, but no hardware decode accelerator found”
02:20:41.290 [19597] DEBUG - Transcode Session: Going to restart at offset 750.750732 with segment number 750
Aug 03, 2018 02:20:41.290 [19597] DEBUG - Killing job.
Aug 03, 2018 02:20:41.290 [19597] DEBUG - Signalling job ID 19796 with 9
Aug 03, 2018 02:20:41.290 [19597] DEBUG - Job was already killed, not killing again.
Aug 03, 2018 02:20:41.290 [19597] DEBUG - Stopping transcode session c39uqwz4vo3zbyb92sb0ougz
Aug 03, 2018 02:20:41.290 [19597] DEBUG - Starting a transcode session c39uqwz4vo3zbyb92sb0ougz at offset 750.8 (state=3)
Aug 03, 2018 02:20:41.290 [19597] DEBUG - TPU: hardware transcoding: enabled, but no hardware decode accelerator found
Aug 03, 2018 02:20:41.293 [19597] DEBUG - [Universal] Using local file path instead of URL: /storage/6472DE6872DE3E8C/My Media/Movies/The Time Machine (2002).mkv
Aug 03, 2018 02:20:41.293 [19597] DEBUG - TPU: hardware transcoding: zero-copy support not present
Aug 03, 2018 02:20:41.293 [19597] DEBUG - TPU: hardware transcoding: final decoder: , final encoder:
Aug 03, 2018 02:20:41.308 [19597] DEBUG - Job running: EAE_ROOT='/data/user/0/com.plexapp.mediaserver.smb/tmp/pms-4388a2be-3b0d-48ee-ab10-06faed4b3f6f/EasyAudioEncoder' FFMPEG_EXTERNAL_LIBS='/data/user/0/com.plexapp.mediaserver.smb/Plex\ Media\ Server/Codecs/e944d3a-1309-android-aarch64/' XDG_CACHE_HOME='/storage/emulated/0/Android/data/com.plexapp.mediaserver.smb/cache' XDG_DATA_HOME='/data/user/0/com.plexapp.mediaserver.smb/Resources' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/data/user/0/com.plexapp.mediaserver.smb/Resources/Plex Transcoder' '-codec:0' 'h264' '-codec:1' 'dca' '-ss' '750' '-i' '/storage/6472DE6872DE3E8C/My Media/Movies/The Time Machine (2002).mkv' '-filter_complex' '[0:0]scale=w=1920:h=800[0];[0]format=pix_fmts=yuv420p|nv12[1]' '-filter_complex' '[0:1] aresample=async=1:ocl='\''5.1'\'':osr=48000:rematrix_maxval=5.000000dB[2]' '-map' '[1]' '-metadata:s:0' 'language=eng' '-codec:0' 'libx264' '-crf:0' '22' '-maxrate:0' '6780k' '-bufsize:0' '13560k' '-r:0' '23.975999999999999' '-preset:0' 'veryfast' '-level:0' '5.1' '-x264opts:0' 'subme=0:me_range=4:rc_lookahead=10:me=dia:no_chroma_me:8x8dct=0:partitions=none' '-force_key_frames:0' 'expr:gte(t,750.750732+n_forced*1)' '-map' '[2]' '-metadata:s:1' 'language=eng' '-codec:1' 'aac' '-strict:1' 'experimental' '-aac_coder:1' 'fast' '-q:1' '0' '-segment_format' 'mpegts' '-f' 'ssegment' '-individual_header_trailer' '0' '-segment_time' '1' '-segment_start_number' '750' '-segment_copyts' '1' '-segment_time_delta' '0.0625' '-segment_list' 'http://127.0.0.1:32400/video/:/transcode/session/c39uqwz4vo3zbyb92sb0ougz/78acd315-f0e1-45e9-b982-3750244f9444/seglist' '-segment_list_type' 'csv' '-segment_list_size' '2147483647' '-segment_list_separate_stream_times' '1' '-max_delay' '5000000' '-avoid_negative_ts' 'disabled' '-map_metadata' '-1' '-map_chapters' '-1' 'media-%05d.ts' '-start_at_zero' '-copyts' '-y' '-nostats' '-loglevel' 'quiet' '-loglevel_plex' 'error' '-progressurl' 'http://127.0.0.1:32400/video/:/transcode/session/c39uqwz4vo3zbyb92sb0ougz/78acd315-f0e1-45e9-b982-3750244f9444/progress'
Aug 03, 2018 02:20:41.324 [19597] DEBUG - Jobs: Starting child process with pid 20498
Aug 03, 2018 02:20:41.324 [19597] DEBUG - Started session successfully: c39uqwz4vo3zbyb92sb0ougz
Aug 03, 2018 02:20:42.256 [19712] DEBUG - Request: [127.0.0.1:60731 (Loopback)] PUT /video/:/transcode/session/c39uqwz4vo3zbyb92sb0ougz/78acd315-f0e1-45e9-b982-3750244f9444/progress/stream?index=0&id=0&codec=h264&type=video (12 live) Signed-in Token (Strategizer8520)
Aug 03, 2018 02:20:42.257 [4452] DEBUG - Completed: [127.0.0.1:60731] 206 PUT /video/:/transcode/session/c39uqwz4vo3zbyb92sb0ougz/78acd315-f0e1-45e9-b982-3750244f9444/progress/stream?index=0&id=0&codec=h264&type=video (11 live) 1ms 227 bytes (range: bytes=0-)
Aug 03, 2018 02:20:42.258 [19609] DEBUG - Request: [127.0.0.1:60732 (Loopback)] PUT /video/:/transcode/session/c39uqwz4vo3zbyb92sb0ougz/78acd315-f0e1-45e9-b982-3750244f9444/progress/stream?index=1&id=0&codec=dts&type=audio (12 live) Signed-in Token (Strategizer8520)
Aug 03, 2018 02:20:42.259 [4452] DEBUG - Completed: [127.0.0.1:60732] 206 PUT /video/:/transcode/session/c39uqwz4vo3zbyb92sb0ougz/78acd315-f0e1-45e9-b982-3750244f9444/progress/stream?index=1&id=0&codec=dts&type=audio (12 live) 0ms 227 bytes (range: bytes=0-)
Aug 03, 2018 02:20:42.266 [19703] ERROR - [Transcoder] [h264 @ 0x20258fda00] SEI type 5 size 4856 truncated at 4843
Aug 03, 2018 02:20:42.403 [19600] DEBUG - Request: [127.0.0.1:60734 (Loopback)] PUT /video/:/transcode/session/c39uqwz4vo3zbyb92sb0ougz/78acd315-f0e1-45e9-b982-3750244f9444/progress/streamDetail?index=0&id=0&codec=h264&type=video&profile=High&language=eng&width=1920&height=800&interlaced=0&sar=1:1&level=41&frameRate=23.976&disp_default=1 (11 live) Signed-in Token (Strategizer8520)
Aug 03, 2018 02:20:42.404 [4453] DEBUG - Completed: [127.0.0.1:60734] 206 PUT /video/:/transcode/session/c39uqwz4vo3zbyb92sb0ougz/78acd315-f0e1-45e9-b982-3750244f9444/progress/streamDetail?index=0&id=0&codec=h264&type=video&profile=High&language=eng&width=1920&height=800&interlaced=0&sar=1:1&level=41&frameRate=23.976&disp_default=1 (11 live) 0ms 227 bytes (range: bytes=0-)
Aug 03, 2018 02:20:42.405 [19709] DEBUG - Request: [127.0.0.1:60735 (Loopback)] PUT /video/:/transcode/session/c39uqwz4vo3zbyb92sb0ougz/78acd315-f0e1-45e9-b982-3750244f9444/progress/streamDetail?index=1&id=0&codec=dts&type=audio&bitrate=768000&profile=DTS&language=eng&channels=6&layout=5.1%28side%29&sampleRate=48000&bitDepth=24&disp_default=1 (12 live) Signed-in Token (Strategizer8520)
Aug 03, 2018 02:20:42.406 [4452] DEBUG - Completed: [127.0.0.1:60735] 206 PUT /video/:/transcode/session/c39uqwz4vo3zbyb92sb0ougz/78acd315-f0e1-45e9-b982-3750244f9444/progress/streamDetail?index=1&id=0&codec=dts&type=audio&bitrate=768000&profile=DTS&language=eng&channels=6&layout=5.1%28side%29&sampleRate=48000&bitDepth=24&disp_default=1 (11 live) 0ms 227 bytes (range: bytes=0-)
Aug 03, 2018 02:20:42.407 [19408] DEBUG - Request: [127.0.0.1:60736 (Loopback)] PUT /video/:/transcode/session/c39uqwz4vo3zbyb92sb0ougz/78acd315-f0e1-45e9-b982-3750244f9444/progress/streamDetail?index=2&id=0&codec=subrip&type=subtitle&language=eng&disp_default=1 (12 live) Signed-in Token (Strategizer8520)
Aug 03, 2018 02:20:42.408 [4452] DEBUG - Completed: [127.0.0.1:60736] 206 PUT /video/:/transcode/session/c39uqwz4vo3zbyb92sb0ougz/78acd315-f0e1-45e9-b982-3750244f9444/progress/streamDetail?index=2&id=0&codec=subrip&type=subtitle&language=eng&disp_default=1 (11 live) 0ms 227 bytes (range: bytes=0-)
Aug 03, 2018 02:20:42.455 [19615] DEBUG - Request: [127.0.0.1:60737 (Loopback)] PUT /video/:/transcode/session/c39uqwz4vo3zbyb92sb0ougz/78acd315-f0e1-45e9-b982-3750244f9444/progress?duration=5743.126000 (11 live) Signed-in Token (Strategizer8520)
Aug 03, 2018 02:20:42.456 [4452] DEBUG - Completed: [127.0.0.1:60737] 206 PUT /video/:/transcode/session/c39uqwz4vo3zbyb92sb0ougz/78acd315-f0e1-45e9-b982-3750244f9444/progress?duration=5743.126000 (11 live) 1ms 326 bytes (range: bytes=0-)
Aug 03, 2018 02:20:42.980 [19712] DEBUG - Transcoder: session c39uqwz4vo3zbyb92sb0ougz indicated fallback to software decoding
Also at this exact time as the buffering accrues, Im monitoring Plex via the web app & Tatulli & notice both Plex & Tautulli remove the (HW) Hardware accelerator from the session info. This is also noticeable because its stops throttling & stays at a speed of 1-1.2, Sometimes much lower.
I am experiencing the same problem. PMS on Shield 16GB on latest Oreo, same issue occurred on Nougat.
Transcoding with HW acceleration ON fails, i can only Transcode/Sync with HW acceleration OFF.
See this thread (SHIELD hardware transcoding problem?) where @DaveBinM has been able to reproduce the problem.
Apparently the engineering team are investigating. Has a fix been found?
1 Like
I also have this issue with the latest os on the shield and plex server and client up to date, i can not optimize/sync any size/kind of files.
Turning HW acceleration off does solve the issue but it is definitely not an option with 4k files.
i am having the same issue. Hardware acceleration is not on in transcoding. I happened last night on my roku 3gen and today i was playing a show on plex browser version and had the same issue. The files are also extremely different, the one that kept failing on my roku was a friends episode that was sd, so an older file. We tried the next episode that failed as well. “Conversion failed. The transcoder exited due to an error.” Today it is an episode of explained and its an h264 1080p file. This has started happening for me since the latest update.
Thank you for the logs. Sorry for not looking at them earlier. I am catching up with my backlog.
The evidence shows that the shield starts with hardware transcoding but after transcoding first 12 minutes 29 seconds the transcoder process gets killed - do not know why and by what at this point. Plex Media Server takes this to indicate an issue with hardware transcoding and switches then to software transcoding which resulted in buffering
Could you get me the media file and we will try to replicate
The file was /storage/6472DE6872DE3E8C/My Media/Movies/The Time Machine (2002).mkv
Perhaps you can trim it to first 20 minutes and upload to dropbox or google drive etc and send me a link by Private Message.
See https://support.plex.tv/articles/201035968-generating-sample-files-from-media/
Please confirm first that the 20 minute clip fails in same way and get me logs for that as well
And also please include the media info xml saved into a text file
See
https://support.plex.tv/articles/201998867-investigate-media-information-and-formats/
We will see if there are any similarities with the hardware transcoding shield issue that @philiptruong linked to here Conversion failed. The transcoder exited due to an error - #50 by philiptruong
@BIFFTAZ could you also please let me know the exact software and OS level details and nVidia Shield model
I also have the similar problem. I’m on a 2017 16GB Nvidia Shield TV. Every time I try and optimize media, it will crash if the hardware acceleration is enabled and the media is >20ish minutes. Please let me know if my logs would be helpful. Thank you!
@alexberman @BIFFTAZ There is a fix coming along that follows investigation into transcoder memory use and there is a possibility it may resolve this issue. The issue being the hardware transcoder job gets killed after a number of minutes.
So suggest waiting for this rather that getting more diagnostics. The fix is going through the QA process
2 Likes
Thats great news!!! Thanks @sa2000 & everyone involved in fixing this issue.
PMS 1.13.6.5339 does not seem to contain the fix yet.
2 Likes
correct
i am hoping that it will make it into 1.13.7
1 Like
Plex Media Server beta 1.13.7.5369 has just been released. It has the fix for Transcoder memory leak.
See Release Note Plex Media Server
- (Transcoder) The transcoder’s memory consumption increased over time on Android or when decoding certain audio codecs (#8830) (#8814)
The release may not be immediately visible on Google Play
4 Likes
The latest Server update seems to resolve the issue for me. Syncing goes smoothly and hw transcoding does not crash anoymore! Awesome work, thanks!
