- Your subtitles are being burned in. The CPU cannot handle that load – none of the NAS Jxxx series can.
Nov 24, 2020 22:14:43.856 [0x7f460d6fb700] DEBUG - [Transcode] We're going to try to auto-select an audio stream for account 1.
Nov 24, 2020 22:14:43.856 [0x7f460d6fb700] DEBUG - [Transcode] Selecting best audio stream for part ID 1 (autoselect: 1 language: en)
Nov 24, 2020 22:14:43.856 [0x7f460d6fb700] DEBUG - [Transcode] We're going to try to auto-select a subtitle.
Nov 24, 2020 22:14:43.856 [0x7f460d6fb700] DEBUG - [Transcode] Subtitles: Found a candidate subtitle language [eng] for a foreign film
Nov 24, 2020 22:14:43.856 [0x7f460d6fb700] DEBUG - [Transcode] Audio Stream: 2, Subtitle Stream: 9
Nov 24, 2020 22:14:43.857 [0x7f460d6fb700] DEBUG - [Transcode] Found session GUID of c74d5e17-423f-4c7a-a30e-f7fe856307aa-1 in session start.
Nov 24, 2020 22:14:43.857 [0x7f460d6fb700] DEBUG - [Transcode] Using session GUID c74d5e17-423f-4c7a-a30e-f7fe856307aa-1 for new transcode session.
Nov 24, 2020 22:14:43.857 [0x7f460d6fb700] DEBUG - [Transcode] Cleaning directory for session c74d5e17-423f-4c7a-a30e-f7fe856307aa-1 ()
Nov 24, 2020 22:14:43.858 [0x7f461c461700] DEBUG - Completed: [192.168.1.44:57201] 200 GET /video/:/transcode/universal/start.m3u8?protocol=hls&mediaIndex=0&waitForSegments=1 (8 live) TLS GZIP 7ms 481 bytes (pipelined: 1)
Nov 24, 2020 22:14:43.911 [0x7f460d40d700] DEBUG - [Transcode] HTTP 403 response from GET https://metadata-static.plex.tv/people/5d7768253c3c2a001fbca9d1.jpg
Nov 24, 2020 22:14:43.911 [0x7f460ffff700] DEBUG - Completed: [192.168.1.44:57202] 404 GET /photo/:/transcode?url=https%3A%2F%2Fmetadata-static.plex.tv%2Fpeople%2F5d7768253c3c2a001fbca9d1.jpg (8 live) TLS 62ms 259 bytes
Nov 24, 2020 22:14:43.928 [0x7f461c461700] DEBUG - Auth: authenticated user 1 as thompsondc
Nov 24, 2020 22:14:43.928 [0x7f4607447700] DEBUG - Request: [192.168.1.44:57201 (Subnet)] GET /video/:/transcode/universal/session/c74d5e17-423f-4c7a-a30e-f7fe856307aa-1/base/index.m3u8?protocol=hls&mediaIndex=0&waitForSegments=1 (8 live) TLS GZIP Signed-in Token (thompsondc)
Nov 24, 2020 22:14:43.928 [0x7f4607447700] DEBUG - [Transcode] Found session GUID of c74d5e17-423f-4c7a-a30e-f7fe856307aa-1 in session start.
Nov 24, 2020 22:14:43.928 [0x7f4607447700] DEBUG - [Transcode] Starting a transcode session c74d5e17-423f-4c7a-a30e-f7fe856307aa-1 at offset -1.0 (state=3)
Nov 24, 2020 22:14:43.929 [0x7f4607447700] DEBUG - [Transcode] TPU: hardware transcoding: using hardware decode accelerator vaapi
Nov 24, 2020 22:14:43.929 [0x7f4607447700] DEBUG - [Transcode] TPU: hardware transcoding: zero-copy support present
Nov 24, 2020 22:14:43.929 [0x7f4607447700] DEBUG - [Transcode] TPU: hardware transcoding: not using zero-copy because subtitle burning is required
Nov 24, 2020 22:14:43.929 [0x7f4607447700] DEBUG - [Transcode] [Universal] Using local file path instead of URL: /share/CACHEDEV2_DATA/NAS Share/Movies/Iron Man 3 (2013).mkv
Nov 24, 2020 22:14:43.929 [0x7f4607447700] DEBUG - [Transcode] Codecs: hardware transcoding: testing API vaapi
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x41524742 -> bgra.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x42475241 -> argb.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x41424752 -> rgba.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x52474241 -> abgr.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x58524742 -> bgr0.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x42475258 -> 0rgb.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x58424752 -> rgb0.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x52474258 -> 0bgr.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x30335241 -> unknown.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x30334241 -> unknown.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x30335258 -> unknown.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x30334258 -> unknown.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x36314752 -> unknown.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x50424752 -> unknown.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x50524742 -> unknown.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x56555941 -> unknown.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x30303859 -> gray.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x3231564e -> nv12.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x3132564e -> unknown.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x32595559 -> yuyv422.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x59565955 -> uyvy422.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x32315659 -> yuv420p.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x30323449 -> yuv420p.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x50313134 -> yuv411p.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x48323234 -> yuv422p.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x56323234 -> yuv440p.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x50343434 -> yuv444p.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x33434d49 -> unknown.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Format 0x30313050 -> p010le.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Created surface 0.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] [FFMPEG] - Direct mapping possible.
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] TPU: hardware transcoding: final decoder: vaapi, final encoder: vaapi
Nov 24, 2020 22:14:43.930 [0x7f4607447700] DEBUG - [Transcode] Job running: EAE_ROOT='/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Library/tmp/pms-b98ec5d3-88fe-4c44-9824-2934776aa7c5/EasyAudioEncoder' FFMPEG_EXTERNAL_LIBS='/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Library/Plex\ Media\ Server/Codecs/7c50c14-3596-linux-x86_64/' LIBVA_DRIVERS_PATH='/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/lib/dri' XDG_CACHE_HOME='/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Library/Plex Media Server/Cache' XDG_DATA_HOME='/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/share/CACHEDEV1_DATA/.qpkg/PlexMediaServer/Plex Transcoder' '-codec:0' 'h264' '-hwaccel:0' 'vaapi' '-hwaccel_fallback_threshold:0' '10' '-hwaccel_device:0' 'vaapi' '-codec:1' 'dca' '-analyzeduration' '20000000' '-probesize' '20000000' '-i' '/share/CACHEDEV2_DATA/NAS Share/Movies/Iron Man 3 (2013).mkv' '-filter_complex' '[0:8]scale=1920:800[0];[0:0][0]overlay[1];[1]scale=w=1920:h=800[2];[2]format=pix_fmts=nv12[3];[3]hwupload[4]' '-filter_complex' '[0:1] aresample=async=1:ocl='\''stereo'\'':rematrix_maxval=0.000000dB:osr=48000[5]' '-map' '[4]' '-codec:0' 'h264_vaapi' '-b:0' '1959k' '-maxrate:0' '2613k' '-bufsize:0' '5226k' '-r:0' '23.975999999999999' '-force_key_frames:0' 'expr:gte(t,0+n_forced*1)' '-map' '[5]' '-metadata:s:1' 'language=eng' '-codec:1' 'aac' '-b:1' '241k' '-segment_format' 'mpegts' '-f' 'ssegment' '-individual_header_trailer' '0' '-segment_time' '1' '-segment_start_number' '0' '-segment_copyts' '1' '-segment_time_delta' '0.0625' '-segment_list' 'http://127.0.0.1:32400/video/:/transcode/session/c74d5e17-423f-4c7a-a30e-f7fe856307aa-1/dfb40bc9-ebe6-40cb-a807-2df44b0c0894/seglist?X-Plex-Http-Pipeline=infinite' '-segment_list_type' 'csv' '-segment_list_size' '5' '-segment_list_separate_stream_times' '1' '-segment_list_unfinished' '1' '-max_delay' '5000000' '-avoid_negative_ts' 'disabled' '-map_metadata' '-1' '-map_chapters' '-1' 'media-%05d.ts' '-start_at_zero' '-copyts' '-vsync' 'cfr' '-y' '-init_hw_device' 'vaapi=vaapi:' '-filter_hw_device' 'vaapi' '-nostats' '-loglevel' 'quiet' '-loglevel_plex' 'error' '-progressurl' 'http://127.0.0.1:32400/video/:/transcode/session/c74d5e17-423f-4c7a-a30e-f7fe856307aa-1/dfb40bc9-ebe6-40cb-a807-2df44b0c0894/progress'
Nov 24, 2020 22:14:43.931 [0x7f4607447700] DEBUG - [Transcode] Jobs: Starting child process with pid 10458
Nov 24, 2020 22:14:43.934 [0x7f460fa23700] DEBUG - Request: [127.0.0.1:58060 (Loopback)] PUT /video/:/transcode/session/c74d5e17-423f-4c7a-a30e-f7fe856307aa-1/dfb40bc9-ebe6-40cb-a807-2df44b0c0894/progress?status=startup (8 live) Signed-in Token (thompsondc) (range: bytes=0-)
Nov 24, 2020 22:14:43.934 [0x7f460ffff700] DEBUG - Completed: [127.0.0.1:58060] 204 PUT /video/:/transcode/session/c74d5e17-423f-4c7a-a30e-f7fe856307aa-1/dfb40bc9-ebe6-40cb-a807-2df44b0c0894/progress?status=startup (8 live) 0ms 203 bytes (pipelined: 1) (range: bytes=0-)
Nov 24, 2020 22:14:43.946 [0x7f460dcd7700] DEBUG - Request: [127.0.0.1:58060 (Loopback)] PUT /video/:/transcode/session/c74d5e17-423f-4c7a-a30e-f7fe856307aa-1/dfb40bc9-ebe6-40cb-a807-2df44b0c0894/progress?status=startup (8 live) Signed-in Token (thompsondc) (range: bytes=0-)
Nov 24, 2020 22:14:43.946 [0x7f461c461700] DEBUG - Completed: [127.0.0.1:58060] 204 PUT /video/:/transcode/session/c74d5e17-423f-4c7a-a30e-f7fe856307aa-1/dfb40bc9-ebe6-40cb-a807-2df44b0c0894/progress?status=startup (8 live) 0ms 203 bytes (pipelined: 2) (range: bytes=0-)
Nov 24, 2020 22:14:43.947 [0x7f46056fb700] DEBUG - Request: [127.0.0.1:58060 (Loopback)] PUT /video/:/transcode/session/c74d5e17-423f-4c7a-a30e-f7fe856307aa-1/dfb40bc9-ebe6-40cb-a807-2df44b0c0894/progress?status=opening (8 live) Signed-in Token (thompsondc) (range: bytes=0-)
Nov 24, 2020 22:14:43.947 [0x7f461c461700] DEBUG - Completed: [127.0.0.1:58060] 204 PUT /video/:/transcode/session/c74d5e17-423f-4c7a-a30e-f7fe856307aa-1/dfb40bc9-ebe6-40cb-a807-2df44b0c0894/progress?status=opening (8 live) 0ms 203 bytes (pipelined: 3) (range: bytes=0-)
Nov 24, 2020 22:14:43.948 [0x7f460d6fb700] DEBUG - Request: [127.0.0.1:58060 (Loopback)] PUT /video/:/transcode/session/c74d5e17-423f-4c7a-a30e-f7fe856307aa-1/dfb40bc9-ebe6-40cb-a807-2df44b0c0894/progress?status=opened (8 live) Signed-in Token (thompsondc) (range: bytes=0-)
Nov 24, 2020 22:14:43.948 [0x7f460ffff700] DEBUG - Completed: [127.0.0.1:58060] 204 PUT /video/:/transcode/session/c74d5e17-423f-4c7a-a30e-f7fe856307aa-1/dfb40bc9-ebe6-40cb-a807-2df44b0c0894/progress?status=opened (8 live) 0ms 203 bytes (pipelined: 4) (range: bytes=0-)
Nov 24, 2020 22:14:43.948 [0x7f460d40d700] DEBUG - Request: [127.0.0.1:58060 (Loopback)] PUT /video/:/transcode/session/c74d5e17-423f-4c7a-a30e-f7fe856307aa-1/dfb40bc9-ebe6-40cb-a807-2df44b0c0894/progress/stream?index=0&id=0&codec=h264&type=video (8 live) Signed-in Token (thompsondc) (range: bytes=0-)
Nov 24, 2020 22:14:43.948 [0x7f460ffff700] DEBUG - Completed: [127.0.0.1:58060] 200 PUT /video/:/transcode/session/c74d5e17-423f-4c7a-a30e-f7fe856307aa-1/dfb40bc9-ebe6-40cb-a807-2df44b0c0894/progress/stream?index=
- I also wish to advise you that whomever performed this re-encode didn’t do it right.
2.5 Mbps , which is well within the default video profile 4.0 (20 Mbos) does not require video profile 5.2 (100 Mbps). 5.2 forced this transcoding session. Subtitles made it worse.
Nov 24, 2020 22:14:42.928 [0x7f460d6fb700] DEBUG - [Transcode] [FFMPEG] - Format 0x30313050 -> p010le.
Nov 24, 2020 22:14:42.928 [0x7f460d6fb700] DEBUG - [Transcode] Codecs: Testing with profile 'Main'
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] Scaled up video bitrate to 2613Kbps based on 1.500000x fudge factor.
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] MDE: Selected protocol hls; container: mpegts
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] MDE: analyzing media item 1
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] MDE: Iron Man 3 (2013): Direct Play is disabled
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] MDE: Iron Man 3 (2013): media must be transcoded in order to use the hls protocol
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] MDE: Iron Man 3 (2013): no direct play video profile exists for http/mkv/h264/dca
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] MDE: Iron Man 3 (2013): no direct play video profile exists for http/mkv/h264/dca
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] MDE: Iron Man 3 (2013): no direct play video profile exists for http/mkv/h264/ac3
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] MDE: Iron Man 3 (2013): no direct play video profile exists for http/mkv/h264/ac3
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] Iron Man 3 - video.level limitation applies: 52 > 41
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] Iron Man 3 - audio.channels limitation applies: 6 > 2
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] MDE: Iron Man 3 (2013): selected subtitle cannot be converted to a compatible format, burning into video stream
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] MDE: Iron Man 3 (2013): avoiding video remux due to burned subtitle stream
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] MDE: Iron Man 3 (2013): no remuxable profile found, so video stream will be transcoded
Nov 24, 2020 22:14:42.929 [0x7f460d6fb700] DEBUG - [Transcode] MDE: Cannot direct stream video stream due to profile or setting limitations
Nov 24, 2020 22:14:42.930 [0x7f460d6fb700] DEBUG - [Transcode] Codecs: testing h264 (decoder) with hwdevice vaapi
Nov 24, 2020 22:14:42.930 [0x7f460d6fb700] DEBUG - [Transcode] Codecs: hardware transcoding: testing API vaapi
Nov 24, 2020 22:14:42.930 [0x7f460d6fb700] DEBUG - [Transcode] [FFMPEG] - Format 0x41524742 -> bgra.
Nov 24, 2020 22:14:42.930 [0x7f460d6fb700] DEBUG - [Transcode] [FFMPEG] - Format 0x42475241 -> argb.
Nov 24, 2020 22:14:42.930 [0x7f460d6fb700] DEBUG - [Transcode] [FFMPEG] - Format 0x41424752 -> rgba.