Bug 59077

Summary: max_latency assertion failed in pa_sink_set_latency_range_within_thread
Product: PulseAudio Reporter: Daniel Drake <dan>
Component: alsaAssignee: pulseaudio-bugs
Status: RESOLVED MOVED QA Contact: pulseaudio-bugs
Severity: normal    
Priority: medium CC: lennart
Version: unspecified   
Hardware: Other   
OS: All   
Whiteboard:
i915 platform: i915 features:

Description Daniel Drake 2013-01-06 10:41:21 UTC
After a system update to Fedora 18, I have no sound output :(
This is with pulseaudio-2.1.

The sound did work on Fedora 17, which uses the same kernel version (3.6.10). However, Fedora 17 was using pulseaudio-1.1, so it seems to be the upgrade to v2.1 that broke this.

The daemon starts OK but crashes with this error as soon as I play a sound:

[alsa-sink] sink.c: Assertion 'max_latency <= (10*((pa_usec_t) 1000000ULL))' failed at pulsecore/sink.c:3148, function pa_sink_set_latency_range_within_thread(). Aborting.


Pulseaudio is also notably a bit unhappy about some ALSA oddness (exceptionally large values). It might be related. That does probably indicate a kernel bug, but given that pulse did work with the same kernel in version v1.1, I'd hope that things could be kept working for newer releases.

I have tried updating to kernel 3.7.1 and pulseaudio-3.0, unfortunately the problem is still there.

Full log of alsa unhappiness:
E: [alsa-sink] alsa-util.c: snd_pcm_avail() returned a value that is
exceptionally large: 3528320 bytes (10000 ms).
E: [alsa-sink] alsa-util.c: Most likely this is a bug in the ALSA driver
'snd_hda_intel'. Please report this issue to the ALSA developers.
E: [alsa-sink] alsa-util.c: snd_pcm_dump():
E: [alsa-sink] alsa-util.c: Soft volume PCM
E: [alsa-sink] alsa-util.c: Control: PCM Playback Volume
E: [alsa-sink] alsa-util.c: min_dB: -51
E: [alsa-sink] alsa-util.c: max_dB: 0
E: [alsa-sink] alsa-util.c: resolution: 256
E: [alsa-sink] alsa-util.c: Its setup is:
E: [alsa-sink] alsa-util.c:   stream       : PLAYBACK
E: [alsa-sink] alsa-util.c:   access       : MMAP_INTERLEAVED
E: [alsa-sink] alsa-util.c:   format       : S16_LE
E: [alsa-sink] alsa-util.c:   subformat    : STD
E: [alsa-sink] alsa-util.c:   channels     : 4
E: [alsa-sink] alsa-util.c:   rate         : 44100
E: [alsa-sink] alsa-util.c:   exact rate   : 44100 (44100/1)
E: [alsa-sink] alsa-util.c:   msbits       : 16
E: [alsa-sink] alsa-util.c:   buffer_size  : 441040
E: [alsa-sink] alsa-util.c:   period_size  : 88208
E: [alsa-sink] alsa-util.c:   period_time  : 2000181
E: [alsa-sink] alsa-util.c:   tstamp_mode  : ENABLE
E: [alsa-sink] alsa-util.c:   period_step  : 1
E: [alsa-sink] alsa-util.c:   avail_min    : 440599
E: [alsa-sink] alsa-util.c:   period_event : 0
E: [alsa-sink] alsa-util.c:   start_threshold  : -1
E: [alsa-sink] alsa-util.c:   stop_threshold   : 1806499840
E: [alsa-sink] alsa-util.c:   silence_threshold: 0
E: [alsa-sink] alsa-util.c:   silence_size : 0
E: [alsa-sink] alsa-util.c:   boundary     : 1806499840
E: [alsa-sink] alsa-util.c: Slave: Hardware PCM card 0 'HDA NVidia' device 0
subdevice 0
E: [alsa-sink] alsa-util.c: Its setup is:
E: [alsa-sink] alsa-util.c:   stream       : PLAYBACK
E: [alsa-sink] alsa-util.c:   access       : MMAP_INTERLEAVED
E: [alsa-sink] alsa-util.c:   format       : S16_LE
E: [alsa-sink] alsa-util.c:   subformat    : STD
E: [alsa-sink] alsa-util.c:   channels     : 4
E: [alsa-sink] alsa-util.c:   rate         : 44100
E: [alsa-sink] alsa-util.c:   exact rate   : 44100 (44100/1)
E: [alsa-sink] alsa-util.c:   msbits       : 16
E: [alsa-sink] alsa-util.c:   buffer_size  : 441040
E: [alsa-sink] alsa-util.c:   period_size  : 88208
E: [alsa-sink] alsa-util.c:   period_time  : 2000181
E: [alsa-sink] alsa-util.c:   tstamp_mode  : ENABLE
E: [alsa-sink] alsa-util.c:   period_step  : 1
E: [alsa-sink] alsa-util.c:   avail_min    : 440599
E: [alsa-sink] alsa-util.c:   period_event : 0
E: [alsa-sink] alsa-util.c:   start_threshold  : -1
E: [alsa-sink] alsa-util.c:   stop_threshold   : 1806499840
E: [alsa-sink] alsa-util.c:   silence_threshold: 0
E: [alsa-sink] alsa-util.c:   silence_size : 0
E: [alsa-sink] alsa-util.c:   boundary     : 1806499840
E: [alsa-sink] alsa-util.c:   appl_ptr     : 0
E: [alsa-sink] alsa-util.c:   hw_ptr       : 0
E: [alsa-sink] alsa-util.c: snd_pcm_mmap_begin() returned a value that is
exceptionally large: 3528320 bytes (10000 ms).
E: [alsa-sink] alsa-util.c: Most likely this is a bug in the ALSA driver
'snd_hda_intel'. Please report this issue to the ALSA developers.
E: [alsa-sink] alsa-util.c: snd_pcm_dump():
E: [alsa-sink] alsa-util.c: Soft volume PCM
E: [alsa-sink] alsa-util.c: Control: PCM Playback Volume
E: [alsa-sink] alsa-util.c: min_dB: -51
E: [alsa-sink] alsa-util.c: max_dB: 0
E: [alsa-sink] alsa-util.c: resolution: 256
E: [alsa-sink] alsa-util.c: Its setup is:
E: [alsa-sink] alsa-util.c:   stream       : PLAYBACK
E: [alsa-sink] alsa-util.c:   access       : MMAP_INTERLEAVED
E: [alsa-sink] alsa-util.c:   format       : S16_LE
E: [alsa-sink] alsa-util.c:   subformat    : STD
E: [alsa-sink] alsa-util.c:   channels     : 4
E: [alsa-sink] alsa-util.c:   rate         : 44100
E: [alsa-sink] alsa-util.c:   exact rate   : 44100 (44100/1)
E: [alsa-sink] alsa-util.c:   msbits       : 16
E: [alsa-sink] alsa-util.c:   buffer_size  : 441040
E: [alsa-sink] alsa-util.c:   period_size  : 88208
E: [alsa-sink] alsa-util.c:   period_time  : 2000181
E: [alsa-sink] alsa-util.c:   tstamp_mode  : ENABLE
E: [alsa-sink] alsa-util.c:   period_step  : 1
E: [alsa-sink] alsa-util.c:   avail_min    : 440599
E: [alsa-sink] alsa-util.c:   period_event : 0
E: [alsa-sink] alsa-util.c:   start_threshold  : -1
E: [alsa-sink] alsa-util.c:   stop_threshold   : 1806499840
E: [alsa-sink] alsa-util.c:   silence_threshold: 0
E: [alsa-sink] alsa-util.c:   silence_size : 0
E: [alsa-sink] alsa-util.c:   boundary     : 1806499840
E: [alsa-sink] alsa-util.c: Slave: Hardware PCM card 0 'HDA NVidia' device 0
subdevice 0
E: [alsa-sink] alsa-util.c: Its setup is:
E: [alsa-sink] alsa-util.c:   stream       : PLAYBACK
E: [alsa-sink] alsa-util.c:   access       : MMAP_INTERLEAVED
E: [alsa-sink] alsa-util.c:   format       : S16_LE
E: [alsa-sink] alsa-util.c:   subformat    : STD
E: [alsa-sink] alsa-util.c:   channels     : 4
E: [alsa-sink] alsa-util.c:   rate         : 44100
E: [alsa-sink] alsa-util.c:   exact rate   : 44100 (44100/1)
E: [alsa-sink] alsa-util.c:   msbits       : 16
E: [alsa-sink] alsa-util.c:   buffer_size  : 441040
E: [alsa-sink] alsa-util.c:   period_size  : 88208
E: [alsa-sink] alsa-util.c:   period_time  : 2000181
E: [alsa-sink] alsa-util.c:   tstamp_mode  : ENABLE
E: [alsa-sink] alsa-util.c:   period_step  : 1
E: [alsa-sink] alsa-util.c:   avail_min    : 440599
E: [alsa-sink] alsa-util.c:   period_event : 0
E: [alsa-sink] alsa-util.c:   start_threshold  : -1
E: [alsa-sink] alsa-util.c:   stop_threshold   : 1806499840
E: [alsa-sink] alsa-util.c:   silence_threshold: 0
E: [alsa-sink] alsa-util.c:   silence_size : 0
E: [alsa-sink] alsa-util.c:   boundary     : 1806499840
E: [alsa-sink] alsa-util.c:   appl_ptr     : 0
E: [alsa-sink] alsa-util.c:   hw_ptr       : 0
E: [alsa-sink] alsa-util.c: snd_pcm_delay() returned a value that is
exceptionally large: 3528320 bytes (10000 ms).
E: [alsa-sink] alsa-util.c: Most likely this is a bug in the ALSA driver
'snd_hda_intel'. Please report this issue to the ALSA developers.
E: [alsa-sink] alsa-util.c: snd_pcm_dump():
E: [alsa-sink] alsa-util.c: Soft volume PCM
E: [alsa-sink] alsa-util.c: Control: PCM Playback Volume
E: [alsa-sink] alsa-util.c: min_dB: -51
E: [alsa-sink] alsa-util.c: max_dB: 0
E: [alsa-sink] alsa-util.c: resolution: 256
E: [alsa-sink] alsa-util.c: Its setup is:
E: [alsa-sink] alsa-util.c:   stream       : PLAYBACK
E: [alsa-sink] alsa-util.c:   access       : MMAP_INTERLEAVED
E: [alsa-sink] alsa-util.c:   format       : S16_LE
E: [alsa-sink] alsa-util.c:   subformat    : STD
E: [alsa-sink] alsa-util.c:   channels     : 4
E: [alsa-sink] alsa-util.c:   rate         : 44100
E: [alsa-sink] alsa-util.c:   exact rate   : 44100 (44100/1)
E: [alsa-sink] alsa-util.c:   msbits       : 16
E: [alsa-sink] alsa-util.c:   buffer_size  : 441040
E: [alsa-sink] alsa-util.c:   period_size  : 88208
E: [alsa-sink] alsa-util.c:   period_time  : 2000181
E: [alsa-sink] alsa-util.c:   tstamp_mode  : ENABLE
E: [alsa-sink] alsa-util.c:   period_step  : 1
E: [alsa-sink] alsa-util.c:   avail_min    : 440599
E: [alsa-sink] alsa-util.c:   period_event : 0
E: [alsa-sink] alsa-util.c:   start_threshold  : -1
E: [alsa-sink] alsa-util.c:   stop_threshold   : 1806499840
E: [alsa-sink] alsa-util.c:   silence_threshold: 0
E: [alsa-sink] alsa-util.c:   silence_size : 0
E: [alsa-sink] alsa-util.c:   boundary     : 1806499840
E: [alsa-sink] alsa-util.c: Slave: Hardware PCM card 0 'HDA NVidia' device 0
subdevice 0
E: [alsa-sink] alsa-util.c: Its setup is:
E: [alsa-sink] alsa-util.c:   stream       : PLAYBACK
E: [alsa-sink] alsa-util.c:   access       : MMAP_INTERLEAVED
E: [alsa-sink] alsa-util.c:   format       : S16_LE
E: [alsa-sink] alsa-util.c:   subformat    : STD
E: [alsa-sink] alsa-util.c:   channels     : 4
E: [alsa-sink] alsa-util.c:   rate         : 44100
E: [alsa-sink] alsa-util.c:   exact rate   : 44100 (44100/1)
E: [alsa-sink] alsa-util.c:   msbits       : 16
E: [alsa-sink] alsa-util.c:   buffer_size  : 441040
E: [alsa-sink] alsa-util.c:   period_size  : 88208
E: [alsa-sink] alsa-util.c:   period_time  : 2000181
E: [alsa-sink] alsa-util.c:   tstamp_mode  : ENABLE
E: [alsa-sink] alsa-util.c:   period_step  : 1
E: [alsa-sink] alsa-util.c:   avail_min    : 440599
E: [alsa-sink] alsa-util.c:   period_event : 0
E: [alsa-sink] alsa-util.c:   start_threshold  : -1
E: [alsa-sink] alsa-util.c:   stop_threshold   : 1806499840
E: [alsa-sink] alsa-util.c:   silence_threshold: 0
E: [alsa-sink] alsa-util.c:   silence_size : 0
E: [alsa-sink] alsa-util.c:   boundary     : 1806499840
E: [alsa-sink] alsa-util.c:   appl_ptr     : 441040
E: [alsa-sink] alsa-util.c:   hw_ptr       : 0
Comment 1 Raymond 2013-12-15 09:56:11 UTC
you have to use "--log-timing" 


E: [alsa-sink] alsa-util.c:   appl_ptr     : 0
E: [alsa-sink] alsa-util.c:   hw_ptr       : 0

seem the alsa-driver still not start playing
Comment 2 GitLab Migration User 2018-07-30 10:30:37 UTC
-- GitLab Migration Automatic Message --

This bug has been migrated to freedesktop.org's GitLab instance and has been closed from further activity.

You can subscribe and participate further through the new bug through this link to our GitLab instance: https://gitlab.freedesktop.org/pulseaudio/pulseaudio/issues/476.

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.