Hi all,
Thought I'd ask this question here in case this is already a known issue and there is a quick fix.
I've been successfully running LibreELEC (official): 9.95.5 (RPi4.arm) since it was released, mainly to get ATMOS pass-through audio and it works really well.
I upgraded to 9.97.1 when it came out and found MKV files with ATMOS stopped opening instantly, when they finally did open after a good 20 second delay no audio was being passed through but video plays, no setting changes were made post upgrade. A quick rollback to 9.95.5 and the files in question were working again opening quickly and passing audio through so I figured I'd wait till v10.0.0 release.
With the release of 10.0.0 I performed an upgrade from 9.95.5. The exact same issue with ATMOS/MKV files explained above happened again - Has anyone else seen this behavior?
The test file I have used is: Dolby_Amaze_Lossless-ATMOS-thedigitaltheater.mkv which can be obtained here: Dolby Trailers - The Digital Theater
From my quick checking in the logs it appears related to CAESinkAlsa not being able to initialize correctly when opening the HDMI port, it then attempts default and goes into a loop? Maybe I need to disable my unused HDMI port - I use the port closest to the USB-C power.
9.95.5
2021-09-09 21:04:55.317 T:867 INFO <general>: Creating audio thread
2021-09-09 21:04:55.317 T:870 INFO <general>: running thread: CVideoPlayerAudio::Process()
2021-09-09 21:04:55.391 T:738 INFO <general>: VideoPlayer: OnResetDisplay received
2021-09-09 21:04:55.432 T:870 INFO <general>: CAEStreamParser::SyncTrueHD - TrueHD stream detected (8 channels, 48000Hz)
2021-09-09 21:04:55.433 T:870 INFO <general>: Creating audio stream (codec id: 86060, channels: 8, sample rate: 48000, pass-through)
2021-09-09 21:04:55.447 T:744 INFO <general>: CActiveAESink::OpenSink - initialize sink
2021-09-09 21:04:55.647 T:744 INFO <general>: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=vc4hdmi0,DEV=0"
2021-09-09 21:04:55.652 T:744 INFO <general>: CAESinkALSA::Initialize - Opened device "hdmi:CARD=vc4hdmi0,DEV=0,AES0=0x06,AES1=0x82,AES2=0x00,AES3=0x09"
2021-09-09 21:04:55.776 T:738 INFO <general>: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY
2021-09-09 21:04:55.791 T:738 INFO <general>: [WHITELIST] Searching the whitelist for: width: 1920, height: 1080, fps: 24.000, 3D: false
2021-09-09 21:04:55.798 T:738 INFO <general>: Display resolution ADJUST : 1920x1080 @ 24.000000 Hz (40)
2021-09-09 21:05:03.973 T:738 INFO <general>: Loading skin file: VideoOSD.xml, load type: KEEP_IN_MEMORY
2021-09-09 21:05:05.348 T:738 INFO <general>: CVideoPlayer::CloseFile()
2021-09-09 21:05:05.348 T:738 INFO <general>: VideoPlayer: waiting for threads to exit
2021-09-09 21:05:05.356 T:867 INFO <general>: CVideoPlayer::OnExit()
2021-09-09 21:05:05.357 T:867 INFO <general>: Closing stream player 1
2021-09-09 21:05:05.357 T:867 INFO <general>: Waiting for audio thread to exit
2021-09-09 21:05:05.410 T:870 INFO <general>: thread end: CVideoPlayerAudio::OnExit()
2021-09-09 21:05:05.411 T:867 INFO <general>: Closing audio device
10.0.0
2021-09-09 21:01:12.928 T:874 INFO <general>: Creating audio thread
2021-09-09 21:01:12.928 T:877 INFO <general>: running thread: CVideoPlayerAudio::Process()
2021-09-09 21:01:12.981 T:765 INFO <general>: VideoPlayer: OnResetDisplay received
2021-09-09 21:01:13.040 T:877 INFO <general>: CAEStreamParser::SyncTrueHD - TrueHD stream detected (8 channels, 48000Hz)
2021-09-09 21:01:13.044 T:877 INFO <general>: Creating audio stream (codec id: 86060, channels: 8, sample rate: 48000, pass-through)
2021-09-09 21:01:13.089 T:771 INFO <general>: CActiveAESink::OpenSink - initialize sink
2021-09-09 21:01:13.289 T:771 INFO <general>: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=vc4hdmi0,DEV=0"
2021-09-09 21:01:13.292 T:771 INFO <general>: CAESinkALSA::Initialize - Opened device "hdmi:CARD=vc4hdmi0,DEV=0,AES0=0x06,AES1=0x82,AES2=0x00,AES3=0x09"
2021-09-09 21:01:13.295 T:771 WARNING <general>: CAESinkAlsa::InitializeHW - Using default alsa values - set failed
2021-09-09 21:01:13.296 T:771 INFO <general>: CAESinkALSA::Initialize - Attempting to open device "default"
2021-09-09 21:01:13.299 T:771 INFO <general>: CAESinkALSA - Unable to open device "default:AES0=0x06,AES1=0x82,AES2=0x00,AES3=0x09" for playback
2021-09-09 21:01:13.300 T:771 INFO <general>: CAESinkALSA::Initialize - Opened device "default"
2021-09-09 21:01:13.305 T:771 WARNING <general>: CAESinkAlsa::InitializeHW - Using default alsa values - set failed
2021-09-09 21:01:13.307 T:771 ERROR <general>: CActiveAESink::OpenSink - no sink was returned
2021-09-09 21:01:13.307 T:770 ERROR <general>: ActiveAE::InitSink - returned error
I have attached my full logs below.
9.95.5.log 10.0.0.log