On 11/26/12 16:42, Henrik /KaarPoSoft wrote: > Tanu, again: Thanks for your help. > > I tried the patch and various other changes to log.c, but getting no > useful logging, and sometimes segfaults instead (as you also noted). > > My mind kept coming back to this: > > ldd /bin/gnome-shell | grep pulse > libpulse-mainloop-glib.so.0 => //lib/libpulse-mainloop-glib.so.0 > (0xb5771000) > libpulse.so.0 => //lib/libpulse.so.0 (0xb5723000) > libpulsecommon-2.1.so => //lib/pulseaudio/libpulsecommon-2.1.so > (0xb56b7000) > libpulsecommon-2.99.so => //lib/pulseaudio/libpulsecommon-2.99.so > (0xb4da6000) > > So, I deleted every file installed by the original pulseaudio 2.1, > recompiled+installed pulseaudio 2.99.2, and recompiled+installed > gnome-shell. > > Now I have: > > ldd /bin/gnome-shell | grep pulse > libpulse-mainloop-glib.so.0 => //lib/libpulse-mainloop-glib.so.0 > (0xb56e3000) > libpulse.so.0 => //lib/libpulse.so.0 (0xb5695000) > libpulsecommon-2.99.so => //lib/pulseaudio/libpulsecommon-2.99.so > (0xb5620000) > > (A quick look at gnome-shell source did not reveal why it would link > to an old version; I must have a closer look at this later). > > And the good news: > Now the clients (incl gnome-shell) are showing the "Received opcode" > in ~/.xsession-errors (presumably because they log to stderr which is > redirected to ~/.xsession-errors). > > And the even better news: > I have tried to recreate the freeze without success. > So, maybe 2.99.2 solved the original problem after all. > > However, I am still having some trouble... > > Syslog show as lot (about 5/sec to 10/sec) entries like: > Nov 26 16:31:04 kx8400-5 pulseaudio[2078]: (1745.440| 0.057) > [pulseaudio] pdispatch.c: [0x9ee32f0] Received opcode > <GET_PLAYBACK_LATENCY>, tag 1088 > And ~/.xsession-errors shows the corresponding > Received opcode <REPLY> > > I am not sure if this is a problem or not, but previously I did not > notice such pulseaudio bursts in syslog. > > Further thunderbird crashes every now and then (maybe not related, but > it never did that before), > and sometimes the terminal does not beep as expected. > > For the latter case (terminal does not beep as expected) I have this > in syslog: > [...] It seems that more apps / libraries depend on libpulsecommon-2.1.so which has now been removed (as 2.99.2 has been installed instead). So, I tried to identify every lib/app dependent on pulseaudio, and have now recompiled+reinstalled: gnome-shell alsa-plugins libcanberra gst-plugins-good gnome-control-center gnome-settings-daemon gtk-vnc empathy Now I am *not* able to recreate this hang: open gnome-terminal (as only app on desktop), press backspace, close terminal. However, this seems to hang every time: open gnome-terminal, press backspace twice to get two beeps. open firefox, play html5 video on youtube, close firefox. close gnome-terminal (which is now last app on desktop). Now the desktop is frozen. The last 40 lines of .xsession-errors: ---------------------------------------- [0x9e6df4f0] Received opcode <REQUEST>, tag 4294967295 [0x9e6df4f0] Received opcode <REQUEST>, tag 4294967295 [0x9e6df4f0] Received opcode <REQUEST>, tag 4294967295 [0x9e6df4f0] Received opcode <REQUEST>, tag 4294967295 [0x9e6df4f0] Received opcode <REQUEST>, tag 4294967295 [0x9e6df4f0] Received opcode <REQUEST>, tag 4294967295 [0x9e6df4f0] Received opcode <REQUEST>, tag 4294967295 [0xb2406210] Received opcode <SUBSCRIBE_EVENT>, tag 4294967295 [0x877c6e0] Received opcode <SUBSCRIBE_EVENT>, tag 4294967295 [0x9e6df4f0] Received opcode <REPLY>, tag 25 [0x9e6df4f0] Received opcode <REPLY>, tag 26 [0xa643cd8] Received opcode <SUBSCRIBE_EVENT>, tag 4294967295 [0x9e6df4f0] Received opcode <REPLY>, tag 27 [0x877c6e0] Received opcode <SUBSCRIBE_EVENT>, tag 4294967295 [0x9e6df4f0] Received opcode <REPLY>, tag 28 [0x877c6e0] Received opcode <REPLY>, tag 35 [0x877c6e0] Received opcode <REPLY>, tag 36 [0xa643cd8] Received opcode <SUBSCRIBE_EVENT>, tag 4294967295 [0x9e6df4f0] Received opcode <REPLY>, tag 29 [0xa643cd8] Received opcode <REPLY>, tag 26 [0xa643cd8] Received opcode <REPLY>, tag 27 [0x9e6df4f0] Received opcode <REPLY>, tag 30 [0x9e6df4f0] Received opcode <REPLY>, tag 31 [0x9e6df4f0] Received opcode <REPLY>, tag 32 [0x9e6df4f0] Received opcode <REPLY>, tag 33 [0x9e6df4f0] Received opcode <REPLY>, tag 34 [0x9e6df4f0] Received opcode <REPLY>, tag 35 [0x9e6df4f0] Received opcode <REPLY>, tag 36 [0x9e6df4f0] Received opcode <REPLY>, tag 37 [0x9e6df4f0] Received opcode <REPLY>, tag 38 [0xb2406210] Received opcode <SUBSCRIBE_EVENT>, tag 4294967295 [0x877c6e0] Received opcode <SUBSCRIBE_EVENT>, tag 4294967295 [0x877c6e0] Received opcode <SUBSCRIBE_EVENT>, tag 4294967295 [0xa643cd8] Received opcode <SUBSCRIBE_EVENT>, tag 4294967295 [0xa643cd8] Received opcode <SUBSCRIBE_EVENT>, tag 4294967295 [0xb2406210] Received opcode <ERROR>, tag 9 [0x877c6e0] Received opcode <SUBSCRIBE_EVENT>, tag 4294967295 [0x877c6e0] Received opcode <SUBSCRIBE_EVENT>, tag 4294967295 [0x877c6e0] Received opcode <REPLY>, tag 37 [0x877c6e0] Received opcode <REPLY>, tag 38 ---------------------------------------- The last 20 lines of syslog matching grep 'Received opcode' ---------------------------------------- Nov 28 02:05:54 kx8400-5 pulseaudio[2064]: ( 52.665| 0.001) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 27 Nov 28 02:05:54 kx8400-5 pulseaudio[2064]: ( 52.675| 0.009) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x8666228] Received opcode <GET_SINK_INPUT_INFO>, tag 35 Nov 28 02:05:54 kx8400-5 pulseaudio[2064]: ( 52.676| 0.001) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x86812c0] Received opcode <GET_SINK_INPUT_INFO>, tag 26 Nov 28 02:05:54 kx8400-5 pulseaudio[2064]: ( 52.677| 0.001) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 28 Nov 28 02:05:54 kx8400-5 pulseaudio[2064]: ( 52.678| 0.001) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x8666228] Received opcode <GET_SINK_INFO>, tag 36 Nov 28 02:05:54 kx8400-5 pulseaudio[2064]: ( 52.694| 0.015) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 29 Nov 28 02:05:54 kx8400-5 pulseaudio[2064]: ( 52.705| 0.011) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x86812c0] Received opcode <GET_SINK_INFO>, tag 27 Nov 28 02:05:54 kx8400-5 pulseaudio[2064]: ( 52.734| 0.029) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 30 Nov 28 02:05:54 kx8400-5 pulseaudio[2064]: ( 52.815| 0.081) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 31 Nov 28 02:05:54 kx8400-5 pulseaudio[2064]: ( 52.976| 0.160) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 32 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.297| 0.320) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 33 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.325| 0.028) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 34 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.327| 0.001) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <CORK_PLAYBACK_STREAM>, tag 35 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.327| 0.000) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 36 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.328| 0.000) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 37 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.328| 0.000) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <FLUSH_PLAYBACK_STREAM>, tag 38 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.328| 0.000) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 39 Nov 28 02:05:56 kx8400-5 pulseaudio[2064]: ( 54.319| 0.052) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x86828d8] Received opcode <PLAY_SAMPLE>, tag 9 Nov 28 02:06:00 kx8400-5 pulseaudio[2064]: ( 58.343| 0.000) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x8666228] Received opcode <GET_SINK_INFO>, tag 37 Nov 28 02:06:00 kx8400-5 pulseaudio[2064]: ( 58.343| 0.000) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x8666228] Received opcode <GET_SOURCE_INFO>, tag 38 ---------------------------------------- So it would seem that tag 39 is received by pulseaudio daemon, but the response not received by the client (presumably gnome-shell) (note that there seems to be two clients both now using the 30-40 range of tags) Last lines of syslog: ---------------------------------------- Nov 28 02:05:54 kx8400-5 pulseaudio[2064]: ( 52.705| 0.011) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x86812c0] Received opcode <GET_SINK_INFO>, tag 27 Nov 28 02:05:54 kx8400-5 pulseaudio[2064]: ( 52.734| 0.029) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 30 Nov 28 02:05:54 kx8400-5 pulseaudio[2064]: ( 52.815| 0.081) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 31 Nov 28 02:05:54 kx8400-5 pulseaudio[2064]: ( 52.976| 0.160) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 32 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.297| 0.320) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 33 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.325| 0.028) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 34 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.327| 0.001) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <CORK_PLAYBACK_STREAM>, tag 35 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.327| 0.000) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 36 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.328| 0.000) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 37 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.328| 0.000) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <FLUSH_PLAYBACK_STREAM>, tag 38 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.328| 0.000) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x868dcc8] Received opcode <GET_PLAYBACK_LATENCY>, tag 39 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.329| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:963 update_sw_params()] hwbuf_unused=0 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.329| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:975 update_sw_params()] setting avail_min=15502 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.329| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:1315 sink_set_volume_cb()] Requested volume: 0: 71% 1: 71% Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.329| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:1316 sink_set_volume_cb()] in dB: 0: -9.00 dB 1: -9.00 dB Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.329| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:1317 sink_set_volume_cb()] Got hardware volume: 0: 71% 1: 71% Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.329| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:1318 sink_set_volume_cb()] in dB: 0: -9.00 dB 1: -9.00 dB Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.329| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:1321 sink_set_volume_cb()] Calculated software volume: 0: 100% 1: 100% (accurate-enough=yes) Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.333| 0.003) [alsa-sink][modules/alsa/alsa-sink.c:1322 sink_set_volume_cb()] in dB: 0: 0.00 dB 1: 0.00 dB Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.333| 0.000) [alsa-sink][pulsecore/sink.c:3539 pa_sink_volume_change_push()] Volume not changing Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.333| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:1619 process_rewind()] Requested to rewind 65536 bytes. Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.333| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:1642 process_rewind()] Limited to 7236 bytes. Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.334| 0.001) [alsa-sink][modules/alsa/alsa-sink.c:1645 process_rewind()] before: 1809 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.336| 0.001) [alsa-sink][modules/alsa/alsa-sink.c:1653 process_rewind()] after: 1744 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.337| 0.001) [alsa-sink][modules/alsa/alsa-sink.c:1661 process_rewind()] Rewound 6976 bytes. Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.339| 0.001) [alsa-sink][pulsecore/sink.c:942 pa_sink_process_rewind()] Processing rewind... Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.340| 0.001) [alsa-sink][pulsecore/sink.c:3656 pa_sink_volume_change_rewind()] latency = 0 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.361| 0.021) [alsa-sink][pulsecore/source.c:874 pa_source_process_rewind()] Processing rewind... Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.333| 0.000) [pulseaudio][modules/module-suspend-on-idle.c:120 restart()] Sink alsa_output.pci-0000_00_1e.2.analog-stereo becomes idle, timeout in 5 seconds. Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.363| 0.001) [pulseaudio][pulsecore/core.c:256 pa_core_maybe_vacuum()] Hmm, no streams around, trying to vacuum. Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.385| 0.021) [pulseaudio][pulsecore/client.c:102 pa_client_free()] Freed 10 "ALSA plug-in [xulrunner]" Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.386| 0.001) [pulseaudio][pulsecore/protocol-native.c:4864 pstream_die_callback()] Connection died. Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.389| 0.003) [pulseaudio][pulsecore/protocol-dbus.c:844 pa_dbus_protocol_remove_interface()] Interface org.PulseAudio.Core1.Stream removed from object /org/pulseaudio/core1/playback_stream2 Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.391| 0.001) [pulseaudio][pulsecore/sink-input.c:675 sink_input_free()] Freeing input 2 "ALSA Playback" Nov 28 02:05:55 kx8400-5 pulseaudio[2064]: ( 53.392| 0.001) [pulseaudio][pulsecore/protocol-dbus.c:844 pa_dbus_protocol_remove_interface()] Interface org.PulseAudio.Core1.Client removed from object /org/pulseaudio/core1/client10 Nov 28 02:05:56 kx8400-5 pulseaudio[2064]: ( 54.267| 0.874) [alsa-sink][modules/alsa/alsa-sink.c:1831 thread_func()] Wakeup from ALSA! Nov 28 02:05:56 kx8400-5 pulseaudio[2064]: ( 54.267| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:468 check_left_to_play()] Underrun! Nov 28 02:05:56 kx8400-5 pulseaudio[2064]: ( 54.267| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:332 increase_watermark()] Increasing wakeup watermark to 30.00 ms Nov 28 02:05:56 kx8400-5 pulseaudio[2064]: ( 54.319| 0.052) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x86828d8] Received opcode <PLAY_SAMPLE>, tag 9 Nov 28 02:05:57 kx8400-5 pulseaudio[2064]: ( 55.753| 1.433) [alsa-sink][modules/alsa/alsa-sink.c:1831 thread_func()] Wakeup from ALSA! Nov 28 02:05:57 kx8400-5 pulseaudio[2064]: ( 55.753| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:468 check_left_to_play()] Underrun! Nov 28 02:05:57 kx8400-5 pulseaudio[2064]: ( 55.753| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:332 increase_watermark()] Increasing wakeup watermark to 40.00 ms Nov 28 02:05:58 kx8400-5 pulseaudio[2064]: ( 56.496| 0.742) [alsa-sink][modules/alsa/alsa-sink.c:1831 thread_func()] Wakeup from ALSA! Nov 28 02:05:58 kx8400-5 pulseaudio[2064]: ( 56.496| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:468 check_left_to_play()] Underrun! Nov 28 02:05:58 kx8400-5 pulseaudio[2064]: ( 56.496| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:332 increase_watermark()] Increasing wakeup watermark to 50.00 ms Nov 28 02:05:59 kx8400-5 pulseaudio[2064]: ( 57.611| 1.114) [alsa-sink][modules/alsa/alsa-sink.c:1831 thread_func()] Wakeup from ALSA! Nov 28 02:05:59 kx8400-5 pulseaudio[2064]: ( 57.611| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:468 check_left_to_play()] Underrun! Nov 28 02:05:59 kx8400-5 pulseaudio[2064]: ( 57.611| 0.000) [alsa-sink][modules/alsa/alsa-sink.c:332 increase_watermark()] Increasing wakeup watermark to 60.00 ms Nov 28 02:06:00 kx8400-5 pulseaudio[2064]: ( 58.337| 0.726) [pulseaudio][modules/module-suspend-on-idle.c:91 timeout_cb()] Sink alsa_output.pci-0000_00_1e.2.analog-stereo idle for too long, suspending ... Nov 28 02:06:00 kx8400-5 pulseaudio[2064]: ( 58.337| 0.000) [pulseaudio][pulsecore/sink.c:854 pa_sink_suspend()] Suspend cause of sink alsa_output.pci-0000_00_1e.2.analog-stereo is 0x0004, suspending Nov 28 02:06:00 kx8400-5 pulseaudio[2064]: ( 58.341| 0.004) [alsa-sink][modules/alsa/alsa-sink.c:926 suspend()] Device suspended... Nov 28 02:06:00 kx8400-5 pulseaudio[2064]: ( 58.341| 0.000) [pulseaudio][pulsecore/core.c:256 pa_core_maybe_vacuum()] Hmm, no streams around, trying to vacuum. Nov 28 02:06:00 kx8400-5 pulseaudio[2064]: ( 58.342| 0.000) [pulseaudio][modules/reserve-wrap.c:243 change_cb()] Device lock status of reserve-monitor-wrapper at Audio0 changed: not busy Nov 28 02:06:00 kx8400-5 pulseaudio[2064]: ( 58.342| 0.000) [pulseaudio][modules/module-udev-detect.c:287 verify_access()] /dev/snd/controlC0 is accessible: yes Nov 28 02:06:00 kx8400-5 pulseaudio[2064]: ( 58.343| 0.000) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x8666228] Received opcode <GET_SINK_INFO>, tag 37 Nov 28 02:06:00 kx8400-5 pulseaudio[2064]: ( 58.343| 0.000) [pulseaudio][pulsecore/pdispatch.c:318 pa_pdispatch_run()] [0x8666228] Received opcode <GET_SOURCE_INFO>, tag 38 Nov 28 02:11:08 kx8400-5 pulseaudio[2064]: ( 366.870| 308.526) [pulseaudio][modules/module-udev-detect.c:287 verify_access()] /dev/snd/controlC0 is accessible: yes ---------------------------------------- As I am quite new to pulseaudio, I have no clue how to interpret the logs. Any help would be most appreciated. /Henrik