Ok, I've logged it all. No surprises. Both logs look similar. Here's a patebin to both:
Living-room:
http://pastebin.com/6fJqyPjL
Theater-room:
http://pastebin.com/qKMjYkqc
As you can see, xbmc correctly identifies the two audio streams and calls them out by name at open time.
Here's the DTS initialization:
T:117645312 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback 15:34:49 T:130162688 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(67968000.000000, 0) 15:34:49 T:130162688 NOTICE: Creating audio device with codec id: 86019, channels: 2, sample rate: 48000, pass-through 15:34:49 T:130162688 INFO: AudioRendererFactory: not a explicit device, trying to autodetect. 15:34:49 T:130162688 DEBUG: RemoveActiveDevice - Removing device 2 15:34:49 T:130162688 DEBUG: SetActiveDevice - SetActiveDevice from 0 to 4 15:34:49 T:130162688 DEBUG: RemoveActiveDevice - Removing device 0
15:34:49 T:130162688 DEBUG: CIOSCoreAudioDevice::SetupInfo: Remote/IO Output Stream Bus 1 Format [lpcm] Mixable 2 Channel 16-bit Signed Integer (48000Hz)
15:34:49 T:130162688 DEBUG: CIOSCoreAudioDevice::SetupInfo: Remote/IO Input Stream Bus 1 Format [lpcm] Mixable 2 Channel 16-bit Signed Integer (48000Hz)
15:34:49 T:117645312 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
15:34:49 T:130162688 DEBUG: CIOSAudioRenderer::Initialize: Renderer Configuration - Chunk Len: 2048, Max Cache: 196608 (1024ms).
15:34:49 T:130162688 INFO: CIOSAudioRenderer::Initialize: Successfully configured audio output.
15:34:49 T:130162688 DEBUG: CIOSAudioRenderer::Initialize - Channels: 2 - SampleRate: 48000 - SampleBit: 16 - Resample false - IsMusic false - IsPassthrough 1 - audioDevice: Default Output Device
15:34:49 T:130162688 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
15:34:49 T:108249088 DEBUG: CDVDPlayer::HandleMessages - player started 1
15:34:49 T:108249088 DEBUG: CheckPlayerInit - dropping packet type:2 dts:67985000.000000 to get to start point at 68018000.000000
Here's what switching to DD looks like:
15:35:17 T:108249088 NOTICE: Opening audio stream: 2 source: 256
15:35:17 T:108249088 NOTICE: Finding audio codec for: 86020
15:35:17 T:108249088 DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Opening
15:35:17 T:108249088 INFO: CDVDAudioCodecPassthroughFFmpeg::SetupMuxer - Trying to setup spdif muxer
15:35:17 T:108249088 INFO: CDVDAudioCodecPassthroughFFmpeg::SetupMuxer - spdif muxer ready
15:35:17 T:108249088 DEBUG: FactoryCodec - Audio: PassthroughFFmpeg - Opened
15:35:17 T:108249088 NOTICE: Creating audio thread
15:35:17 T:108249088 DEBUG: CDVDPlayer::SetCaching - caching state 2
15:35:17 T:108249088 DEBUG: demuxer seek to: 95425
15:35:17 T:108249088 DEBUG: SeekTime - seek ended up on time 95295
15:35:17 T:108249088 DEBUG: demuxer seek to: 95425, success
15:35:17 T:142925824 DEBUG: Thread CDVDPlayerAudio start, auto delete: 0
15:35:17 T:142925824 NOTICE: running thread: CDVDPlayerAudio:
rocess()
15:35:17 T:117645312 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
15:35:17 T:142925824 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
15:35:17 T:108249088 DEBUG: CheckPlayerInit - dropping packet type:2 dts:95295000.000000 to get to start point at 95425000.000000
15:35:17 T:108249088 DEBUG: CheckPlayerInit - dropping packet type:2 dts:95212000.000000 to get to start point at 95425000.000000
15:35:17 T:108249088 DEBUG: CheckPlayerInit - dropping packet type:1 dts:95232000.000000 to get to start point at 95425000.000000
15:35:17 T:117645312 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
15:35:17 T:117645312 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
15:35:17 T:108249088 DEBUG: CheckPlayerInit - dropping packet type:1 dts:95242000.000000 to get to start point at 95425000.000000
.
.
.
15:35:17 T:108249088 DEBUG: CheckPlayerInit - dropping packet type:1 dts:95408000.000000 to get to start point at 95425000.000000
15:35:17 T:117645312 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
15:35:17 T:117645312 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(95429000.000000, 1)
15:35:17 T:108249088 DEBUG: CDVDPlayer::HandleMessages - player started 2
15:35:17 T:108249088 DEBUG: CheckPlayerInit - dropping packet type:2 dts:95345000.000000 to get to start point at 95429000.000000
15:35:17 T:108249088 DEBUG: CheckPlayerInit - dropping packet type:2 dts:95379000.000000 to get to start point at 95429000.000000
15:35:17 T:108249088 DEBUG: CheckPlayerInit - dropping packet type:1 dts:95424000.000000 to get to start point at 95425000.000000
15:35:17 T:142925824 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(95434000.000000, 0)
15:35:17 T:142925824 NOTICE: Creating audio device with codec id: 86020, channels: 2, sample rate: 48000, pass-through
15:35:17 T:142925824 INFO: AudioRendererFactory: not a explicit device, trying to autodetect.
15:35:17 T:142925824 DEBUG: SetActiveDevice - SetActiveDevice from 4 to 2
15:35:17 T:142925824 DEBUG: RemoveActiveDevice - Removing device 4
15:35:17 T:142925824 DEBUG: RemoveActiveDevice - Removing device 2
15:35:17 T:142925824 DEBUG: SetActiveDevice - SetActiveDevice from 0 to 4
15:35:17 T:142925824 DEBUG: RemoveActiveDevice - Removing device 0
15:35:17 T:142925824 DEBUG: CIOSCoreAudioDevice::SetupInfo: Remote/IO Output Stream Bus 1 Format [lpcm] Mixable 2 Channel 16-bit Signed Integer (48000Hz)
15:35:17 T:142925824 DEBUG: CIOSCoreAudioDevice::SetupInfo: Remote/IO Input Stream Bus 1 Format [lpcm] Mixable 2 Channel 16-bit Signed Integer (48000Hz)
15:35:17 T:142925824 DEBUG: CIOSAudioRenderer::Initialize: Renderer Configuration - Chunk Len: 2048, Max Cache: 196608 (1024ms).
15:35:17 T:142925824 INFO: CIOSAudioRenderer::Initialize: Successfully configured audio output.
15:35:17 T:142925824 DEBUG: CIOSAudioRenderer::Initialize - Channels: 2 - SampleRate: 48000 - SampleBit: 16 - Resample false - IsMusic false - IsPassthrough 3 - audioDevice: Default Output Device
15:35:17 T:142925824 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
15:35:17 T:108249088 DEBUG: CDVDPlayer::HandleMessages - player started 1
15:35:17 T:108249088 DEBUG: CDVDPlayer::SetCaching - caching state 0
15:35:17 T:117645312 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
15:35:17 T:142925824 DEBUG: CDVDPlayerAudio:: Discontinuity - was:95444181.750000, should be:95434000.000000, error:-10181.750000
15:35:17 T:142925824 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
15:35:18 T:117645312 WARNING: Previous line repeats 1 times.
15:35:18 T:117645312 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
15:35:18 T:142925824 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
What is the difference between IsPassthrough 1 and IsPassthrough 3?
Since both ATV's are doing the same thing, and since one processor works and one doesn't, I can only conclude that the ac3 stream is malformed in some way coming from xbmc and that the Marantz "figures it out and does the right thing" while the Meridian doesn't.