Acer Revo 3700 SPDIF Failed to Initialise Audio

Hi,

Been using XBMC for a while now on Ubuntu 10.04. Just upgraded by old machine for an Acer 3700. looks smart and seemed to work ok until I plugged the external DVD drive in and attempted play back -

Failed to initialize audio device : is the message I get. Changing to Analog sorts this but I lose 5.1 sound.

There seems to a be a few people experiencing problems in this area and I cannot locate a definite solution. It's been 8 hours now... and I'm sick of searching and trying all the hacks I've found. has anyone come up against this and how did you get round it.

i686
Linux 2.6.32-31-generic #61-Ubuntu SMP (10.04 LTS)
XBMC 10.1 Git unknown (compiled March 9 2011)
http://pastebin.com/KiNDMFhP


Thanks

layolayo

Just noticed that when I get the error I quit XBMC then run:

sudo alsa force-reload

restart XBMC - I get 5.1 SPDIF sound on DVD

but when going back to my usual library (avi's etc.) I get the Failed message.

I repeat the above process, goto usual library first and I get sound?!?

Sound Settings:

System->Pref->Sound
Hardware-> HDMI (Disabled), Internal Audio Digital Stereo (IEC958) Output + Analog Stereo Input

XBMC->System->System->Audio Output
Audio Output: Optical/Coax
Speaker Configuration: 5.1
Boost volume level on downmix: enabled
Dolby Digital (AC3) capable receiver: enabled
DTS capable receiver: enabled
Audio output device: Internal Audio Digital Stereo (IEC958)
Passthrough output device: HDA Intel iec958

:~$ cat /proc/asound/version
Advanced Linux Sound Architecture Driver Version 1.0.24.
Compiled on May 16 2011 for kernel 2.6.32-31-generic (SMP).

# autoloader aliases
install sound-slot-0 /sbin/modprobe snd-card-0
install sound-slot-1 /sbin/modprobe snd-card-1
install sound-slot-2 /sbin/modprobe snd-card-2
install sound-slot-3 /sbin/modprobe snd-card-3
install sound-slot-4 /sbin/modprobe snd-card-4
install sound-slot-5 /sbin/modprobe snd-card-5
install sound-slot-6 /sbin/modprobe snd-card-6
install sound-slot-7 /sbin/modprobe snd-card-7

# Cause optional modules to be loaded above generic modules
install snd /sbin/modprobe --ignore-install snd $CMDLINE_OPTS && { /sbin/modprobe --quiet --use-blacklist snd-ioctl32 ; /sbin/modprobe --quiet --use-blacklist snd-seq ; }
#
# Workaround at bug #499695 (reverted in Ubuntu see LP #319505)
install snd-pcm /sbin/modprobe --ignore-install snd-pcm $CMDLINE_OPTS && { /sbin/modprobe --quiet --use-blacklist snd-pcm-oss ; : ; }
install snd-mixer /sbin/modprobe --ignore-install snd-mixer $CMDLINE_OPTS && { /sbin/modprobe --quiet --use-blacklist snd-mixer-oss ; : ; }
install snd-seq /sbin/modprobe --ignore-install snd-seq $CMDLINE_OPTS && { /sbin/modprobe --quiet --use-blacklist snd-seq-midi ; /sbin/modprobe --quiet --use-blacklist snd-seq-oss ; : ; }
#
install snd-rawmidi /sbin/modprobe --ignore-install snd-rawmidi $CMDLINE_OPTS && { /sbin/modprobe --quiet --use-blacklist snd-seq-midi ; : ; }
# Cause optional modules to be loaded above sound card driver modules
install snd-emu10k1 /sbin/modprobe --ignore-install snd-emu10k1 $CMDLINE_OPTS && { /sbin/modprobe --quiet --use-blacklist snd-emu10k1-synth ; }
install snd-via82xx /sbin/modprobe --ignore-install snd-via82xx $CMDLINE_OPTS && { /sbin/modprobe --quiet --use-blacklist snd-seq ; }

# Load saa7134-alsa instead of saa7134 (which gets dragged in by it anyway)
install saa7134 /sbin/modprobe --ignore-install saa7134 $CMDLINE_OPTS && { /sbin/modprobe --quiet --use-blacklist saa7134-alsa ; : ; }
# Prevent abnormal drivers from grabbing index 0
options bt87x index=-2
options cx88_alsa index=-2
options saa7134-alsa index=-2
options snd-atiixp-modem index=-2
options snd-intel8x0m index=-2
options snd-via82xx-modem index=-2
options snd-usb-audio index=-2
options snd-usb-us122l index=-2
options snd-usb-usx2y index=-2
options snd-usb-caiaq index=-2
# Ubuntu #62691, enable MPU for snd-cmipci
options snd-cmipci mpu_port=0x330 fm_port=0x388
# Keep snd-pcsp from being loaded as first soundcard
options snd-pcsp index=-2
#options snd-hda-intel model=3stack-6ch-dig

22:15:09 T:3077515136 M:1654214656 DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
22:15:09 T:2664426352 M:1654214656 DEBUG: Initialize - using alsa device iec958:CARD=Intel,AES0=0x6,AES1=0x82,AES2=0x0,AES3=0x2
22:15:09 T:2664426352 M:1654214656 ERROR: Initialize - device iec958:CARD=Intel,AES0=0x6,AES1=0x82,AES2=0x0,AES3=0x2 busy retrying...
22:15:09 T:3077515136 M:1654214656 DEBUG: ------ Window Init (VideoFullScreen.xml) ------
22:15:09 T:3077515136 M:1654214656 INFO: Loading skin file: VideoFullScreen.xml
22:15:09 T:3077515136 M:1654087680 DEBUG: CAnnouncementManager - Announcement: PlaybackStarted from xbmc
22:15:10 T:3077515136 M:1660239872 DEBUG: CGUIInfoManager::SetCurrentMovie(/media/video/Movies/Jonah Hex (2010)/Jonah Hex (2010).mkv)
22:15:10 T:2664426352 M:1660239872 ERROR: Initialize - failed to open custom device iec958:CARD=Intel,AES0=0x6,AES1=0x82,AES2=0x0,AES3=0x2 (error:Device or resource busy), retry with default iec958:CARD=Intel
22:15:10 T:2664426352 M:1660239872 ERROR: Initialize - pcm_open_lconf, alsa error: -16 - Device or resource busy
22:15:10 T:2664426352 M:1660239872 DEBUG: SetActiveDevice - SetActiveDevice from 2 to 1
22:15:10 T:2664426352 M:1660239872 DEBUG: RemoveActiveDevice - Removing device 2
22:15:10 T:2664426352 M:1660239872 DEBUG: CGUIAudioManager::Initialize
22:15:10 T:2664426352 M:1659850752 ERROR: Creating a Null Audio Renderer, Check your audio settings as this should not happen
22:15:10 T:2664426352 M:1659850752 DEBUG: RemoveActiveDevice - Removing device 1
22:15:10 T:2664426352 M:1659850752 DEBUG: CGUIAudioManager::DeInitialize
22:15:10 T:3077515136 M:1659850752 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
22:15:10 T:2664426352 M:1659850752 DEBUG: SetActiveDevice - SetActiveDevice from 0 to 2
22:15:10 T:2664426352 M:1659850752 DEBUG: RemoveActiveDevice - Removing device 0
22:15:10 T:2664426352 M:1659850752 DEBUG: CNullDirectSound::Initialize - Channels: 2 - SampleRate: 48000 - SampleBit: 16 - Resample false - IsMusic false - IsPassthrough true - audioDevice: iec958:CARD=Intel
22:15:10 T:2664426352 M:1659850752 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
22:15:10 T:2681211760 M:1659850752 DEBUG: CDVDPlayer::HandleMessages - player started 1
22:15:10 T:2681211760 M:1659850752 DEBUG: CDVDPlayer::SetCaching - caching state 3
22:15:10 T:2681211760 M:1659850752 DEBUG: CDVDPlayer::SetCaching - caching state 0
22:15:10 T:2664426352 M:1659850752 DEBUG: CDVDPlayerAudio:: Discontinuity - was:925.770000, should be:0.000000, error:-925.770000
22:15:10 T:2664426352 M:1659850752 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(10000.000000, 1)
22:15:10 T:3077515136 M:1659723776 NOTICE: Created m_glPixmapTexture (94)
22:15:10 T:3077515136 M:1659088896 DEBUG: ------ Window Init (DialogKaiToast.xml) ------
22:15:12 T:2681211760 M:1657573376 WARNING: CDVDPlayer::CheckContinuity - wrapback of stream:1, prev:8999000.000000, curr:8949000.000000, diff:-50000.000000
22:15:12 T:2672819056 M:1657573376 DEBUG: CPullupCorrection: detected pattern of length 24: 42000.00 41000.00 42000.00 42000.00 41000.00 42000.00 42000.00 42000.00 41000.00 42000.00 42000.00 41000.00 42000.00 42000.00 42000.00 41000.00 42000.00 42000.00 41000.00 42000.00 42000.00 41000.00 42000.00 42000.00
22:15:13 T:3077515136 M:1657573376 DEBUG: ------ Window Init (VideoOSD.xml) ------
22:15:13 T:3077515136 M:1657573376 INFO: Loading skin file: VideoOSD.xml
22:15:13 T:2664426352 M:1657319424 DEBUG: CDVDPlayerAudio:: Discontinuity - was:3007390.735000, should be:2965537.354038, error:-41853.380962
22:15:13 T:2681211760 M:1657319424 WARNING: CDVDPlayer::CheckContinuity - wrapback of stream:1, prev:10153000.000000, curr:10123000.000000, diff:-30000.000000
22:15:15 T:3077515136 M:1657319424 DEBUG: ExecuteXBMCAction : Translating PlayerControl(Play)
22:15:15 T:3077515136 M:1657319424 DEBUG: ExecuteXBMCAction : To PlayerControl(Play)
22:15:15 T:3077515136 M:1657319424 DEBUG: CAnnouncementManager - Announcement: PlaybackPaused from xbmc
22:15:15 T:3077515136 M:1657319424 DEBUG: ------ Window Init (DialogSeekBar.xml) ------
22:15:15 T:3077515136 M:1657319424 DEBUG: ------ Window Deinit (DialogKaiToast.xml) ------
22:15:19 T:3077515136 M:1657073664 DEBUG: ExecuteXBMCAction : Translating PlayerControl(Stop)
22:15:19 T:3077515136 M:1657073664 DEBUG: ExecuteXBMCAction : To PlayerControl(Stop)
22:15:19 T:3077515136 M:1657073664 NOTICE: CDVDPlayer::CloseFile()
22:15:19 T:3077515136 M:1657073664 NOTICE: DVDPlayer: waiting for threads to exit
22:15:19 T:2664426352 M:1657073664 DEBUG: CDVDPlayerAudio:: Discontinuity - was:4560720.707038, should be:4605681.028320, error:44960.321282
22:15:19 T:2681211760 M:1657073664 NOTICE: CDVDPlayer::OnExit()
22:15:19 T:2681211760 M:1657073664 NOTICE: DVDPlayer: closing audio stream
22:15:19 T:2681211760 M:1657073664 NOTICE: Closing audio stream
22:15:19 T:2681211760 M:1657073664 NOTICE: Waiting for audio thread to exit
22:15:19 T:2664426352 M:1657073664 NOTICE: thread end: CDVDPlayerAudio::OnExit()
22:15:19 T:2664426352 M:1657073664 DEBUG: Thread 2664426352 terminating
22:15:19 T:2681211760 M:1657073664 NOTICE: Closing audio device
22:15:19 T:2681211760 M:1657073664 DEBUG: SetActiveDevice - SetActiveDevice from 2 to 1
22:15:19 T:2681211760 M:1657073664 DEBUG: RemoveActiveDevice - Removing device 2
22:15:19 T:2681211760 M:1657073664 DEBUG: CGUIAudioManager::Initialize
22:15:19 T:2681211760 M:1656946688 NOTICE: Deleting audio codec
22:15:19 T:2681211760 M:1656946688 NOTICE: DVDPlayer: closing video stream
22:15:19 T:2681211760 M:1656946688 NOTICE: Closing video stream
22:15:19 T:2681211760 M:1656946688 NOTICE: waiting for video thread to exit
22:15:19 T:2672819056 M:1656946688 NOTICE: thread end: video_thread
22:15:19 T:2672819056 M:1656946688 DEBUG: Thread 2672819056 terminating
22:15:19 T:2681211760 M:1656946688 NOTICE: deleting video codec
22:15:19 T:2681211760 M:1659613184 NOTICE: DVDPlayer: closing subtitle stream
22:15:19 T:2681211760 M:1659613184 NOTICE: Closing subtitle stream
22:15:19 T:2681211760 M:1659613184 NOTICE: CDVDPlayer::OnExit() deleting demuxer
22:15:19 T:2681211760 M:1659613184 NOTICE: CDVDPlayer::OnExit() deleting input stream
22:15:19 T:2681211760 M:1659613184 DEBUG: CAnnouncementManager - Announcement: PlaybackStopped from xbmc
22:15:19 T:2681211760 M:1659613184 DEBUG: Thread 2681211760 terminating
22:15:19 T:3077515136 M:1661390848 NOTICE: DVDPlayer: finished waiting

Ok, so just installed 10.1 XBMC Live and all seems to work ok. There is a slight glitch on sound when playing 5.1 encoded avi files. Causes my amp to give a subwoofer pulse.

I will pursue this line of enquiry now. Unless someone already has an idea about this?

Yeah, Ubuntu + XBMC 10.1 was working great w/ HDMI and S/PDIF and then suddenly S/PDIF broke! XBMC keeps telling me that it failed to initialize the device!

Spent hours trying everything documented at http://forum.xbmc.org/archive/index.php/t-35901.html. IIRC, I started seeing this problem after I used Rhythmbox and played it over S/PDIF.. Reinstalling everything now to see if it fixes

(2011-11-04 10:07)xbmc-user Wrote:  Yeah, Ubuntu + XBMC 10.1 was working great w/ HDMI and S/PDIF and then suddenly S/PDIF broke!

I just had the same problem. After removing dir ~/.pulse and ~/.pulse-cookie AC3 and DTS are working again.

Hmm, will remember to try this next time, if it break again