I’m using LSIO’s docker container on a Snyology DS1817+ NAS with the latest PMS installed (1.20.3.3437). I’m testing out playing a movie through my Samsung Galaxy S8+ mobile android device and all TrueHD audio (whether 5.1 or 7.1) streams fail with error “unable to play media” device. I have video transcoding disabled on PMS because the NAS does not support hardware transcoding support. The client can play 4K and 1080p streams so that shouldn’t be a problem. I also have subtitles disabled to make sure that the error isn’t caused by the video not being supported. And playing the same file with the alternate audio stream (AC3 or DTS-HD MA, for example) works just fine, so it isn’t the video.
I have debug logging enabled in PMS and here are the logs:
The relevant logs start from Oct 18, 2020, 19:10:25 and here’s a snippet:
Oct 18, 2020 19:10:25.189 [0x7f63437f6700] DEBUG - It took 10.000000 ms to retrieve 101 items.
Oct 18, 2020 19:10:25.190 [0x7f63437f6700] DEBUG - We're going to try to auto-select an audio stream for account 1.
Oct 18, 2020 19:10:25.190 [0x7f63437f6700] DEBUG - Selecting best audio stream for part ID 78900 (autoselect: 1 language: en)
Oct 18, 2020 19:10:25.190 [0x7f63437f6700] DEBUG - Audio Stream: 181028, Subtitle Stream: 0
Oct 18, 2020 19:10:25.203 [0x7f63437f6700] DEBUG - It took 0.000000 ms to retrieve 101 items.
Oct 18, 2020 19:10:25.254 [0x7f63cbfff700] DEBUG - Completed: [192.168.10.203:45474] 200 GET /library/metadata/29686?includeChapters=1&includeLoudnessRamps=1&includeMarkers=1&includeRelated=1 (17 live) TLS GZIP 76ms 11151 bytes (pipelined: 22)
Oct 18, 2020 19:10:25.282 [0x7f63cbfff700] DEBUG - Auth: authenticated user 1 as Kevin Ong
Oct 18, 2020 19:10:25.282 [0x7f63827fc700] DEBUG - Request: [192.168.10.203:45542 (Subnet)] GET /video/:/transcode/universal/decision?audioBoost=120&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%2F29686&protocol=*&session=4ebe9634721bc941-com-plexapp-android&subtitleSize=100&videoBitrate=200000&videoQuality=100&videoResolution=3840x2160 (18 live) TLS GZIP Signed-in Token (Kevin Ong)
Oct 18, 2020 19:10:25.282 [0x7f63827fc700] DEBUG - [Transcode] Found session GUID of 4ebe9634721bc941-com-plexapp-android in session start.
Oct 18, 2020 19:10:25.283 [0x7f63827fc700] DEBUG - [Transcode] TranscodeUniversalRequest: using augmented profile Android
Oct 18, 2020 19:10:25.283 [0x7f63827fc700] DEBUG - [Transcode] Downloading document http://127.0.0.1:32400/library/metadata/29686?includeBandwidths=1&offset=-1&X-Plex-Incomplete-Segments=1&X-Plex-Session-Identifier=4ebe9634721bc941-com-plexapp-android
Oct 18, 2020 19:10:25.283 [0x7f63827fc700] DEBUG - [Transcode] Auth: authenticated user 1 as Kevin Ong
Oct 18, 2020 19:10:25.295 [0x7f63827fc700] DEBUG - [Transcode] It took 10.000000 ms to retrieve 101 items.
Oct 18, 2020 19:10:25.297 [0x7f63827fc700] DEBUG - [Transcode] We're going to try to auto-select an audio stream for account 1.
Oct 18, 2020 19:10:25.297 [0x7f63827fc700] DEBUG - [Transcode] Selecting best audio stream for part ID 78900 (autoselect: 1 language: en)
Oct 18, 2020 19:10:25.297 [0x7f63827fc700] DEBUG - [Transcode] Audio Stream: 181028, Subtitle Stream: 0
Oct 18, 2020 19:10:25.301 [0x7f63827fc700] DEBUG - [Transcode] Codecs: testing h264_nvenc (encoder)
Oct 18, 2020 19:10:25.302 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: testing API nvenc
Oct 18, 2020 19:10:25.302 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Cannot load libcuda.so.1
Oct 18, 2020 19:10:25.302 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Could not dynamically load CUDA
Oct 18, 2020 19:10:25.302 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Oct 18, 2020 19:10:25.302 [0x7f63827fc700] DEBUG - [Transcode] Codecs: testing hevc (decoder) with hwdevice vaapi
Oct 18, 2020 19:10:25.302 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: testing API vaapi
Oct 18, 2020 19:10:25.302 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Generic error in an external library
Oct 18, 2020 19:10:25.302 [0x7f63827fc700] DEBUG - [Transcode] Codecs: testing hevc (decoder) with hwdevice nvdec
Oct 18, 2020 19:10:25.302 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: testing API nvdec
Oct 18, 2020 19:10:25.303 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Cannot load libcuda.so.1
Oct 18, 2020 19:10:25.303 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Could not dynamically load CUDA
Oct 18, 2020 19:10:25.303 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Oct 18, 2020 19:10:25.303 [0x7f63827fc700] DEBUG - [Transcode] Scaled up video bitrate to 254421Kbps based on 4.500000x fudge factor.
Oct 18, 2020 19:10:25.303 [0x7f63827fc700] DEBUG - [Transcode] MDE: Selected protocol hls; container: mkv
Oct 18, 2020 19:10:25.303 [0x7f63827fc700] DEBUG - [Transcode] MDE: analyzing media item 72200
Oct 18, 2020 19:10:25.304 [0x7f63827fc700] DEBUG - [Transcode] MDE: Mission: Impossible (1996): Direct Play is disabled
Oct 18, 2020 19:10:25.304 [0x7f63827fc700] DEBUG - [Transcode] MDE: Mission: Impossible (1996): media must be transcoded in order to use the hls protocol
Oct 18, 2020 19:10:25.304 [0x7f63827fc700] DEBUG - [Transcode] MDE: Mission: Impossible (1996): no direct play video profile exists for http/mkv/hevc
Oct 18, 2020 19:10:25.304 [0x7f63827fc700] DEBUG - [Transcode] MDE: Mission: Impossible (1996): no direct play video profile exists for http/mkv/hevc/truehd
Oct 18, 2020 19:10:25.304 [0x7f63827fc700] DEBUG - [Transcode] MDE: Mission: Impossible (1996): no direct play video profile exists for http/mkv/hevc/ac3
Oct 18, 2020 19:10:25.304 [0x7f63827fc700] DEBUG - [Transcode] Mission: Impossible - video.colorTrc limitation applies: smpte2084 != bt709|bt470m|smpte240m|smpte170m|bt470bg|bt2020-10 [list]
Oct 18, 2020 19:10:25.304 [0x7f63827fc700] DEBUG - [Transcode] MDE: Mission: Impossible (1996): no remuxable profile found, so video stream will be transcoded
Oct 18, 2020 19:10:25.304 [0x7f63827fc700] DEBUG - [Transcode] Codecs: testing h264_nvenc (encoder)
Oct 18, 2020 19:10:25.304 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: testing API nvenc
Oct 18, 2020 19:10:25.304 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Cannot load libcuda.so.1
Oct 18, 2020 19:10:25.304 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Could not dynamically load CUDA
Oct 18, 2020 19:10:25.304 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Oct 18, 2020 19:10:25.304 [0x7f63827fc700] DEBUG - [Transcode] MDE: Cannot direct stream video stream due to profile or setting limitations
Oct 18, 2020 19:10:25.304 [0x7f63827fc700] DEBUG - [Transcode] Codecs: testing hevc (decoder) with hwdevice vaapi
Oct 18, 2020 19:10:25.305 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: testing API vaapi
Oct 18, 2020 19:10:25.305 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Generic error in an external library
Oct 18, 2020 19:10:25.305 [0x7f63827fc700] DEBUG - [Transcode] Codecs: testing hevc (decoder) with hwdevice nvdec
Oct 18, 2020 19:10:25.305 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: testing API nvdec
Oct 18, 2020 19:10:25.305 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Cannot load libcuda.so.1
Oct 18, 2020 19:10:25.305 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Could not dynamically load CUDA
Oct 18, 2020 19:10:25.305 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Oct 18, 2020 19:10:25.305 [0x7f63827fc700] DEBUG - [Transcode] Scaled up video bitrate to 254421Kbps based on 4.500000x fudge factor.
Oct 18, 2020 19:10:25.306 [0x7f63827fc700] DEBUG - [Transcode] MDE: Cannot direct stream audio stream due to codec truehd when profile only allows aac
Oct 18, 2020 19:10:25.306 [0x7f63827fc700] DEBUG - [Transcode] MDE: Mission: Impossible (1996): selected media 0 / 72200
Oct 18, 2020 19:10:25.306 [0x7f63827fc700] DEBUG - [Transcode] Streaming Resource: Calculated bandwidth of 267955kbps exceeds bandwidth limit. Changing decision parameters provided by client to fit bandwidth limit of 200000kbps
Oct 18, 2020 19:10:25.306 [0x7f63827fc700] DEBUG - [Transcode] Streaming Resource: Determining preferred transcode encoders through transcode only decision.
Oct 18, 2020 19:10:25.306 [0x7f63827fc700] DEBUG - [Transcode] Codecs: testing h264_nvenc (encoder)
Oct 18, 2020 19:10:25.306 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: testing API nvenc
Oct 18, 2020 19:10:25.307 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Cannot load libcuda.so.1
Oct 18, 2020 19:10:25.307 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Could not dynamically load CUDA
Oct 18, 2020 19:10:25.307 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Oct 18, 2020 19:10:25.307 [0x7f63827fc700] DEBUG - [Transcode] Codecs: testing hevc (decoder) with hwdevice vaapi
Oct 18, 2020 19:10:25.307 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: testing API vaapi
Oct 18, 2020 19:10:25.307 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Generic error in an external library
Oct 18, 2020 19:10:25.307 [0x7f63827fc700] DEBUG - [Transcode] Codecs: testing hevc (decoder) with hwdevice nvdec
Oct 18, 2020 19:10:25.307 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: testing API nvdec
Oct 18, 2020 19:10:25.307 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Cannot load libcuda.so.1
Oct 18, 2020 19:10:25.307 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Could not dynamically load CUDA
Oct 18, 2020 19:10:25.307 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Oct 18, 2020 19:10:25.307 [0x7f63827fc700] DEBUG - [Transcode] Scaled up video bitrate to 254421Kbps based on 4.500000x fudge factor.
Oct 18, 2020 19:10:25.308 [0x7f63827fc700] DEBUG - [Transcode] Codecs: testing h264_nvenc (encoder)
Oct 18, 2020 19:10:25.309 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: testing API nvenc
Oct 18, 2020 19:10:25.309 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Cannot load libcuda.so.1
Oct 18, 2020 19:10:25.309 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Could not dynamically load CUDA
Oct 18, 2020 19:10:25.309 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
Oct 18, 2020 19:10:25.309 [0x7f63827fc700] DEBUG - [Transcode] Codecs: testing hevc (decoder) with hwdevice vaapi
Oct 18, 2020 19:10:25.309 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: testing API vaapi
Oct 18, 2020 19:10:25.309 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Generic error in an external library
Oct 18, 2020 19:10:25.309 [0x7f63827fc700] DEBUG - [Transcode] Codecs: testing hevc (decoder) with hwdevice nvdec
Oct 18, 2020 19:10:25.310 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: testing API nvdec
Oct 18, 2020 19:10:25.310 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Cannot load libcuda.so.1
Oct 18, 2020 19:10:25.310 [0x7f63827fc700] ERROR - [Transcode] [FFMPEG] - Could not dynamically load CUDA
Oct 18, 2020 19:10:25.310 [0x7f63827fc700] DEBUG - [Transcode] Codecs: hardware transcoding: opening hw device failed - probably not supported by this system, error: Unknown error occurred
What is going on? The expectation is for PMS to transcode the audio to a stream that is compatible with the client since the client doesn’t obviously support TrueHD.