Attachment 78833 Details for Bug 58758 – Debug log as requested in comment above

Debug log as requested in comment above

pulseaudio-debuglog-58758.txt (text/plain), 17.46 KB, created by Matthew Cope on 2013-05-04 08:37:45 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Matthew Cope

Created: 2013-05-04 08:37:45 UTC

Size: 17.46 KB

patch

obsolete

>May  2 19:30:51 debian pulseaudio[13531]: (   0.000|   0.000) [pulseaudio] main.c: setrlimit(RLIMIT_NICE, (31, 31)) failed: Operation not permitted
>May  2 19:30:51 debian pulseaudio[13531]: (   0.000|   0.000) [pulseaudio] main.c: setrlimit(RLIMIT_RTPRIO, (9, 9)) failed: Operation not permitted
>May  2 19:30:51 debian pulseaudio[13531]: (   0.006|   0.000) [pulseaudio] core-util.c: Successfully gained nice level -11.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.006|   0.000) [pulseaudio] main.c: This is PulseAudio 2.0
>May  2 19:30:51 debian pulseaudio[13531]: (   0.006|   0.000) [pulseaudio] main.c: Page size is 4096 bytes
>May  2 19:30:51 debian pulseaudio[13531]: (   0.007|   0.000) [pulseaudio] main.c: Machine ID is ${my_machine-id}.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.007|   0.000) [pulseaudio] main.c: Session ID is ${my_machine-id}-1367519441.355754-46751455.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.007|   0.000) [pulseaudio] main.c: Using runtime directory /home/matt/.pulse/${my_machine-id}-runtime.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.007|   0.000) [pulseaudio] main.c: Using state directory /home/matt/.pulse.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.007|   0.000) [pulseaudio] main.c: Using modules directory /usr/lib/pulse-2.0/modules.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.007|   0.000) [pulseaudio] main.c: Running in system mode: no
>May  2 19:30:51 debian pulseaudio[13531]: (   0.007|   0.000) [pulseaudio] pid.c: Stale PID file, overwriting.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.007|   0.000) [pulseaudio] main.c: Fresh high-resolution timers available! Bon appetit!
>May  2 19:30:51 debian pulseaudio[13531]: (   0.008|   0.000) [pulseaudio] cpu-x86.c: CPU flags: CMOV MMX SSE SSE2 SSE3 SSSE3 SSE4_1 
>May  2 19:30:51 debian pulseaudio[13531]: (   0.008|   0.000) [pulseaudio] svolume_mmx.c: Initialising MMX optimized volume functions.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.008|   0.000) [pulseaudio] remap_mmx.c: Initialising MMX optimized remappers.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.008|   0.000) [pulseaudio] svolume_sse.c: Initialising SSE2 optimized volume functions.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.008|   0.000) [pulseaudio] remap_sse.c: Initialising SSE2 optimized remappers.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.008|   0.000) [pulseaudio] sconv_sse.c: Initialising SSE2 optimized conversions.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.008|   0.000) [pulseaudio] svolume_orc.c: Initialising ORC optimized volume functions.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.009|   0.000) [pulseaudio] module-device-restore.c: Successfully opened database file '/home/matt/.pulse/${my_machine-id}-device-volumes'.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.009|   0.000) [pulseaudio] module.c: Loaded "module-device-restore" (index: #0; argument: "").
>May  2 19:30:51 debian pulseaudio[13531]: (   0.010|   0.000) [pulseaudio] module-stream-restore.c: Successfully opened database file '/home/matt/.pulse/${my_machine-id}-stream-volumes'.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.012|   0.000) [pulseaudio] module.c: Loaded "module-stream-restore" (index: #1; argument: "").
>May  2 19:30:51 debian pulseaudio[13531]: (   0.013|   0.000) [pulseaudio] module-card-restore.c: Successfully opened database file '/home/matt/.pulse/${my_machine-id}-card-database'.
>May  2 19:30:51 debian pulseaudio[13531]: (   0.013|   0.000) [pulseaudio] module.c: Loaded "module-card-restore" (index: #2; argument: "").
>May  2 19:30:51 debian pulseaudio[13531]: (   0.013|   0.000) [pulseaudio] module.c: Loaded "module-augment-properties" (index: #3; argument: "").
>May  2 19:30:51 debian pulseaudio[13531]: (   0.029|   0.000) [pulseaudio] alsa-util.c: Failed to set hardware parameters on plug:hw:0: Invalid argument
>May  2 19:30:51 debian pulseaudio[13531]: (   0.030|   0.000) [pulseaudio] alsa-util.c: Failed to set hardware parameters on plug:hw:0: Invalid argument
>May  2 19:30:51 debian pulseaudio[13531]: (   0.033|   0.000) [pulseaudio] alsa-util.c: Failed to set hardware parameters on plug:hw:0: Invalid argument
>May  2 19:30:51 debian pulseaudio[13531]: (   0.035|   0.000) [pulseaudio] alsa-util.c: Failed to set hardware parameters on plug:hw:0: Invalid argument
>May  2 19:30:51 debian pulseaudio[13531]: (   0.053|   0.000) [pulseaudio] (alsa-lib)control.c: Invalid CTL front:0
>May  2 19:30:51 debian pulseaudio[13531]: (   0.053|   0.000) [pulseaudio] alsa-util.c: Unable to attach to mixer front:0: No such file or directory
>May  2 19:30:51 debian pulseaudio[13531]: (   0.053|   0.000) [pulseaudio] alsa-util.c: Successfully attached to mixer 'hw:0'
>May  2 19:30:51 debian pulseaudio[13528]: (   0.000|   0.000) [pulseaudio] main.c: Daemon startup successful.
>May  2 19:30:55 debian pulseaudio[13583]: (   0.000|   0.000) [pulseaudio] main.c: setrlimit(RLIMIT_NICE, (31, 31)) failed: Operation not permitted
>May  2 19:30:55 debian pulseaudio[13583]: (   0.002|   0.002) [pulseaudio] main.c: setrlimit(RLIMIT_RTPRIO, (9, 9)) failed: Operation not permitted
>May  2 19:30:55 debian pulseaudio[13583]: (   0.012|   0.000) [pulseaudio] core-util.c: Successfully gained nice level -11.
>May  2 19:30:55 debian pulseaudio[13583]: (   0.012|   0.000) [pulseaudio] main.c: This is PulseAudio 2.0
>May  2 19:30:55 debian pulseaudio[13583]: (   0.012|   0.000) [pulseaudio] main.c: Page size is 4096 bytes
>May  2 19:30:55 debian pulseaudio[13583]: (   0.013|   0.000) [pulseaudio] main.c: Machine ID is ${my_machine-id}.
>May  2 19:30:55 debian pulseaudio[13583]: (   0.013|   0.000) [pulseaudio] main.c: Session ID is ${my_machine-id}-1367519441.355754-46751455.
>May  2 19:30:55 debian pulseaudio[13583]: (   0.013|   0.000) [pulseaudio] main.c: Using runtime directory /home/matt/.pulse/${my_machine-id}-runtime.
>May  2 19:30:55 debian pulseaudio[13583]: (   0.013|   0.000) [pulseaudio] main.c: Using state directory /home/matt/.pulse.
>May  2 19:30:55 debian pulseaudio[13583]: (   0.013|   0.000) [pulseaudio] main.c: Using modules directory /usr/lib/pulse-2.0/modules.
>May  2 19:30:55 debian pulseaudio[13583]: (   0.013|   0.000) [pulseaudio] main.c: Running in system mode: no
>May  2 19:30:55 debian pulseaudio[13587]: (   0.000|   0.000) [pulseaudio] main.c: setrlimit(RLIMIT_NICE, (31, 31)) failed: Operation not permitted
>May  2 19:30:55 debian pulseaudio[13587]: (   0.000|   0.000) [pulseaudio] main.c: setrlimit(RLIMIT_RTPRIO, (9, 9)) failed: Operation not permitted
>May  2 19:30:55 debian pulseaudio[13587]: (   0.008|   0.000) [pulseaudio] core-util.c: Successfully gained nice level -11.
>May  2 19:30:55 debian pulseaudio[13587]: (   0.009|   0.000) [pulseaudio] main.c: This is PulseAudio 2.0
>May  2 19:30:55 debian pulseaudio[13587]: (   0.009|   0.000) [pulseaudio] main.c: Page size is 4096 bytes
>May  2 19:30:55 debian pulseaudio[13587]: (   0.009|   0.000) [pulseaudio] main.c: Machine ID is ${my_machine-id}.
>May  2 19:30:55 debian pulseaudio[13587]: (   0.009|   0.000) [pulseaudio] main.c: Session ID is ${my_machine-id}-1367519441.355754-46751455.
>May  2 19:30:55 debian pulseaudio[13587]: (   0.010|   0.000) [pulseaudio] main.c: Using runtime directory /home/matt/.pulse/${my_machine-id}-runtime.
>May  2 19:30:55 debian pulseaudio[13587]: (   0.010|   0.000) [pulseaudio] main.c: Using state directory /home/matt/.pulse.
>May  2 19:30:55 debian pulseaudio[13587]: (   0.010|   0.000) [pulseaudio] main.c: Using modules directory /usr/lib/pulse-2.0/modules.
>May  2 19:30:55 debian pulseaudio[13587]: (   0.010|   0.000) [pulseaudio] main.c: Running in system mode: no
>May  2 19:31:20 debian pulseaudio[13531]: (  29.247|  24.866) [pulseaudio] module-x11-xsmp.c: Connected to session manager 'KDE' as '10c5d36269000136751948000000133730017'.
>May  2 19:31:20 debian pulseaudio[13531]: (  29.247|   0.000) [pulseaudio] client.c: Created 9 "XSMP Session on KDE as 10c5d36269000136751948000000133730017"
>May  2 19:31:20 debian pulseaudio[13531]: (  29.247|   0.000) [pulseaudio] module.c: Loaded "module-x11-xsmp" (index: #23; argument: "display=:0 session_manager=local/debian:@/tmp/.ICE-unix/13373,unix/debian:/tmp/.ICE-unix/13373").
>May  2 19:31:20 debian pulseaudio[13531]: (  29.248|   0.000) [pulseaudio] module-suspend-on-idle.c: Source alsa_input.pci-0000_00_1b.0.analog-stereo idle for too long, suspending ...
>May  2 19:31:20 debian pulseaudio[13531]: (  29.248|   0.000) [alsa-source] alsa-source.c: Device suspended...
>May  2 19:31:20 debian pulseaudio[13531]: (  29.248|   0.000) [pulseaudio] module-suspend-on-idle.c: Sink alsa_output.pci-0000_00_1b.0.analog-stereo idle for too long, suspending ...
>May  2 19:31:20 debian pulseaudio[13531]: (  29.249|   0.001) [alsa-sink] alsa-sink.c: Device suspended...
>May  2 19:31:20 debian pulseaudio[13531]: (  29.249|   0.000) [pulseaudio] client.c: Created 10 "Native client (UNIX socket client)"
>May  2 19:31:20 debian pulseaudio[13531]: (  29.250|   0.000) [pulseaudio] protocol-native.c: Got credentials: uid=1000 gid=1000 success=1
>May  2 19:31:20 debian pulseaudio[13531]: (  29.251|   0.000) [pulseaudio] client.c: Freed 8 "pactl"
>May  2 19:31:20 debian pulseaudio[13531]: (  29.251|   0.000) [pulseaudio] protocol-native.c: Connection died.
>May  2 19:31:20 debian pulseaudio[13531]: (  29.252|   0.001) [pulseaudio] client.c: Freed 10 "kmix-probe"
>May  2 19:31:20 debian pulseaudio[13531]: (  29.252|   0.000) [pulseaudio] protocol-native.c: Connection died.
>May  2 19:31:20 debian pulseaudio[13531]: (  29.301|   0.049) [pulseaudio] client.c: Created 11 "Native client (UNIX socket client)"
>May  2 19:31:21 debian pulseaudio[13531]: (  29.842|   0.000) [pulseaudio] protocol-native.c: Got credentials: uid=1000 gid=1000 success=1
>May  2 19:31:21 debian pulseaudio[13531]: (  30.059|   0.215) [pulseaudio] client.c: Created 12 "Native client (UNIX socket client)"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.060|   0.000) [pulseaudio] protocol-native.c: Got credentials: uid=1000 gid=1000 success=1
>May  2 19:31:21 debian pulseaudio[13531]: (  30.061|   0.001) [pulseaudio] client.c: Freed 12 "libphonon-probe"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.061|   0.000) [pulseaudio] protocol-native.c: Connection died.
>May  2 19:31:21 debian pulseaudio[13531]: (  30.063|   0.001) [pulseaudio] client.c: Created 13 "Native client (UNIX socket client)"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.068|   0.000) [pulseaudio] protocol-native.c: Got credentials: uid=1000 gid=1000 success=1
>May  2 19:31:21 debian pulseaudio[13531]: (  30.134|   0.065) [pulseaudio] client.c: Created 14 "Native client (UNIX socket client)"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.135|   0.000) [pulseaudio] protocol-native.c: Got credentials: uid=1000 gid=1000 success=1
>May  2 19:31:21 debian pulseaudio[13531]: (  30.137|   0.000) [pulseaudio] module-stream-restore.c: Restoring volume for sink input sink-input-by-media-role:event.
>May  2 19:31:21 debian pulseaudio[13531]: (  30.137|   0.000) [pulseaudio] module-stream-restore.c: Restoring mute state for sink input sink-input-by-media-role:event.
>May  2 19:31:21 debian pulseaudio[13531]: (  30.138|   0.000) [alsa-sink] alsa-sink.c: Trying resume...
>May  2 19:31:21 debian pulseaudio[13531]: (  30.138|   0.000) [alsa-sink] alsa-util.c: Trying to disable ALSA period wakeups, using timers only
>May  2 19:31:21 debian pulseaudio[13531]: (  30.138|   0.000) [alsa-sink] alsa-util.c: ALSA period wakeups disabled
>May  2 19:31:21 debian pulseaudio[13531]: (  30.139|   0.000) [alsa-sink] alsa-sink.c: Time scheduling watermark is 20.00ms
>May  2 19:31:21 debian pulseaudio[13531]: (  30.139|   0.000) [alsa-sink] alsa-sink.c: Resumed successfully...
>May  2 19:31:21 debian pulseaudio[13531]: (  30.139|   0.000) [alsa-sink] alsa-sink.c: Starting playback.
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] resampler.c: Using resampler 'speex-float-3'
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] resampler.c: Using float32le as working format.
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] resampler.c: Choosing speex quality setting 3.
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c: Created input 0 "audio stream" on alsa_output.pci-0000_00_1b.0.analog-stereo with sample spec float32le 2ch 48000Hz and channel map front-left,front-right
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     media.name = "audio stream"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     application.name = "knotify"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     native-protocol.peer = "UNIX socket client"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     native-protocol.version = "26"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     application.id = "org.VideoLAN.VLC"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     application.version = "2.0.6"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     application.icon_name = "vlc"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     application.language = "en_GB.UTF-8"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     application.process.id = "13386"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     application.process.machine_id = "${my_machine-id}"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     application.process.session_id = "${my_machine-id}-1367519441.355754-46751455"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     media.role = "event"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     phonon.streamid = "{5104513c-c380-4661-9168-0cf37f7c7238}"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     application.process.user = "matt"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     application.process.host = "debian"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     application.process.binary = "knotify4"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     window.x11.display = ":0"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] sink-input.c:     module-stream-restore.id = "sink-input-by-media-role:event"
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] protocol-native.c: Requested tlength=40.00 ms, minreq=13.33 ms
>May  2 19:31:21 debian pulseaudio[13531]: (  30.140|   0.000) [pulseaudio] protocol-native.c: Final latency 53.33 ms = 13.33 ms + 2*13.33 ms + 13.33 ms
>May  2 19:31:21 debian pulseaudio[13531]: (  30.159|   0.000) [alsa-sink] alsa-sink.c: Device suspended...
>May  2 19:31:21 debian pulseaudio[13531]: (  30.160|   0.000) [pulseaudio] alsa-sink.c: Updating rate for device front:0, new rate is 48000
>May  2 19:31:21 debian pulseaudio[13531]: (  30.160|   0.000) [pulseaudio] sink.c: Changed sampling rate successfully
>May  2 19:31:21 debian pulseaudio[13531]: (  30.160|   0.000) [pulseaudio] resampler.c: Using resampler 'speex-float-3'
>May  2 19:31:21 debian pulseaudio[13531]: (  30.160|   0.000) [pulseaudio] resampler.c: Using float32le as working format.
>May  2 19:31:21 debian pulseaudio[13531]: (  30.160|   0.000) [pulseaudio] resampler.c: Choosing speex quality setting 3.
>May  2 19:31:21 debian pulseaudio[13531]: (  30.161|   0.000) [alsa-sink] alsa-sink.c: Trying resume...
>May  2 19:31:21 debian pulseaudio[13531]: (  30.161|   0.000) [alsa-sink] alsa-util.c: Trying to disable ALSA period wakeups, using timers only
>May  2 19:31:21 debian pulseaudio[13531]: (  30.176|   0.000) [alsa-sink] alsa-util.c: ALSA period wakeups disabled
>May  2 19:31:21 debian pulseaudio[13531]: (  30.176|   0.000) [alsa-sink] alsa-sink.c: Time scheduling watermark is 6.67ms
>May  2 19:31:21 debian pulseaudio[13531]: (  30.176|   0.000) [alsa-sink] alsa-sink.c: Resumed successfully...
>May  2 19:31:21 debian pulseaudio[13531]: (  30.177|   0.000) [alsa-sink] alsa-sink.c: Starting playback.
>May  2 19:31:21 debian pulseaudio[13531]: (  30.177|   0.000) [alsa-sink] alsa-sink.c: Device suspended...
>May  2 19:31:21 debian pulseaudio[13531]: (  30.178|   0.000) [alsa-sink] alsa-sink.c: Trying resume...
>May  2 19:31:21 debian pulseaudio[13531]: (  30.178|   0.000) [alsa-sink] alsa-util.c: Trying to disable ALSA period wakeups, using timers only
>May  2 19:31:21 debian pulseaudio[13531]: (  30.178|   0.000) [alsa-sink] alsa-util.c: ALSA period wakeups disabled
>May  2 19:31:21 debian pulseaudio[13531]: (  30.178|   0.000) [alsa-sink] alsa-sink.c: Time scheduling watermark is 6.67ms
>May  2 19:31:21 debian pulseaudio[13531]: (  30.178|   0.000) [alsa-sink] alsa-sink.c: Resumed successfully...
>May  2 19:31:29 debian pulseaudio[13531]: (  38.539|   0.000) [pulseaudio] client.c: Freed 14 "knotify"
>May  2 19:31:29 debian pulseaudio[13531]: (  38.539|   0.000) [pulseaudio] protocol-native.c: Connection died.
>May  2 19:31:29 debian pulseaudio[13531]: (  38.539|   0.000) [pulseaudio] sink-input.c: Freeing input 0 "audio stream"
>May  2 19:31:34 debian pulseaudio[13531]: (  43.540|   3.322) [pulseaudio] module-suspend-on-idle.c: Sink alsa_output.pci-0000_00_1b.0.analog-stereo idle for too long, suspending ...
>May  2 19:31:34 debian pulseaudio[13531]: (  43.541|   0.000) [alsa-sink] alsa-sink.c: Device suspended...

Actions: View

Attachments on bug 58758: 78833 | 78930 | 79002 | 79003 | 79033

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.