No Audio with TrueHD Passthrough (but DTS/AC3/DD work) [SOLVED]
#1
I decided today to see what TrueHD audio sounds like on my HTPC, but unfortunately I get no audio when I select a TrueHD track. Under settings I have enabled passthrough for TrueHD; my receiver supports it and AC3/DTS/DD/DD+ all work fine with passthrough.

I am running Gotham 13.2 built from a fresh git pull this morning with these options:
Code:
--prefix=/usr/local --disable-dvdcss --disable-rsxs --disable-optical-drive --enable-libcec --disable-pulse --disable-crystalhd --enable-nfs

I pasted the parts of the log that (I think) are relevant. I have passthrough audio set to ONK TX-NR808 on HDMI (DEV=1) and all the other passthrough formats that I've tried work fine.


Code:
09:13:55 T:3038419264  NOTICE: Starting XBMC (13.2-RC1 Git:20140809-b79e5f1). Platform: x86 Linux 32-bit
09:13:55 T:3038419264  NOTICE: Using Debug XBMC x32 build, compiled Aug 10 2014 by GCC 4.6.3 for x86 Linux 32-bit 3.2.60
09:13:55 T:3038419264  NOTICE: Running on Linux 32-bit (Ubuntu precise (12.04.4 LTS), 3.2.0-67-generic-pae i686)
09:13:55 T:3038419264  NOTICE: Host CPU: Intel(R) Core(TM) i3-3220T CPU @ 2.80GHz, 4 cores available

09:13:55 T:3038419264    INFO: CAESinkALSA - Unable to open device "pulse" for playback
09:13:55 T:3038419264   DEBUG: CAESinkALSA - Unable to obtain ELD information for device "hdmi:CARD=PCH,DEV=0" (not supported by device, or kernel older than 3.2)
09:13:55 T:3038419264  NOTICE: CAESinkALSA::EnumerateDevice data format "AE_FMT_LPCM" on device "hdmi:CARD=PCH,DEV=0" seems to be not supported.
09:13:55 T:3038419264  NOTICE: CAESinkALSA::EnumerateDevice data format "AE_FMT_DTSHD" on device "hdmi:CARD=PCH,DEV=0" seems to be not supported.
09:13:55 T:3038419264  NOTICE: CAESinkALSA::EnumerateDevice data format "AE_FMT_TRUEHD" on device "hdmi:CARD=PCH,DEV=0" seems to be not supported.
09:13:55 T:3038419264  NOTICE: CAESinkALSA::EnumerateDevice data format "AE_FMT_EAC3" on device "hdmi:CARD=PCH,DEV=0" seems to be not supported.
09:13:55 T:3038419264  NOTICE: CAESinkALSA::EnumerateDevice data format "AE_FMT_DTS" on device "hdmi:CARD=PCH,DEV=0" seems to be not supported.
09:13:55 T:3038419264  NOTICE: CAESinkALSA::EnumerateDevice data format "AE_FMT_AC3" on device "hdmi:CARD=PCH,DEV=0" seems to be not supported.
09:13:55 T:3038419264  NOTICE: CAESinkALSA::EnumerateDevice data format "AE_FMT_AAC" on device "hdmi:CARD=PCH,DEV=0" seems to be not supported.
09:13:55 T:3038419264  NOTICE: CAESinkALSA::EnumerateDevice data format "AE_FMT_AAC" on device "hdmi:CARD=PCH,DEV=1" seems to be not supported.
09:13:55 T:3038419264  NOTICE: Found 1 Lists of Devices
09:13:55 T:3038419264  NOTICE: Enumerated ALSA devices:
09:13:55 T:3038419264  NOTICE:     Device 1
09:13:55 T:3038419264  NOTICE:         m_deviceName      : @
09:13:55 T:3038419264  NOTICE:         m_displayName     : Default (HDA Intel PCH ALC887-VD Analog)
09:13:55 T:3038419264  NOTICE:         m_displayNameExtra:
09:13:55 T:3038419264  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
09:13:55 T:3038419264  NOTICE:         m_channels        : FL,FR
09:13:55 T:3038419264  NOTICE:         m_sampleRates     : 48000
09:13:55 T:3038419264  NOTICE:         m_dataFormats     : AE_FMT_S32NE
09:13:55 T:3038419264  NOTICE:     Device 2
09:13:55 T:3038419264  NOTICE:         m_deviceName      : @:CARD=PCH,DEV=0
09:13:55 T:3038419264  NOTICE:         m_displayName     : HDA Intel PCH
09:13:55 T:3038419264  NOTICE:         m_displayNameExtra: ALC887-VD Analog
09:13:55 T:3038419264  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM
09:13:55 T:3038419264  NOTICE:         m_channels        : FL,FR
09:13:55 T:3038419264  NOTICE:         m_sampleRates     : 48000
09:13:55 T:3038419264  NOTICE:         m_dataFormats     : AE_FMT_S32NE
09:13:55 T:3038419264  NOTICE:     Device 3
09:13:55 T:3038419264  NOTICE:         m_deviceName      : hdmi:CARD=PCH,DEV=0
09:13:55 T:3038419264  NOTICE:         m_displayName     : HDA Intel PCH
09:13:55 T:3038419264  NOTICE:         m_displayNameExtra: HDMI
09:13:55 T:3038419264  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
09:13:55 T:3038419264  NOTICE:         m_channels        : FL,FR
09:13:55 T:3038419264  NOTICE:         m_sampleRates     : 32000,44100,48000,88200,96000,192000
09:13:55 T:3038419264  NOTICE:         m_dataFormats     : AE_FMT_LPCM,AE_FMT_DTSHD,AE_FMT_TRUEHD,AE_FMT_EAC3,AE_FMT_DTS,AE_FMT_AC3,AE_FMT_AAC,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE
09:13:55 T:3038419264  NOTICE:     Device 4
09:13:55 T:3038419264  NOTICE:         m_deviceName      : hdmi:CARD=PCH,DEV=1
09:13:55 T:3038419264  NOTICE:         m_displayName     : HDA Intel PCH
09:13:55 T:3038419264  NOTICE:         m_displayNameExtra: ONK TX-NR808 on HDMI
09:13:55 T:3038419264  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI
09:13:55 T:3038419264  NOTICE:         m_channels        : FL,FR,LFE,FC,BL,BR,SL,SR
09:13:55 T:3038419264  NOTICE:         m_sampleRates     : 32000,44100,48000,88200,96000,176400,192000
09:13:55 T:3038419264  NOTICE:         m_dataFormats     : AE_FMT_LPCM,AE_FMT_AC3,AE_FMT_DTS,AE_FMT_EAC3,AE_FMT_DTSHD,AE_FMT_TRUEHD,AE_FMT_AAC,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE


09:14:09 T:2736626496   DEBUG: FactoryCodec - Audio: passthrough - Opening
09:14:09 T:2736626496   DEBUG: FactoryCodec - Audio: passthrough - Opened
09:14:09 T:2662333248   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
09:14:09 T:2736626496  NOTICE: Creating audio thread
09:14:09 T:2653940544  NOTICE: Thread DVDPlayerAudio start, auto delete: false
09:14:09 T:2653940544  NOTICE: running thread: CDVDPlayerAudio::Process()


09:14:10 T:2653940544   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(869494000.000000, 0)
09:14:10 T:2653940544    INFO: CAEStreamInfo::SyncTrueHD - TrueHD stream detected (8 channels, 48000Hz)
09:14:10 T:2653940544 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
09:14:10 T:2653940544  NOTICE: Creating audio stream (codec id: 86061, channels: 8, sample rate: 192000, pass-through)
09:14:10 T:2653940544   DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback


09:14:10 T:3036064576   DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=1
09:14:10 T:3036064576   DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 8 Output Channel Count: 8
09:14:10 T:3036064576   DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: RAW,RAW,RAW,RAW,RAW,RAW,RAW,RAW
09:14:10 T:3036064576   DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: RAW,RAW,RAW,RAW,RAW,RAW,RAW,RAW
09:14:10 T:3036064576    INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=1"
09:14:10 T:3036064576    INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=1,AES0=0x06,AES1=0x82,AES2=0x00,AES3=0x0e"
09:14:10 T:3036064576   DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 1024, bufferSize 4096
09:14:10 T:3036064576   DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 1024, bufferSize 4096
09:14:10 T:3036064576   DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 22 ms
09:14:10 T:3036064576   DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 8 Output Channel Count: 8
09:14:10 T:3036064576   DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: RAW,RAW,RAW,RAW,RAW,RAW,RAW,RAW
09:14:10 T:3036064576   DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: RAW,RAW,RAW,RAW,RAW,RAW,RAW,RAW
09:14:10 T:3036064576   DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
09:14:10 T:3036064576   DEBUG:   Output Device : HDA Intel PCH
09:14:10 T:3036064576   DEBUG:   Sample Rate   : 192000
09:14:10 T:3036064576   DEBUG:   Sample Format : AE_FMT_S16NE
09:14:10 T:3036064576   DEBUG:   Channel Count : 8
09:14:10 T:3036064576   DEBUG:   Channel Layout: RAW,RAW,RAW,RAW,RAW,RAW,RAW,RAW
09:14:10 T:3036064576   DEBUG:   Frames        : 1024
09:14:10 T:3036064576   DEBUG:   Frame Samples : 8192
09:14:10 T:3036064576   DEBUG:   Frame Size    : 16
09:14:10 T:2971126592   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
09:14:10 T:2736626496   DEBUG: Previous line repeats 1 times.
09:14:10 T:2736626496   DEBUG: CDVDPlayer::HandleMessages - player started 1
09:14:10 T:2736626496   DEBUG: CDVDPlayer::SetCaching - caching state 0
09:14:10 T:2653940544   DEBUG: CDVDPlayerAudio:: synctype set to 1: skip/duplicate
09:14:10 T:2653940544   DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:869494373.065000, should be:869545000.000000, error:50626.935000
09:14:12 T:2653940544   DEBUG: CDVDPlayerAudio:: Dropping packet of 20 ms
09:14:15 T:2662333248   DEBUG: Previous line repeats 1 times.
09:14:15 T:2662333248   DEBUG: CPullupCorrection: detected pattern of length 1: 41708.33, frameduration: 41708.333333
09:14:16 T:3038419264   DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0
09:14:16 T:3038419264   DEBUG: OnKey: return (0xf00d) pressed, action is OSD
09:14:16 T:3038419264   DEBUG: ------ Window Init (VideoOSD.xml) ------
09:14:16 T:3038419264    INFO: Loading skin file: VideoOSD.xml, load type: KEEP_IN_MEMORY
09:14:16 T:3038419264   DEBUG: Load VideoOSD.xml: 13.42ms
09:14:16 T:3038419264   DEBUG: Alloc resources: 15.31ms  (13.53 ms skin load)
09:14:17 T:3038419264   DEBUG: Keyboard: scancode: 0x72, sym: 0x0113, unicode: 0x0000, modifier: 0x0
09:14:17 T:3038419264   DEBUG: OnKey: right (0xf083) pressed, action is Right
09:14:18 T:3038419264   DEBUG: Keyboard: scancode: 0x24, sym: 0x000d, unicode: 0x000d, modifier: 0x0
09:14:18 T:3038419264   DEBUG: OnKey: return (0xf00d) pressed, action is Select
09:14:18 T:3038419264  NOTICE: CDVDPlayer::CloseFile()
09:14:18 T:3038419264  NOTICE: DVDPlayer: waiting for threads to exit
09:14:18 T:2736626496  NOTICE: CDVDPlayer::OnExit()
09:14:18 T:2736626496  NOTICE: DVDPlayer: closing audio stream
09:14:18 T:2736626496  NOTICE: Closing audio stream
09:14:18 T:2736626496  NOTICE: Waiting for audio thread to exit
09:14:18 T:2653940544  NOTICE: thread end: CDVDPlayerAudio::OnExit()
09:14:18 T:2653940544   DEBUG: Thread DVDPlayerAudio 2653940544 terminating
09:14:18 T:2736626496  NOTICE: Closing audio device
09:14:18 T:2971126592   DEBUG: CActiveAE::DiscardStream - audio stream deleted
09:14:18 T:2971126592   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
09:14:18 T:3036064576   DEBUG: Previous line repeats 1 times.
09:14:18 T:3036064576    INFO: CActiveAESink::OpenSink - initialize sink
09:14:18 T:2736626496  NOTICE: Deleting audio codec
09:14:18 T:2736626496  NOTICE: DVDPlayer: closing video stream
09:14:18 T:2736626496  NOTICE: Closing video stream
09:14:18 T:2736626496  NOTICE: waiting for video thread to exit
09:14:18 T:3036064576   DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=PCH,DEV=1
09:14:18 T:3036064576   DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
09:14:18 T:3036064576   DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
09:14:18 T:3036064576   DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR
09:14:18 T:3036064576    INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=PCH,DEV=1"
09:14:18 T:3036064576    INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=PCH,DEV=1,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
09:14:18 T:3036064576    INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
09:14:18 T:3036064576    INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
09:14:18 T:3036064576   DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192
09:14:18 T:3036064576   DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192
09:14:18 T:3036064576   DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms
09:14:18 T:3036064576   DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
09:14:18 T:3036064576   DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
09:14:18 T:3036064576   DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR
09:14:18 T:3036064576   DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
09:14:18 T:3036064576   DEBUG:   Output Device : HDA Intel PCH
09:14:18 T:3036064576   DEBUG:   Sample Rate   : 44100
09:14:18 T:3036064576   DEBUG:   Sample Format : AE_FMT_S32NE
09:14:18 T:3036064576   DEBUG:   Channel Count : 2
09:14:18 T:3036064576   DEBUG:   Channel Layout: FL,FR
09:14:18 T:3036064576   DEBUG:   Frames        : 2048
09:14:18 T:3036064576   DEBUG:   Frame Samples : 4096
09:14:18 T:3036064576   DEBUG:   Frame Size    : 8
09:14:18 T:2971126592   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
09:14:18 T:2662333248  NOTICE: thread end: video_thread
09:14:18 T:2662333248   DEBUG: Thread DVDPlayerVideo 2662333248 terminating
09:14:18 T:2736626496  NOTICE: deleting video codec
09:14:18 T:2736626496  NOTICE: DVDPlayer: closing subtitle stream
09:14:18 T:2736626496  NOTICE: Closing subtitle stream
09:14:18 T:2736626496  NOTICE: CDVDPlayer::OnExit() deleting demuxer
09:14:18 T:2736626496  NOTICE: CDVDPlayer::OnExit() deleting input stream
09:14:18 T:2736626496   DEBUG: CNFSFile::Close closing file scratch/news/Movies/Star_Trek_Into_Darkness_(2013).mkv
09:14:18 T:2736626496   DEBUG: OnPlayBackStopped : play state was 2, starting 0
09:14:18 T:2736626496   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc
09:14:18 T:2736626496   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop
09:14:18 T:2736626496   DEBUG: Thread DVDPlayer 2736626496 terminating
09:14:18 T:3038419264  NOTICE: DVDPlayer: finished waiting
09:14:18 T:3038419264   DEBUG: LinuxRendererGL: Cleaning up GL resources
09:14:18 T:3038419264   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
09:14:18 T:3038419264   DEBUG: ------ Window Deinit (VideoOSD.xml) ------
09:14:18 T:3038419264   DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------

Any help would be greatly appreciated.
Reply
#2
Your kernel is much too old. Use something newer. As you are running 12.04.x already - it should be enough to install the -trusty kernel meta package.
First decide what functions / features you expect from a system. Then decide for the hardware. Don't waste your money on crap.
Reply
#3
(2014-08-10, 10:08)fritsch Wrote: Your kernel is much too old. Use something newer. As you are running 12.04.x already - it should be enough to install the -trusty kernel meta package.

That did the trick, thanks!
Reply
#4
Which kernel version did you upgrade to?

I'm getting "DEBUG: CDVDPlayerAudio:: Dropping packet of 20 ms" messages and slight audio dropouts with "Linux hollywood 3.18.6-031806-generic #201502061036 SMP Fri Feb 6 15:38:09 UTC 2015 x86_64 x86_64 x86_64 GNU/Linux".

Thanks!
Reply
#5
Debug Log that's sync related. Refreshrate does not match fps?
First decide what functions / features you expect from a system. Then decide for the hardware. Don't waste your money on crap.
Reply
#6
That's my expectation - 23.976hz content on a 24hz display. Should there be an audio glitch in playback with that? Just wanted to see what the kernel version that fixed the issue for the OP was.
Reply
#7
Debug log attached at http://paste.ubuntu.com/10215429/
Reply
#8
Disable mythtv plugin, it holds off the main loop for more than one second - you should also see that on the picture. That myth thingy fills your recordings constantly in that log.
First decide what functions / features you expect from a system. Then decide for the hardware. Don't waste your money on crap.
Reply
#9
The mythtv PVR addon?

It's responding to the PVR sending an event RECORDING_LIST_CHANGE generated by the server I think (which in my case was every minute). I'll change some timing on my workaround for another problem and see what happens.

Thanks!
Reply

Logout Mark Read Team Forum Stats Members Help
No Audio with TrueHD Passthrough (but DTS/AC3/DD work) [SOLVED]0