Plex On TrueNAS Scale App - GPU transcodes not working

mattdeezly1996 · July 4, 2024, 7:53pm

Server Version#: 1.40.3.8555
Player Version#:1.96.0.177-dc5df788

I’m using TrueNAS Scale for my OS - I was using the TrueCharts release but they’ve abandoned the project so I am forced to migrate over to the officail TrueNAS Plex app. On the previous app, everything worked fine - my GPU could transcode and it was fine. But on this version, it errors out 100%.

So - I start the transcode, I check my GPU wit nvidia-smi and it even shows Plex is a active process & I check the transcode folder and it even makes a session folder. But then it immediately crashes and the transcode fails.

Screenshot 2024-07-04 155127

Their support is less then helpful, so I’m asking around here to see if I can see what you all make of it so I can find the issue on the PLEX side of things.

I have some logs here from Plex Media Server .log - I grabbed a snippet that I think it possibly helpful - I will provide any more logs or useful things requested of me. Also note this is a FRESH install , I’m not even trying to import any old files for now.

This one stuck out to me -

Jul 04, 2024 15:35:03.479 [139892876434232] WARN - [Req#3b4f/Transcode] Denying access due to session lacking permission to transcode key /library/metadata/26

Jul 04, 2024 15:35:03.208 [139892897528632] DEBUG - Request: [69.244.121.75:10715 (WAN)] GET /library/metadata/26/thumb/1720121442?hasMDE=1&path=%2Flibrary%2Fmetadata%2F26&mediaIndex=0&partIndex=0&protocol=http&fastSeek=1&directPlay=0&directStream=0&subtitleSize=100&audioBoost=100&location=wan&maxVideoBitrate=320&addDebugOverlay=0&autoAdjustQuality=0&directStreamAudio=1&advancedSubtitles=text&mediaBufferSize=157286&session=b1wl3cqqww5578sjz06bejl0&offset=167&subtitles=auto&copyts=1&Accept-Language=en (24 live) #3b18 TLS GZIP Signed-in Token (mattdeezly1996) (Deezly002)
Jul 04, 2024 15:35:03.216 [139892897528632] DEBUG - [Req#3b18] Calculated media file path for path [metadata://posters/tv.plex.agents.series_3e9725654bfb2449cca6d372874141242a043733]: ["/config/Library/Application Support/Plex Media Server/Metadata/TV Shows/a/8b232c82a8de6f9282ea1c3f3b1a801b391bcb5.bundle/Contents/_combined/posters/tv.plex.agents.series_3e9725654bfb2449cca6d372874141242a043733"]
Jul 04, 2024 15:35:03.217 [139892897528632] DEBUG - Content-Length of /config/Library/Application Support/Plex Media Server/Metadata/TV Shows/a/8b232c82a8de6f9282ea1c3f3b1a801b391bcb5.bundle/Contents/_combined/posters/tv.plex.agents.series_3e9725654bfb2449cca6d372874141242a043733 is 105238 (of total: 105238).
Jul 04, 2024 15:35:03.217 [139892994403128] DEBUG - Completed: [69.244.121.75:10715] 200 GET /library/metadata/26/thumb/1720121442?hasMDE=1&path=%2Flibrary%2Fmetadata%2F26&mediaIndex=0&partIndex=0&protocol=http&fastSeek=1&directPlay=0&directStream=0&subtitleSize=100&audioBoost=100&location=wan&maxVideoBitrate=320&addDebugOverlay=0&autoAdjustQuality=0&directStreamAudio=1&advancedSubtitles=text&mediaBufferSize=157286&session=b1wl3cqqww5578sjz06bejl0&offset=167&subtitles=auto&copyts=1&Accept-Language=en (24 live) #3b18 TLS GZIP 9ms 105238 bytes (pipelined: 2)
Jul 04, 2024 15:35:03.346 [139892917308216] DEBUG - [Req#3b42/Transcode] Codecs: Testing with profile 'Main 10'
Jul 04, 2024 15:35:03.346 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - nal_unit_type: 32(VPS), nuh_layer_id: 0, temporal_id: 0
Jul 04, 2024 15:35:03.346 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - nal_unit_type: 33(SPS), nuh_layer_id: 0, temporal_id: 0
Jul 04, 2024 15:35:03.346 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - nal_unit_type: 34(PPS), nuh_layer_id: 0, temporal_id: 0
Jul 04, 2024 15:35:03.346 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - nal_unit_type: 20(IDR_N_LP), nuh_layer_id: 0, temporal_id: 0
Jul 04, 2024 15:35:03.346 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Decoding VPS
Jul 04, 2024 15:35:03.346 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Main 10 profile bitstream
Jul 04, 2024 15:35:03.346 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Decoding SPS
Jul 04, 2024 15:35:03.346 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Main 10 profile bitstream
Jul 04, 2024 15:35:03.346 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Decoding VUI
Jul 04, 2024 15:35:03.346 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Decoding PPS
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Format cuda chosen by get_format().
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Format cuda requires hwaccel initialisation.
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - CUDA texture alignment: 512
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - CUDA texture alignment: 512
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded lib: libnvcuvid.so.1
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidGetDecoderCaps
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidCreateDecoder
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidDestroyDecoder
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidDecodePicture
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidGetDecodeStatus
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidReconfigureDecoder
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidMapVideoFrame64
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidUnmapVideoFrame64
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidCtxLockCreate
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidCtxLockDestroy
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidCtxLock
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidCtxUnlock
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidCreateVideoSource
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidCreateVideoSourceW
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidDestroyVideoSource
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidSetVideoSourceState
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidGetVideoSourceState
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidGetSourceVideoFormat
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidGetSourceAudioFormat
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidCreateVideoParser
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidParseVideoData
Jul 04, 2024 15:35:03.347 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuvidDestroyVideoParser
Jul 04, 2024 15:35:03.358 [139892917308216] DEBUG - [Req#3b42/Transcode] Codecs: dummy-frame test succeeded
Jul 04, 2024 15:35:03.399 [139892917308216] DEBUG - [Req#3b42/Transcode] MDE: Selected protocol http; container: mkv
Jul 04, 2024 15:35:03.399 [139892917308216] DEBUG - [Req#3b42/Transcode] MDE: analyzing media item 24
Jul 04, 2024 15:35:03.399 [139892917308216] DEBUG - [Req#3b42/Transcode] MDE: E24 - Accomplices: Direct Play is disabled
Jul 04, 2024 15:35:03.399 [139892917308216] DEBUG - [Req#3b42/Transcode] MDE: E24 - Accomplices: no direct play video profile exists for http/mkv/hevc
Jul 04, 2024 15:35:03.399 [139892917308216] DEBUG - [Req#3b42/Transcode] MDE: E24 - Accomplices: no direct play video profile exists for http/mkv/hevc/flac
Jul 04, 2024 15:35:03.399 [139892917308216] DEBUG - [Req#3b42/Transcode] MDE: E24 - Accomplices: no direct play video profile exists for http/mkv/hevc/aac
Jul 04, 2024 15:35:03.399 [139892917308216] DEBUG - [Req#3b42/Transcode] Accomplices - video.width limitation applies: 1920 > 320
Jul 04, 2024 15:35:03.399 [139892917308216] DEBUG - [Req#3b42/Transcode] MDE: E24 - Accomplices: Direct Streaming is disabled, so video stream will be transcoded
Jul 04, 2024 15:35:03.399 [139892917308216] DEBUG - [Req#3b42/Transcode] MDE: E24 - Accomplices: no remuxable profile found, so video stream will be transcoded
Jul 04, 2024 15:35:03.399 [139892917308216] DEBUG - [Req#3b42/Transcode] Codecs: testing h264_nvenc (encoder)
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] Codecs: hardware transcoding: testing API nvenc for device 'pci:0000:02:00.0' (GA106 [RTX A2000])
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded lib: libcuda.so.1
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuInit
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDeviceGetCount
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDeviceGet
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDeviceGetAttribute
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDeviceGetName
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDeviceComputeCapability
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuCtxCreate_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuCtxSetLimit
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuCtxPushCurrent_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuCtxPopCurrent_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuCtxDestroy_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemAlloc_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemAllocPitch_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemAllocManaged
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemsetD8Async
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemFree_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemcpy
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemcpyAsync
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemcpy2D_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemcpy2DAsync_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemcpyHtoD_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemcpyHtoDAsync_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemcpyDtoH_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemcpyDtoHAsync_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemcpyDtoD_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMemcpyDtoDAsync_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuGetErrorName
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuGetErrorString
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuCtxGetDevice
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDevicePrimaryCtxRetain
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDevicePrimaryCtxRelease
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDevicePrimaryCtxSetFlags
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDevicePrimaryCtxGetState
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDevicePrimaryCtxReset
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuStreamCreate
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuStreamQuery
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuStreamSynchronize
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuStreamDestroy_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuStreamAddCallback
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuEventCreate
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuEventDestroy_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuEventSynchronize
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuEventQuery
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuEventRecord
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuLaunchKernel
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuLinkCreate
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuLinkAddData
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuLinkComplete
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuLinkDestroy
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuModuleLoadData
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuModuleUnload
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuModuleGetFunction
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuModuleGetGlobal
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuTexObjectCreate
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuTexObjectDestroy
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuGLGetDevices_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuGraphicsGLRegisterImage
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuGraphicsUnregisterResource
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuGraphicsMapResources
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuGraphicsUnmapResources
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuGraphicsSubResourceGetMappedArray
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuGraphicsResourceGetMappedPointer_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDeviceGetUuid
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDeviceGetUuid_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDeviceGetLuid
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDeviceGetByPCIBusId
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDeviceGetPCIBusId
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuImportExternalMemory
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDestroyExternalMemory
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuExternalMemoryGetMappedBuffer
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuExternalMemoryGetMappedMipmappedArray
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMipmappedArrayGetLevel
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuMipmappedArrayDestroy
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuImportExternalSemaphore
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuDestroyExternalSemaphore
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuSignalExternalSemaphoresAsync
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuWaitExternalSemaphoresAsync
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuArrayCreate_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuArray3DCreate_v2
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuArrayDestroy
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuEGLStreamProducerConnect
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuEGLStreamProducerDisconnect
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuEGLStreamConsumerDisconnect
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuEGLStreamProducerPresentFrame
Jul 04, 2024 15:35:03.400 [139892917308216] DEBUG - [Req#3b42/Transcode] [FFMPEG] - Loaded sym: cuEGLStreamProducerReturnFrame
Jul 04, 2024 15:35:03.466 [139892876434232] DEBUG - Request: [69.244.121.75:10724 (WAN)] GET /video/:/transcode/universal/start?hasMDE=1&path=%2Flibrary%2Fmetadata%2F26&mediaIndex=0&partIndex=0&protocol=http&fastSeek=1&directPlay=0&directStream=0&subtitleSize=100&audioBoost=100&location=wan&maxVideoBitrate=320&addDebugOverlay=0&autoAdjustQuality=0&directStreamAudio=1&advancedSubtitles=text&mediaBufferSize=157286&session=b1wl3cqqww5578sjz06bejl0&offset=167&subtitles=auto&copyts=1&Accept-Language=en (25 live) #3b4f TLS Signed-in Token (mattdeezly1996) (Deezly002) (range: bytes=0-) 
Jul 04, 2024 15:35:03.466 [139892876434232] DEBUG - [Req#3b4f/Transcode] Found session GUID of b1wl3cqqww5578sjz06bejl0 in session start.
Jul 04, 2024 15:35:03.467 [139892876434232] DEBUG - [Req#3b4f/Transcode] TranscodeUniversalRequest: using profile Plex Desktop
Jul 04, 2024 15:35:03.467 [139892876434232] DEBUG - [Req#3b4f/Transcode] Downloading document http://127.0.0.1:32400/library/metadata/26?checkFiles=1&includeBandwidths=1&offset=167&X-Plex-Incomplete-Segments=1&X-Plex-Session-Identifier=ilmp95qtxxzw6bitlautcqu6
Jul 04, 2024 15:35:03.476 [139892876434232] DEBUG - [Req#3b4f/Transcode] We're going to try to auto-select an audio stream for account 1.
Jul 04, 2024 15:35:03.476 [139892876434232] DEBUG - [Req#3b4f/Transcode] Selecting best audio stream for part ID 24 (language: ja)
Jul 04, 2024 15:35:03.476 [139892876434232] DEBUG - [Req#3b4f/Transcode] We're going to try to auto-select a subtitle for account 1.
Jul 04, 2024 15:35:03.476 [139892876434232] DEBUG - [Req#3b4f/Transcode] Selected a foreign audio track: ja
Jul 04, 2024 15:35:03.476 [139892876434232] DEBUG - [Req#3b4f/Transcode] Subtitles: Found a candidate subtitle language [en] for a foreign film
Jul 04, 2024 15:35:03.476 [139892876434232] DEBUG - [Req#3b4f/Transcode] Audio Stream: 139, Subtitle Stream: 141
Jul 04, 2024 15:35:03.479 [139892876434232] WARN - [Req#3b4f/Transcode] Denying access due to session lacking permission to transcode key /library/metadata/26
Jul 04, 2024 15:35:03.480 [139892994403128] DEBUG - Completed: [69.244.121.75:10724] 400 GET /video/:/transcode/universal/start?hasMDE=1&path=%2Flibrary%2Fmetadata%2F26&mediaIndex=0&partIndex=0&protocol=http&fastSeek=1&directPlay=0&directStream=0&subtitleSize=100&audioBoost=100&location=wan&maxVideoBitrate=320&addDebugOverlay=0&autoAdjustQuality=0&directStreamAudio=1&advancedSubtitles=text&mediaBufferSize=157286&session=b1wl3cqqww5578sjz06bejl0&offset=167&subtitles=auto&copyts=1&Accept-Language=en (25 live) #3b4f TLS 13ms 265 bytes (range: bytes=0-) 
Jul 04, 2024 15:35:03.541 [139892891200312] DEBUG - Request: [69.244.121.75:10643 (WAN)] GET /video/:/transcode/universal/decision?hasMDE=1&path=%2Flibrary%2Fmetadata%2F26&mediaIndex=0&partIndex=0&protocol=http&fastSeek=1&directPlay=0&directStream=0&subtitleSize=100&audioBoost=100&location=wan&maxVideoBitrate=320&directStreamAudio=0&session=unpaspxeic1f4ypameg59pz8&offset=167&subtitles=auto&copyts=1&Accept-Language=en (24 live) #3b52 TLS GZIP Signed-in Token (mattdeezly1996) (Deezly002)
Jul 04, 2024 15:35:03.542 [139892891200312] DEBUG - [Req#3b52/Transcode] Found session GUID of unpaspxeic1f4ypameg59pz8 in session start.

ChuckPa · July 4, 2024, 10:24pm

can’t diagnose from a snippet which doesn’t actually capture the error.

Best is to attach the ZIP file which contains the failure.

From what little I can see, it looks like an android playback.
Playback in the web browser is much easier to diagnose, if possible.

Be advised: HW transcoding does not work (suppressed) for a portion of the transcode process when subtitle burning (PGS/VOBSUB/DVDRIP) is involved.

mattdeezly1996 · July 5, 2024, 2:05am

Turning off “Use hardware-accelerated video encoding” seems to make the issue go away. What does this specific feature do? As I still have “Use Hardware acceleration when available” and can confirm that it is using my GPU. What benefit does having “Use hardware-accelerated video encoding” disabled take away from you?

Plex Media Server Logs_2024-07-04_04-00-19.zip (416.1 KB)

Here’s the zip file I was inspecting. I was looking though the logs but couldn’t find much - I thought this one was a telling sign - but I might just not understand what its saying.

Jul 04, 2024 15:35:03.479 [139892876434232] WARN - [Req#3b4f/Transcode] Denying access due to session lacking permission to transcode key /library/metadata/26

ChuckPa · July 5, 2024, 3:02am

In your logs,

It finds the RTX2000 and successfully tests the capability to use for the playback.
When it starts the transcode, it does a few blocks of data then just stops with “404” (not found) errors.

Where is the transcoder temp directory resolve to?
Local file? Network mount ?

mattdeezly1996 · July 5, 2024, 4:52am

it resolved to a local folder I have set /transcode which (I think) has proper permissions?

When I disable this

Without changing any folder or permissions its able to transcode in the folder I have set - which I thought had permissions issues.

And its using my GPU for everything but the audio.

So I’m curious about whats going on with that setting & if having it disabled is really going to hurt me

ChuckPa · July 5, 2024, 5:34am

Thanks for that nvidia-smi output.

I don’t know if it matters but most of us are using 535.183.01 drivers (CUDA 12.2)

Would that be easy for you to switch to and test?

+---------------------------------------------------------------------------------------+
| NVIDIA-SMI 535.183.01             Driver Version: 535.183.01   CUDA Version: 12.2     |
|-----------------------------------------+----------------------+----------------------+
| GPU  Name                 Persistence-M | Bus-Id        Disp.A | Volatile Uncorr. ECC |
| Fan  Temp   Perf          Pwr:Usage/Cap |         Memory-Usage | GPU-Util  Compute M. |
|                                         |                      |               MIG M. |
|=========================================+======================+======================|
|   0  Quadro P2200                   On  | 00000000:07:00.0 Off |                  N/A |
| 48%   38C    P8               4W /  75W |      1MiB /  5120MiB |      0%      Default |
|                                         |                      |                  N/A |
+-----------------------------------------+----------------------+----------------------+
                                                                                         
+---------------------------------------------------------------------------------------+
| Processes:                                                                            |
|  GPU   GI   CI        PID   Type   Process name                            GPU Memory |
|        ID   ID                                                             Usage      |
|=======================================================================================|
|  No running processes found                                                           |
+---------------------------------------------------------------------------------------+

mattdeezly1996 · July 5, 2024, 6:19am

I don’t think I have the ability to update or downgrade the drivers on truenas scale - ill do some research though

ChuckPa · July 5, 2024, 6:39am

Another possibility, turn off HDR tone mapping. That will tell us if the CUDA version is the problem. It shouldn’t be but it doesn’t hurt to make certain basic transcoding works ok. (It is showing up in the logs correctly)

mattdeezly1996 · July 5, 2024, 5:46pm

Turned off HDR tone mapping and it still crashes. Hmm

ChuckPa · July 5, 2024, 9:22pm

Whose image is this container made from?

Please play this test file.

It’s 80 Mbps.
Please set Plex/web player quality to 20 Mbps (forces transcode)
It will play for 30 seconds.
Pull the logs when complete.

mattdeezly1996 · July 6, 2024, 4:25am

There are two links for the source (besides plex) it has their chart release here and then it has a link to plex’s official docker image - so I gather its based off this

a

Tried to play the video you provided and it still errored out. Got fresh logs from this specific instance if needed.
Plex Media Server Logs_2024-07-06_00-24-51.zip (1018.8 KB)

ChuckPa · July 6, 2024, 5:42am

The “based off” is usually the problem I encounter.
All non-Plex images must use the Plex binaries (Plex isn’t open source) but the runtime configuration inside the container, and it’s initialization, is however the author wants and, if there are issues, that’s where I’ll find them.

I see you put the file in with other media. This isn’t the best way to test it.

Create a shared folder / dataset
Put the file in there.
In PMS, create a “Other Videos” library section.

What did you play this on, an Android device ?

I ask because I don’t see the normal FFMPEG invocation. I see a lot of GPU testing but don’t see the invocation I saw before.

If you didn’t use Plex/web, would you mind doing it again with Plex/web after you put the test video in the Other Videos library section?

ChuckPa · July 6, 2024, 8:08pm

A post was split to a new topic: HW transcoding issue: QTS + Nvidia T600

mattdeezly1996 · July 6, 2024, 11:59pm

I am using the Plex App for windows. I don’t have any Android devices currently.

Running into a strange issue - I cannot add library’s to my plex for some reason

The language box is just blank and when I click it, nothing is there… the plot thickens.
I also tried adding a library on Brave and on Edge, both have the box blank as well.

ChuckPa · July 7, 2024, 12:42am

@mattdeezly1996

Need server DEBUG logs please to see what’s happening and not working.
Likely a permissions or communication problem.

mattdeezly1996 · July 7, 2024, 1:05am

plex_Debuglogs.txt (24.6 KB)
Here are the logs - all I did here was I attempted to add a library.

ChuckPa · July 7, 2024, 1:23am

Those are the Plex web logs.

May I have the server debug logs please?

Settings - Server - Troubleshooting - Download Logs

mattdeezly1996 · July 7, 2024, 1:34am

I downloaded the logs and its just a empty ZIP. I think my install might have some major issues. Is there another way for me to get the logs?

ChuckPa · July 7, 2024, 1:49am

Go to where the container (/config) is in the file system .

/config/Library/Application Support/Plex Media Server

You’ll see Logs . Make a tar.gz of Logs and attach it

Be advised – If you’re getting a zero-length log file, I question if the file permissions under /config are correct

mattdeezly1996 · July 7, 2024, 2:22am

Strange - I got the logs fixed, the language box is gone but it lets me go to the next step

But strangely when I try to add the library now it says “Your changes could not be saved”

Anyway I got the logs here for you.
Plex Media Server Logs_2024-07-06_22-20-34.zip (302.4 KB)

I have a backup of my whole plex Library (Databases, everything) before I moved over to this TrueNAS thing… I’m starting to wonder if I should try to recreate my plex instance and be clean about it…

Topic		Replies	Views
Plex Media Server 1.16.7.1597 (Updated) - New Transcoder Preview Plex Pass Betas	143	26216	September 16, 2019
Transcode Folders Getting Deleted NAS & Devices server-docker	20	739	January 8, 2020
Constantly failing due to transcoder errors Plex Media Server server-windows	11	176	December 24, 2020
PMS 1.23.0.4497 Transcoder no longer transcodes anything Plex Media Server server-linux	25	554	August 6, 2021
Transcoder Failure on Old media NAS & Devices subtitles , server-truenas	7	226	December 16, 2018

Plex On TrueNAS Scale App - GPU transcodes not working

Related topics