[Bug 692953] alsa modules are silent or noisy after several hours of use
GStreamer (bugzilla.gnome.org)
bugzilla at gnome.org
Thu Aug 22 09:51:54 PDT 2013
https://bugzilla.gnome.org/show_bug.cgi?id=692953
GStreamer | gst-plugins-base | 1.0.6
--- Comment #42 from Thomas DEBESSE <thomas.debesse at rcf.fr> 2013-08-22 16:51:48 UTC ---
(Sorry for the french output in logs)
If I "grep -v" the lines that are normally printed when all is ok I got this :
[Before this line, some init (manually filtered)]
----8<------------------------------------------
0:00:01.010961951 26625 0x1487800 DEBUG GST_BUS
gstbus.c:977:poll_func: mainloop 0x1667c30 quit
0:00:01.010970276 26625 0x1487800 DEBUG GST_BUS
gstbus.c:776:gst_bus_source_dispatch:<bus1> source 0x1652d40 handler returns 1
0:00:01.010977012 26625 0x1487800 DEBUG GST_BUS
gstbus.c:1087:gst_bus_poll: mainloop stopped 0x1667c30
0:00:01.010982794 26625 0x1487800 DEBUG GST_BUS
gstbus.c:1332:gst_bus_remove_signal_watch:<bus1> removing signal watch 37
0:00:01.010989419 26625 0x1487800 DEBUG GST_BUS
gstbus.c:797:gst_bus_source_finalize:<bus1> finalize source 0x1652d40
0:00:01.010997014 26625 0x1487800 DEBUG GST_BUS
gstbus.c:1100:gst_bus_poll:<bus1> finished poll with message 0x7f8b24002bb0
0:00:01.011009960 26625 0x1487800 DEBUG GST_BUS
gstbus.c:874:gst_bus_add_watch_full_unlocked:<bus1> New source 0x1652d40 with
id 38
0:00:01.011015432 26625 0x1487800 DEBUG GST_BUS
gstbus.c:1085:gst_bus_poll: running mainloop 0x1669b50
----8<------------------------------------------
[Here the normal output begin (filtered by grep)]
----8<------------------------------------------
1:39:18.548386467 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
1:39:18.548478614 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
1:39:18.548444919 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
1:39:18.548522986 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
----8<------------------------------------------
[↑↑↑↑↑ first xrun, just a little silence, the sound comes back (computer
overloaded ?)]
----8<------------------------------------------
5:11:46.754841692 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
5:11:46.754985448 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
5:11:46.755004859 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
5:11:46.755006648 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
----8<------------------------------------------
[↑↑↑↑↑ second xrun, just a little silence, the sound comes back (computer
overloaded ?)]
----8<------------------------------------------
8:49:45.691399650 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
8:49:45.691438249 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
8:49:45.691451177 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
8:49:45.691725109 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
----8<------------------------------------------
[↑↑↑↑↑ third xrun, just a little silence, the sound comes back (computer
overloaded ?)]
----8<------------------------------------------
10:10:09.780821374 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
10:10:09.780871631 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
10:10:09.780879167 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
10:10:09.780811676 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
----8<------------------------------------------
[↑↑↑↑↑ fourth xrun, just a little silence, the sound comes back (computer
overloaded ?)]
----8<------------------------------------------
11:34:43.663271577 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
11:34:43.663336178 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
11:34:43.663343045 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
11:34:43.663423626 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
----8<------------------------------------------
[↑↑↑↑↑ fifth xrun, just a little silence, the sound comes back (computer
overloaded ?)]
----8<------------------------------------------
14:28:48.792458775 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
14:28:48.792510714 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
14:28:48.792572219 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
14:28:48.792593378 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
----8<------------------------------------------
[↑↑↑↑↑ sixth xrun, a little silence then the sound comes back for only one
second]
----8<------------------------------------------
14:29:18.561641218 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
14:29:18.561620176 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
14:29:18.561691630 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
14:29:18.561746935 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
----8<------------------------------------------
[↑↑↑↑↑ seventh xrun, a little silence then the sound comes back for only one
second]
----8<------------------------------------------
14:37:02.081587565 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
14:37:02.081590217 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
14:37:02.081647110 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
14:37:02.081663490 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
----8<------------------------------------------
[↑↑↑↑↑ eight xrun, silence, the sound never comes back]
----8<------------------------------------------
14:37:09.653318664 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
14:37:09.653356667 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
14:37:09.653379130 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
14:37:09.653389271 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
14:37:39.391359336 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
14:37:39.391426380 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
14:37:39.391566483 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
14:37:39.391580180 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
14:37:51.609751820 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
14:37:51.609767869 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
14:37:51.609840609 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
14:37:51.609880816 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
14:38:07.080395430 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
14:38:07.080340839 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
14:38:07.080532913 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
14:38:07.080543652 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
14:38:14.702682538 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
14:38:14.702752311 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
14:38:14.702791369 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
14:38:14.702816161 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
14:38:26.766826905 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
14:38:26.766843180 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
14:38:26.766856321 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
14:38:26.773252846 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
14:38:49.100970619 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
14:38:49.101167862 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
14:38:49.101205932 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
14:38:49.101226340 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
14:39:06.039074866 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
14:39:06.039121976 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
14:39:06.039206224 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
14:39:06.039308589 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
14:39:13.460915390 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
14:39:13.460942043 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
14:39:13.460956710 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
14:39:13.461264641 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
14:39:28.997048359 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
14:39:28.997113305 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
14:39:28.997261885 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
14:39:28.997287389 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
14:39:44.134017322 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1014:gst_alsasink_write:<alsasink0> wait error, -32
14:39:44.134077422 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:1023:gst_alsasink_write:<alsasink0> Write error: Relais brisé
(pipe)
14:39:44.134094772 26625 0x7f8b2c003a30 DEBUG alsa
gstalsasink.c:960:xrun_recovery:<alsasink0> xrun recovery -32: Erreur inconnue
-32
14:39:44.134140042 26625 0x7f8b2c003630 DEBUG alsa
gstalsasrc.c:808:xrun_recovery:<alsasrc0> xrun recovery -32: Erreur inconnue
-32
----8<------------------------------------------
[endlessly]
This is my grep filter (exclusion) :
===========================================
GST_ELEMENT_PADS gstelement.c:
GST_INIT gst.c:
GST_INIT gstmessage.c:
GST_MEMORY gstmemory.c:
GST_MEMORY gstallocator.c
GST_PLUGIN_LOADING gstplugin.c:
GST_REFCOUNTING gstobject.c:
GST_REGISTRY gstregistry.c:
GST_REGISTRY gstregistrybinary.c
GST_REGISTRY gstregistrychunks.c:
structure gststructure.c:
alsa gstalsasink.c:1021:
audiobasesink gstaudiobasesink.c:1664:
audiobasesink gstaudiobasesink.c:1701:
audiobasesink gstaudiobasesink.c:1751:
audiobasesink gstaudiobasesink.c:1885:
audiobasesink gstaudiobasesink.c:1896:
audiobasesink gstaudiobasesink.c:1928:
audiobasesrc gstaudiobasesrc.c:721:
audiobasesrc gstaudiobasesrc.c:744:
audiobasesrc gstaudiobasesrc.c:799:
audiobasesrc gstaudiobasesrc.c:821:
basesink gstbasesink.c:1803:
basesink gstbasesink.c:3168:
basesink gstbasesink.c:3209:
basesink gstbasesink.c:3248:
basesrc gstbasesrc.c:2213:
basesrc gstbasesrc.c:2351:
basesrc gstbasesrc.c:2414:
queue_dataflow gstqueue.c:1149:
queue_dataflow gstqueue.c:1161:
ringbuffer gstaudioringbuffer.c:1281:
ringbuffer gstaudioringbuffer.c:1490:
ringbuffer gstaudioringbuffer.c:1521:
ringbuffer gstaudioringbuffer.c:1547:
ringbuffer gstaudioringbuffer.c:1708:
ringbuffer gstaudioringbuffer.c:1733:
ringbuffer gstaudioringbuffer.c:1761:
ringbuffer gstaudioringbuffer.c:1851:
ringbuffer gstaudioringbuffer.c:1966:
===========================================
The last lines are supposedly (but faster filtered) equivalent to:
===========================================
alsa gstalsasink.c:1021:gst_alsasink_write:<alsasink0>ESC\[00m written 384
frames out of 384
audiobasesink
gstaudiobasesink.c:1664:gst_audio_base_sink_render:<alsasink0>ESC\[00m time
audiobasesink
gstaudiobasesink.c:1701:gst_audio_base_sink_render:<alsasink0>ESC\[00m
sync-offset
audiobasesink
gstaudiobasesink.c:1751:gst_audio_base_sink_render:<alsasink0>ESC\[00m no sync
needed. Using render_start=
audiobasesink
gstaudiobasesink.c:1885:gst_audio_base_sink_render:<alsasink0>ESC\[00m
rendering at
audiobasesink
gstaudiobasesink.c:1896:gst_audio_base_sink_render:<alsasink0>ESC\[00m wrote
384 of 384
audiobasesink
gstaudiobasesink.c:1928:gst_audio_base_sink_render:<alsasink0>ESC\[00m next
sample expected at
audiobasesrc
gstaudiobasesrc.c:721:gst_audio_base_src_get_offset:<alsasrc0>ESC\[00m at
segment
audiobasesrc
gstaudiobasesrc.c:744:gst_audio_base_src_get_offset:<alsasrc0>ESC\[00m reading
from
audiobasesrc gstaudiobasesrc.c:799:gst_audio_base_src_create:<alsasrc0>ESC\[00m
reading from sample
audiobasesrc gstaudiobasesrc.c:821:gst_audio_base_src_create:<alsasrc0>ESC\[00m
read
basesink gstbasesink.c:1803:gst_base_sink_get_sync_times:<alsasink0>ESC\[00m
got times start:
basesink gstbasesink.c:3168:gst_base_sink_chain_unlocked:<alsasink0>ESC\[00m
got times start:
basesink gstbasesink.c:3209:gst_base_sink_chain_unlocked:<alsasink0>ESC\[00m
rendering object
basesink gstbasesink.c:3248:gst_base_sink_chain_unlocked:<alsasink0>ESC\[00m
object unref after render
basesrc gstbasesrc.c:2213:gst_base_src_do_sync:<alsasrc0>ESC\[00m no sync
needed
basesrc gstbasesrc.c:2351:gst_base_src_get_range:<alsasrc0>ESC\[00m calling
create offset
basesrc gstbasesrc.c:2414:gst_base_src_get_range:<alsasrc0>ESC\[00m buffer ok
queue_dataflow gstqueue.c:1149:gst_queue_loop:<queue0>ESC\[00m queue is empty
queue_dataflow gstqueue.c:1161:gst_queue_loop:<queue0>ESC\[00m queue is not
empty
ringbuffer gstaudioringbuffer.c:1281:wait_segment:<audiosrcringbuffer0>ESC\[00m
waiting..
ringbuffer gstaudioringbuffer.c:1490:default_commit:ESC\[00m pointer at
ringbuffer
gstaudioringbuffer.c:1521:default_commit:<audiosinkringbuffer0>ESC\[00m write
ringbuffer gstaudioringbuffer.c:1547:default_commit:ESC\[00m copy 1536 bytes
ringbuffer gstaudioringbuffer.c:1708:gst_audio_ring_buffer_read:ESC\[00m
pointer at
ringbuffer
gstaudioringbuffer.c:1733:gst_audio_ring_buffer_read:<audiosrcringbuffer0>ESC\[00m
read
ringbuffer
gstaudioringbuffer.c:1761:gst_audio_ring_buffer_read:<audiosrcringbuffer0>ESC\[00m
Retrieved timestamp
ringbuffer
gstaudioringbuffer.c:1851:gst_audio_ring_buffer_advance:<audiosrcringbuffer0>ESC\[00m
signal waiter
ringbuffer
gstaudioringbuffer.c:1966:gst_audio_ring_buffer_set_timestamp:<audiosrcringbuffer0>ESC\[00m
Storing timestamp 99:99:99.999999999 @
===========================================
--
Configure bugmail: https://bugzilla.gnome.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are the QA contact for the bug.
You are the assignee for the bug.
More information about the gstreamer-bugs
mailing list