Description of problem: I can't play mp3/oga files in rhythmbox, the sound contains scratches and other defects and is totaly unlistenable. "ratelimit.c: <many> events suppressed" messages appear in /var/log/messages where many is between 500 and 1000. Version-Release number of selected component (if applicable): pulseaudio-0.9.21-2.fc12.x86_64 kernel-2.6.31.9-174.fc12.x86_64 rhythmbox-0.12.6-2.fc12.x86_64 gstreamer-0.10.25.1-2.fc12.x86_64 Additional info: My system is Fedora 12 updated from F-10 where I had no such problems with playing mp3/oga files
Hmm, there's probably something wrong with your driver. PA now suppresses its log output if some error is repeating too often, so that /var/ is not flooded (crappy rsyslog does not do log rate limiting by itself...) This probably means that you need to browse a little in syslog for outher PA related output, which might give us a hint which msg might get repeated that often that it is suppressed. Please grep for "pulseaudio" in syslog and attach this here. Which audio driver is this?
Created attachment 383191 [details] grep pulseaudio in /var/log/messages The output from yesterday is from using rhythmbox to play an Internet radio and then mp3/oga. Today nothing was played yet, only rhythmbox was started. from lspci: ----------- 00:1b.0 Audio device: Intel Corporation 82801I (ICH9 Family) HD Audio Controller (rev 02) from lspci -n: -------------- 00:1b.0 0403: 8086:293e (rev 02) lsmod | grep snd: ---------------- snd_hda_codec_realtek 281380 1 snd_hda_intel 30360 2 snd_hda_codec 72832 2 snd_hda_codec_realtek,snd_hda_intel snd_hwdep 9224 1 snd_hda_codec snd_seq 58080 0 snd_seq_device 7620 1 snd_seq snd_pcm 83144 3 saa7134_alsa,snd_hda_intel,snd_hda_codec snd_timer 22608 2 snd_seq,snd_pcm snd 67592 15 saa7134_alsa,snd_hda_codec_realtek,snd_hda_intel,snd_hda_codec,snd_hwdep,snd_seq,snd_seq_device,snd_pcm,snd_timer soundcore 7328 1 snd snd_page_alloc 9568 2 snd_hda_intel,snd_pcm If you need any additional information, please let me know.
Same problem (rhythmbox,quodlibet): lspci -nn ------------ 00:1f.5 Multimedia audio controller [0401]: Intel Corporation 82801DB/DBL/DBM (ICH4/ICH4-L/ICH4-M) AC'97 Audio Controller [8086:24c5] (rev 01) lsmod | grep snd ------------ snd_hda_intel 25096 0 snd_hda_codec 60584 1 snd_hda_intel snd_hwdep 6900 1 snd_hda_codec snd_intel8x0 28148 3 snd_ac97_codec 92136 1 snd_intel8x0 ac97_bus 1424 1 snd_ac97_codec snd_seq 46960 0 snd_seq_device 6232 1 snd_seq snd_pcm 64772 5 snd_hda_intel,snd_hda_codec,snd_intel8x0,snd_ac97_codec snd_timer 17992 2 snd_seq,snd_pcm snd 50908 14 snd_hda_intel,snd_hda_codec,snd_hwdep,snd_intel8x0,snd_ac97_codec,snd_seq,snd_seq_device,snd_pcm,snd_timer soundcore 5672 1 snd snd_page_alloc 7832 3 snd_hda_intel,snd_intel8x0,snd_pcm
If you run PA in a terminal, is the output any more interesting? (to do that set autospawn=false in ~/pulse/client.conf, then stop pa with pulseaudio -k, and then run PA in the terminal as pulseaudio -vvvvv)
(Side note: upstream now knows a new env var that allows us to easily disable log rate limiting for cases like this.)
Created attachment 383523 [details] output of pulseaudio -vvvvv Started pulseaudio -vvvvv, rhythmbox and played one song. The scratches and other defects were produced, but this time no "ratelimit" messages appeared in /var/log/messages. Also no messages were written by pulseaudio on the terminal during the playback. Let me know if I trying for example older (kernel-2.6.30.10-105.fc11.x86_64 is ready) or newer kernel would help.
Please do not compress log file, it makes them very hard to read.
Created attachment 383623 [details] output of pulseaudio -vvvvv I am used to compress attachments when they larger, but I know disk space is cheap. An uncompressed log file now uploaded. For completeness I've tried the F-11 kernel and same audio defects are produced as when running with the F-12 kernel.
pulseaudio-0.9.21-3.fc12 has been submitted as an update for Fedora 12. http://admin.fedoraproject.org/updates/pulseaudio-0.9.21-3.fc12
I've installed the updated pulseaudio packages and the suppressed message is: Jan 15 13:15:05 eagle pulseaudio[2127]: protocol-native.c: Failed to push data into queue I think it will be now appropriate to create a new bug for tracking the actual audio playback defects.
pulseaudio-0.9.21-4.fc12 has been submitted as an update for Fedora 12. http://admin.fedoraproject.org/updates/pulseaudio-0.9.21-4.fc12
pulseaudio-0.9.21-4.fc12 has been pushed to the Fedora 12 testing repository. If problems still persist, please make note of it in this bug report. If you want to test the update, you can install it with su -c 'yum --enablerepo=updates-testing update pulseaudio'. You can provide feedback for this update here: http://admin.fedoraproject.org/updates/F12/FEDORA-2010-0745
After update to pulseaudio-0.9.21-4.fc12 the suppressed messages visible in pulseaudio-0.9.21-3.fc12 disappeared again.
pulseaudio-0.9.21-4.fc12 has been pushed to the Fedora 12 stable repository. If problems still persist, please make note of it in this bug report.
Hi, I have some problems with pulseaudio , sound with defects and a lot of ratelimit.c spam in the log, here some information. Linux station3 2.6.32.11-99.fc12.i686 #1 SMP Mon Apr 5 16:32:08 EDT 2010 i686 i686 i386 GNU/Linux pulseaudio-0.9.21-5.fc12.i686 00:1b.0 Audio device [0403]: Intel Corporation 82801G (ICH7 Family) High Definition Audio Controller [8086:27d8] (rev 01) snd_hda_codec_realtek 197362 1 snd_hda_intel 19811 4 snd_hda_codec 59921 2 snd_hda_codec_realtek,snd_hda_intel snd_hwdep 4868 1 snd_hda_codec snd_seq 42811 0 snd_seq_device 5031 1 snd_seq snd_pcm 60772 3 snd_hda_intel,snd_hda_codec snd_timer 15541 2 snd_seq,snd_pcm snd 46576 15 snd_hda_codec_realtek,snd_hda_intel,snd_hda_codec,snd_hwdep,snd_seq,snd_seq_device,snd_pcm,snd_timer soundcore 4863 1 snd snd_page_alloc 6061 2 snd_hda_intel,snd_pcm May 14 07:45:31 localhost pulseaudio[1636]: ratelimit.c: 1434 events suppressed May 14 07:45:36 localhost pulseaudio[1636]: ratelimit.c: 1872 events suppressed May 14 07:45:41 localhost pulseaudio[1636]: ratelimit.c: 1461 events suppressed May 14 07:45:46 localhost pulseaudio[1636]: ratelimit.c: 1821 events suppressed May 14 07:45:51 localhost pulseaudio[1636]: ratelimit.c: 1513 events suppressed May 14 07:45:56 localhost pulseaudio[1636]: ratelimit.c: 1814 events suppressed May 14 07:46:01 localhost pulseaudio[1636]: ratelimit.c: 1514 events suppressed May 14 07:46:06 localhost pulseaudio[1636]: ratelimit.c: 1826 events suppressed May 14 07:46:11 localhost pulseaudio[1636]: ratelimit.c: 1506 events suppressed May 14 07:46:16 localhost pulseaudio[1636]: ratelimit.c: 1784 events suppressed May 14 07:46:21 localhost pulseaudio[1636]: ratelimit.c: 1560 events suppressed May 14 07:46:26 localhost pulseaudio[1636]: ratelimit.c: 1765 events suppressed May 14 07:46:31 localhost pulseaudio[1636]: ratelimit.c: 1576 events suppressed May 14 07:46:36 localhost pulseaudio[1636]: ratelimit.c: 1761 events suppressed May 14 07:46:41 localhost pulseaudio[1636]: ratelimit.c: 1634 events suppressed May 14 07:46:46 localhost pulseaudio[1636]: ratelimit.c: 1689 events suppressed May 14 07:46:52 localhost pulseaudio[1636]: ratelimit.c: 1132 events suppressed May 14 07:46:57 localhost pulseaudio[1636]: ratelimit.c: 1285 events suppressed May 14 07:47:02 localhost pulseaudio[1636]: ratelimit.c: 911 events suppressed May 14 07:47:07 localhost pulseaudio[1636]: ratelimit.c: 1288 events suppressed May 14 07:47:12 localhost pulseaudio[1636]: ratelimit.c: 911 events suppressed May 14 07:47:17 localhost pulseaudio[1636]: ratelimit.c: 1274 events suppressed May 14 07:47:22 localhost pulseaudio[1636]: ratelimit.c: 928 events suppressed May 14 07:47:27 localhost pulseaudio[1636]: ratelimit.c: 1273 events suppressed May 14 07:47:32 localhost pulseaudio[1636]: ratelimit.c: 921 events suppressed May 14 07:47:37 localhost pulseaudio[1636]: ratelimit.c: 1259 events suppressed May 14 07:47:42 localhost pulseaudio[1636]: ratelimit.c: 938 events suppressed May 14 07:47:47 localhost pulseaudio[1636]: ratelimit.c: 1252 events suppressed May 14 07:47:52 localhost pulseaudio[1636]: ratelimit.c: 944 events suppressed May 14 07:47:57 localhost pulseaudio[1636]: ratelimit.c: 1240 events suppressed May 14 07:48:02 localhost pulseaudio[1636]: ratelimit.c: 944 events suppressed May 14 07:48:07 localhost pulseaudio[1636]: ratelimit.c: 1255 events suppressed May 14 07:48:12 localhost pulseaudio[1636]: ratelimit.c: 939 events suppressed May 14 07:48:17 localhost pulseaudio[1636]: ratelimit.c: 1231 events suppressed May 14 07:48:22 localhost pulseaudio[1636]: ratelimit.c: 950 events suppressed May 14 07:48:27 localhost pulseaudio[1636]: ratelimit.c: 1220 events suppressed May 14 07:48:33 localhost pulseaudio[1636]: ratelimit.c: 910 events suppressed
I want to stress the fact that /var/log/messages on Debian squeeze pulseaudio 0.9.21-3 lists _ONLY_ ratelimit.c messages and no informational messages whatsoever. IMHO this can only be a (rather annoying) BUG. Everywhere else ratelimiting serves the purpose of trimming _additional_ messages after a certain message has already been output. Will continue investigation (via non-daemon spawning etc.) where exactly my driver (azt3328) fails to supply correct information (or perhaps where PA fails to interpret things correctly).
What follows now is quite off-topic, but I have to vent somewhere. Frankly I'm rather miffed at the relatively immature appearance of the subsystem that I'm seeing after about an hour of tribulations. I've got a PC with a multitude of soundcards, and the _VERY LAST_ thing I would have wanted to see is yet another sound system which has yet another huge amount of issues telling apart sound cards. Yet that's just exactly what pavucontrol seems to dare try forcing upon me: If I go to "Output Devices" tab, then I really do not want to see "Internes Audio Analog Stereo" a friggin three times, for each - VERY DISTINCT - audio device that there is (azt3328, via8233, als4000), and to make matters worse with no identification possibility at some advanced info either. Plus, trying to reroute playback (on the Playback tab) is damn near impossible on my Athlon due to excess activity of the interactive playback volume slider (somehow slider activity appears to always bogusly re-set the mouse context menu selection of the listbox that gets displayed for playback hardware choice). I have to do a workaround by actively _SUSPENDING_ the playback application (mpg321 in my case) in order to finally peacefully switch the listbox between cards (this could be GTK listbox control issues, however; from wxWidgets experience I know that [de-]selection handling of some GTK controls is problematic and may need some extra care). We're now rather near the end of 2010, that's almost 4 years after the very unfortunate release of u8.04 with it's - from hearsay - multitudes of PA beta issues (premature force-feeding not PA's fault though). A long time since, and at least in the areas I'm checking out I'm left wondering (on an up-to-date Debian squeeze, using pavucontrol 0.9.9-1). I could live with a single slider bug, but slider issue plus lack of ESSENTIAL MULTI-DEVICE support is too much for me. I wanted to check out PA to see whether all my cards work fine and fix any remaining driver issues (at least azt3328 does exhibit some), but I'm currently quite a lot less feeling like doing that, due to the extra miles for getting this stubborn beast to work. Oh well, sound subsystems appear to be an overly complex topic after all...