Bug 667515 - ratelimit.c 140 events suppressed
Summary: ratelimit.c 140 events suppressed
Keywords:
Status: CLOSED WONTFIX
Alias: None
Product: Fedora
Classification: Fedora
Component: pulseaudio
Version: 13
Hardware: i686
OS: Linux
low
medium
Target Milestone: ---
Assignee: Lennart Poettering
QA Contact: Fedora Extras Quality Assurance
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2011-01-05 20:30 UTC by xset1980
Modified: 2011-06-27 12:43 UTC (History)
5 users (show)

Fixed In Version:
Doc Type: Bug Fix
Doc Text:
Clone Of:
: 710309 (view as bug list)
Environment:
Last Closed: 2011-06-27 12:43:10 UTC
Type: ---
Embargoed:


Attachments (Terms of Use)
config of kernel 2.6.35.10 with intel-HD (77.90 KB, text/plain)
2011-01-05 20:36 UTC, xset1980
no flags Details
complete /var/log/messages (2.58 KB, text/plain)
2011-01-06 00:39 UTC, xset1980
no flags Details
alsa-info.sh (45.18 KB, text/plain)
2011-01-06 00:40 UTC, xset1980
no flags Details
alsa-info.sh output (30.53 KB, text/plain)
2011-02-20 16:17 UTC, Per Nystrom
no flags Details

Description xset1980 2011-01-05 20:30:24 UTC
Description of problem:

pulseaudio produces errors in / var / log / messages to start playing audio, or open the gnome mixer

Version-Release number of selected component (if applicable):

pulseaudio 0.9.21

How reproducible:

1) Open anyway player, audacious, exaile.
2) Play mp3
3) Open Sound Preferences Gnome and change tab -hardware- -input- -output-


Steps to Reproduce:
1.Open anyway player, audacious, exaile.
2.Play mp3
3.Open Sound Preferences Gnome and change tab -hardware- -input- -output-
  
Actual results:

Jan  5 16:38:54 tux pulseaudio[1636]: alsa-source.c: ALSA nos despertó para leer nuevos datos desde el dispositivo, ¡pero en realidad no hay nada para leer!
Jan  5 16:38:54 tux pulseaudio[1636]: alsa-source.c: Lo más probable es que sea un error del controlador ALSA 'snd_hda_intel'. Por favor, informe esto a los desarrolladores de ALSA.
Jan  5 16:38:54 tux pulseaudio[1636]: alsa-source.c: Nos despertaron con POLLIN puesto -- sin embargo, una llamada a snd_pcm_avail() devolvió 0 u otro valor < min_avail.
Jan  5 16:38:56 tux pulseaudio[1636]: ratelimit.c: 20 events suppressed
Jan  5 16:39:02 tux pulseaudio[1636]: ratelimit.c: 4 events suppressed


Expected results:


Additional info:

With the current kernel fedora date vmlinuz-2.6.34.7-66.fc13.i686.PAE suppressed the number of events is a value between 100 to 150.
Compiling a kernel branch 2.6.35.x with intel-HD option in the audio section, not as a module, but built into the kernel, is reduced from 4 to 40 events, at times.
This happens with some chipset like Azalia ALC888.
00:14.2 Audio device: ATI Technologies Inc SBx00 Azalia (Intel HDA)
My contribution attempts to show that recompiling the kernel and putting the driver in the form of * and not as a module - [m] - the error is greatly reduced.
The kernel that was used for the test was:

http://git.kernel.org/?p=linux/kernel/git/longterm/linux-2.6.35.y.git a = summary

Did not affect the rest of the system, or as with selinux kernel 2.6.1936.
Thanks

Comment 1 xset1980 2011-01-05 20:36:08 UTC
Created attachment 471939 [details]
config of kernel 2.6.35.10 with intel-HD

Comment 2 Lennart Poettering 2011-01-06 00:08:44 UTC
Your ALSA driver is most likely broked. Please attach a longer excerpt of syslog (i.e. from the beginning of where it was initialized and where you played audio) and also include the output generated by alsa-info.sh --no-upload.)

Comment 3 xset1980 2011-01-06 00:39:18 UTC
Created attachment 471969 [details]
complete /var/log/messages

Comment 4 xset1980 2011-01-06 00:40:00 UTC
Created attachment 471970 [details]
alsa-info.sh

Comment 5 xset1980 2011-01-06 00:41:44 UTC
(In reply to comment #2)
> Your ALSA driver is most likely broked. Please attach a longer excerpt of
> syslog (i.e. from the beginning of where it was initialized and where you
> played audio) and also include the output generated by alsa-info.sh
> --no-upload.)

Dear Lennart,

This error was reported with a vanilla 2.6.35.10 kernel, but with Fedora 13 kernel vmlinuz-2.6.34.7-66.fc13.i686.PAE happens every time you start any audio player so the messages constantly shows the errors, and even the ratelimit.c shows a value of 100 - 200 events suppressed.
With the vanilla kernel 2.6.35.10 this happens when you start the player and improves in quantity, 4 and 40 respectively (suppressed events).
I have already tried to remove pulseaudio but it still happens the same thing.
In other audio chipset, as pure Intel, no, i.e., with a Lenovo X60.

Attachments:

1.- Created attachment 471969 [details]
    complete /var/log/messages

2.- Created attachment 471970 [details]
    alsa-info.sh

Comment 6 xset1980 2011-01-21 09:08:21 UTC
Lennart,

My alsa is good, i tested in other distro, Archlinux, Gentoo, Slackware, Debian, ubuntu, opensuse, and the bug is the same with ALC888 chipset. The problem is pulseaudio + alsa

Comment 7 xset1980 2011-01-21 09:08:55 UTC
(In reply to comment #2)
> Your ALSA driver is most likely broked. Please attach a longer excerpt of
> syslog (i.e. from the beginning of where it was initialized and where you
> played audio) and also include the output generated by alsa-info.sh
> --no-upload.)

Lennart,

My alsa is good, i tested in other distro, Archlinux, Gentoo, Slackware,
Debian, ubuntu, opensuse, and the bug is the same with ALC888 chipset. The
problem is pulseaudio + alsa

Comment 8 Per Nystrom 2011-02-20 16:15:54 UTC
I also have the ALC888 and I have been getting spam in /var/log/messages ever since pulseaudio shipped in Fedora (11? 12?).

Feb 19 15:48:59 spike pulseaudio[3179]: ratelimit.c: 889 events suppressed
Feb 19 15:49:04 spike pulseaudio[3179]: ratelimit.c: 685 events suppressed
Feb 19 17:55:04 spike pulseaudio[3179]: ratelimit.c: 456 events suppressed
Feb 19 18:45:05 spike pulseaudio[3179]: ratelimit.c: 35 events suppressed
Feb 19 20:05:05 spike pulseaudio[3179]: ratelimit.c: 34 events suppressed
Feb 19 22:35:05 spike pulseaudio[3179]: ratelimit.c: 35 events suppressed
Feb 19 23:45:05 spike pulseaudio[3179]: ratelimit.c: 35 events suppressed
Feb 20 02:15:05 spike pulseaudio[3179]: ratelimit.c: 34 events suppressed
Feb 20 02:35:08 spike pulseaudio[3179]: ratelimit.c: 34 events suppressed
Feb 20 03:55:04 spike pulseaudio[3179]: ratelimit.c: 35 events suppressed
Feb 20 05:45:06 spike pulseaudio[3179]: ratelimit.c: 34 events suppressed
Feb 20 05:55:03 spike pulseaudio[3179]: ratelimit.c: 34 events suppressed
Feb 20 06:35:06 spike pulseaudio[3179]: ratelimit.c: 35 events suppressed
Feb 20 07:39:31 spike pulseaudio[3179]: ratelimit.c: 35 events suppressed

Comment 9 Per Nystrom 2011-02-20 16:17:00 UTC
Created attachment 479779 [details]
alsa-info.sh output

Comment 10 xset1980 2011-03-07 08:41:13 UTC
Per, yes, is a problem with pulseaudio, only alsa not spam in /var/log/messages, but, lennart think that my alsa is broken... i waiting for a real solution or fix

Comment 11 infertux 2011-03-12 11:28:38 UTC
Same problem here under 2.6.35.11-83.fc14.x86_64.

My /var/log/messages is flooded of:
alsa-sink.c: ALSA woke us up to write new data to the device, but there was actually nothing to write!
alsa-sink.c: Most likely this is a bug in the ALSA driver 'snd_hda_intel'. Please report this issue to the ALSA developers.
alsa-sink.c: We were woken up with POLLOUT set -- however a subsequent snd_pcm_avail() returned 0 or another value < min_avail.
ratelimit.c: [N] events suppressed
[...]

The bug is already reported to ALSA devs: https://bugtrack.alsa-project.org/alsa-bug/view.php?id=5295

I also noticed a line maybe interesting that sometimes appears between "[N] events suppressed":
module.c: Module "module-stream-restore" should be loaded once at most. Refusing to load.

Comment 12 Bug Zapper 2011-05-30 12:10:04 UTC
This message is a reminder that Fedora 13 is nearing its end of life.
Approximately 30 (thirty) days from now Fedora will stop maintaining
and issuing updates for Fedora 13.  It is Fedora's policy to close all
bug reports from releases that are no longer maintained.  At that time
this bug will be closed as WONTFIX if it remains open with a Fedora 
'version' of '13'.

Package Maintainer: If you wish for this bug to remain open because you
plan to fix it in a currently maintained version, simply change the 'version' 
to a later Fedora version prior to Fedora 13's end of life.

Bug Reporter: Thank you for reporting this issue and we are sorry that 
we may not be able to fix it before Fedora 13 is end of life.  If you 
would still like to see this bug fixed and are able to reproduce it 
against a later version of Fedora please change the 'version' of this 
bug to the applicable version.  If you are unable to change the version, 
please add a comment here and someone will do it for you.

Although we aim to fix as many bugs as possible during every release's 
lifetime, sometimes those efforts are overtaken by events.  Often a 
more recent Fedora release includes newer upstream software that fixes 
bugs or makes them obsolete.

The process we are following is described here: 
http://fedoraproject.org/wiki/BugZappers/HouseKeeping

Comment 13 Per Nystrom 2011-05-30 14:51:48 UTC
This problem is still present in Fedora 14.

Comment 14 Bug Zapper 2011-06-27 12:43:10 UTC
Fedora 13 changed to end-of-life (EOL) status on 2011-06-25. Fedora 13 is 
no longer maintained, which means that it will not receive any further 
security or bug fix updates. As a result we are closing this bug.

If you can reproduce this bug against a currently maintained version of 
Fedora please feel free to reopen this bug against that version.

Thank you for reporting this bug and we are sorry it could not be fixed.


Note You need to log in before you can comment on or make changes to this bug.