He don't want play the last episode of Miss Marvel in 4K

Server Version#: 1.27.2.5929
Player Version#: 4.76.1

Plex Media Server Logs_2022-07-14_19-51-24.zip (2.3 MB)

Hello,

When I try to watch the latest episode of Miss Marvell in 4K it doesn’t work, it just loads blankly doing nothing. Apparently it’s trying to transcode to 1080p.
However on the other epidoses it works very well!
Especially since the last episode but this time in 1080p works!

  1. Please again enable DEBUG logging. It is not possible to diagnose much without it.
  2. The i7-4770K cannot HW transcode 4K.
Jul 14, 2022 19:49:59.314 [0x7f9d345ceb38] WARN - [Req#1bdd9] QueryParser: Invalid field 'pinnedContentDirectoryID' found, ignoring.
Jul 14, 2022 19:50:03.882 [0x7f9d345ceb38] ERROR - [Req#1bddc/Transcode] [FFMPEG] - libva: vaGetDriverNameByIndex() failed with unknown libva error, driver_name = (null)
Jul 14, 2022 19:50:03.882 [0x7f9d345ceb38] ERROR - [Req#1bddc/Transcode] [FFMPEG] - Failed to initialise VAAPI connection: -1 (unknown libva error).
Jul 14, 2022 19:50:04.154 [0x7f9d345ceb38] ERROR - [Req#1bddc/Transcode] [FFMPEG] - libva: vaGetDriverNameByIndex() failed with unknown libva error, driver_name = (null)
Jul 14, 2022 19:50:04.154 [0x7f9d345ceb38] ERROR - [Req#1bddc/Transcode] [FFMPEG] - Failed to initialise VAAPI connection: -1 (unknown libva error).
Jul 14, 2022 19:51:20.778 [0x7f9d34317b38] WARN - [Req#1c7ce/Transcode/oz9xanq9ahhbz25gew15elxo] Transcode runner appears to have died.

I disable it because someone say it’s too much log

Here are the new logs:

Plex Media Server Logs_2022-07-14_21-13-43.zip (2.4 MB)

But it’s not supposed to be the processor to do the transcoding but the GTX 1060 graphics card. I played the episode of Miss Marvel in 4K and it doesn’t work and just after to show you I watched Doctor Strange who is also in 4K, except that he works!

Thank you.

  1. Keep DEBUG logging enabled.

  2. Please disable VERBOSE logging. It makes too much output.

  3. I can see “Miss Marvel” starting to play

Jul 14, 2022 21:13:12.849 [0x7f9d33e31b38] DEBUG - [Req#2212d/Transcode] Starting a transcode session 08jxe5njs0fuumrhwzyx0taw at offset -1.0 (state=3)
Jul 14, 2022 21:13:12.849 [0x7f9d33e31b38] DEBUG - [Req#2212d/Transcode] TPU: hardware transcoding: using hardware decode accelerator nvdec
Jul 14, 2022 21:13:12.849 [0x7f9d33e31b38] DEBUG - [Req#2212d/Transcode] TPU: hardware transcoding: zero-copy support present
Jul 14, 2022 21:13:12.849 [0x7f9d33e31b38] DEBUG - [Req#2212d/Transcode] TPU: hardware transcoding: using zero-copy transcoding
Jul 14, 2022 21:13:12.849 [0x7f9d33e31b38] DEBUG - [Req#2212d/Transcode] [Universal] Using local file path instead of URL: /srv/dev-disk-by-uuid-dcb7f413-b47f-4380-a5da-abad1515dee3/Netflix/Repository/Miss.MARVEL.S01E06.FiNAL.4K.MULTI.2160p.HDR.WEB.H265-Wawacity.red.mkv
Jul 14, 2022 21:13:12.849 [0x7f9d33e31b38] DEBUG - [Req#2212d/Transcode] TPU: hardware transcoding: final decoder: nvdec, final encoder: nvenc
Jul 14, 2022 21:13:12.849 [0x7f9d33e31b38] VERBOSE - [Req#2212d/Transcode] Sufficient disk space: 476.68kB source file, 1.79TB capacity, 1.67TB available on "/srv/dev-disk-by-uuid-b3782573-cf2f-4251-9204-ad677450d3ed/TRANSCODE/Transcode/Sessions"
Jul 14, 2022 21:13:12.849 [0x7f9d33e31b38] DEBUG - [Req#2212d/Transcode/JobRunner] Job running: EAE_ROOT=/tmp/pms-927169e0-4eb1-4fd3-8e0d-de0550529541/EasyAudioEncoder FFMPEG_EXTERNAL_LIBS='/var/lib/plexmediaserver/Library/Application\ Support/Plex\ Media\ Server/Codecs/d53cb63-4323-linux-x86_64/' X_PLEX_TOKEN=xxxxxxxxxxxxxxxxxxxx "/usr/lib/plexmediaserver/Plex Transcoder" -codec:3 hevc -hwaccel:3 nvdec -hwaccel_fallback_threshold:3 10 -threads:3 1 -hwaccel_output_format:3 cuda -hwaccel_device:3 cuda -codec:0 eac3_eae -eae_prefix:0 08jxe5njs0fuumrhwzyx0taw_ -analyzeduration 20000000 -probesize 20000000 -i /srv/dev-disk-by-uuid-dcb7f413-b47f-4380-a5da-abad1515dee3/Netflix/Repository/Miss.MARVEL.S01E06.FiNAL.4K.MULTI.2160p.HDR.WEB.H265-Wawacity.red.mkv -filter_complex "[0:3]hwupload[0];[0]scale_cuda=w=2276:h=1280:format=p010[1];[1]tonemap_cuda=mobius:nv12[2]" -map "[2]" -metadata:s:0 language=eng -codec:0 h264_nvenc -b:0 20000k -preset:0 hq -forced-idr:0 1 -r:0 24 -force_key_frames:0 "expr:gte(t,n_forced*1)" -filter_complex "[0:0] aresample=async=1:ocl='stereo':rematrix_maxval=0.000000dB:osr=48000[3]" -map "[3]" -metadata:s:1 language=fra -codec:1 aac -b:1 256k -f dash -seg_duration 1 -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/08jxe5njs0fuumrhwzyx0taw/4c20c29b-f093-4785-b1f8-4556f1c51d43/manifest?X-Plex-Http-Pipeline=infinite" -avoid_negative_ts disabled -map_metadata -1 -map_chapters -1 dash -map 0:1 -metadata:s:0 language=fra -codec:0 ass -f segment -segment_format ass -segment_time 1 -segment_header_filename sub-header -segment_start_number 0 -segment_list "http://127.0.0.1:32400/video/:/transcode/session/08jxe5njs0fuumrhwzyx0taw/4c20c29b-f093-4785-b1f8-4556f1c51d43/manifest?stream=subtitles&X-Plex-Http-Pipeline=infinite" -segment_list_type csv -segment_list_size 5 -segment_list_separate_stream_times 1 -segment_format_options ignore_readorder=1 -segment_list_unfinished 1 -fflags +flush_packets "sub-chunk-%05d" -start_at_zero -copyts -vsync cfr -init_hw_device cuda=cuda: -filter_hw_device cuda -y -nostats -loglevel quiet -loglevel_plex error -progressurl http://127.0.0.1:32400/video/:/transcode/session/08jxe5njs0fuumrhwzyx0taw/4c20c29b-f093-4785-b1f8-4556f1c51d43/progress
Jul 14, 2022 21:13:12.849 [0x7f9d33e31b38] DEBUG - [Req#2212d/Transcode/JobRunner] Jobs: Starting child process with pid 210364

What are you playing this with?
I see where playback begins then PMS receives “End of File” and stops.

Is the file truncated / damaged?

Jul 14, 2022 21:13:17.119 [0x7f9d3e796b38] VERBOSE - Didn't receive a request from 127.0.0.1:55674: End of file
Jul 14, 2022 21:13:17.154 [0x7f9d355d1b38] DEBUG - Request: [192.168.5.9:29117 (Subnet)] GET /status/sessions (11 live) #221c6 TLS GZIP Signed-in Token (OverStyleFR) (Opera) / Accept => application/json, text/plain, */* / Accept-Encoding => gzip, deflate, br / Accept-Language => en / Connection => keep-alive / Host => 192-168-5-10.0c153cec4d9e452d80fd3a032b2ffa37.plex.direct:32400 / Origin => http://192.168.5.10:32400 / Referer => http://192.168.5.10:32400/ / sec-ch-ua => "Chromium";v="102", "Opera GX";v="88", ";Not A Brand";v="99" / sec-ch-ua-mobile => ?0 / sec-ch-ua-platform => "Windows" / Sec-Fetch-Dest => empty / Sec-Fetch-Mode => cors / Sec-Fetch-Site => cross-site / User-Agent => Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/102.0.5005.115 Safari/537.36 OPR/88.0.4412.75 / X-Plex-Client-Identifier => bgq3kg2izm61qufkhmxuswkh / X-Plex-Device => Windows / X-Plex-Device-Name => Opera / X-Plex-Device-Screen-Resolution => 2519x1337,2560x1440 / X-Plex-Features => external-media,indirect-media / X-Plex-Language => en / X-Plex-Model => bundled / X-Plex-Platform => Opera / X-Plex-Platform-Version => 88.0 / X-Plex-Product => Plex Web / X-Plex-Sync-Version => 2 / X-Plex-Token => xxxxxxxxxxxxxxxxxxxx / X-Plex-Version => 4.76.1
Jul 14, 2022 21:13:17.154 [0x7f9d355d1b38] DEBUG - [Req#221c6] [Now] Adding 1 sessions.
Jul 14, 2022 21:13:17.154 [0x7f9d355d1b38] VERBOSE - It took 0.0 sec to serialize a list with 1 elements.
Jul 14, 2022 21:13:17.155 [0x7f9d3e796b38] DEBUG - Completed: [192.168.5.9:29117] 200 GET /status/sessions (11 live) TLS GZIP 1ms 2085 bytes (pipelined: 7)
Jul 14, 2022 21:13:17.167 [0x7f9d415ffb38] VERBOSE - JobManager: child process with handle 210428 exited
Jul 14, 2022 21:13:17.167 [0x7f9d415ffb38] DEBUG - Jobs: '/usr/lib/plexmediaserver/Plex Transcoder' exit code for process 210428 is -9 (signal: Killed)
Jul 14, 2022 21:13:17.237 [0x7f9d33ea4b38] VERBOSE - LongPoll: Sending data...
Jul 14, 2022 21:13:17.237 [0x7f9d3e796b38] VERBOSE - LongPoll: got onDataRequested, closing connection
Jul 14, 2022 21:13:17.237 [0x7f9d3e796b38] DEBUG - Completed: [192.168.5.9:1097] 200 GET /player/proxy/poll?deviceClass=pc&protocolVersion=3&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (11 live) TLS GZIP 20001ms 5 bytes (pipelined: 160)

Alright I did this.

No, the file is not damaged, I can read it very well when I access the NAS via SMB (Windows Protocol).
It’s from Plex.

And I would also like to know if there is a Plex repository? So that with a simple

apt update && apt full-upgrade

it updates the Plex and my OS.

I add the repo of Plex.

@OverStyleFR

You might get a warning about the repository signature.
Do not worry.

I have an update coming which moves to GPG key signing for Debian packages Debian 10+ and Ubuntu 20+

No it’s okay. I accept the key signature.
It’s perfectly works ! Look

1 Like

You can help me ?

Can you please try to play again?
After you do, please download the ZIP file and attach it here.
I will read through it.

Zip file ? From de log you mean?

Plex Media Server Logs_2022-07-22_03-48-18.zip (4.3 MB)

PMS is seeing your graphics adapter
It is able to decode HEVC HDR video

ul 22, 2022 02:56:25.634 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuWaitExternalSemaphoresAsync
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] Codecs: Testing with profile 'Main 10'
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - nal_unit_type: 32(VPS), nuh_layer_id: 0, temporal_id: 0
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - nal_unit_type: 33(SPS), nuh_layer_id: 0, temporal_id: 0
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - nal_unit_type: 34(PPS), nuh_layer_id: 0, temporal_id: 0
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - nal_unit_type: 20(IDR_N_LP), nuh_layer_id: 0, temporal_id: 0
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Decoding VPS
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Main 10 profile bitstream
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Decoding SPS
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Main 10 profile bitstream
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Decoding VUI
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Decoding PPS
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Format cuda chosen by get_format().
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Format cuda requires hwaccel initialisation.
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - CUDA texture alignment: 512
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - CUDA texture alignment: 512
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded lib: libnvcuvid.so.1
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidGetDecoderCaps
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidCreateDecoder
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidDestroyDecoder
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidDecodePicture
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidGetDecodeStatus
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidReconfigureDecoder
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidMapVideoFrame64
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidUnmapVideoFrame64
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidCtxLockCreate
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidCtxLockDestroy
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidCtxLock
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidCtxUnlock
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidCreateVideoSource
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidCreateVideoSourceW
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidDestroyVideoSource
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidSetVideoSourceState
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidGetVideoSourceState
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidGetSourceVideoFormat
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidGetSourceAudioFormat
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidCreateVideoParser
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidParseVideoData
Jul 22, 2022 02:56:25.708 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] [FFMPEG] - Loaded sym: cuvidDestroyVideoParser
Jul 22, 2022 02:56:25.714 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] Codecs: 10-bit HEVC test succeeded
Jul 22, 2022 02:56:25.739 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] MDE: Cannot direct stream audio stream due to codec eac3 when profile only allows aac
Jul 22, 2022 02:56:25.739 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] MDE: Miss Marvel - S1 E6 - Retour à la normale: selected media 0 / 3146
Jul 22, 2022 02:56:25.739 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] Streaming Resource: Adding session 0x7fdcd364acc8:ettlochez84vmjjlajxag8ud which is using transcoder slot.  Used slots is now 1
Jul 22, 2022 02:56:25.739 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] Streaming Resource: Added session 0x7fdcd364acc8:ettlochez84vmjjlajxag8ud
Jul 22, 2022 02:56:25.740 [0x7fdcd2ad3b38] DEBUG - [Req#e019/Transcode] Streaming Resource: Reached Decision id=2011 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=3146 part=(id=3148 decision=transcode container=mp4 protocol=dash streams=(Video=(id=7577 decision=transcode bitrate=2147483647 encoder=h264_nvenc width=2276 height=1280) Audio=(id=7574 decision=transcode bitrate=256 encoder=aac channels=2 rate=48000) Subtitle=(id=7575 decision=transcode bitrate=2147483647 encoder=ass languageCode=fra location=sidecar))))
Jul 22, 2022 02:56:25.740 [0x7fdcd4b8ab38] DEBUG - Completed: [192.168.5.9:2353] 200 GET /video/:/transcode/universal/decision?hasMDE=1&path=%2Flibrary%2Fmetadata%2F2011&mediaIndex=0&partIndex=0&protocol=dash&fastSeek=1&directPlay=0&directStream=1&subtitleSize=100&audioBoost=100&location=lan&addDebugOverlay=0&autoAdjustQuality=0&directStreamAudio=1&mediaBufferSize=102400&session=uo95kfynl9sh5itswia76dac&subtitles=auto&advancedSubtitles=text&Accept-Language=en (13 live) TLS GZIP 662ms 2138 bytes (pipelined: 13)
Jul 22, 2022 02:56:25.784 [0x7fdcd3204b38] DEBUG - Request: [192.168.5.9:2364 (Subnet)] GET /web/js/chunk-123-ff63466dc0e6aab4ae61-plex-4.76.1.22469-3117cd9.js (13 live) #e016 GZIP Signed-in
Jul 22, 2022 02:56:25.784 [0x7fdcd3204b38] DEBUG - [Req#e016] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-a806c5905/WebClient.bundle/Contents/Resources/js/chunk-123-ff63466dc0e6aab4ae61-plex-4.76.1.22469-3117cd9.js"
Jul 22, 2022 02:56:25.784 [0x7fdcd3204b38] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-a806c5905/WebClient.bundle/Contents/Resources/js/chunk-123-ff63466dc0e6aab4ae61-plex-4.76.1.22469-3117cd9.js is 379365 (of total: 379365).
Jul 22, 2022 02:56:25.785 [0x7fdcd2ce8b38] DEBUG - Request: [192.168.5.9:2366 (Subnet)] GET /web/js/chunk-781-b5e628b65a7c96dace72-plex-4.76.1.22469-3117cd9.js (14 live) #e021 GZIP Signed-in
Jul 22, 2022 02:56:25.785 [0x7fdcd2ce8b38] DEBUG - [Req#e021] Final path: "/usr/lib/plexmediaserver/Resources/Plug-ins-a806c5905/WebClient.bundle/Contents/Resources/js/chunk-781-b5e628b65a7c96dace72-plex-4.76.1.22469-3117cd9.js"
Jul 22, 2022 02:56:25.785 [0x7fdcd2ce8b38] DEBUG - Content-Length of /usr/lib/plexmediaserver/Resources/Plug-ins-a806c5905/WebClient.bundle/Contents/Resources/js/chunk-781-b5e628b65a7c96dace72-plex-4.76.1.22469-3117cd9.js is 7895 (of total: 7895).
Jul 22, 2022 02:56:25.785 [0x7fdcd4b67b38] DEBUG - Completed: [192.168.5.9:2366] 200 GET /web/js/chunk-781-b5e628b65a7c96dace72-plex-4.76.1.22469-3117cd9.js (14 live) GZIP 0ms 7895 bytes (pipelined: 1)
Jul 22, 2022 02:56:25.786 [0x7fdcd4b67b38] DEBUG - Completed: [192.168.5.9:2364] 200 GET /web/js/chunk-123-ff63466dc0e6aab4ae61-plex-4.76.1.22469-3117cd9.js (14 live) GZIP 1ms 379365 bytes (pipelined: 2)
Jul 22, 2022 02:56:25.849 [0x7fdcd2b9bb38] DEBUG - Request: [192.168.5.9:2353 (Subnet)] GET /video/:/transcode/universal/start.mpd?hasMDE=1&path=%2Flibrary%2Fmetadata%2F2011&mediaIndex=0&partIndex=0&protocol=dash&fastSeek=1&directPlay=0&directStream=1&subtitleSize=100&audioBoost=100&location=lan&addDebugOverlay=0&autoAdjustQuality=0&directStreamAudio=1&mediaBufferSize=102400&session=uo95kfynl9sh5itswia76dac&subtitles=auto&advancedSubtitles=text&Accept-Language=en (14 live) #e024 TLS GZIP Signed-in Token (OverStyleFR) (Opera)
Jul 22, 2022 02:56:25.849 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode] Found session GUID of uo95kfynl9sh5itswia76dac in session start.
Jul 22, 2022 02:56:25.849 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode] TranscodeUniversalRequest: adapting profile with augmentation data: add-limitation(scope=videoCodec&scopeName=*&type=upperBound&name=video.height&value=1280&replace=true)+append-transcode-target-codec(type=videoProfile&context=streaming&audioCodec=aac&protocol=dash)
Jul 22, 2022 02:56:25.849 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode] TranscodeUniversalRequest: using augmented profile Web
Jul 22, 2022 02:56:25.849 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode] Downloading document http://127.0.0.1:32400/library/metadata/2011?checkFiles=1&includeBandwidths=1&offset=-1&X-Plex-Incomplete-Segments=1&X-Plex-Session-Identifier=ettlochez84vmjjlajxag8ud
Jul 22, 2022 02:56:25.857 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/Req#e028] We're going to try to auto-select an audio stream for account 1.
Jul 22, 2022 02:56:25.857 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/Req#e028] Selecting best audio stream for part ID 3148 (autoselect: 1 language: fr)
Jul 22, 2022 02:56:25.857 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/Req#e028] We're going to try to auto-select a subtitle.
Jul 22, 2022 02:56:25.857 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/Req#e028] Subtitles: Found a candidate subtitle language [fr] for a foreign film
Jul 22, 2022 02:56:25.857 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/Req#e028] Audio Stream: 7574, Subtitle Stream: 7575
Jul 22, 2022 02:56:25.858 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/Req#e028] We're going to try to auto-select an audio stream for account 1.
Jul 22, 2022 02:56:25.858 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/Req#e028] Selecting best audio stream for part ID 3146 (autoselect: 1 language: fr)
Jul 22, 2022 02:56:25.858 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/Req#e028] We're going to try to auto-select a subtitle.
Jul 22, 2022 02:56:25.858 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/Req#e028] Subtitles: Found a candidate subtitle language [fr] for a foreign film
Jul 22, 2022 02:56:25.858 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/Req#e028] Audio Stream: 7572, Subtitle Stream: 7573
Jul 22, 2022 02:56:25.859 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode] Found session GUID of uo95kfynl9sh5itswia76dac in session start.
Jul 22, 2022 02:56:25.859 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode] Cleaning directory for session uo95kfynl9sh5itswia76dac ()
Jul 22, 2022 02:56:25.859 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode] Starting a transcode session uo95kfynl9sh5itswia76dac at offset -1.0 (state=3)
Jul 22, 2022 02:56:25.859 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode] TPU: hardware transcoding: using hardware decode accelerator nvdec
Jul 22, 2022 02:56:25.859 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode] TPU: hardware transcoding: zero-copy support present
Jul 22, 2022 02:56:25.859 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode] TPU: hardware transcoding: using zero-copy transcoding
Jul 22, 2022 02:56:25.859 [0x7fdcd2b9bb38] INFO - [Req#e024/Transcode] CodecManager: obtaining EAE
Jul 22, 2022 02:56:25.860 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/HCl#1b9] HTTP requesting GET https://plex.tv/api/codecs/easyaudioencoder?build=linux-x86_64-standard&deviceId=e9d1eecb-dc96-40ec-82b6-b310f537d060&oldestPreviousVersion=1%2E27%2E1%2E5916-6b0e31a64&version=1785
Jul 22, 2022 02:56:26.466 [0x7fdcd4644b38] DEBUG - [HttpClient/HCl#1b9] HTTP/2.0 (0.6s) 200 response from GET https://plex.tv/api/codecs/easyaudioencoder?build=linux-x86_64-standard&deviceId=e9d1eecb-dc96-40ec-82b6-b310f537d060&oldestPreviousVersion=1%2E27%2E1%2E5916-6b0e31a64&version=1785
Jul 22, 2022 02:56:26.471 [0x7fdcd4b8ab38] DEBUG - Completed: [192.168.5.9:2222] 200 GET /player/proxy/poll?deviceClass=pc&protocolVersion=3&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (14 live) TLS GZIP 20000ms 5 bytes (pipelined: 16)
Jul 22, 2022 02:56:26.475 [0x7fdcd2ad3b38] DEBUG - Request: [192.168.5.9:2222 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=3&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (14 live) #e02a TLS GZIP Signed-in Token (OverStyleFR) (Opera)
Jul 22, 2022 02:56:26.475 [0x7fdcd2ad3b38] DEBUG - Content-Length is -1 (of total: -1).
Jul 22, 2022 02:56:26.475 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/HCl#1ba] HTTP requesting GET https://downloads.plex.tv/codecs/1785/linux-x86_64-standard/EasyAudioEncoder-linux-x86_64-standard.zip
Jul 22, 2022 02:56:31.015 [0x7fdcd4644b38] DEBUG - [HttpClient/HCl#1ba] HTTP/2.0 (4.5s) 200 response from GET https://downloads.plex.tv/codecs/1785/linux-x86_64-standard/EasyAudioEncoder-linux-x86_64-standard.zip
Jul 22, 2022 02:56:31.073 [0x7fdcd2b9bb38] INFO - [Req#e024/Transcode] CodecManager: starting EAE at "/tmp/pms-71902ad8-9a06-4765-9d1b-ee8e3593799f/EasyAudioEncoder"
Jul 22, 2022 02:56:31.073 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/JobRunner] Job running: "/var/lib/plexmediaserver/Library/Application Support/Plex Media Server/Codecs/EasyAudioEncoder-1785-linux-x86_64/EasyAudioEncoder/EasyAudioEncoder"
Jul 22, 2022 02:56:31.087 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/JobRunner] Jobs: Starting child process with pid 82102
Jul 22, 2022 02:56:31.087 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode] [Universal] Using local file path instead of URL: /srv/dev-disk-by-uuid-dcb7f413-b47f-4380-a5da-abad1515dee3/Netflix/Repository/Miss.MARVEL.S01E06.FiNAL.4K.MULTI.2160p.HDR.WEB.H265-Wawacity.red.mkv
Jul 22, 2022 02:56:31.088 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode] TPU: hardware transcoding: final decoder: nvdec, final encoder: nvenc
Jul 22, 2022 02:56:31.089 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/JobRunner] Job running: EAE_ROOT=/tmp/pms-71902ad8-9a06-4765-9d1b-ee8e3593799f/EasyAudioEncoder FFMPEG_EXTERNAL_LIBS='/var/lib/plexmediaserver/Library/Application\ Support/Plex\ Media\ Server/Codecs/d53cb63-4323-linux-x86_64/' X_PLEX_TOKEN=xxxxxxxxxxxxxxxxxxxx "/usr/lib/plexmediaserver/Plex Transcoder" -codec:3 hevc -hwaccel:3 nvdec -hwaccel_fallback_threshold:3 10 -threads:3 1 -hwaccel_output_format:3 cuda -hwaccel_device:3 cuda -codec:0 eac3_eae -eae_prefix:0 uo95kfynl9sh5itswia76dac_ -analyzeduration 20000000 -probesize 20000000 -i /srv/dev-disk-by-uuid-dcb7f413-b47f-4380-a5da-abad1515dee3/Netflix/Repository/Miss.MARVEL.S01E06.FiNAL.4K.MULTI.2160p.HDR.WEB.H265-Wawacity.red.mkv -filter_complex "[0:3]hwupload[0];[0]scale_cuda=w=2276:h=1280:format=p010[1];[1]tonemap_cuda=mobius:nv12[2]" -map "[2]" -metadata:s:0 language=eng -codec:0 h264_nvenc -b:0 20000k -preset:0 hq -forced-idr:0 1 -r:0 24 -force_key_frames:0 "expr:gte(t,n_forced*1)" -filter_complex "[0:0] aresample=async=1:ocl='stereo':rematrix_maxval=0.000000dB:osr=48000[3]" -map "[3]" -metadata:s:1 language=fra -codec:1 aac -b:1 256k -f dash -seg_duration 1 -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/uo95kfynl9sh5itswia76dac/812299c9-0e23-4c0f-862e-3d85960efcc8/manifest?X-Plex-Http-Pipeline=infinite" -avoid_negative_ts disabled -map_metadata -1 -map_chapters -1 dash -map 0:1 -metadata:s:0 language=fra -codec:0 ass -f segment -segment_format ass -segment_time 1 -segment_header_filename sub-header -segment_start_number 0 -segment_list "http://127.0.0.1:32400/video/:/transcode/session/uo95kfynl9sh5itswia76dac/812299c9-0e23-4c0f-862e-3d85960efcc8/manifest?stream=subtitles&X-Plex-Http-Pipeline=infinite" -segment_list_type csv -segment_list_size 5 -segment_list_separate_stream_times 1 -segment_format_options ignore_readorder=1 -segment_list_unfinished 1 -fflags +flush_packets "sub-chunk-%05d" -start_at_zero -copyts -vsync cfr -init_hw_device cuda=cuda: -filter_hw_device cuda -y -nostats -loglevel quiet -loglevel_plex error -progressurl http://127.0.0.1:32400/video/:/transcode/session/uo95kfynl9sh5itswia76dac/812299c9-0e23-4c0f-862e-3d85960efcc8/progress
Jul 22, 2022 02:56:31.090 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/JobRunner] Jobs: Starting child process with pid 82103

If I look at this:

Jul 22, 2022 02:56:31.088 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode] TPU: hardware transcoding: final decoder: nvdec, final encoder: nvenc
Jul 22, 2022 02:56:31.089 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/JobRunner] Job running: EAE_ROOT=/tmp/pms-71902ad8-9a06-4765-9d1b-ee8e3593799f/EasyAudioEncoder FFMPEG_EXTERNAL_LIBS='/var/lib/plexmediaserver/Library/Application\ Support/Plex\ Media\ Server/Codecs/d53cb63-4323-linux-x86_64/' X_PLEX_TOKEN=xxxxxxxxxxxxxxxxxxxx "/usr/lib/plexmediaserver/Plex Transcoder" -codec:3 hevc -hwaccel:3 nvdec -hwaccel_fallback_threshold:3 10 -threads:3 1 -hwaccel_output_format:3 cuda -hwaccel_device:3 cuda -codec:0 eac3_eae -eae_prefix:0 uo95kfynl9sh5itswia76dac_ -analyzeduration 20000000 -probesize 20000000 -i /srv/dev-disk-by-uuid-dcb7f413-b47f-4380-a5da-abad1515dee3/Netflix/Repository/Miss.MARVEL.S01E06.FiNAL.4K.MULTI.2160p.HDR.WEB.H265-Wawacity.red.mkv -filter_complex "[0:3]hwupload[0];[0]scale_cuda=w=2276:h=1280:format=p010[1];[1]tonemap_cuda=mobius:nv12[2]" -map "[2]" -metadata:s:0 language=eng -codec:0 h264_nvenc -b:0 20000k -preset:0 hq -forced-idr:0 1 -r:0 24 -force_key_frames:0 "expr:gte(t,n_forced*1)" -filter_complex "[0:0] aresample=async=1:ocl='stereo':rematrix_maxval=0.000000dB:osr=48000[3]" -map "[3]" -metadata:s:1 language=fra -codec:1 aac -b:1 256k -f dash -seg_duration 1 -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/uo95kfynl9sh5itswia76dac/812299c9-0e23-4c0f-862e-3d85960efcc8/manifest?X-Plex-Http-Pipeline=infinite" -avoid_negative_ts disabled -map_metadata -1 -map_chapters -1 dash -map 0:1 -metadata:s:0 language=fra -codec:0 ass -f segment -segment_format ass -segment_time 1 -segment_header_filename sub-header -segment_start_number 0 -segment_list "http://127.0.0.1:32400/video/:/transcode/session/uo95kfynl9sh5itswia76dac/812299c9-0e23-4c0f-862e-3d85960efcc8/manifest?stream=subtitles&X-Plex-Http-Pipeline=infinite" -segment_list_type csv -segment_list_size 5 -segment_list_separate_stream_times 1 -segment_format_options ignore_readorder=1 -segment_list_unfinished 1 -fflags +flush_packets "sub-chunk-%05d" -start_at_zero -copyts -vsync cfr -init_hw_device cuda=cuda: -filter_hw_device cuda -y -nostats -loglevel quiet -loglevel_plex error -progressurl http://127.0.0.1:32400/video/:/transcode/session/uo95kfynl9sh5itswia76dac/812299c9-0e23-4c0f-862e-3d85960efcc8/progress
Jul 22, 2022 02:56:31.090 [0x7fdcd2b9bb38] DEBUG - [Req#e024/Transcode/JobRunner] Jobs: Starting child process with pid 82103

It is playing Miss.MARVEL.S01E06.FiNAL.4K.MULTI.2160p.HDR.WEB.H265-Wawacity.red.mkv

It is outputting: H264 video at 20 Mbps
-codec:0 h264_nvenc -b:0 20000k

It is scaling the output to match the display (2276 x 1280)

"[0:3]hwupload[0];[0]scale_cuda=w=2276:h=1280

The player appears to be the Opera web browser.

Is this what you expect ?

Yeah.

I change the fil and now it’s work ! But i don’t why :joy:

The new logs :
Plex Media Server Logs_2022-07-23_03-31-58.zip (4.4 MB)

I just found something.

Jul 23, 2022 03:29:54.766 [0x7f132a1f6b38] DEBUG - Completed: [192.168.5.9:1366] 200 GET /photo/:/transcode?width=1920&height=1080&minSize=1&opacity=10&background=343a3f&url=%2Flibrary%2Fmetadata%2F337%2Fart%2F1658513243%3FX-Plex-Token%3Dxxxxxxxxxxxxxxxxxxxx (12 live) TLS GZIP 460ms 58545 bytes (pipelined: 27)
Jul 23, 2022 03:29:55.833 [0x7f132cb4ab38] WARN - JobManager: Could not find job for handle 104646
Jul 23, 2022 03:29:55.834 [0x7f13291fdb38] ERROR - [Req#816/Transcode] [FFMPEG] - cu->cuInit(0) failed
Jul 23, 2022 03:29:55.834 [0x7f13291fdb38] ERROR - [Req#816/Transcode] [FFMPEG] -  -> CUDA_ERROR_UNKNOWN: unknown error
Jul 23, 2022 03:29:55.834 [0x7f13291fdb38] ERROR - [Req#816/Transcode] [FFMPEG] - 
Jul 23, 2022 03:29:55.834 [0x7f13291fdb38] DEBUG - [Req#816/Transcode] Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Jul 23, 2022 03:29:55.834 [0x7f13291fdb38] DEBUG - [Req#816/Transcode] Could not create hardware context for h264_nvenc
Jul 23, 2022 03:29:55.834 [0x7f13291fdb38] DEBUG - [Req#816/Transcode] Codecs: testing hevc (decoder) with hwdevice vaapi
Jul 23, 2022 03:29:55.834 [0x7f13291fdb38] DEBUG - [Req#816/Transcode] Codecs: hardware transcoding: testing API vaapi
Jul 23, 2022 03:29:55.834 [0x7f13291fdb38] ERROR - [Req#816/Transcode] [FFMPEG] - libva: vaGetDriverNameByIndex() failed with unknown libva error, driver_name = (null)
Jul 23, 2022 03:29:55.834 [0x7f13291fdb38] ERROR - [Req#816/Transcode] [FFMPEG] - Failed to initialise VAAPI connection: -1 (unknown libva error).
Jul 23, 2022 03:29:55.834 [0x7f13291fdb38] DEBUG - [Req#816/Transcode] Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: I/O error
Jul 23, 2022 03:29:55.834 [0x7f13291fdb38] DEBUG - [Req#816/Transcode] Could not create hardware context for hevc
Jul 23, 2022 03:29:55.834 [0x7f13291fdb38] DEBUG - [Req#816/Transcode] Codecs: testing hevc (decoder) with hwdevice nvdec
Jul 23, 2022 03:29:55.835 [0x7f13291fdb38] DEBUG - [Req#816/Transcode] Codecs: hardware transcoding: testing API nvdec

Are the Nvidia drivers up to date?
Was there another device locking the GPU ?
Does the card you are using support 2160p HEVC ?

Yes i think the drivers is up to date.
I have only one GPU card.
And i don’t know

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