QNAP transcoding problems after upgrade to Firmware 5.0.0.1986 Build 20220324

Plex Media Server NAS & Devices
1

Hello Plex community,
despite Plex pass and a NAS what is listed in the compatibility list, since upgrading to the latest QNAP version (and the latest Plex qpkg) I have problems playing media that needs to be converted. This manifests itself by having to wait a long time after a few seconds for buffering of playback, or even not starting playback at all.

So currently my Plex app on iOS can only play things that run via direct play.

Am I making a mistake or does the Plex app need to be updated to the new QNAP update?

Thanks!
jomjohannes

Server Version#: 1.25.9.5673 (.opkg install), running as user admin.
Player Version#: iOS Version 8, latest iOS Upgrade
QNAP: TS-453Be (Intel(R) Celeron(R) CPU J3455), Firmware QTS 5.0.0.1986 Build 20220324

Settings:

CleanShot 2022-04-03 at 13.40.52@2x
CleanShot 2022-04-03 at 13.40.52@2x774×646 67.6 KB

[~] # ls -la /dev/dri
total 0
drwxr-xr-x  2 admin administrators       80 2022-04-03 14:16 ./
drwxr-xr-x 16 admin administrators    20640 2022-04-03 14:08 ../
crw-------  1 admin administrators 226,   0 2022-04-03 14:16 card0
crw-------  1 admin administrators 226, 128 2022-04-03 14:16 renderD128

Logs:

Apr 03, 2022 14:13:42.478 [0x7f057680cb38] DEBUG - [Now] User is Julia (ID: 123276799)
Apr 03, 2022 14:13:42.478 [0x7f057680cb38] DEBUG - [Now] Device is iOS (iPad von Julia).
Apr 03, 2022 14:13:42.478 [0x7f057680cb38] DEBUG - [Now] Profile is iOS
Apr 03, 2022 14:13:42.478 [0x7f057680cb38] DEBUG - [Now] Updated play state for /library/metadata/27687.
Apr 03, 2022 14:13:42.488 [0x7f057680cb38] DEBUG - It took 0.000000 ms to retrieve 125 items.
Apr 03, 2022 14:13:42.490 [0x7f0576a9ab38] DEBUG - Request: [192.168.178.28:65448 (Subnet)] GET /status/sessions (21 live) TLS GZIP Signed-in Token (jomjohannes) (Safari)
Apr 03, 2022 14:13:42.490 [0x7f05774b5b38] DEBUG - Request: [192.168.178.92:64824 (Subnet)] GET /video/:/transcode/universal/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/base/index.m3u8 (21 live) TLS GZIP Signed-in
Apr 03, 2022 14:13:42.491 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] Starting a transcode session EBA2235B-5743-4AD7-8418-4DED4CAA2503 at offset -1.0 (state=3)
Apr 03, 2022 14:13:42.491 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] TPU: hardware transcoding: using hardware decode accelerator vaapi
Apr 03, 2022 14:13:42.491 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] TPU: hardware transcoding: zero-copy support present
Apr 03, 2022 14:13:42.491 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] TPU: hardware transcoding: using zero-copy transcoding
Apr 03, 2022 14:13:42.492 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] [Universal] Using local file path instead of URL: /share/Download/torrent/complete/Filme/fooo/fooo.mkv
Apr 03, 2022 14:13:42.492 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] Codecs: hardware transcoding: testing API vaapi
Apr 03, 2022 14:13:42.493 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] [FFMPEG] - Format 0x32315659 -> yuv420p.
Apr 03, 2022 14:13:42.493 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] [FFMPEG] - Format 0x30323449 -> yuv420p.
Apr 03, 2022 14:13:42.493 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] [FFMPEG] - Format 0x3231564e -> nv12.
Apr 03, 2022 14:13:42.493 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] [FFMPEG] - Format 0x32595559 -> yuyv422.
Apr 03, 2022 14:13:42.493 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] [FFMPEG] - Format 0x59565955 -> uyvy422.
Apr 03, 2022 14:13:42.493 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] [FFMPEG] - Format 0x48323234 -> yuv422p.
Apr 03, 2022 14:13:42.493 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] [FFMPEG] - Format 0x58424752 -> rgb0.
Apr 03, 2022 14:13:42.493 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] [FFMPEG] - Format 0x58524742 -> bgr0.
Apr 03, 2022 14:13:42.493 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] [FFMPEG] - Format 0x30313050 -> p010le.
Apr 03, 2022 14:13:42.493 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] [FFMPEG] - Created surface 0x4000000.
Apr 03, 2022 14:13:42.493 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] [FFMPEG] - Direct mapping possible.
Apr 03, 2022 14:13:42.494 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] TPU: hardware transcoding: final decoder: vaapi, final encoder: vaapi
Apr 03, 2022 14:13:42.494 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503/JobRunner] Job running: EAE_ROOT='/share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Library/tmp/pms-e9759754-08de-4843-92c9-437fedd180f5/EasyAudioEncoder' FFMPEG_EXTERNAL_LIBS='/share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Library/Plex\ Media\ Server/Codecs/62cc2bc-4278-linux-x86_64/' LIBVA_DRIVERS_PATH='/share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/lib/dri' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Plex Transcoder' '-codec:0' 'hevc' '-hwaccel:0' 'vaapi' '-hwaccel_fallback_threshold:0' '10' '-hwaccel_output_format:0' 'vaapi' '-hwaccel_device:0' 'vaapi' '-codec:2' 'eac3_eae' '-eae_prefix:2' 'EBA2235B-5743-4AD7-8418-4DED4CAA2503_' '-ss' '1958' '-analyzeduration' '20000000' '-probesize' '20000000' '-i' '/share/Download/torrent/complete/Filme/fooo/fooo.mkv' '-filter_complex' '[0:0]hwupload[0];[0]scale_vaapi=w=3840:h=1920,scale_vaapi=format=p010[1];[1]hwdownload[2];[2]format=p010,tonemap=mobius[3];[3]hwupload[4]' '-map' '[4]' '-codec:0' 'h264_vaapi' '-b:0' '20000k' '-r:0' '24' '-force_key_frames:0' 'expr:gte(t,n_forced*3)' '-filter_complex' '[0:2] aresample=async=1:ocl='\''stereo'\'':rematrix_maxval=0.000000dB:osr=48000[5]' '-map' '[5]' '-metadata:s:1' 'language=eng' '-codec:1' 'aac' '-b:1' '256k' '-segment_format' 'mpegts' '-f' 'ssegment' '-individual_header_trailer' '0' '-segment_time' '3' '-segment_start_number' '652' '-segment_copyts' '1' '-segment_time_delta' '0.0625' '-segment_list' 'http://127.0.0.1:32400/video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/manifest?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' '-init_hw_device' 'vaapi=vaapi:,driver=i965' '-filter_hw_device' 'vaapi' '-y' '-nostats' '-loglevel' 'quiet' '-loglevel_plex' 'error' '-progressurl' 'http://127.0.0.1:32400/video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress'
Apr 03, 2022 14:13:42.495 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503/JobRunner] Jobs: Starting child process with pid 29030
Apr 03, 2022 14:13:42.500 [0x7f0576aeeb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?status=startup (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:42.500 [0x7f057897db38] DEBUG - Completed: [127.0.0.1:54816] 204 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?status=startup (22 live) 0ms 203 bytes (pipelined: 1) (range: bytes=0-) 
Apr 03, 2022 14:13:42.507 [0x7f0576acbb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?status=startup (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:42.507 [0x7f057895ab38] DEBUG - Completed: [127.0.0.1:54816] 204 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?status=startup (22 live) 0ms 203 bytes (pipelined: 2) (range: bytes=0-) 
Apr 03, 2022 14:13:42.507 [0x7f05769dcb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?status=opening (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:42.508 [0x7f057895ab38] DEBUG - Completed: [127.0.0.1:54816] 204 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?status=opening (22 live) 0ms 203 bytes (pipelined: 3) (range: bytes=0-) 
Apr 03, 2022 14:13:42.508 [0x7f057680cb38] DEBUG - Statistics: (8CF7C69A-2874-4058-A815-139AB08881DB) Reporting active playback in state 2 of type 1 (scrobble: 0) for account 123276799
Apr 03, 2022 14:13:42.510 [0x7f0576a9ab38] DEBUG - [Now] Adding 1 sessions.
Apr 03, 2022 14:13:42.510 [0x7f0576aeeb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?status=opened (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:42.510 [0x7f0576acbb38] DEBUG - Request: [192.168.178.28:54908 (Subnet)] GET /status/sessions (22 live) TLS GZIP Signed-in Token (jomjohannes) (milhouse.fritz.box)
Apr 03, 2022 14:13:42.510 [0x7f057897db38] DEBUG - Completed: [127.0.0.1:54816] 204 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?status=opened (22 live) 0ms 203 bytes (pipelined: 4) (range: bytes=0-) 
Apr 03, 2022 14:13:42.510 [0x7f0576acbb38] DEBUG - [Now] Adding 1 sessions.
Apr 03, 2022 14:13:42.511 [0x7f05769dcb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/stream?index=0&id=0&codec=hevc&type=video (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:42.512 [0x7f057895ab38] DEBUG - Completed: [127.0.0.1:54816] 200 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/stream?index=0&id=0&codec=hevc&type=video (22 live) 1ms 195 bytes (pipelined: 5) (range: bytes=0-) 
Apr 03, 2022 14:13:42.513 [0x7f057897db38] DEBUG - Completed: [192.168.178.28:65448] 200 GET /status/sessions (22 live) TLS GZIP 22ms 3898 bytes (pipelined: 3)
Apr 03, 2022 14:13:42.513 [0x7f0576aeeb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/stream?index=1&id=0&codec=eac3&type=audio (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:42.515 [0x7f057895ab38] DEBUG - Completed: [192.168.178.92:64811] 200 GET /:/timeline?bufferedTime=0&col=0&context=home%3Ahub.continueWatching&duration=7018833&key=%2Flibrary%2Fmetadata%2F27687&location=lan&playQueueItemID=5446&playbackTime=0&ratingKey=27687&row=0&state=buffering&time=1958806 (22 live) TLS GZIP 39ms 743 bytes (pipelined: 14)
Apr 03, 2022 14:13:42.515 [0x7f057895ab38] DEBUG - Completed: [192.168.178.28:54908] 200 GET /status/sessions (22 live) TLS GZIP 5ms 3773 bytes (pipelined: 3)
Apr 03, 2022 14:13:42.516 [0x7f057895ab38] DEBUG - Completed: [127.0.0.1:54816] 200 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/stream?index=1&id=0&codec=eac3&type=audio (22 live) 2ms 195 bytes (pipelined: 6) (range: bytes=0-) 
Apr 03, 2022 14:13:42.516 [0x7f05769dcb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/stream?index=2&id=0&codec=eac3&type=audio (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:42.517 [0x7f057897db38] DEBUG - Completed: [127.0.0.1:54816] 200 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/stream?index=2&id=0&codec=eac3&type=audio (22 live) 0ms 195 bytes (pipelined: 7) (range: bytes=0-) 
Apr 03, 2022 14:13:42.518 [0x7f0576a9ab38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/streamDetail?index=0&id=0&codec=hevc&type=video&profile=Main%2010&width=3840&height=1920&interlaced=0&sar=1:1&level=150&frameRate=24.000&disp_default=1 (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:42.519 [0x7f057897db38] DEBUG - Completed: [127.0.0.1:54816] 200 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/streamDetail?index=0&id=0&codec=hevc&type=video&profile=Main%2010&width=3840&height=1920&interlaced=0&sar=1:1&level=150&frameRate=24.000&disp_default=1 (22 live) 0ms 195 bytes (pipelined: 8) (range: bytes=0-) 
Apr 03, 2022 14:13:42.519 [0x7f057680cb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/streamDetail?index=1&id=0&codec=eac3&type=audio&language=ger&channels=6&layout=5.1%28side%29&sampleRate=48000&disp_default=1 (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:42.520 [0x7f057897db38] DEBUG - Completed: [127.0.0.1:54816] 200 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/streamDetail?index=1&id=0&codec=eac3&type=audio&language=ger&channels=6&layout=5.1%28side%29&sampleRate=48000&disp_default=1 (22 live) 0ms 195 bytes (pipelined: 9) (range: bytes=0-) 
Apr 03, 2022 14:13:42.520 [0x7f0576acbb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/streamDetail?index=2&id=0&codec=eac3&type=audio&language=eng&channels=6&layout=5.1%28side%29&sampleRate=48000 (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:42.521 [0x7f057895ab38] DEBUG - Completed: [127.0.0.1:54816] 200 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/streamDetail?index=2&id=0&codec=eac3&type=audio&language=eng&channels=6&layout=5.1%28side%29&sampleRate=48000 (22 live) 0ms 195 bytes (pipelined: 10) (range: bytes=0-) 
Apr 03, 2022 14:13:42.521 [0x7f0576aeeb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/streamDetail?index=3&id=0&codec=subrip&type=subtitle&language=ger&disp_default=1&disp_forced=1 (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:42.521 [0x7f057895ab38] DEBUG - Completed: [127.0.0.1:54816] 200 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/streamDetail?index=3&id=0&codec=subrip&type=subtitle&language=ger&disp_default=1&disp_forced=1 (22 live) 0ms 195 bytes (pipelined: 11) (range: bytes=0-) 
Apr 03, 2022 14:13:42.522 [0x7f05769dcb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/streamDetail?index=4&id=0&codec=subrip&type=subtitle&language=ger (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:42.522 [0x7f057895ab38] DEBUG - Completed: [127.0.0.1:54816] 200 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/streamDetail?index=4&id=0&codec=subrip&type=subtitle&language=ger (22 live) 0ms 195 bytes (pipelined: 12) (range: bytes=0-) 
Apr 03, 2022 14:13:42.522 [0x7f0576a9ab38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/streamDetail?index=5&id=0&codec=subrip&type=subtitle&language=eng (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:42.523 [0x7f057897db38] DEBUG - Completed: [127.0.0.1:54816] 200 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress/streamDetail?index=5&id=0&codec=subrip&type=subtitle&language=eng (22 live) 0ms 195 bytes (pipelined: 13) (range: bytes=0-) 
Apr 03, 2022 14:13:42.537 [0x7f057680cb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?duration=7018.834000 (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:42.537 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] Started session successfully: EBA2235B-5743-4AD7-8418-4DED4CAA2503
Apr 03, 2022 14:13:42.537 [0x7f057895ab38] DEBUG - Completed: [127.0.0.1:54816] 204 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?duration=7018.834000 (22 live) 0ms 203 bytes (pipelined: 14) (range: bytes=0-) 
Apr 03, 2022 14:13:42.537 [0x7f05774b5b38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] HLS: Building an M3U8 for 7019 total seconds with 3 seconds/segment, target duration of 3.
Apr 03, 2022 14:13:42.541 [0x7f057895ab38] DEBUG - Completed: [192.168.178.92:64824] 200 GET /video/:/transcode/universal/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/base/index.m3u8 (22 live) TLS GZIP 50ms 6281 bytes (pipelined: 2)
Apr 03, 2022 14:13:42.560 [0x7f0576acbb38] DEBUG - Request: [192.168.178.28:65448 (Subnet)] GET /status/sessions (22 live) TLS GZIP Signed-in Token (jomjohannes) (Safari)
Apr 03, 2022 14:13:42.560 [0x7f0576acbb38] DEBUG - [Now] Adding 1 sessions.
Apr 03, 2022 14:13:42.562 [0x7f057897db38] DEBUG - Completed: [192.168.178.28:65448] 200 GET /status/sessions (22 live) TLS GZIP 2ms 3904 bytes (pipelined: 4)
Apr 03, 2022 14:13:42.583 [0x7f0576aeeb38] DEBUG - Request: [192.168.178.28:54908 (Subnet)] GET /status/sessions (22 live) TLS GZIP Signed-in Token (jomjohannes) (milhouse.fritz.box)
Apr 03, 2022 14:13:42.583 [0x7f0576aeeb38] DEBUG - [Now] Adding 1 sessions.
Apr 03, 2022 14:13:42.585 [0x7f057895ab38] DEBUG - Completed: [192.168.178.28:54908] 200 GET /status/sessions (22 live) TLS GZIP 2ms 3779 bytes (pipelined: 4)
Apr 03, 2022 14:13:42.629 [0x7f05769dcb38] DEBUG - Request: [192.168.178.92:64824 (Subnet)] GET /video/:/transcode/universal/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/base/00652.ts (22 live) TLS Signed-in
Apr 03, 2022 14:13:42.629 [0x7f05769dcb38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] Asked for segment 652 from session.
Apr 03, 2022 14:13:42.629 [0x7f057895ab38] DEBUG - Auth: authenticated user 123276799 as Julia
Apr 03, 2022 14:13:42.630 [0x7f057895ab38] DEBUG - Request: [192.168.178.92:64811 (Subnet)] GET /transcode/sessions (22 live) TLS GZIP Signed-in Token ()
Apr 03, 2022 14:13:42.630 [0x7f057895ab38] DEBUG - Completed: [192.168.178.92:64811] 401 GET /transcode/sessions (22 live) TLS GZIP 0ms 357 bytes
Apr 03, 2022 14:13:43.451 [0x7f05786c0b38] DEBUG - [HttpClient] HTTP/2.0 (1.2s) 404 response from POST https://fooooo.fooooo.com/api?id=0645ec20fd7afa5e466643393b8e3dd3
Apr 03, 2022 14:13:43.452 [0x7f057660eb38] WARN - Webhook: Error delivering payload to https://fooooo.fooooo.com/api?id=0645ec20fd7afa5e466643393b8e3dd3: 404
Apr 03, 2022 14:13:43.487 [0x7f0576a9ab38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=0.0&size=-22&remaining=-1&vdec_packets=55&vdec_hw_ok=49&speed=0.0&vdec_hw_status=1 (21 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:43.488 [0x7f057895ab38] DEBUG - Completed: [127.0.0.1:54816] 206 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=0.0&size=-22&remaining=-1&vdec_packets=55&vdec_hw_ok=49&speed=0.0&vdec_hw_status=1 (21 live) 0ms 355 bytes (pipelined: 15) (range: bytes=0-) 
Apr 03, 2022 14:13:43.814 [0x7f0576a9ab38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=-1&vdec_packets=56&vdec_hw_ok=50&speed=-3097.3&vdec_hw_status=1 (21 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:43.815 [0x7f057897db38] DEBUG - Completed: [127.0.0.1:54816] 206 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=-1&vdec_packets=56&vdec_hw_ok=50&speed=-3097.3&vdec_hw_status=1 (21 live) 0ms 355 bytes (pipelined: 16) (range: bytes=0-) 
Apr 03, 2022 14:13:43.885 [0x7f05786c0b38] DEBUG - [HttpClient] HTTP/2.0 (1.7s) 502 response from POST https://fooooo.fooooo.com/api?id=2ff88f80346d953ec2db838ba23e3724
Apr 03, 2022 14:13:43.885 [0x7f0576686b38] WARN - Webhook: Error delivering payload to https://fooooo.fooooo.com/api?id=2ff88f80346d953ec2db838ba23e3724: 502
Apr 03, 2022 14:13:44.455 [0x7f057680cb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=67521&vdec_packets=58&vdec_hw_ok=52&speed=0.1&vdec_hw_status=1 (21 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:44.455 [0x7f057895ab38] DEBUG - Completed: [127.0.0.1:54816] 206 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=67521&vdec_packets=58&vdec_hw_ok=52&speed=0.1&vdec_hw_status=1 (21 live) 0ms 355 bytes (pipelined: 17) (range: bytes=0-) 
Apr 03, 2022 14:13:44.788 [0x7f0576a9ab38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=139987&vdec_packets=59&vdec_hw_ok=53&speed=0.1&vdec_hw_status=1 (21 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:44.789 [0x7f057895ab38] DEBUG - Completed: [127.0.0.1:54816] 206 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=139987&vdec_packets=59&vdec_hw_ok=53&speed=0.1&vdec_hw_status=1 (21 live) 0ms 355 bytes (pipelined: 18) (range: bytes=0-) 
Apr 03, 2022 14:13:44.824 [0x7f057895ab38] DEBUG - Completed: [192.168.178.28:65371] 200 GET /player/proxy/poll?deviceClass=pc&protocolVersion=3&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (21 live) TLS GZIP 20001ms 5 bytes (pipelined: 26)
Apr 03, 2022 14:13:44.844 [0x7f057680cb38] DEBUG - Request: [192.168.178.28:65371 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=3&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (21 live) TLS GZIP Signed-in Token (jomjohannes) (Safari)
Apr 03, 2022 14:13:44.845 [0x7f057680cb38] DEBUG - Content-Length is -1 (of total: -1).
Apr 03, 2022 14:13:45.668 [0x7f0576a9ab38] DEBUG - Request: [192.168.178.92:64826 (Subnet)] GET /video/:/transcode/universal/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/base/00652.ts (22 live) TLS Signed-in
Apr 03, 2022 14:13:45.668 [0x7f0576a9ab38] DEBUG - [Transcode/EBA2235B-5743-4AD7-8418-4DED4CAA2503] Asked for segment 652 from session.
Apr 03, 2022 14:13:45.760 [0x7f057680cb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=95962&vdec_packets=62&vdec_hw_ok=56&speed=0.2&vdec_hw_status=1 (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:45.761 [0x7f057895ab38] DEBUG - Completed: [127.0.0.1:54816] 206 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=95962&vdec_packets=62&vdec_hw_ok=56&speed=0.2&vdec_hw_status=1 (22 live) 0ms 355 bytes (pipelined: 19) (range: bytes=0-) 
Apr 03, 2022 14:13:46.421 [0x7f05774b5b38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=58348&vdec_packets=64&vdec_hw_ok=58&speed=0.1&vdec_hw_status=1 (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:46.422 [0x7f057897db38] DEBUG - Completed: [127.0.0.1:54816] 206 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=58348&vdec_packets=64&vdec_hw_ok=58&speed=0.1&vdec_hw_status=1 (22 live) 0ms 355 bytes (pipelined: 20) (range: bytes=0-) 
Apr 03, 2022 14:13:47.105 [0x7f05774b5b38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=72111&vdec_packets=66&vdec_hw_ok=60&speed=0.1&vdec_hw_status=1 (22 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:47.106 [0x7f057895ab38] DEBUG - Completed: [127.0.0.1:54816] 206 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=72111&vdec_packets=66&vdec_hw_ok=60&speed=0.1&vdec_hw_status=1 (22 live) 0ms 355 bytes (pipelined: 21) (range: bytes=0-) 
Apr 03, 2022 14:13:47.589 [0x7f057895ab38] DEBUG - Completed: [192.168.178.28:53314] 200 GET /player/proxy/poll?deviceClass=pc&protocolVersion=3&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (22 live) TLS GZIP 20001ms 5 bytes (pipelined: 127)
Apr 03, 2022 14:13:47.617 [0x7f057680cb38] DEBUG - Request: [192.168.178.28:53314 (Subnet)] GET /player/proxy/poll?deviceClass=pc&protocolVersion=3&protocolCapabilities=timeline%2Cplayback%2Cnavigation%2Cmirror%2Cplayqueues&timeout=1 (22 live) TLS GZIP Signed-in Token (jomjohannes) (milhouse.fritz.box)
Apr 03, 2022 14:13:47.617 [0x7f057680cb38] DEBUG - Content-Length is -1 (of total: -1).
Apr 03, 2022 14:13:47.627 [0x7f057895ab38] DEBUG - Auth: authenticated user 123276799 as Julia
Apr 03, 2022 14:13:47.627 [0x7f057895ab38] DEBUG - Request: [192.168.178.92:64812 (Subnet)] GET /transcode/sessions (22 live) TLS GZIP Signed-in Token ()
Apr 03, 2022 14:13:47.628 [0x7f057895ab38] DEBUG - Completed: [192.168.178.92:64812] 401 GET /transcode/sessions (22 live) TLS GZIP 0ms 357 bytes
Apr 03, 2022 14:13:47.628 [0x7f057895ab38] DEBUG - Auth: authenticated user 123276799 as Julia
Apr 03, 2022 14:13:47.631 [0x7f05774b5b38] DEBUG - Request: [192.168.178.92:64813 (Subnet)] GET /:/timeline?bufferedTime=0&col=0&context=home%3Ahub.continueWatching&duration=7018833&key=%2Flibrary%2Fmetadata%2F27687&location=lan&playQueueItemID=5446&playbackTime=0&ratingKey=27687&row=0&state=buffering&time=1958806 (22 live) TLS GZIP Signed-in Token (Julia)
Apr 03, 2022 14:13:47.632 [0x7f05774b5b38] DEBUG - Client [8CF7C69A-2874-4058-A815-139AB08881DB] reporting timeline state buffering, progress of 1958806/7018833ms for guid=, playbackTime=0ms ratingKey=27687 url=, key=/library/metadata/27687, containerKey=, metadataId=27687, source=
Apr 03, 2022 14:13:47.634 [0x7f05774b5b38] DEBUG - Play progress on 27687 'I Want You Back' - got played 1958806 ms by account 123276799!
Apr 03, 2022 14:13:47.635 [0x7f05774b5b38] DEBUG - [Now] User is Julia (ID: 123276799)
Apr 03, 2022 14:13:47.635 [0x7f05774b5b38] DEBUG - [Now] Device is iOS (iPad von Julia).
Apr 03, 2022 14:13:47.635 [0x7f05774b5b38] DEBUG - [Now] Profile is iOS
Apr 03, 2022 14:13:47.635 [0x7f05774b5b38] DEBUG - [Now] Updated play state for /library/metadata/27687.
Apr 03, 2022 14:13:47.648 [0x7f05774b5b38] DEBUG - It took 10.000000 ms to retrieve 125 items.
Apr 03, 2022 14:13:47.680 [0x7f05774b5b38] DEBUG - Statistics: (8CF7C69A-2874-4058-A815-139AB08881DB) Reporting active playback in state 2 of type 1 (scrobble: 0) for account 123276799
Apr 03, 2022 14:13:47.683 [0x7f057897db38] DEBUG - Completed: [192.168.178.92:64813] 200 GET /:/timeline?bufferedTime=0&col=0&context=home%3Ahub.continueWatching&duration=7018833&key=%2Flibrary%2Fmetadata%2F27687&location=lan&playQueueItemID=5446&playbackTime=0&ratingKey=27687&row=0&state=buffering&time=1958806 (21 live) TLS GZIP 51ms 793 bytes (pipelined: 9)
Apr 03, 2022 14:13:47.785 [0x7f0576acbb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=73354&vdec_packets=68&vdec_hw_ok=62&speed=0.1&vdec_hw_status=1 (21 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:47.786 [0x7f057895ab38] DEBUG - Completed: [127.0.0.1:54816] 206 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=73354&vdec_packets=68&vdec_hw_ok=62&speed=0.1&vdec_hw_status=1 (21 live) 0ms 355 bytes (pipelined: 22) (range: bytes=0-) 
Apr 03, 2022 14:13:48.107 [0x7f0576aeeb38] DEBUG - Request: [127.0.0.1:54816 (Loopback)] PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=106653&vdec_packets=69&vdec_hw_ok=63&speed=0.1&vdec_hw_status=1 (21 live) Signed-in Token (jomjohannes) (schnippi) (range: bytes=0-) 
Apr 03, 2022 14:13:48.108 [0x7f057897db38] DEBUG - Completed: [127.0.0.1:54816] 206 PUT /video/:/transcode/session/EBA2235B-5743-4AD7-8418-4DED4CAA2503/fe00a2ef-f441-4e77-bf29-74aa9d97a587/progress?progress=-27.9&size=-22&remaining=106653&vdec_packets=69&vdec_hw_ok=63&speed=0.1&vdec_hw_status=1 (21 live) 0ms 355 bytes (pipelined: 23) (range: bytes=0-) 

<SessionReport version="2" startTime="0" startTimestamp="Apr 03, 2022 14:13:42.442" key="/library/metadata/27687" session="8CF7C69A-2874-4058-A815-139AB08881DB" transcode="EBA2235B-5743-4AD7-8418-4DED4CAA2503">
<User id="123276799" thumb="https://plex.tv/users/6a617e127d4c9bc4/avatar?c=1645447181" title="Julia" />
<Player address="192.168.178.92" device="iPad" machineIdentifier="8CF7C69A-2874-4058-A815-139AB08881DB" model="7,5" platform="iOS" platformVersion="15.4.1" product="Plex for iOS" title="iPad von Julia" vendor="Apple" version="8.0" local="1" relayed="0" secure="1" userID="123276799" />
<Variants>
<Variant id="fe00a2ef-f441-4e77-bf29-74aa9d97a587" targetBitrate="10000000" context="streaming" sourceVideoCodec="hevc" sourceAudioCodec="eac3" videoDecision="transcode" audioDecision="transcode" protocol="hls" container="mpegts" videoCodec="h264" audioCodec="aac" audioChannels="2" transcodeHwRequested="1" transcodeHwDecoding="vaapi" transcodeHwEncoding="vaapi" transcodeHwDecodingTitle="Intel (VA API)" transcodeHwEncodingTitle="Intel (VA API)" transcodeHwFullPipeline="1">
<Media id="20985" videoProfile="main 10" audioChannels="2" audioCodec="aac" container="mpegts" duration="7018833" height="1920" protocol="hls" videoCodec="h264" videoFrameRate="24p" videoResolution="4K" width="3840" selected="1">
<Part deepAnalysisVersion="6" id="21375" requiredBandwidths="16292,16286,16270,16270,16270,16270,16270,16270" videoProfile="main 10" container="mpegts" duration="7018833" height="1920" protocol="hls" width="3840" decision="transcode" selected="1">
<Stream bitrate="2147483647" codec="h264" default="1" displayTitle="4K HDR10 (HEVC Main 10)" extendedDisplayTitle="4K HDR10 (HEVC Main 10)" frameRate="24" height="1920" id="39199" requiredBandwidths="15012,15006,14990,14990,14990,14990,14990,14990" streamType="1" width="3840" decision="transcode" location="segments-av" />
<Stream bitrate="256" bitrateMode="cbr" channels="2" codec="aac" displayTitle="English (EAC3 5.1)" extendedDisplayTitle="English (EAC3 5.1)" id="39201" language="English" languageCode="eng" languageTag="en" requiredBandwidths="640,640,640,640,640,640,640,640" selected="1" streamType="2" decision="transcode" location="segments-av" />
</Part>
</Media>
</Variant>
</Variants>
<SegmentList>
<Segment duration="0" startOffset="-1" endOffset="-1">
<Timelines>
<Download startTime="186" fileType="av" variant="fe00a2ef-f441-4e77-bf29-74aa9d97a587" />
<Download startTime="3225" fileType="av" variant="fe00a2ef-f441-4e77-bf29-74aa9d97a587" />
<Download startTime="13169" fileType="av" variant="fe00a2ef-f441-4e77-bf29-74aa9d97a587" />
</Timelines>
</Segment>
</SegmentList>
<PlaybackReports>
<Playback startTime="68" endTime="5238" state="buffering" progress="1958806" />
<Playback startTime="5238" endTime="13548" state="buffering" progress="1958806" />
<Playback startTime="13548" endTime="13587" state="stopped" progress="0" />
</PlaybackReports>
<StateReports />
<StateReports />
</SessionReport>
2

Please tell me if there is anything else I can do to help solve this problem. My wife can no longer watch her favourite show on her iPad and I desperately want to fix this condition. :blush:

3

May I see the full log ZIP file which contains a playback attempt ?

I need to see more of the PMS log (before and after the FFMPEG invocation)

5

@jomjohannes

Thank you for the logs:

  1. This is all good
Apr 03, 2022 16:41:01.918 [0x7f057a208b38] INFO - Plex Media Server v1.25.9.5673-bf5697c5d - QNAP TS-453Be x86_64 - build: linux-x86_64 qnap - GMT 02:00
Apr 03, 2022 16:41:01.918 [0x7f057a208b38] INFO - Linux version: QTS 5.0.0.1986, language: en-US
Apr 03, 2022 16:41:01.918 [0x7f057a208b38] INFO - Processor: 4-core Intel(R) Celeron(R) CPU J3455 @ 1.50GHz

This starts out ok (MDE:) but absolutely fails to see any hardware

Apr 03, 2022 17:08:26.193 [0x7f0575048b38] DEBUG - [Transcode] It took 0.000000 ms to retrieve 125 items.
Apr 03, 2022 17:08:26.196 [0x7f0575048b38] DEBUG - [Transcode] We're going to try to auto-select an audio stream for account 123276799.
Apr 03, 2022 17:08:26.196 [0x7f0575048b38] DEBUG - [Transcode] Selecting best audio stream for part ID 21375 (autoselect: 1 language: en)
Apr 03, 2022 17:08:26.196 [0x7f0575048b38] DEBUG - [Transcode] We're going to try to auto-select a subtitle.
Apr 03, 2022 17:08:26.196 [0x7f0575048b38] DEBUG - [Transcode] Audio Stream: 39201, Subtitle Stream: -1
Apr 03, 2022 17:08:26.200 [0x7f0575048b38] DEBUG - [Transcode] MDE: Selected protocol hls; container: mkv
Apr 03, 2022 17:08:26.200 [0x7f0575048b38] DEBUG - [Transcode] MDE: analyzing media item 20985
Apr 03, 2022 17:08:26.200 [0x7f0575048b38] DEBUG - [Transcode] MDE: Filmtitle1 (2022): Direct Play is disabled
Apr 03, 2022 17:08:26.200 [0x7f0575048b38] DEBUG - [Transcode] MDE: Filmtitle1 (2022): media must be transcoded in order to use the hls protocol
Apr 03, 2022 17:08:26.200 [0x7f0575048b38] DEBUG - [Transcode] MDE: Filmtitle1 (2022): selected audio stream is not the first audio stream and direct play stream selection is not enabled
Apr 03, 2022 17:08:26.200 [0x7f0575048b38] DEBUG - [Transcode] MDE: Filmtitle1 (2022): no direct play video profile exists for http/mkv/hevc
Apr 03, 2022 17:08:26.200 [0x7f0575048b38] DEBUG - [Transcode] MDE: Filmtitle1 (2022): no direct play video profile exists for http/mkv/hevc/eac3
Apr 03, 2022 17:08:26.200 [0x7f0575048b38] DEBUG - [Transcode] MDE: Filmtitle1 (2022): no direct play video profile exists for http/mkv/hevc/eac3
Apr 03, 2022 17:08:26.201 [0x7f0575048b38] DEBUG - [Transcode] MDE: Cannot direct stream audio stream due to codec eac3 when profile only allows ac3
Apr 03, 2022 17:08:26.201 [0x7f0575048b38] DEBUG - [Transcode] MDE: Filmtitle1 (2022): selected media 0 / 20985
Apr 03, 2022 17:08:26.201 [0x7f0575048b38] DEBUG - [Transcode] Streaming Resource: Added session 0x7f05785aafd8:653be7755d921970-com-plexapp-android
Apr 03, 2022 17:08:26.201 [0x7f0575048b38] DEBUG - [Transcode] Streaming Resource: Reached Decision id=27687 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=20985 part=(id=21375 decision=transcode container=mkv protocol=hls streams=(Video=(id=39199 decision=copy width=3840 height=1920) Audio=(id=39201 decision=transcode bitrate=640 encoder=ac3 channels=6 rate=48000))))
Apr 03, 2022 17:08:26.204 [0x7f057895ab38] DEBUG - Completed: [192.168.178.84:47934] 200 GET /video/:/transcode/universal/decision?audioBoost=100&autoAdjustQuality=0&directPlay=0&directStream=1&directStreamAudio=1&fastSeek=1&hasMDE=1&location=lan&maxVideoBitrate=200000&mediaBufferSize=209664&mediaIndex=0&partIndex=0&path=%2Flibrary%2Fmetadata%2F27687&protocol=*&session=653be7755d921970-com-plexapp-android&subtitleSize=100&videoBitrate=200000&videoQuality=100&videoResolution=3840x2160 (9 live) TLS GZIP 30ms 3641 bytes (pipelined: 2)
Apr 03, 2022 17:08:27.783 [0x7f057895ab38] DEBUG - Auth: authenticated user 123276799 as Julia
Apr 03, 2022 17:08:27.783 [0x7f0575048b38] DEBUG - Request: [192.168.178.84:47935 (Subnet)] GET /video/:/transcode/universal/start.m3u8?audioBoost=100&autoAdjustQuality=0&directPlay=0&directStream=1&directStreamAudio=1&fastSeek=1&hasMDE=1&location=lan&maxVideoBitrate=200000&mediaBufferSize=209664&mediaIndex=0&partIndex=0&path=%2Flibrary%2Fmetadata%2F27687&protocol=hls&session=653be7755d921970-com-plexapp-android&subtitleSize=100&videoBitrate=200000&videoQuality=100&videoResolution=3840x2160 (10 live) TLS Signed-in Token (Julia) (range: bytes=0-) 
Apr 03, 2022 17:08:27.784 [0x7f0575048b38] DEBUG - [Transcode] Found session GUID of 653be7755d921970-com-plexapp-android in session start.
Apr 03, 2022 17:08:27.784 [0x7f0575048b38] DEBUG - [Transcode] TranscodeUniversalRequest: using augmented profile Android
Apr 03, 2022 17:08:27.785 [0x7f0575048b38] DEBUG - [Transcode] Downloading document http://127.0.0.1:32400/library/metadata/27687?checkFiles=1&includeBandwidths=1&offset=-1&X-Plex-Incomplete-Segments=1&X-Plex-Session-Identifier=653be7755d921970-com-plexapp-android
Apr 03, 2022 17:08:27.785 [0x7f0575048b38] DEBUG - [Transcode] Auth: authenticated user 123276799 as Julia
Apr 03, 2022 17:08:27.793 [0x7f0575048b38] DEBUG - [Transcode] It took 10.000000 ms to retrieve 125 items.
Apr 03, 2022 17:08:27.802 [0x7f0575048b38] DEBUG - [Transcode] It took 10.000000 ms to retrieve 125 items.
Apr 03, 2022 17:08:27.809 [0x7f0575048b38] DEBUG - [Transcode] We're going to try to auto-select an audio stream for account 123276799.
Apr 03, 2022 17:08:27.809 [0x7f0575048b38] DEBUG - [Transcode] Selecting best audio stream for part ID 21375 (autoselect: 1 language: en)
Apr 03, 2022 17:08:27.809 [0x7f0575048b38] DEBUG - [Transcode] We're going to try to auto-select a subtitle.
Apr 03, 2022 17:08:27.809 [0x7f0575048b38] DEBUG - [Transcode] Audio Stream: 39201, Subtitle Stream: -1
Apr 03, 2022 17:08:27.812 [0x7f0575048b38] DEBUG - [Transcode] Found session GUID of 653be7755d921970-com-plexapp-android in session start.
Apr 03, 2022 17:08:27.812 [0x7f0575048b38] DEBUG - [Transcode] Using session GUID 653be7755d921970-com-plexapp-android for new transcode session.
Apr 03, 2022 17:08:27.812 [0x7f0575048b38] DEBUG - [Transcode] Cleaning directory for session 653be7755d921970-com-plexapp-android ()
Apr 03, 2022 17:08:27.814 [0x7f057895ab38] DEBUG - Completed: [192.168.178.84:47935] 206 GET /video/:/transcode/universal/start.m3u8?audioBoost=100&autoAdjustQuality=0&directPlay=0&directStream=1&directStreamAudio=1&fastSeek=1&hasMDE=1&location=lan&maxVideoBitrate=200000&mediaBufferSize=209664&mediaIndex=0&partIndex=0&path=%2Flibrary%2Fmetadata%2F27687&protocol=hls&session=653be7755d921970-com-plexapp-android&subtitleSize=100&videoBitrate=200000&videoQuality=100&videoResolution=3840x2160 (10 live) TLS 30ms 409 bytes (range: bytes=0-) 
Apr 03, 2022 17:08:28.015 [0x7f0575048b38] DEBUG - Request: [192.168.178.84:47936 (Subnet)] GET /video/:/transcode/universal/session/653be7755d921970-com-plexapp-android/base/index.m3u8 (11 live) TLS Signed-in
Apr 03, 2022 17:08:28.015 [0x7f0575048b38] DEBUG - [Transcode/653be7755d921970-com-plexapp-android] Starting a transcode session 653be7755d921970-com-plexapp-android at offset -1.0 (state=3)
Apr 03, 2022 17:08:28.016 [0x7f0575048b38] DEBUG - [Transcode/653be7755d921970-com-plexapp-android] TPU: hardware transcoding: enabled, but no hardware decode accelerator found
Apr 03, 2022 17:08:28.016 [0x7f0575048b38] DEBUG - [Transcode/653be7755d921970-com-plexapp-android] [Universal] Using local file path instead of URL: /share/Download/torrent/complete/Filme/fooo.mkv
Apr 03, 2022 17:08:28.017 [0x7f0575048b38] DEBUG - [Transcode/653be7755d921970-com-plexapp-android] TPU: hardware transcoding: final decoder: , final encoder: 
Apr 03, 2022 17:08:28.017 [0x7f0575048b38] DEBUG - [Transcode/653be7755d921970-com-plexapp-android/JobRunner] Job running: EAE_ROOT='/share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Library/tmp/pms-e9759754-08de-4843-92c9-437fedd180f5/EasyAudioEncoder' FFMPEG_EXTERNAL_LIBS='/share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Library/Plex\ Media\ Server/Codecs/62cc2bc-4278-linux-x86_64/' X_PLEX_TOKEN='xxxxxxxxxxxxxxxxxxxx' '/share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Plex Transcoder' '-codec:0' 'hevc' '-codec:2' 'eac3_eae' '-eae_prefix:2' '653be7755d921970-com-plexapp-android_' '-noaccurate_seek' '-analyzeduration' '20000000' '-probesize' '20000000' '-i' '/share/Download/torrent/complete/Filme/fooo.mkv' '-map' '0:0' '-codec:0' 'copy' '-filter_complex' '[0:2] aresample=async=1:ocl='\''5.1'\'':rematrix_maxval=0.000000dB:osr=48000[0]' '-map' '[0]' '-metadata:s:1' 'language=eng' '-codec:1' 'ac3' '-b:1' '640k' '-segment_format' 'matroska' '-f' 'ssegment' '-individual_header_trailer' '0' '-flags' '+global_header' '-segment_header_filename' 'header' '-segment_time' '10' '-segment_start_number' '0' '-segment_copyts' '1' '-segment_time_delta' '0.0625' '-segment_list' 'http://127.0.0.1:32400/video/:/transcode/session/653be7755d921970-com-plexapp-android/84d88f85-35ee-4331-9ba8-7918ce6b48c6/manifest?X-Plex-Http-Pipeline=infinite' '-segment_list_type' 'csv' '-segment_list_size' '5' '-segment_list_separate_stream_times' '1' '-segment_list_unfinished' '1' '-segment_format_options' 'output_ts_offset=10' '-max_delay' '5000000' '-avoid_negative_ts' 'disabled' '-map_metadata:g' '-1' '-map_metadata:c' '-1' '-map_chapters' '-1' 'media-%05d.ts' '-start_at_zero' '-copyts' '-vsync' 'cfr' '-y' '-nostats' '-loglevel' 'quiet' '-loglevel_plex' 'error' '-progressurl' 'http://127.0.0.1:32400/video/:/transcode/session/653be7755d921970-com-plexapp-android/84d88f85-35ee-4331-9ba8-7918ce6b48c6/progress'

I would like you to SSH into the machine and do the following:

ls -la /dev/dri

ps -ef | grep -i plexm

Please share that console output text.

6 
[~] # ls -la /dev/dri
total 0
drwxr-xr-x  2 admin administrators       80 2022-04-03 14:16 ./
drwxr-xr-x 16 admin administrators    20640 2022-04-03 20:10 ../
crw-------  1 admin administrators 226,   0 2022-04-03 14:16 card0
crw-------  1 admin administrators 226, 128 2022-04-03 14:16 renderD128
[~] # ps -ef | grep -i plexm
 5686 admin     43164 S N Plex Plug-in [com.plexapp.system] /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-bf5697c5d/Framework.bundle/Contents/Resources/Versions/2/Python/bootstrap.py --server-version 1.25.9.5673-bf5697c5d /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-bf5697c5d/System.bundle
 5897 admin     10052 S   /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Plex Tuner Service /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Tuner/Private /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Tuner/Shared 1.25.9.5673-bf5697c5d 32600
 5925 admin     33508 S   Plex Plug-in [tv.plex.agents.movie] /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-bf5697c5d/Framework.bundle/Contents/Resources/Versions/2/Python/bootstrap.py --server-version 1.25.9.5673-bf5697c5d /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-bf5697c5d/PlexMovieNew.bundle
 5926 admin     43844 S   Plex Plug-in [com.plexapp.agents.thetvdb] /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-bf5697c5d/Framework.bundle/Contents/Resources/Versions/2/Python/bootstrap.py --server-version 1.25.9.5673-bf5697c5d /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-bf5697c5d/TheTVDBv4.bundle
 6880 admin     33612 S   Plex Plug-in [tv.plex.agents.series] /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-bf5697c5d/Framework.bundle/Contents/Resources/Versions/2/Python/bootstrap.py --server-version 1.25.9.5673-bf5697c5d /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-bf5697c5d/PlexSeries.bundle
 6882 admin     35280 S   Plex Plug-in [tv.plex.agents.music] /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-bf5697c5d/Framework.bundle/Contents/Resources/Versions/2/Python/bootstrap.py --server-version 1.25.9.5673-bf5697c5d /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-bf5697c5d/PlexMusic.bundle
 6944 admin     34040 S   Plex Plug-in [org.musicbrainz.agents.music] /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-bf5697c5d/Framework.bundle/Contents/Resources/Versions/2/Python/bootstrap.py --server-version 1.25.9.5673-bf5697c5d /share/CE_CACHEDEV1_DATA/.qpkg/PlexMediaServer/Resources/Plug-ins-bf5697c5d/Musicbrainz.bundle
[~] #
7

That is 100% correct.

I would very much like you to try this file.

  1. Settings - Transcoder – Enable HW transcoding - Turn off tone mapping
  2. Create a test library (Other videos) section with this file in it (unzipped)
  3. Let PMS scan it
  4. Play it.
  5. Gather the logs ZIP when done.
9

I really hope there is a fix for this, as that was the reason I bought Plex two months ago. Is there anything else I can do to help with the research?

10

@jomjohannes

Please provide the full logs ZIP file and not an edited and pruned excerpt of what you feel is appropriate.

11

Is there any way to send you these documents without putting them completely public on the internet? (There is some data about the content and viewing habits of my local members in it and to publish it publicly is illegal in my country. :confused: )

12

Yes,

I have sent you a PM.

You may reply there.

1 Like
13

DM is sent

14

Solution was to downgrade Version to PlexMediaServer-1.24.5.5173
Thanks @ChuckPa!

15

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