[pulseaudio-tickets] [PulseAudio] #557: snd_pcm_avail_update() large value

PulseAudio trac-noreply at tango.0pointer.de
Mon Apr 27 16:09:56 PDT 2009


#557: snd_pcm_avail_update() large value
--------------------+-------------------------------------------------------
 Reporter:  Gokee2  |       Owner:  lennart
     Type:  defect  |      Status:  new    
Milestone:          |   Component:  daemon 
 Keywords:          |  
--------------------+-------------------------------------------------------
 Hello all,

 I decided to upgrade to Debian Squeeze after trying for a few hours to get
 pulseaudio working, so I figured I would get a bit newer software.  Bad
 idea, now I have a mostly broke instead of mostly working pulseaudio.

 When I start it fails and tells me to "Please report this issue to the
 PulseAudio developers."  I have a m-audio revolution 7.1 sound card.  It
 start up about half the time and the other half it does this.

 Once its running and you start playing it starts/stops/goes/fast for a few
 seconds before settling down and sounding ok.  Not sure if that problem is
 related or not though.


 {{{
 pulseaudio -vvvvv
 I: caps.c: Limited capabilities successfully to CAP_SYS_NICE.
 I: caps.c: Dropping root privileges.
 I: caps.c: Limited capabilities successfully to CAP_SYS_NICE.
 D: main.c: Started as real root: no, suid root: yes
 I: main.c: We're in the group 'pulse-rt', allowing high-priority
 scheduling.
 I: main.c: setrlimit(RLIMIT_NICE, (31, 31)) failed: Operation not
 permitted
 I: main.c: setrlimit(RLIMIT_RTPRIO, (9, 9)) failed: Operation not
 permitted
 I: core-util.c: Successfully gained nice level -11.
 D: main.c: Can realtime: yes, can high-priority: yes
 I: main.c: Giving up CAP_NICE
 D: main.c: Can realtime: no, can high-priority: no
 I: main.c: This is PulseAudio 0.9.14
 D: main.c: Compilation host: x86_64-pc-linux-gnu
 D: main.c: Compilation CFLAGS: -g -O2 -g -Wall -O2 -Wall -W -Wextra
 -pedantic -pipe -Wno-long-long -Wvla -Wno-overlength-strings -Wconversion
 -Wundef -Wformat -Wlogical-op -Wpacked -Wformat-security -Wmissing-
 include-dirs -Wformat-nonliteral -Wold-style-definition -Wdeclaration-
 after-statement -Wfloat-equal -Wmissing-declarations -Wmissing-prototypes
 -Wstrict-prototypes -Wredundant-decls -Wmissing-noreturn -Wshadow -Wendif-
 labels -Wpointer-arith -Wcast-align -Wwrite-strings -Wno-unused-parameter
 -ffast-math
 D: main.c: Running on host: Linux x86_64 2.6.26-2-amd64 #1 SMP Fri Mar 27
 04:02:59 UTC 2009
 I: main.c: Page size is 4096 bytes
 D: main.c: Compiled with Valgrind support: no
 D: main.c: Running in valgrind mode: no
 D: main.c: Optimized build: yes
 I: main.c: Machine ID is 5598d686a77282761134833949bb693d.
 I: main.c: Using runtime directory
 /home/gokee2/.pulse/5598d686a77282761134833949bb693d:runtime.
 I: main.c: Using state directory /home/gokee2/.pulse.
 I: main.c: Running in system mode: no
 I: main.c: Fresh high-resolution timers available! Bon appetit!
 D: memblock.c: Using shared memory pool with 1024 slots of size 64.0 KiB
 each, total size is 64.0 MiB, maximum usable slot size is 65472
 I: module-device-restore.c: Sucessfully opened database file
 '/home/gokee2/.pulse/5598d686a77282761134833949bb693d:device-
 volumes.x86_64-pc-linux-gnu.gdbm'.
 I: module.c: Loaded "module-device-restore" (index: #0; argument: "").
 I: module-stream-restore.c: Sucessfully opened database file
 '/home/gokee2/.pulse/5598d686a77282761134833949bb693d:stream-
 volumes.x86_64-pc-linux-gnu.gdbm'.
 I: module.c: Loaded "module-stream-restore" (index: #1; argument: "").
 D: cli-command.c: Checking for existance of '/usr/lib/pulse-0.9/modules
 /module-hal-detect.so': success
 I: module-hal-detect.c: Trying capability alsa
 D: module-hal-detect.c: Not loaded device
 /org/freedesktop/Hal/devices/computer_alsa_timer
 D: module-hal-detect.c: Loading module-alsa-source with arguments
 'device_id=1 source_name=alsa_input.pci_1412_1724_alsa_capture_0 tsched=1'
 D: alsa-util.c: Trying surround51:1 with SND_PCM_NO_AUTO_FORMAT ...
 D: alsa-util.c: Trying surround51:1 without SND_PCM_NO_AUTO_FORMAT ...
 D: alsa-util.c: Trying plug:surround51:1 with SND_PCM_NO_AUTO_FORMAT ...
 I: (alsa-lib)pcm_params.c: Slave PCM not usable
 D: alsa-util.c: Trying plug:surround51:1 without SND_PCM_NO_AUTO_FORMAT
 ...
 I: (alsa-lib)pcm_params.c: Slave PCM not usable
 I: alsa-util.c: PCM device plug:surround51:1 refused our hw parameters:
 Invalid argument
 D: alsa-util.c: Trying surround71:1 with SND_PCM_NO_AUTO_FORMAT ...
 D: alsa-util.c: Trying surround71:1 without SND_PCM_NO_AUTO_FORMAT ...
 D: alsa-util.c: Trying plug:surround71:1 with SND_PCM_NO_AUTO_FORMAT ...
 I: (alsa-lib)pcm_params.c: Slave PCM not usable
 D: alsa-util.c: Trying plug:surround71:1 without SND_PCM_NO_AUTO_FORMAT
 ...
 I: (alsa-lib)pcm_params.c: Slave PCM not usable
 I: alsa-util.c: PCM device plug:surround71:1 refused our hw parameters:
 Invalid argument
 D: alsa-util.c: Trying surround50:1 with SND_PCM_NO_AUTO_FORMAT ...
 D: alsa-util.c: Trying surround50:1 without SND_PCM_NO_AUTO_FORMAT ...
 D: alsa-util.c: Trying plug:surround50:1 with SND_PCM_NO_AUTO_FORMAT ...
 I: (alsa-lib)pcm_params.c: Slave PCM not usable
 D: alsa-util.c: Trying plug:surround50:1 without SND_PCM_NO_AUTO_FORMAT
 ...
 I: (alsa-lib)pcm_params.c: Slave PCM not usable
 I: alsa-util.c: PCM device plug:surround50:1 refused our hw parameters:
 Invalid argument
 D: alsa-util.c: Trying surround41:1 with SND_PCM_NO_AUTO_FORMAT ...
 D: alsa-util.c: Trying surround41:1 without SND_PCM_NO_AUTO_FORMAT ...
 D: alsa-util.c: Trying plug:surround41:1 with SND_PCM_NO_AUTO_FORMAT ...
 I: (alsa-lib)pcm_params.c: Slave PCM not usable
 D: alsa-util.c: Trying plug:surround41:1 without SND_PCM_NO_AUTO_FORMAT
 ...
 I: (alsa-lib)pcm_params.c: Slave PCM not usable
 I: alsa-util.c: PCM device plug:surround41:1 refused our hw parameters:
 Invalid argument
 D: alsa-util.c: Trying surround40:1 with SND_PCM_NO_AUTO_FORMAT ...
 D: alsa-util.c: Trying surround40:1 without SND_PCM_NO_AUTO_FORMAT ...
 D: alsa-util.c: Trying plug:surround40:1 with SND_PCM_NO_AUTO_FORMAT ...
 I: (alsa-lib)pcm_params.c: Slave PCM not usable
 D: alsa-util.c: Trying plug:surround40:1 without SND_PCM_NO_AUTO_FORMAT
 ...
 I: (alsa-lib)pcm_params.c: Slave PCM not usable
 I: alsa-util.c: PCM device plug:surround40:1 refused our hw parameters:
 Invalid argument
 D: alsa-util.c: Trying front:1 with SND_PCM_NO_AUTO_FORMAT ...
 D: alsa-util.c: Maximum hw buffer size is 743 ms
 W: alsa-util.c: Device front:1 doesn't support sample format s16le,
 changed to s32le.
 I: module-alsa-source.c: Successfully opened device front:1.
 I: module-alsa-source.c: Successfully enabled mmap() mode.
 I: module-alsa-source.c: Successfully enabled timer-based scheduling mode.
 I: (alsa-lib)control.c: Invalid CTL front:1
 I: alsa-util.c: Unable to attach to mixer front:1: No such file or
 directory
 I: alsa-util.c: Successfully attached to mixer 'hw:1'
 I: alsa-util.c: Cannot find mixer control "Capture".
 W: alsa-util.c: Cannot find fallback mixer control "Mic".
 I: module-device-restore.c: Restoring volume for source
 alsa_input.pci_1412_1724_alsa_capture_0.
 I: module-device-restore.c: Restoring mute state for source
 alsa_input.pci_1412_1724_alsa_capture_0.
 I: source.c: Created source 0 "alsa_input.pci_1412_1724_alsa_capture_0"
 with sample spec s32le 2ch 44100Hz and channel map front-left,front-right
 I: module-alsa-source.c: Using 2 fragments of size 131072 bytes, buffer
 time is 743.04ms
 I: module-alsa-source.c: Time scheduling watermark is 30.00ms
 D: module-alsa-source.c: hwbuf_unused_frames=0
 D: module-alsa-source.c: setting avail_min=251553
 D: alsa-util.c: snd_pcm_dump():
 D: alsa-util.c: Hardware PCM card 1 'M Audio Revolution-7.1' device 0
 subdevice 0
 D: alsa-util.c: Its setup is:
 D: alsa-util.c:   stream       : CAPTURE
 D: alsa-util.c:   access       : MMAP_INTERLEAVED
 D: alsa-util.c:   format       : S32_LE
 D: alsa-util.c:   subformat    : STD
 D: alsa-util.c:   channels     : 2
 D: alsa-util.c:   rate         : 44100
 D: alsa-util.c:   exact rate   : 44100 (44100/1)
 D: alsa-util.c:   msbits       : 24
 D: alsa-util.c:   buffer_size  : 32768
 D: alsa-util.c:   period_size  : 16384
 D: alsa-util.c:   period_time  : 371519
 D: alsa-util.c:   tstamp_mode  : NONE
 D: alsa-util.c:   period_step  : 1
 D: alsa-util.c:   avail_min    : 251553
 D: alsa-util.c:   period_event : 0
 D: alsa-util.c:   start_threshold  : -1
 D: alsa-util.c:   stop_threshold   : -1
 D: alsa-util.c:   silence_threshold: 0
 D: alsa-util.c:   silence_size : 0
 D: alsa-util.c:   boundary     : 4611686018427387904
 D: module-alsa-source.c: Thread starting up
 D: rtpoll.c: Acquired POSIX realtime signal SIGRTMIN+29
 I: module.c: Loaded "module-alsa-source" (index: #2; argument:
 "device_id=1 source_name=alsa_input.pci_1412_1724_alsa_capture_0
 tsched=1").
 D: module-hal-detect.c: Not loaded device
 /org/freedesktop/Hal/devices/computer_alsa_sequencer
 D: module-hal-detect.c: Not loaded device
 /org/freedesktop/Hal/devices/pci_1412_1724_alsa_playback_2
 D: module-hal-detect.c: Not loaded device
 /org/freedesktop/Hal/devices/pci_1412_1724_alsa_playback_1
 D: module-hal-detect.c: Loading module-alsa-sink with arguments
 'device_id=1 sink_name=alsa_output.pci_1412_1724_alsa_playback_0 tsched=1'
 D: alsa-util.c: Trying surround51:1 with SND_PCM_NO_AUTO_FORMAT ...
 D: alsa-util.c: Maximum hw buffer size is 247 ms
 W: alsa-util.c: Device surround51:1 doesn't support sample format s16le,
 changed to s32le.
 I: module-alsa-sink.c: Successfully opened device surround51:1.
 I: module-alsa-sink.c: Successfully enabled mmap() mode.
 I: module-alsa-sink.c: Successfully enabled timer-based scheduling mode.
 I: (alsa-lib)control.c: Invalid CTL surround51:1
 I: alsa-util.c: Unable to attach to mixer surround51:1: No such file or
 directory
 I: alsa-util.c: Successfully attached to mixer 'hw:1'
 I: alsa-util.c: Cannot find mixer control "Master".
 I: alsa-util.c: Using mixer control "PCM".
 I: module-device-restore.c: Restoring volume for sink
 alsa_output.pci_1412_1724_alsa_playback_0.
 I: module-device-restore.c: Restoring mute state for sink
 alsa_output.pci_1412_1724_alsa_playback_0.
 I: sink.c: Created sink 0 "alsa_output.pci_1412_1724_alsa_playback_0" with
 sample spec s32le 6ch 44100Hz and channel map front-left,front-right,rear-
 left,rear-right,front-center,lfe
 I: module-device-restore.c: Restoring volume for source
 alsa_output.pci_1412_1724_alsa_playback_0.monitor.
 I: module-device-restore.c: Restoring mute state for source
 alsa_output.pci_1412_1724_alsa_playback_0.monitor.
 I: source.c: Created source 1
 "alsa_output.pci_1412_1724_alsa_playback_0.monitor" with sample spec s32le
 6ch 44100Hz and channel map front-left,front-right,rear-left,rear-right
 ,front-center,lfe
 I: module-alsa-sink.c: Using 2 fragments of size 131040 bytes, buffer time
 is 247.62ms
 I: module-alsa-sink.c: Time scheduling watermark is 10.00ms
 D: module-alsa-sink.c: hwbuf_unused_frames=0
 D: module-alsa-sink.c: setting avail_min=251473
 I: module-alsa-sink.c: Volume ranges from 0 to 255.
 I: module-alsa-sink.c: Volume ranges from -99999.99 dB to 0.00 dB.
 I: alsa-util.c: ALSA device lacks separate volumes control for channel
 'rear-left'
 I: module-alsa-sink.c: Using hardware volume control. Hardware dB scale
 supported.
 D: alsa-util.c: snd_pcm_dump():
 D: alsa-util.c: Route conversion PCM
 D: alsa-util.c:   Transformation table:
 D: alsa-util.c:     0 <- 0
 D: alsa-util.c:     1 <- 1
 D: alsa-util.c:     2 <- 4
 D: alsa-util.c:     3 <- 5
 D: alsa-util.c:     4 <- 2
 D: alsa-util.c:     5 <- 3
 D: alsa-util.c: Its setup is:
 D: alsa-util.c:   stream       : PLAYBACK
 D: alsa-util.c:   access       : MMAP_INTERLEAVED
 D: alsa-util.c:   format       : S32_LE
 D: alsa-util.c:   subformat    : STD
 D: alsa-util.c:   channels     : 6
 D: alsa-util.c:   rate         : 44100
 D: alsa-util.c:   exact rate   : 44100 (44100/1)
 D: alsa-util.c:   msbits       : 32
 D: alsa-util.c:   buffer_size  : 10920
 D: alsa-util.c:   period_size  : 5460
 D: alsa-util.c:   period_time  : 123809
 D: alsa-util.c:   tstamp_mode  : NONE
 D: alsa-util.c:   period_step  : 1
 D: alsa-util.c:   avail_min    : 251473
 D: alsa-util.c:   period_event : 0
 D: alsa-util.c:   start_threshold  : -1
 D: alsa-util.c:   stop_threshold   : -1
 D: alsa-util.c:   silence_threshold: 0
 D: alsa-util.c:   silence_size : 0
 D: alsa-util.c:   boundary     : 6147413491360727040
 D: alsa-util.c: Slave: Hardware PCM card 1 'M Audio Revolution-7.1' device
 0 subdevice 0
 D: alsa-util.c: Its setup is:
 D: alsa-util.c:   stream       : PLAYBACK
 D: alsa-util.c:   access       : MMAP_INTERLEAVED
 D: alsa-util.c:   format       : S32_LE
 D: alsa-util.c:   subformat    : STD
 D: alsa-util.c:   channels     : 6
 D: alsa-util.c:   rate         : 44100
 D: alsa-util.c:   exact rate   : 44100 (44100/1)
 D: alsa-util.c:   msbits       : 24
 D: alsa-util.c:   buffer_size  : 10920
 D: alsa-util.c:   period_size  : 5460
 D: alsa-util.c:   period_time  : 123809
 D: alsa-util.c:   tstamp_mode  : NONE
 D: alsa-util.c:   period_step  : 1
 D: alsa-util.c:   ava
 D: module-alsa-sink.c: Thread starting up
 D: module-alsa-sink.c: Requested volume: 0:  62% 1:  62% 2:  52% 3:  52%
 4:  52% 5:  52%
 D: module-alsa-sink.c: Got hardware volume: 0:  62% 1:  62% 2:  62% 3:
 62% 4:  62% 5:  62%
 D: module-alsa-sink.c: Calculated software volume: 0:  99% 1:  99% 2:  89%
 3:  89% 4:  89% 5:  89%
 D: rtpoll.c: Acquired POSIX realtime signal SIGRTMIN+28
 I: module-alsa-sink.c: Starting playback.
 I: module.c: Loaded "module-alsa-sink" (index: #3; argument: "device_id=1
 sink_name=alsa_output.pci_1412_1724_alsa_playback_0 tsched=1").
 D: module-hal-detect.c: Not loaded device
 /org/freedesktop/Hal/devices/pci_1412_1724_alsa_control__1
 I: module-hal-detect.c: Loaded 2 modules.
 I: module.c: Loaded "module-hal-detect" (index: #4; argument: "").
 D: cli-command.c: Checking for existance of '/usr/lib/pulse-0.9/modules
 /module-esound-protocol-unix.so': success
 I: module.c: Loaded "module-esound-protocol-unix" (index: #5; argument:
 "").
 I: module.c: Loaded "module-native-protocol-unix" (index: #6; argument:
 "").
 D: cli-command.c: Checking for existance of '/usr/lib/pulse-0.9/modules
 /module-gconf.so': success
 I: module.c: Loaded "module-gconf" (index: #7; argument: "").
 I: module-default-device-restore.c: Restored default sink
 'alsa_output.pci_1412_1724_alsa_playback_0'.
 D: core-subscribe.c: Dropped redundant event due to change event.
 I: module-default-device-restore.c: Restored default source
 'alsa_input.pci_1412_1724_alsa_capture_0'.
 I: module.c: Loaded "module-default-device-restore" (index: #8; argument:
 "").
 I: module.c: Loaded "module-rescue-streams" (index: #9; argument: "").
 I: module.c: Loaded "module-always-sink" (index: #10; argument: "").
 D: module-suspend-on-idle.c: Sink
 alsa_output.pci_1412_1724_alsa_playback_0 becomes idle.
 D: module-suspend-on-idle.c: Source
 alsa_input.pci_1412_1724_alsa_capture_0 becomes idle.
 D: module-suspend-on-idle.c: Source
 alsa_output.pci_1412_1724_alsa_playback_0.monitor becomes idle.
 I: module.c: Loaded "module-suspend-on-idle" (index: #11; argument: "").
 I: client.c: Created 0 "ConsoleKit Session
 /org/freedesktop/ConsoleKit/Session14"
 D: module-console-kit.c: Added new session
 /org/freedesktop/ConsoleKit/Session14
 I: module.c: Loaded "module-console-kit" (index: #12; argument: "").
 I: module.c: Loaded "module-position-event-sounds" (index: #13; argument:
 "").
 I: main.c: Daemon startup complete.
 D: module-hal-detect.c: dbus: interface=org.freedesktop.DBus,
 path=/org/freedesktop/DBus, member=NameAcquired
 D: module-console-kit.c: dbus: interface=org.freedesktop.DBus,
 path=/org/freedesktop/DBus, member=NameAcquired
 D: module-alsa-source.c: Wakeup from ALSA! INPUT
 E: alsa-util.c: snd_pcm_avail_update() returned a value that is
 exceptionally large: 18446744073709484608 bytes (418293516220 ms) Most
 likely this is an ALSA driver bug. Please report this issue to the
 PulseAudio developers.
 I: module-alsa-source.c: Overrun!
 N: module-alsa-source.c: Increasing wakeup watermark to 60.00 ms
 I: module-suspend-on-idle.c: Source
 alsa_output.pci_1412_1724_alsa_playback_0.monitor idle for too long,
 suspending ...
 I: module-suspend-on-idle.c: Source
 alsa_input.pci_1412_1724_alsa_capture_0 idle for too long, suspending ...
 Soft CPU time limit exhausted, terminating.
 Hard CPU time limit exhausted, terminating forcibly.
 Aborted
 }}}

-- 
Ticket URL: <http://pulseaudio.org/ticket/557>
PulseAudio <http://pulseaudio.org/>
The PulseAudio Sound Server


More information about the pulseaudio-bugs mailing list