Gentoo Websites Logo
Go to: Gentoo Home Documentation Forums Lists Bugs Planet Store Wiki Get Gentoo!
Bug 347245 - Sound doesn't work using alsa and snd_intel8x0 with error message of "analog subsections not ready", unreliable DMA position
Summary: Sound doesn't work using alsa and snd_intel8x0 with error message of "analog ...
Status: RESOLVED CANTFIX
Alias: None
Product: Gentoo Linux
Classification: Unclassified
Component: [OLD] Core system (show other bugs)
Hardware: AMD64 Linux
: High major (vote)
Assignee: Gentoo Linux bug wranglers
URL:
Whiteboard:
Keywords:
Depends on:
Blocks:
 
Reported: 2010-11-30 05:19 UTC by Jacob Martin
Modified: 2011-01-25 22:51 UTC (History)
1 user (show)

See Also:
Package list:
Runtime testing required: ---


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description Jacob Martin 2010-11-30 05:19:09 UTC
After a slew of recent updates to my system, sound does not work anymore.  When I modprobe snd_intel8x0, I get the following output in /var/log/messages

Intel ICH 0000:00:04.0: PCI INT A disabled
Intel ICH 0000:00:04.0: PCI INT A -> Link[LACI] -> GSI 22 (level, high) -> IRQ 22
Intel ICH 0000:00:04.0: setting latency timer to 64
AC'97 0 analog subsections not ready
intel8x0_measure_ac97_clock: measured 50838 usecs (64 samples)
intel8x0: measured clock 1258 rejected
intel8x0: measure - unreliable DMA position..
intel8x0: measure - unreliable DMA position..
intel8x0: clocking to 48000

I noticed that interrupt 22 is shared with sata_nv:

optimator ~ # cat /proc/interrupts 
           CPU0       CPU1       CPU2       CPU3       
  0:        133          0          0          0   IO-APIC-edge      timer
  1:          0          0          0          2   IO-APIC-edge      i8042
  4:          0          0          0          1   IO-APIC-edge    
  6:          0          0          0          5   IO-APIC-edge      floppy
  7:          1          0          0          0   IO-APIC-edge    
  9:          0          0          0          0   IO-APIC-fasteoi   acpi
 14:          0          0          0          0   IO-APIC-edge      pata_amd
 15:          0          0          0         10   IO-APIC-edge      pata_amd
 19:          0          1         26      19062   IO-APIC-fasteoi   nvidia
 20:          0          0          0          5   IO-APIC-fasteoi   ehci_hcd:usb1
 21:          0          0          5       4062   IO-APIC-fasteoi   eth0
 22:          0          0          3        413   IO-APIC-fasteoi   sata_nv, NVidia CK804
 23:          0          3         33      15976   IO-APIC-fasteoi   sata_nv, ohci_hcd:usb2
 30:          0          0          0         45   IO-APIC-fasteoi   ioc0
 31:          0          1         60     167974   IO-APIC-fasteoi   ioc1
NMI:          0          0          0          0   Non-maskable interrupts
LOC:    2759890    2759801    2759739    2759662   Local timer interrupts
SPU:          0          0          0          0   Spurious interrupts
PMI:          0          0          0          0   Performance monitoring interrupts
PND:          0          0          0          0   Performance pending work
RES:      24576      24110      57486      57850   Rescheduling interrupts
CAL:       8662       1256       1313        362   Function call interrupts
TLB:       2747       2494       1937       2075   TLB shootdowns
THR:          0          0          0          0   Threshold APIC interrupts
MCE:          0          0          0          0   Machine check exceptions
MCP:         10         10         10         10   Machine check polls
ERR:          1
MIS:          0

I am using a newly compiled Linux optimator 2.6.36-gentoo-r3 #2 SMP PREEMPT Sun Nov 28 14:42:26 EST 2010 x86_64 Dual Core AMD Opteron(tm) Processor 275 AuthenticAMD GNU/Linux 

I followed the Gentoo ALSA guide exactly.

When I try to play something, using speaker-test, mplayer, or madplay, the program simply does not advance the stream and locks up.

I do not have a .asoundrc file



Reproducible: Always

Actual Results:  
no sound

Expected Results:  
sound

optimator ~ # emerge --info
--- Unmatch removal atom(s) in /usr/local/portage/layman/gnome/profiles/package.mask: -dev-libs/gir-repository, ->=x11-libs/libxklavier-5, -dev-libs/gobject-introspection
Portage 2.1.9.24 (default/linux/amd64/10.0/desktop, gcc-4.4.4, glibc-2.11.2-r3, 2.6.36-gentoo-r3 x86_64)
=================================================================
System uname: Linux-2.6.36-gentoo-r3-x86_64-Dual_Core_AMD_Opteron-tm-_Processor_275-with-gentoo-1.12.14
Timestamp of tree: Mon, 29 Nov 2010 16:30:23 +0000
ccache version 2.4 [disabled]
app-shells/bash:     4.1_p7
dev-java/java-config: 1.3.7-r1, 2.1.11-r1
dev-lang/python:     2.4.6, 2.5.4-r4, 2.6.5-r3, 3.1.2-r4
dev-util/ccache:     2.4-r7::<unknown repository>
dev-util/cmake:      2.8.1-r2
sys-apps/baselayout: 1.12.14-r1
sys-apps/sandbox:    2.3-r1
sys-devel/autoconf:  2.13::<unknown repository>, 2.65-r1
sys-devel/automake:  1.4_p6::<unknown repository>, 1.5::<unknown repository>, 1.6.3::<unknown repository>, 1.7.9-r1::<unknown repository>, 1.8.5-r3::<unknown repository>, 1.9.6-r3, 1.10.3, 1.11.1
sys-devel/binutils:  2.16.1-r3::<unknown repository>, 2.17-r1, 2.18-r3, 2.20.1-r1
sys-devel/gcc:       3.4.5::<unknown repository>, 3.4.6-r2::<unknown repository>, 4.1.1-r3::<unknown repository>, 4.1.2, 4.3.2-r3, 4.3.4, 4.4.4-r2
sys-devel/gcc-config: 1.4.1
sys-devel/libtool:   2.4-r1
sys-devel/make:      3.81-r2
virtual/os-headers:  2.6.30-r1 (sys-kernel/linux-headers)
ACCEPT_KEYWORDS="amd64"
ACCEPT_LICENSE="*"
CBUILD="x86_64-pc-linux-gnu"
CFLAGS="-march=opteron-sse3 -mtune=opteron-sse3 -O2 -pipe -msse -msse2 -funit-at-a-time -fomit-frame-pointer -frename-registers -fweb"
CHOST="x86_64-pc-linux-gnu"
CONFIG_PROTECT="/etc /usr/kde/3.5/env /usr/kde/3.5/share/config /usr/kde/3.5/shutdown /usr/share/X11/xkb /usr/share/config /usr/share/openvpn/easy-rsa /var/lib/hsqldb"
CONFIG_PROTECT_MASK="/etc/ca-certificates.conf /etc/env.d /etc/env.d/java/ /etc/fonts/fonts.conf /etc/gconf /etc/php/apache2-php5/ext-active/ /etc/php/cgi-php5/ext-active/ /etc/php/cli-php5/ext-active/ /etc/revdep-rebuild /etc/sandbox.d /etc/terminfo /etc/texmf/language.dat.d /etc/texmf/language.def.d /etc/texmf/updmap.d /etc/texmf/web2c"
CXXFLAGS="-march=opteron-sse3 -mtune=opteron-sse3 -O2 -pipe -msse -msse2 -funit-at-a-time -fomit-frame-pointer -frename-registers -fweb"
DISTDIR="/usr/portage/distfiles"
FEATURES="assume-digests binpkg-logs distlocks fixlafiles fixpackages news parallel-fetch protect-owned sandbox sfperms strict unknown-features-warn unmerge-logs unmerge-orphans userfetch"
GENTOO_MIRRORS="http://distfiles.gentoo.org http://www.ibiblio.org/pub/Linux/distributions/gentoo"
LDFLAGS="-Wl,-O1 -Wl,--as-needed"
MAKEOPTS="-j5"
PKGDIR="/usr/portage/packages"
PORTAGE_CONFIGROOT="/"
PORTAGE_RSYNC_OPTS="--recursive --links --safe-links --perms --times --compress --force --whole-file --delete --stats --timeout=180 --exclude=/distfiles --exclude=/local --exclude=/packages"
PORTAGE_TMPDIR="/var/tmp"
PORTDIR="/usr/portage"
PORTDIR_OVERLAY="/usr/local/portage/layman/kde-sunset /usr/local/portage/layman/gnome /usr/local/portage/layman/science /usr/local/portage /var/lib/layman/kde"
SYNC="rsync://rsync.gentoo.org/gentoo-portage"
USE="3dnow 3dnowext X Xaw3d a52 aac acl acpi alsa amd amd64 apache2 arts audiofile bash-completion berkdb binfilter bl blas bluetooth boost branding bzip2 cairo cdb cdda cddb cdr cli consolekit cpudetection cracklib crypt cups curl custom-optimization cxx dbus debugger designer-plugin dia directfb disk-partition djvu dri dts dv dvb dvd dvdnav dvdr dvdread dvi embedded emboss encode examples exif extras fam fame ffmpeg firefox flac fontconfig fortran fts3 gd gdbm gif gimpprint git glitz gnome gnutls gpm graphviz gstreamer gtk gtkhtml hal hou hpcups htmlhandbook iconv id3tag inkjar ipv6 ithreads jai java jbig jpeg jpeg2k kde kpathsea ladspa lapack lasi latex lcms ldap libnotify libsamplerate lm_sensors lzo mad math midi mikmod mjpeg mmx mmxext mng modplug modules moonlight mozcalendar mozilla mozsvg mp2 mp3 mp4 mp4live mpeg mpeg2 mpi mplayer mpx mudflap multilib musepack mysql mysqli nas nautilus ncurses network new-hpcups nls nptl nptlonly nsplugin octave ogg opencl openexr opengl openmp pam pango paste64 pcre pdf perl phonon php plasma plotutils png postscript ppds pppd profiler python qt3support qt4 quicktime readline redland restrict-javascript samba sdl secure-delete semantic-desktop sensord session slp smp socks5 sou soundtouch spell sql sse sse2 ssl startup-notification svg sysfs t1lib tcpd tetex theora threads tiff tivo tk toolbar tools truetype tta twolame udev unicode usb utempter v4l vamp vcd virtualbox vorbis wavpack webdav webkit wma wmf x264 xanim xcb xcomposite xine xinerama xml xorg xrandr xulrunner xv xvid zeroconf zlib" ALSA_CARDS="emu10k1" ALSA_PCM_PLUGINS="*" APACHE2_MODULES="actions alias auth_basic authn_alias authn_anon authn_dbm authn_default authn_file authz_dbm authz_default authz_groupfile authz_host authz_owner authz_user autoindex cache cgi cgid dav dav_fs dav_lock deflate dir disk_cache env expires ext_filter file_cache filter headers include info log_config logio mem_cache mime mime_magic negotiation rewrite setenvif speling status unique_id userdir usertrack vhost_alias" COLLECTD_PLUGINS="df interface irq load memory rrdtool swap syslog" ELIBC="glibc" GPSD_PROTOCOLS="ashtech aivdm earthmate evermore fv18 garmin garmintxt gpsclock itrax mtk3301 nmea ntrip navcom oceanserver oldstyle oncore rtcm104v2 rtcm104v3 sirf superstar2 timing tsip tripmate tnt ubx" INPUT_DEVICES="keyboard mouse evdev" KERNEL="linux" LCD_DEVICES="bayrad cfontz cfontz633 glk hd44780 lb216 lcdm001 mtxorb ncurses text" NETBEANS_MODULES="nb cnd ide identity profiler visualweb java dlight enterprise harness websvccommon" PHP_TARGETS="php5-2" RUBY_TARGETS="ruby18" USERLAND="GNU" VIDEO_CARDS="nvidia" XTABLES_ADDONS="quota2 psd pknock lscan length2 ipv4options ipset ipp2p iface geoip fuzzy condition tee tarpit sysrq steal rawnat logmark ipmark dhcpmac delude chaos account" 
Unset:  CPPFLAGS, CTARGET, EMERGE_DEFAULT_OPTS, FFLAGS, INSTALL_MASK, LANG, LC_ALL, LINGUAS, PORTAGE_BUNZIP2_COMMAND, PORTAGE_COMPRESS, PORTAGE_COMPRESS_FLAGS, PORTAGE_RSYNC_EXTRA_OPTS
Comment 1 Jacob Martin 2010-11-30 05:27:43 UTC
More information:

optimator ~ # aplay -l
**** List of PLAYBACK Hardware Devices ****
card 0: CK804 [NVidia CK804], device 0: Intel ICH [NVidia CK804]
  Subdevices: 1/1
  Subdevice #0: subdevice #0
card 0: CK804 [NVidia CK804], device 2: Intel ICH - IEC958 [NVidia CK804 - IEC958]
  Subdevices: 1/1
  Subdevice #0: subdevice #0
optimator ~ # aplay -L  
null
    Discard all samples (playback) or generate zero samples (capture)
default:CARD=CK804
    NVidia CK804, NVidia CK804
    Default Audio Device
front:CARD=CK804,DEV=0
    NVidia CK804, NVidia CK804
    Front speakers
surround40:CARD=CK804,DEV=0
    NVidia CK804, NVidia CK804
    4.0 Surround output to Front and Rear speakers
surround41:CARD=CK804,DEV=0
    NVidia CK804, NVidia CK804
    4.1 Surround output to Front, Rear and Subwoofer speakers
surround50:CARD=CK804,DEV=0
    NVidia CK804, NVidia CK804
    5.0 Surround output to Front, Center and Rear speakers
surround51:CARD=CK804,DEV=0
    NVidia CK804, NVidia CK804
    5.1 Surround output to Front, Center, Rear and Subwoofer speakers
surround71:CARD=CK804,DEV=0
    NVidia CK804, NVidia CK804
    7.1 Surround output to Front, Center, Side, Rear and Woofer speakers
iec958:CARD=CK804,DEV=0
    NVidia CK804, NVidia CK804 - IEC958
    IEC958 (S/PDIF) Digital Audio Output
optimator ~ # cat /proc/asound/
CK804/   card0/   cards    devices  modules  oss/     pcm      seq/     timers   version  
optimator ~ # cat /proc/asound/cads
cat: /proc/asound/cads: No such file or directory
optimator ~ # cat /proc/asound/cards
 0 [CK804          ]: NFORCE - NVidia CK804
                      NVidia CK804 with AD1981B at irq 22
optimator ~ # cat /proc/asound/devices
  2:        : timer
  3: [ 0- 2]: digital audio playback
  4: [ 0- 1]: digital audio capture
  5: [ 0- 0]: digital audio playback
  6: [ 0- 0]: digital audio capture
  7: [ 0]   : control
  8:        : sequencer
optimator ~ # cat /proc/asound/modules
 0 snd_intel8x0
optimator ~ # cat /proc/asound/oss/   
devices  sndstat  
optimator ~ # cat /proc/asound/oss/devices 
  0: [0- 0]: mixer
  1:       : sequencer
  3: [0- 0]: digital audio
  4: [0- 0]: digital audio
  8:       : sequencer
 12: [0- 1]: digital audio
optimator ~ # cat /proc/asound/CK804/      
codec97#0/ id         intel8x0   oss_mixer  pcm0c/     pcm0p/     pcm1c/     pcm2p/     
optimator ~ # cat /proc/asound/CK804/intel8x0 
Intel8x0

Global control        : 0x00000002
Global status         : 0x00700100
AC'97 codecs ready    : primary
optimator ~ # cat /proc/asound/CK804/oss_mixer 
VOLUME "Master" 0
BASS "" 0
TREBLE "" 0
SYNTH "" 0
PCM "PCM" 0
SPEAKER "" 0
LINE "Line" 0
MIC "Mic" 0
CD "CD" 0
IMIX "" 0
ALTPCM "" 0
RECLEV "" 0
IGAIN "Capture" 0
OGAIN "" 0
LINE1 "Aux" 0
LINE2 "" 0
LINE3 "" 0
DIGITAL1 "IEC958" 0
DIGITAL2 "" 0
DIGITAL3 "" 0
PHONEIN "Phone" 0
PHONEOUT "Master Mono" 0
VIDEO "Video" 0
RADIO "" 0
MONITOR "" 0
optimator ~ # alsamixer
optimator ~ # cat /proc/asound/card            
card0/ cards  
optimator ~ # cat /proc/asound/card0/
codec97#0/ id         intel8x0   oss_mixer  pcm0c/     pcm0p/     pcm1c/     pcm2p/     
optimator ~ # cat /proc/asound/card0/oss_mixer 
VOLUME "Master" 0
BASS "" 0
TREBLE "" 0
SYNTH "" 0
PCM "PCM" 0
SPEAKER "" 0
LINE "Line" 0
MIC "Mic" 0
CD "CD" 0
IMIX "" 0
ALTPCM "" 0
RECLEV "" 0
IGAIN "Capture" 0
OGAIN "" 0
LINE1 "Aux" 0
LINE2 "" 0
LINE3 "" 0
DIGITAL1 "IEC958" 0
DIGITAL2 "" 0
DIGITAL3 "" 0
PHONEIN "Phone" 0
PHONEOUT "Master Mono" 0
VIDEO "Video" 0
RADIO "" 0
MONITOR "" 0

optimator ~ # cat /var/lib/alsa/asound.state 
state.CK804 {
        control.1 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 2
                iface MIXER
                name 'Master Playback Switch'
                value.0 true
                value.1 true
        }
        control.2 {
                comment.access 'read write'
                comment.type INTEGER
                comment.count 2
                comment.range '0 - 31'
                comment.dbmin -4650
                comment.dbmax 0
                iface MIXER
                name 'Master Playback Volume'
                value.0 27
                value.1 27
        }
        control.5 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 1
                iface MIXER
                name 'Master Mono Playback Switch'
                value true
        }
        control.6 {
                comment.access 'read write'
                comment.type INTEGER
                comment.count 1
                comment.range '0 - 31'
                comment.dbmin -4650
                comment.dbmax 0
                iface MIXER
                name 'Master Mono Playback Volume'
                value 27
        }
        control.7 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 1
                iface MIXER
                name 'Phone Playback Switch'
                value false
        }
        control.8 {
                comment.access 'read write'
                comment.type INTEGER
                comment.count 1
                comment.range '0 - 31'
                comment.dbmin -3450
                comment.dbmax 1200
                iface MIXER
                name 'Phone Playback Volume'
                value 0
        }
        control.9 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 1
                iface MIXER
                name 'Mic Playback Switch'
                value false
        }
        control.10 {
                comment.access 'read write'
                comment.type INTEGER
                comment.count 1
                comment.range '0 - 31'
                comment.dbmin -3450
                comment.dbmax 1200
                iface MIXER
                name 'Mic Playback Volume'
                value 0
        }
        control.11 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 1
                iface MIXER
                name 'Mic Boost (+20dB)'
                value false
        }
        control.12 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 2
                iface MIXER
                name 'Line Playback Switch'
                value.0 false
                value.1 false
        }
        control.13 {
                comment.access 'read write'
                comment.type INTEGER
                comment.count 2
                comment.range '0 - 31'
                comment.dbmin -3450
                comment.dbmax 1200
                iface MIXER
                name 'Line Playback Volume'
                value.0 0
                value.1 0
        }
        control.14 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 2
                iface MIXER
                name 'CD Playback Switch'
                value.0 false
                value.1 false
        }
        control.15 {
                comment.access 'read write'
                comment.type INTEGER
                comment.count 2
                comment.range '0 - 31'
                comment.dbmin -3450
                comment.dbmax 1200
                iface MIXER
                name 'CD Playback Volume'
                value.0 0
                value.1 0
        }
        control.16 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 2
                iface MIXER
                name 'Aux Playback Switch'
                value.0 false
                value.1 false
        }
        control.17 {
                comment.access 'read write'
                comment.type INTEGER
                comment.count 2
                comment.range '0 - 31'
                comment.dbmin -3450
                comment.dbmax 1200
                iface MIXER
                name 'Aux Playback Volume'
                value.0 0
                value.1 0
        }
        control.18 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 2
                iface MIXER
                name 'PCM Playback Switch'
                value.0 true
                value.1 true
        }
        control.19 {
                comment.access 'read write'
                comment.type INTEGER
                comment.count 2
                comment.range '0 - 31'
                comment.dbmin -3450
                comment.dbmax 1200
                iface MIXER
                name 'PCM Playback Volume'
                value.0 27
                value.1 27
        }
        control.20 {
                comment.access 'read write'
                comment.type ENUMERATED
                comment.count 2
                comment.item.0 Mic
                comment.item.1 CD
                comment.item.2 Video
                comment.item.3 Aux
                comment.item.4 Line
                comment.item.5 Mix
                comment.item.6 'Mix Mono'
                comment.item.7 Phone
                iface MIXER
                name 'Capture Source'
                value.0 Mic
                value.1 Mic
        }
        control.21 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 2
                iface MIXER
                name 'Capture Switch'
                value.0 true
                value.1 true
        }
        control.22 {
                comment.access 'read write'
                comment.type INTEGER
                comment.count 2
                comment.range '0 - 15'
                comment.dbmin 0
                comment.dbmax 2250
                iface MIXER
                name 'Capture Volume'
                value.0 0
                value.1 0
        }
        control.23 {
                comment.access 'read write'
                comment.type ENUMERATED
                comment.count 1
                comment.item.0 Mix
                comment.item.1 Mic
                iface MIXER
                name 'Mono Output Select'
                value Mix
        }
        control.24 {
                comment.access 'read write'
                comment.type ENUMERATED
                comment.count 1
                comment.item.0 Mic1
                comment.item.1 Mic2
                iface MIXER
                name 'Mic Select'
                value Mic1
        }
        control.25 {
                comment.access read
                comment.type IEC958
                comment.count 1
                iface MIXER
                name 'IEC958 Playback Con Mask'
                value '0fff000f00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000'
        }
        control.26 {
                comment.access read
                comment.type IEC958
                comment.count 1
                iface MIXER
                name 'IEC958 Playback Pro Mask'
                value cf00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
        }
        control.27 {
                comment.access 'read write'
                comment.type IEC958
                comment.count 1
                iface MIXER
                name 'IEC958 Playback Default'
                value '0082000200000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000'
        }
        control.28 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 1
                iface MIXER
                name 'IEC958 Playback Switch'
                value false
        }
        control.29 {
                comment.access 'read write'
                comment.type INTEGER
                comment.count 1
                comment.range '0 - 3'
                iface MIXER
                name 'IEC958 Playback AC97-SPSA'
                value 1
        }
        control.30 {
                comment.access 'read write'
                comment.type ENUMERATED
                comment.count 1
                comment.item.0 AC-Link
                comment.item.1 'A/D Converter'
                iface MIXER
                name 'IEC958 Playback Source'
                value 'A/D Converter'
        }
        control.31 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 1
                iface MIXER
                name 'Stereo Mic'
                value false
        }
        control.32 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 1
                iface MIXER
                name 'Headphone Jack Sense'
                value false
        }
        control.33 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 1
                iface MIXER
                name 'Line Jack Sense'
                value false
        }
        control.34 {
                comment.access 'read write'
                comment.type BOOLEAN
                comment.count 1
                iface MIXER
                name 'External Amplifier'
                value false
        }
}


Not sure what's up with the zero values for volumes in /proc/asound/card0/oss_mixer, because when I go into alsamixer, I have unmuted and raised volumes for Master, Master Mono, PCM, and muted Line jack sense, headphones, stereo mic, and External Amplifier.

I don't think it is a volume issue because when I try to play any file, the system just locks up and won't play the file.  (need hard ^C's to get out of madplay, mplayer, etc).  

I've also tried mplayer with -ao alsa, and -ao oss.  Both with the same result.
Comment 2 Jacob Martin 2010-11-30 05:31:27 UTC
More information about modules:

optimator Classical $ lsmod |grep snd
snd_intel8x0           24034  3 
snd_ac97_codec         99435  1 snd_intel8x0
ac97_bus                1078  1 snd_ac97_codec
snd_seq_oss            22940  0 
snd_seq_midi_event      4684  1 snd_seq_oss
snd_seq                40701  4 snd_seq_oss,snd_seq_midi_event
snd_seq_device          4533  2 snd_seq_oss,snd_seq
snd_pcm_oss            31651  0 
snd_mixer_oss          12315  1 snd_pcm_oss
snd_pcm                60739  3 snd_intel8x0,snd_ac97_codec,snd_pcm_oss
snd_timer              15653  2 snd_seq,snd_pcm
snd                    44706  15 snd_intel8x0,snd_ac97_codec,snd_seq_oss,snd_seq,snd_seq_device,snd_pcm_oss,snd_mixer_oss,snd_pcm,snd_timer
soundcore               4607  1 snd
snd_page_alloc          6001  2 snd_intel8x0,snd_pcm
Comment 3 Jacob Martin 2010-11-30 05:46:01 UTC
Last but not least, here's the alsa.conf.  Thanks for any help!


optimator ~ # cat /etc/modprobe.d/alsa.conf 
# Alsa kernel modules' configuration file.

# ALSA portion
# OSS/Free portion

##
## IMPORTANT:
## You need to customise this section for your specific sound card(s)
## and then run `update-modules' command.
## Read alsa-driver's INSTALL file in /usr/share/doc for more info.
##
##  ALSA portion
## alias snd-card-0 snd-interwave
## alias snd-card-1 snd-ens1371
##  OSS/Free portion
## alias sound-slot-0 snd-card-0
## alias sound-slot-1 snd-card-1
##

# OSS/Free portion - card #1
##  OSS/Free portion - card #2
## alias sound-service-1-0 snd-mixer-oss
## alias sound-service-1-3 snd-pcm-oss
## alias sound-service-1-12 snd-pcm-oss

alias /dev/mixer snd-mixer-oss
alias /dev/dsp snd-pcm-oss
alias /dev/midi snd-seq-oss

# Set this to the correct number of cards.

# --- BEGIN: Generated by ALSACONF, do not edit. ---
# --- ALSACONF version 1.0.23 ---
alias snd-card-0 snd-intel8x0
alias sound-slot-0 snd-intel8x0
# --- END: Generated by ALSACONF, do not edit. ---
Comment 4 Jacob Martin 2010-11-30 07:09:18 UTC
Here is the verbose output while trying to use mplayer to play an mp3 as root:

It just hangs on the last line...


optimator Classical # mplayer -v Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3 
MPlayer SVN-r29796-4.4.4 (C) 2000-2009 MPlayer Team
CPU vendor name: AuthenticAMD  max cpuid level: 1
CPU: Dual Core AMD Opteron(tm) Processor 275 (Family: 15, Model: 33, Stepping: 2)
extended cpuid-level: 24
extended cache-info: 67141952
Detected cache-line size is 64 bytes
CPUflags:  MMX: 1 MMX2: 1 3DNow: 1 3DNowExt: 1 SSE: 1 SSE2: 1 SSSE3: 0
Compiled with runtime CPU detection.
get_path('codecs.conf') -> '/root/.mplayer/codecs.conf'
Reading /root/.mplayer/codecs.conf: Can't open '/root/.mplayer/codecs.conf': No such file or directory
Reading /etc/mplayer/codecs.conf: Can't open '/etc/mplayer/codecs.conf': No such file or directory
Using built-in default codecs.conf.
Configuration: --cc=x86_64-pc-linux-gnu-gcc --host-cc=x86_64-pc-linux-gnu-gcc --prefix=/usr --confdir=/etc/mplayer --datadir=/usr/share/mplayer --libdir=/usr/lib64 --enable-network --disable-arts --disable-fribidi --enable-bl --disable-ftp --disable-lirc --disable-lircc --disable-apple-ir --disable-libnut --disable-svga --disable-svgalib_helper --disable-joystick --disable-cdparanoia --charset=UTF-8 --disable-tv-bsdbt848 --disable-ivtv --disable-pvr --disable-tv-v4l2 --disable-tv-teletext --disable-radio-v4l2 --disable-radio-bsdbt848 --disable-liba52 --disable-musepack --disable-libopencore_amrnb --disable-libopencore_amrwb --xanimcodecsdir=/usr/lib/xanim/mods --disable-libbs2b --disable-pnm --disable-tga --realcodecsdir=/usr/lib64/codecs --disable-md5sum --disable-aa --disable-fbdev --disable-caca --disable-zr --disable-gui --disable-dga1 --disable-dga2 --disable-dxr3 --disable-ggi --enable-menu --disable-vdpau --disable-vidix --disable-vidix-pcidb --disable-xvmc --disable-3dfx --disable-tdfxvid --disable-tdfxfb --disable-esd --disable-jack --disable-openal --disable-pulse --enable-runtime-cpudetection
CommandLine: '-v' 'Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3'
init_freetype
Using MMX (with tiny bit MMX2) Optimized OnScreenDisplay
get_path('fonts') -> '/root/.mplayer/fonts'
Using nanosleep() timing
get_path('input.conf') -> '/root/.mplayer/input.conf'
Can't open input config file /root/.mplayer/input.conf: No such file or directory
Parsing input config file /etc/mplayer/input.conf
Input config file /etc/mplayer/input.conf parsed: 90 binds
get_path('Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3.conf') -> '/root/.mplayer/Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3.conf'

Playing Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3.
get_path('sub/') -> '/root/.mplayer/sub/'
[file] File size is 61384619 bytes
STREAM: [file] Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3
STREAM: Description: File
STREAM: Author: Albeu
STREAM: Comment: based on the code from ??? (probably Arpi)
LAVF_check: MPEG audio layer 2/3
Checking for YUV4MPEG2
ASF_check: not ASF guid!
Checking for REAL
Checking for SMJPEG
Searching demuxer type for filename Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3 ext: .mp3
Trying demuxer 17 based on filename extension
==> Found audio stream: 0
demux_audio: seeking from 0x3A8A72E to start pos 0x0
demux_audio: audio data 0x0 - 0x3A8A7AB  
Audio only file format detected.
get_path('sub/') -> '/root/.mplayer/sub/'
==========================================================================
Opening audio decoder: [mp3lib] MPEG layer-2, layer-3
dec_audio: Allocating 4608 + 65536 = 70144 bytes for output buffer.
mp3lib: using SSE optimized decore!
MP3lib: init layer2&3 finished, tables done
MPEG 1.0, Layer III, 44100 Hz 320 kbit Joint-Stereo, BPF: 1044
Channels: 2, copyright: No, original: Yes, CRC: No, emphasis: 0
AUDIO: 44100 Hz, 2 ch, s16le, 320.0 kbit/22.68% (ratio: 40000->176400)
Selected audio codec: [mp3] afm: mp3lib (mp3lib MPEG layer-2, layer-3)
==========================================================================
Building audio filter chain for 44100Hz/2ch/s16le -> 0Hz/0ch/??...
[libaf] Adding filter dummy 
[dummy] Was reinitialized: 44100Hz/2ch/s16le
[dummy] Was reinitialized: 44100Hz/2ch/s16le
Trying every known audio driver...
ao2: 44100 Hz  2 chans  s16le
audio_setup: using '/dev/dsp' dsp device
audio_setup: using '/dev/mixer' mixer device
audio_setup: using 'pcm' mixer device
[AO OSS] audio_setup: Can't open audio device /dev/dsp: Device or resource busy
alsa-init: requested format: 44100 Hz, 2 channels, 9
alsa-init: using ALSA 1.0.23
alsa-init: setup for 1/2 channel(s)
alsa-init: using device default
alsa-init: pcm opened in blocking mode
alsa-init: got buffersize=65536
alsa-init: got period size 1024
alsa: 48000 Hz/2 channels/4 bpf/65536 bytes buffer/Signed 16 bit Little Endian
AO: [alsa] 48000Hz 2ch s16le (2 bytes per sample)
AO: Description: ALSA-0.9.x-1.x audio output
AO: Author: Alex Beregszaszi, Zsolt Barat <joy@streamminister.de>
AO: Comment: under developement
Building audio filter chain for 44100Hz/2ch/s16le -> 48000Hz/2ch/s16le...
[dummy] Was reinitialized: 44100Hz/2ch/s16le
[libaf] Adding filter lavcresample 
[dummy] Was reinitialized: 48000Hz/2ch/s16le
[dummy] Was reinitialized: 48000Hz/2ch/s16le
Video: no video
Freeing 0 unused video chunks.
Starting playback...
[libaf] Reallocating memory in module lavcresample, old len = 0, new len = 67714
Increasing filtered audio buffer size from 0 to 67672
A:   0.0 (00.0) of 1534.0 (25:34.0) ??,?% 
Comment 5 Jacob Martin 2010-11-30 07:13:13 UTC
Sorry for all the background data, Comment #4 had a spurious error because chromium was hogging the sound card (must be some OSS/ALSA multi sound thread problem?).  Here's the new output with no resource contention:

optimator Classical # mplayer -v Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3 
MPlayer SVN-r29796-4.4.4 (C) 2000-2009 MPlayer Team
CPU vendor name: AuthenticAMD  max cpuid level: 1
CPU: Dual Core AMD Opteron(tm) Processor 275 (Family: 15, Model: 33, Stepping: 2)
extended cpuid-level: 24
extended cache-info: 67141952
Detected cache-line size is 64 bytes
CPUflags:  MMX: 1 MMX2: 1 3DNow: 1 3DNowExt: 1 SSE: 1 SSE2: 1 SSSE3: 0
Compiled with runtime CPU detection.
get_path('codecs.conf') -> '/root/.mplayer/codecs.conf'
Reading /root/.mplayer/codecs.conf: Can't open '/root/.mplayer/codecs.conf': No such file or directory
Reading /etc/mplayer/codecs.conf: Can't open '/etc/mplayer/codecs.conf': No such file or directory
Using built-in default codecs.conf.
Configuration: --cc=x86_64-pc-linux-gnu-gcc --host-cc=x86_64-pc-linux-gnu-gcc --prefix=/usr --confdir=/etc/mplayer --datadir=/usr/share/mplayer --libdir=/usr/lib64 --enable-network --disable-arts --disable-fribidi --enable-bl --disable-ftp --disable-lirc --disable-lircc --disable-apple-ir --disable-libnut --disable-svga --disable-svgalib_helper --disable-joystick --disable-cdparanoia --charset=UTF-8 --disable-tv-bsdbt848 --disable-ivtv --disable-pvr --disable-tv-v4l2 --disable-tv-teletext --disable-radio-v4l2 --disable-radio-bsdbt848 --disable-liba52 --disable-musepack --disable-libopencore_amrnb --disable-libopencore_amrwb --xanimcodecsdir=/usr/lib/xanim/mods --disable-libbs2b --disable-pnm --disable-tga --realcodecsdir=/usr/lib64/codecs --disable-md5sum --disable-aa --disable-fbdev --disable-caca --disable-zr --disable-gui --disable-dga1 --disable-dga2 --disable-dxr3 --disable-ggi --enable-menu --disable-vdpau --disable-vidix --disable-vidix-pcidb --disable-xvmc --disable-3dfx --disable-tdfxvid --disable-tdfxfb --disable-esd --disable-jack --disable-openal --disable-pulse --enable-runtime-cpudetection
CommandLine: '-v' 'Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3'
init_freetype
Using MMX (with tiny bit MMX2) Optimized OnScreenDisplay
get_path('fonts') -> '/root/.mplayer/fonts'
Using nanosleep() timing
get_path('input.conf') -> '/root/.mplayer/input.conf'
Can't open input config file /root/.mplayer/input.conf: No such file or directory
Parsing input config file /etc/mplayer/input.conf
Input config file /etc/mplayer/input.conf parsed: 90 binds
get_path('Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3.conf') -> '/root/.mplayer/Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3.conf'

Playing Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3.
get_path('sub/') -> '/root/.mplayer/sub/'
[file] File size is 61384619 bytes
STREAM: [file] Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3
STREAM: Description: File
STREAM: Author: Albeu
STREAM: Comment: based on the code from ??? (probably Arpi)
LAVF_check: MPEG audio layer 2/3
Checking for YUV4MPEG2
ASF_check: not ASF guid!
Checking for REAL
Checking for SMJPEG
Searching demuxer type for filename Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3 ext: .mp3
Trying demuxer 17 based on filename extension
==> Found audio stream: 0
demux_audio: seeking from 0x3A8A72E to start pos 0x0
demux_audio: audio data 0x0 - 0x3A8A7AB  
Audio only file format detected.
get_path('sub/') -> '/root/.mplayer/sub/'
==========================================================================
Opening audio decoder: [mp3lib] MPEG layer-2, layer-3
dec_audio: Allocating 4608 + 65536 = 70144 bytes for output buffer.
mp3lib: using SSE optimized decore!
MP3lib: init layer2&3 finished, tables done
MPEG 1.0, Layer III, 44100 Hz 320 kbit Joint-Stereo, BPF: 1044
Channels: 2, copyright: No, original: Yes, CRC: No, emphasis: 0
AUDIO: 44100 Hz, 2 ch, s16le, 320.0 kbit/22.68% (ratio: 40000->176400)
Selected audio codec: [mp3] afm: mp3lib (mp3lib MPEG layer-2, layer-3)
==========================================================================
Building audio filter chain for 44100Hz/2ch/s16le -> 0Hz/0ch/??...
[libaf] Adding filter dummy 
[dummy] Was reinitialized: 44100Hz/2ch/s16le
[dummy] Was reinitialized: 44100Hz/2ch/s16le
Trying every known audio driver...
ao2: 44100 Hz  2 chans  s16le
audio_setup: using '/dev/dsp' dsp device
audio_setup: using '/dev/mixer' mixer device
audio_setup: using 'pcm' mixer device
audio_setup: sample format: s16le (requested: s16le)
audio_setup: using 2 channels (requested: 2)
audio_setup: using 44100 Hz samplerate (requested: 44100)
audio_setup: frags:  16/16  (4096 bytes/frag)  free:  65536
AO: [oss] 44100Hz 2ch s16le (2 bytes per sample)
AO: Description: OSS/ioctl audio output
AO: Author: A'rpi
Building audio filter chain for 44100Hz/2ch/s16le -> 44100Hz/2ch/s16le...
[dummy] Was reinitialized: 44100Hz/2ch/s16le
[dummy] Was reinitialized: 44100Hz/2ch/s16le
Video: no video
Freeing 0 unused video chunks.
Starting playback...
Increasing filtered audio buffer size from 0 to 65536
A:   0.0 (00.0) of 1534.0 (25:34.0) ??,?% 

MPlayer interrupted by signal 2 in module: play_audio


MPlayer interrupted by signal 2 in module: play_audio
^C^C^C^C^Coptimator Classical # 

Comment 6 Jacob Martin 2010-11-30 07:14:34 UTC
Same effect when using "mplayer -ao alsa -v..."


optimator Classical # mplayer -ao alsa -v Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3 
MPlayer SVN-r29796-4.4.4 (C) 2000-2009 MPlayer Team
CPU vendor name: AuthenticAMD  max cpuid level: 1
CPU: Dual Core AMD Opteron(tm) Processor 275 (Family: 15, Model: 33, Stepping: 2)
extended cpuid-level: 24
extended cache-info: 67141952
Detected cache-line size is 64 bytes
CPUflags:  MMX: 1 MMX2: 1 3DNow: 1 3DNowExt: 1 SSE: 1 SSE2: 1 SSSE3: 0
Compiled with runtime CPU detection.
get_path('codecs.conf') -> '/root/.mplayer/codecs.conf'
Reading /root/.mplayer/codecs.conf: Can't open '/root/.mplayer/codecs.conf': No such file or directory
Reading /etc/mplayer/codecs.conf: Can't open '/etc/mplayer/codecs.conf': No such file or directory
Using built-in default codecs.conf.
Configuration: --cc=x86_64-pc-linux-gnu-gcc --host-cc=x86_64-pc-linux-gnu-gcc --prefix=/usr --confdir=/etc/mplayer --datadir=/usr/share/mplayer --libdir=/usr/lib64 --enable-network --disable-arts --disable-fribidi --enable-bl --disable-ftp --disable-lirc --disable-lircc --disable-apple-ir --disable-libnut --disable-svga --disable-svgalib_helper --disable-joystick --disable-cdparanoia --charset=UTF-8 --disable-tv-bsdbt848 --disable-ivtv --disable-pvr --disable-tv-v4l2 --disable-tv-teletext --disable-radio-v4l2 --disable-radio-bsdbt848 --disable-liba52 --disable-musepack --disable-libopencore_amrnb --disable-libopencore_amrwb --xanimcodecsdir=/usr/lib/xanim/mods --disable-libbs2b --disable-pnm --disable-tga --realcodecsdir=/usr/lib64/codecs --disable-md5sum --disable-aa --disable-fbdev --disable-caca --disable-zr --disable-gui --disable-dga1 --disable-dga2 --disable-dxr3 --disable-ggi --enable-menu --disable-vdpau --disable-vidix --disable-vidix-pcidb --disable-xvmc --disable-3dfx --disable-tdfxvid --disable-tdfxfb --disable-esd --disable-jack --disable-openal --disable-pulse --enable-runtime-cpudetection
CommandLine: '-ao' 'alsa' '-v' 'Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3'
init_freetype
Using MMX (with tiny bit MMX2) Optimized OnScreenDisplay
get_path('fonts') -> '/root/.mplayer/fonts'
Using nanosleep() timing
get_path('input.conf') -> '/root/.mplayer/input.conf'
Can't open input config file /root/.mplayer/input.conf: No such file or directory
Parsing input config file /etc/mplayer/input.conf
Input config file /etc/mplayer/input.conf parsed: 90 binds
get_path('Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3.conf') -> '/root/.mplayer/Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3.conf'

Playing Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3.
get_path('sub/') -> '/root/.mplayer/sub/'
[file] File size is 61384619 bytes
STREAM: [file] Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3
STREAM: Description: File
STREAM: Author: Albeu
STREAM: Comment: based on the code from ??? (probably Arpi)
LAVF_check: MPEG audio layer 2/3
Checking for YUV4MPEG2
ASF_check: not ASF guid!
Checking for REAL
Checking for SMJPEG
Searching demuxer type for filename Ludwig_van_Beethoven_-_Complete_Symphonies_Disc_5_-_04_-_Symphony_No_9_in_D_Minor_Op_125_Choral_Presto-Allegro.mp3 ext: .mp3
Trying demuxer 17 based on filename extension
==> Found audio stream: 0
demux_audio: seeking from 0x3A8A72E to start pos 0x0
demux_audio: audio data 0x0 - 0x3A8A7AB  
Audio only file format detected.
get_path('sub/') -> '/root/.mplayer/sub/'
==========================================================================
Opening audio decoder: [mp3lib] MPEG layer-2, layer-3
dec_audio: Allocating 4608 + 65536 = 70144 bytes for output buffer.
mp3lib: using SSE optimized decore!
MP3lib: init layer2&3 finished, tables done
MPEG 1.0, Layer III, 44100 Hz 320 kbit Joint-Stereo, BPF: 1044
Channels: 2, copyright: No, original: Yes, CRC: No, emphasis: 0
AUDIO: 44100 Hz, 2 ch, s16le, 320.0 kbit/22.68% (ratio: 40000->176400)
Selected audio codec: [mp3] afm: mp3lib (mp3lib MPEG layer-2, layer-3)
==========================================================================
Building audio filter chain for 44100Hz/2ch/s16le -> 0Hz/0ch/??...
[libaf] Adding filter dummy 
[dummy] Was reinitialized: 44100Hz/2ch/s16le
[dummy] Was reinitialized: 44100Hz/2ch/s16le
Trying preferred audio driver 'alsa', options '[none]'
alsa-init: requested format: 44100 Hz, 2 channels, 9
alsa-init: using ALSA 1.0.23
alsa-init: setup for 1/2 channel(s)
alsa-init: using device default
alsa-init: pcm opened in blocking mode
alsa-init: got buffersize=65536
alsa-init: got period size 1024
alsa: 48000 Hz/2 channels/4 bpf/65536 bytes buffer/Signed 16 bit Little Endian
AO: [alsa] 48000Hz 2ch s16le (2 bytes per sample)
AO: Description: ALSA-0.9.x-1.x audio output
AO: Author: Alex Beregszaszi, Zsolt Barat <joy@streamminister.de>
AO: Comment: under developement
Building audio filter chain for 44100Hz/2ch/s16le -> 48000Hz/2ch/s16le...
[dummy] Was reinitialized: 44100Hz/2ch/s16le
[libaf] Adding filter lavcresample 
[dummy] Was reinitialized: 48000Hz/2ch/s16le
[dummy] Was reinitialized: 48000Hz/2ch/s16le
Video: no video
Freeing 0 unused video chunks.
Starting playback...
[libaf] Reallocating memory in module lavcresample, old len = 0, new len = 67714
Increasing filtered audio buffer size from 0 to 67672
A:   0.0 (00.0) of 1534.0 (25:34.0) ??,?% 

MPlayer interrupted by signal 2 in module: play_audio


MPlayer interrupted by signal 2 in module: play_audio
Comment 7 Jacob Martin 2010-11-30 18:22:42 UTC
Ok, so this is weird.  I've rebooted now, and now the sound works.  

I did remove +oss from use flags and did some recompiling with emerge --newuse world.  Then I rebooted.

I can't explain it, but the errors on loading the module are no longer there.  I'll leave the bug open for now, but something is definitely fishy.

Here are the last 1000 packages I installed.  The ones after the last Sync are recompiled without oss.  Was oss the culprit?

optimator Classical $ sudo tail -n 1000 /var/log/emerge.log  |grep completed
1290979036:  ::: completed emerge (6 of 52) net-wireless/bluez-4.75 to /
1290979178:  ::: completed emerge (7 of 52) dev-tex/luatex-0.63.0 to /
1290981036:  ::: completed emerge (1 of 63) x11-libs/cairo-1.8.10 to /
1290981199:  ::: completed emerge (2 of 63) dev-libs/libgweather-2.30.2 to /
1290981244:  ::: completed emerge (3 of 63) gnome-base/gnome-desktop-2.30.2 to /
1290981268:  ::: completed emerge (4 of 63) app-text/gtkspell-2.0.16 to /
1290981302:  ::: completed emerge (5 of 63) dev-libs/rasqal-0.9.19 to /
1290981403:  ::: completed emerge (6 of 63) gnome-base/gnome-keyring-2.30.3 to /
1290981466:  ::: completed emerge (7 of 63) gnome-extra/gtkhtml-3.30.2 to /
1290981514:  ::: completed emerge (8 of 63) media-gfx/gtkimageview-1.6.4 to /
1290981549:  ::: completed emerge (9 of 63) media-libs/libiec61883-1.1.0 to /
1290981577:  ::: completed emerge (10 of 63) sys-libs/libavc1394-0.5.3 to /
1290981610:  ::: completed emerge (11 of 63) app-text/aiksaurus-1.2.1 to /
1290987377:  ::: completed emerge (1 of 51) media-libs/libdvdplay-1.0.1 to /
1290987388:  ::: completed emerge (2 of 51) media-video/dvdbackup-0.1.1-r2 to /
1290987408:  ::: completed emerge (3 of 51) media-gfx/xloadimage-4.1-r10 to /
1290987437:  ::: completed emerge (4 of 51) media-plugins/gst-plugins-mad-0.10.13 to /
1290987472:  ::: completed emerge (5 of 51) dev-db/libdbi-drivers-0.8.3 to /
1290987612:  ::: completed emerge (6 of 51) net-libs/libwww-5.4.0-r7 to /
1290987646:  ::: completed emerge (7 of 51) x11-libs/libnotify-0.4.5 to /
1290987683:  ::: completed emerge (8 of 51) media-gfx/xsane-0.996 to /
1290987769:  ::: completed emerge (9 of 51) dev-libs/redland-1.0.10-r2 to /
1290987884:  ::: completed emerge (10 of 51) dev-libs/cyrus-sasl-2.1.23-r1 to /
1290988478:  ::: completed emerge (1 of 40) kde-base/arts-3.5.10 to /
1290988508:  ::: completed emerge (2 of 40) media-libs/libprojectm-1.2.0 to /
1290988650:  ::: completed emerge (3 of 40) gnome-base/gnome-settings-daemon-2.30.2-r1 to /
1290988704:  ::: completed emerge (4 of 40) x11-libs/libgksu-2.0.12-r1 to /
1290988793:  ::: completed emerge (5 of 40) x11-libs/pango-1.28.1 to /
1290988823:  ::: completed emerge (6 of 40) dev-dotnet/libgdiplus-2.6.7-r1 to /
1290988860:  ::: completed emerge (7 of 40) gnome-base/libgnomecanvas-2.30.1 to /
1290988917:  ::: completed emerge (8 of 40) net-analyzer/rrdtool-1.3.8 to /
1290988958:  ::: completed emerge (9 of 40) x11-misc/notification-daemon-0.4.0-r1 to /
1290989254:  ::: completed emerge (1 of 30) gnome-extra/libgda-4.1.4-r1 to /
1290989502:  ::: completed emerge (2 of 30) app-office/dia-0.97.1 to /
1290989549:  ::: completed emerge (3 of 30) net-libs/libproxy-0.2.3-r3 to /
1290989828:  ::: completed emerge (4 of 30) gnome-extra/evolution-data-server-2.30.2 to /
1290989872:  ::: completed emerge (5 of 30) gnome-base/gnome-mount-0.8-r1 to /
1290990033:  ::: completed emerge (6 of 30) app-text/evince-2.30.3 to /
1290992971:  ::: completed emerge (1 of 23) app-office/abiword-2.8.6 to /
1290993132:  ::: completed emerge (2 of 23) gnome-base/gnome-panel-2.30.2 to /
1290995241:  ::: completed emerge (3 of 23) mail-client/thunderbird-3.1.6 to /
1290995417:  ::: completed emerge (4 of 23) x11-plugins/enigmail-1.1.2-r2 to /
1290995649:  ::: completed emerge (5 of 23) media-gfx/imagemagick-6.6.5.6 to /
1290995669:  ::: completed emerge (6 of 23) media-video/dvdauthor-0.6.14 to /
1290996326:  ::: completed emerge (7 of 23) media-gfx/inkscape-0.48.0 to /
1290996389:  ::: completed emerge (8 of 23) media-libs/libsdl-1.2.13-r1 to /
1290996441:  ::: completed emerge (9 of 23) media-libs/smpeg-0.4.4-r9 to /
1290996461:  ::: completed emerge (10 of 23) media-libs/sdl-image-1.2.10-r1 to /
1290996481:  ::: completed emerge (11 of 23) media-libs/sdl-mixer-1.2.11-r1 to /
1290996510:  ::: completed emerge (12 of 23) media-sound/mpg123-1.12.1 to /
1290996951:  ::: completed emerge (13 of 23) media-video/avidemux-2.5.1_p5428 to /
1290997085:  ::: completed emerge (14 of 23) media-libs/xine-lib-1.1.18.1 to /
1290997168:  ::: completed emerge (15 of 23) media-libs/libquicktime-1.1.5 to /
1290997218:  ::: completed emerge (16 of 23) media-sound/sox-14.3.0 to /
1290997389:  ::: completed emerge (17 of 23) media-video/mplayer-1.0_rc4_p20091026-r1 to /
1290997419:  ::: completed emerge (18 of 23) media-libs/sdl-sound-1.0.3 to /
1290997515:  ::: completed emerge (19 of 23) media-video/mjpegtools-1.9.0-r1 to /
1290997591:  ::: completed emerge (20 of 23) media-video/kino-1.3.3 to /
1290998783:  ::: completed emerge (1 of 2) sci-mathematics/octave-3.2.4-r1 to /
1291049152: === Sync completed with rsync://88.198.83.250/gentoo-portage
1291050899:  ::: completed emerge (1 of 46) dev-lang/perl-5.12.2-r4 to /
1291050959:  ::: completed emerge (2 of 46) sys-devel/libtool-2.4-r1 to /
1291051045:  ::: completed emerge (3 of 46) dev-libs/soprano-2.5.2 to /
1291051130:  ::: completed emerge (4 of 46) sci-visualization/gnuplot-4.4.2 to /
1291051151:  ::: completed emerge (5 of 46) sys-apps/attr-2.4.44 to /
1291086941:  ::: completed emerge (1 of 1) x11-drivers/nvidia-drivers-260.19.21 to /
1291087506:  ::: completed emerge (1 of 1) media-sound/alsa-utils-1.0.23-r1 to /
1291088350:  ::: completed emerge (1 of 5) media-libs/jpeg-6b-r9 to /
1291088414:  ::: completed emerge (2 of 5) media-libs/alsa-lib-1.0.23 to /
1291088460:  ::: completed emerge (3 of 5) media-sound/madplay-0.15.2b-r1 to /
1291088636:  ::: completed emerge (4 of 5) media-video/mplayer-1.0_rc4_p20091026-r1 to /
1291088668:  ::: completed emerge (5 of 5) media-sound/alsa-utils-1.0.23-r1 to /
1291088779:  ::: completed emerge (1 of 10) media-libs/jpeg-6b-r9 to /
1291088808:  ::: completed emerge (2 of 10) media-sound/mpg123-1.12.1 to /
1291088865:  ::: completed emerge (3 of 10) media-libs/flac-1.2.1-r3 to /
1291088904:  ::: completed emerge (4 of 10) gnome-extra/gconf-editor-2.30.0 to /
1291089056:  ::: completed emerge (1 of 5) media-libs/mesa-7.8.2 to /
1291089507:  ::: completed emerge (2 of 5) media-video/avidemux-2.5.1_p5428 to /
1291089634:  ::: completed emerge (3 of 5) media-plugins/audacious-plugins-2.4.0 to /
1291089748:  ::: completed emerge (4 of 5) media-video/transcode-1.1.5-r2 to /
1291089888:  ::: completed emerge (5 of 5) app-editors/kile-2.1_beta4 to /
1291090330:  ::: completed emerge (1 of 1) media-libs/libsdl-1.2.13-r1 to /
1291097107: === Sync completed with rsync://134.68.240.58/gentoo-portage
1291101370:  ::: completed emerge (1 of 8) media-libs/jpeg-6b-r9 to /
1291102692:  ::: completed emerge (1 of 6) media-libs/libsdl-1.2.13-r1 to /
1291102722:  ::: completed emerge (2 of 6) media-sound/mpg123-1.12.1 to /
1291103169:  ::: completed emerge (3 of 6) media-video/avidemux-2.5.1_p5428 to /
1291103292:  ::: completed emerge (4 of 6) media-plugins/audacious-plugins-2.4.0 to /
1291103474:  ::: completed emerge (5 of 6) media-video/mplayer-1.0_rc4_p20091026-r1 to /
1291103595:  ::: completed emerge (6 of 6) media-video/transcode-1.1.5-r2 to /
1291103877:  ::: completed emerge (1 of 1) sys-libs/libavc1394-0.5.3 to 
Comment 8 Jeroen Roovers (RETIRED) gentoo-dev 2010-12-15 01:08:36 UTC
There was a problem and it solved itself. You cannot now figure out what caused the problem and the information you need to figure it out is already lost.
Comment 9 Jacob Martin 2011-01-20 03:46:38 UTC
I'm getting the error again.  Perhaps it is a random event, but I'll try to reboot and see if it remains broken.

No apps can play sound (even the progress bar does not move), even though volume levels are adjusted properly and unmuted in alsamixer and alsa loads with no errors.

Jan 19 22:40:47 localhost su[6706]: Successful su for root by martin
Jan 19 22:40:47 localhost su[6706]: + /dev/pts/3 martin:root
Jan 19 22:40:47 localhost su[6706]: pam_unix(su:session): session opened for user root by martin(uid=1000)
Jan 19 22:41:28 localhost kernel: Intel ICH 0000:00:04.0: PCI INT A disabled
Jan 19 22:41:30 localhost kernel: Intel ICH 0000:00:04.0: PCI INT A -> Link[LACI] -> GSI 22 (level, high) -> IRQ 22
Jan 19 22:41:30 localhost kernel: Intel ICH 0000:00:04.0: setting latency timer to 64
Jan 19 22:41:30 localhost kernel: intel8x0_measure_ac97_clock: measured 50798 usecs (64 samples)
Jan 19 22:41:30 localhost kernel: intel8x0: measured clock 1259 rejected
Jan 19 22:41:31 localhost kernel: intel8x0: measure - unreliable DMA position..
Jan 19 22:41:31 localhost kernel: intel8x0: measure - unreliable DMA position..
Jan 19 22:41:31 localhost kernel: intel8x0: clocking to 48000
Comment 10 Jacob Martin 2011-01-20 04:46:07 UTC
Rebooted once, same problem as before.

Rebooted again, problem went away, DMA position messages missing from boot log.

Interrupt 22 is shared by sata_nv, NVidia CK804

Comment 11 Jacob Martin 2011-01-25 22:51:50 UTC
I just had to reboot 5 times.  On the fifth time, the module was loaded properly and I receive the following messages (when sound works):

ACPI: PCI Interrupt Link [LACI] enabled at IRQ 22
Intel ICH 0000:00:04.0: PCI INT A -> Link[LACI] -> GSI 22 (level, high) -> IRQ 22
Intel ICH 0000:00:04.0: setting latency timer to 64

Four out of five times it didn't work and instead fails with:
Jan 25 10:28:43 localhost kernel: ACPI: PCI Interrupt Link [LACI] enabled at IRQ 22
Jan 25 10:28:43 localhost kernel: Intel ICH 0000:00:04.0: PCI INT A -> Link[LACI] -> GSI 22 (level, high) -> IRQ 22
Jan 25 10:28:43 localhost kernel: Intel ICH 0000:00:04.0: setting latency timer to 64
Jan 25 10:28:43 localhost kernel: nvidia: module license 'NVIDIA' taints kernel.
Jan 25 10:28:43 localhost kernel: Disabling lock debugging due to kernel taint
Jan 25 10:28:43 localhost kernel: usb 2-3: new low speed USB device using ohci_hcd and address 3
Jan 25 10:28:43 localhost kernel: input: Dynex 5-Button Wired Optical Mouse as /devices/pci0000:00/0000:00:02.0/usb2/2-3/2-3:1.0/input/input4
Jan 25 10:28:43 localhost kernel: generic-usb 0003:0461:4D42.0003: input: USB HID v1.11 Mouse [Dynex 5-Button Wired Optical Mouse] on usb-0000:00:02.0-3/input0
Jan 25 10:28:43 localhost kernel: intel8x0_measure_ac97_clock: measured 50792 usecs (2496 samples)
Jan 25 10:28:43 localhost kernel: intel8x0: clocking to 46885
Jan 25 10:28:43 localhost kernel: nvidia 0000:02:00.0: PCI INT A -> Link[LNK3] -> GSI 19 (level, high) -> IRQ 19
Jan 25 10:28:43 localhost kernel: nvidia 0000:02:00.0: setting latency timer to 64
Jan 25 10:28:43 localhost kernel: vgaarb: device changed decodes: PCI:0000:02:00.0,olddecodes=io+mem,decodes=none:owns=io+mem