Hi,
I'm running XBMC Frodo Beta 1 on my ATV2. Music and videos are stored on my Synology NAS.
My ATV2 is connected via cable (no WIFI connection). ATV2 is connected to my Synology via SMB.
Since "years" everything was perfect :-)
A couple of weeks ago I've updated my ATV to 5.0.2 and my Synology to 4.x firmware.
I'm using XBMC nightlies and I'm updating my ATV2 every 2 to 4 weeks.
Now my problem:
When listening to music, 6 seconds before the end of a song, the playback stops for around 1 second and then the music continues (as nothing went wrong).
This happens only if there is a following song. If it's the last song of an album, everything is fine (no interrupt).
There is no error message in my xbmc logfile.
Any hint what this could be
? Anything that I can check or change?
I have tested UPNP, AFP and NFS --> same result
And I have tested a connection to another network storage via UPNP --> same result
It seems to me that something is corrupt on my ATV or XBMC .... :-(
After I had activated the debug log, I found the following error in the xbmc logfile:
ERROR: CCoreAudioUnit::Close: Unable to disconnect AudioUnit. Error = -10860
Here is the whole part during the problem:
Code:
19:14:02 T:108711936 DEBUG: CSmbFile::Close closing fd 10001
19:14:02 T:108711936 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
19:14:02 T:108711936 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
19:14:02 T:154546176 INFO: CFileCache::Process - Hit eof.
19:14:52 T:108711936 DEBUG: CFileCache::Open - opening <music/_Alben/Coldplay - Live 2012 (2012)/02 - Hurts Like Heaven.mp3> using cache
19:14:52 T:108711936 DEBUG: CSmbFile::Open - opened music/_Alben/Coldplay - Live 2012 (2012)/02 - Hurts Like Heaven.mp3, fd=10001
19:14:52 T:108711936 DEBUG: CSmbFile::Open - opened music/_Alben/Coldplay - Live 2012 (2012)/02 - Hurts Like Heaven.mp3, fd=10002
19:14:52 T:108711936 DEBUG: CSmbFile::Close closing fd 10002
19:14:52 T:142921728 DEBUG: Process, request seek on source to 10256497
19:14:52 T:108711936 DEBUG: Seek - waiting for position 10321905.
19:14:52 T:142921728 DEBUG: Process, request seek on source to 0
19:14:52 T:108711936 INFO: AudioDecoder: File is queued
19:14:52 T:108711936 INFO: CCoreAudioAE::MakeStream - AE_FMT_S32NE, 44100, 0, FL,FR
19:14:53 T:108711936 ERROR: CCoreAudioUnit::Close: Unable to disconnect AudioUnit. Error = -10860
19:14:53 T:108711936 ERROR: Previous line repeats 2 times.
19:14:53 T:108711936 INFO: CCoreAudioGraph::Open: Input Stream Format [lpcm] Mixable Non-Interleaved 2 Channel 32-bit Signed Integer LE (44100Hz)
19:14:53 T:108711936 INFO: CCoreAudioGraph::Open: Output Stream Format [lpcm] Mixable Interleaved 2 Channel 32-bit Floating Point LE (44100Hz)
19:14:53 T:108711936 INFO: CCoreAudioGraph::Open: Input Stream Format [lpcm] Mixable Non-Interleaved 2 Channel 32-bit Signed Integer LE (44100Hz)
19:14:53 T:108711936 INFO: CCoreAudioGraph::Open: Output Stream Format [lpcm] Mixable Non-Interleaved 2 Channel 32-bit Signed Integer LE (44100Hz)
19:14:53 T:108711936 INFO: CCoreAudioGraph::Open: Input Stream Format [lpcm] Mixable Interleaved 2 Channel 32-bit Floating Point LE (44100Hz)
19:14:53 T:108711936 INFO: CCoreAudioGraph::Open: Output Stream Format [lpcm] Mixable Non-Interleaved 2 Channel 32-bit Signed Integer LE (44100Hz)
19:14:53 T:108711936 INFO: CCoreAudioAE::Initialize:
19:14:53 T:108711936 INFO: Output Device :
19:14:53 T:108711936 INFO: Sample Rate : 44100
19:14:53 T:108711936 INFO: Sample Format : AE_FMT_FLOAT
19:14:53 T:108711936 INFO: Channel Count : 2
19:14:53 T:108711936 INFO: Channel Layout: FL,FR
19:14:53 T:108711936 INFO: Frame Size : 8
19:14:53 T:108711936 INFO: Volume Level : 0.758577
19:14:53 T:108711936 INFO: Passthrough : 0
19:14:53 T:108711936 DEBUG: AERemap: Downmix normalization is enabled
19:14:53 T:108711936 DEBUG: Previous line repeats 3 times.
19:14:53 T:108711936 DEBUG: CCoreAudioAEStream::CCoreAudioAEStream - Converting from AE_FMT_S32NE to AE_FMT_FLOAT
19:14:53 T:108711936 INFO: CCoreAudioGraph::Open: Input Stream Format [lpcm] Mixable Interleaved 2 Channel 32-bit Floating Point LE (44100Hz)
19:14:53 T:108711936 INFO: CCoreAudioGraph::Open: Output Stream Format [lpcm] Mixable Non-Interleaved 2 Channel 32-bit Signed Integer LE (44100Hz)
19:14:53 T:108711936 DEBUG: AERemap: Downmix normalization is enabled
19:14:53 T:108711936 DEBUG: CCoreAudioAEStream::CCoreAudioAEStream - Converting from AE_FMT_S32NE to AE_FMT_FLOAT
19:14:53 T:108711936 INFO: CCoreAudioGraph::Open: Input Stream Format [lpcm] Mixable Interleaved 2 Channel 32-bit Floating Point LE (44100Hz)
19:14:53 T:108711936 INFO: CCoreAudioGraph::Open: Output Stream Format [lpcm] Mixable Non-Interleaved 2 Channel 32-bit Signed Integer LE (44100Hz)
19:14:53 T:108711936 DEBUG: AudioDecoder::GetReplayGain - Final Replaygain applied: 1.000000, Track/Album Gain 89.000000, Peak 0.000000
19:14:53 T:108711936 INFO: PAPlayer::PrepareStream - Ready
19:14:57 T:158109696 DEBUG: CSmbFile::Close closing fd 10000
i've pushed an improvment to this a couple of hours ago. Next nightly should behave better (still not perfect as of my tests).
This sounds great.
What type of problem is it? Is it specific to my setup?
no its the new audio engine in conjunction with apples coreaudio interface.
So I'm not alone with this problem :-)
I've installed the latest nightly from today ... and what should I say --> it's much much better.
Not okay ... but the interrupt is now maybe 1/10 second. Thanks a lot !!!
Will it be fixed in the near future?
If we find the cause - maybe ...