#898: Bluetooth sink isn't created when pulseaudio run as system daemon --------------------+------------------------------------------------------- Reporter: murz | Owner: lennart Type: defect | Status: new Milestone: | Component: daemon Keywords: | --------------------+------------------------------------------------------- I need to use pulseaudio as system daemon, not per-user. Version is 1:0.9.22-0ubuntu2~diwic
When I run pulseaudio as user and connect bluetooth audio, new sink creates successfully. But if I run pulseaudio as system daemon, bluetooth audio connects, but sink is not created, here is output of pulseaudio -vv: {{{ Jan 22 13:25:41 kit pulseaudio[2934]: bluetooth-util.c: dbus: interface=org.bluez.Headset, path=/org/bluez/2167/hci0/dev_00_22_FC_74_AA_3C, member=PropertyChanged Jan 22 13:25:41 kit pulseaudio[2934]: bluetooth-util.c: dbus: interface=org.bluez.Audio, path=/org/bluez/2167/hci0/dev_00_22_FC_74_AA_3C, member=PropertyChanged Jan 22 13:25:41 kit pulseaudio[2934]: bluetooth-util.c: dbus: interface=org.bluez.Device, path=/org/bluez/2167/hci0/dev_00_22_FC_74_AA_3C, member=PropertyChanged Jan 22 13:25:41 kit bluetoothd[2172]: link_key_request (sba=00:15:83:3F:6D:E7, dba=00:22:FC:74:AA:3C) Jan 22 13:25:41 kit bluetoothd[2172]: link_key_request (sba=00:15:83:3F:6D:E7, dba=00:22:FC:74:AA:3C) Jan 22 13:25:43 kit pulseaudio[2934]: bluetooth-util.c: dbus: interface=org.bluez.Headset, path=/org/bluez/2167/hci0/dev_00_22_FC_74_AA_3C, member=PropertyChanged Jan 22 13:25:44 kit pulseaudio[2934]: last message repeated 3 times Jan 22 13:25:44 kit pulseaudio[2934]: bluetooth-util.c: dbus: interface=org.bluez.AudioSink, path=/org/bluez/2167/hci0/dev_00_22_FC_74_AA_3C, member=PropertyChanged Jan 22 13:25:44 kit bluetoothd[2172]: Badly formated or unrecognized command: AT+CSRSF=1,1,1,1,1,1 Jan 22 13:25:45 kit kernel: [ 8268.925610] input: 00:22:FC:74:AA:3C as /devices/virtual/input/input24 Jan 22 13:25:45 kit pulseaudio[2934]: bluetooth-util.c: dbus: interface=org.bluez.AudioSink, path=/org/bluez/2167/hci0/dev_00_22_FC_74_AA_3C, member=PropertyChanged Jan 22 13:25:45 kit pulseaudio[2934]: bluetooth-util.c: dbus: interface=org.bluez.AudioSink, path=/org/bluez/2167/hci0/dev_00_22_FC_74_AA_3C, member=PropertyChanged Jan 22 13:25:45 kit pulseaudio[2934]: bluetooth-util.c: dbus: interface=org.bluez.Audio, path=/org/bluez/2167/hci0/dev_00_22_FC_74_AA_3C, member=PropertyChanged Jan 22 13:25:45 kit pulseaudio[2934]: client.c: Created 6 "Native client (UNIX socket client)" Jan 22 13:25:45 kit pulseaudio[2934]: protocol-native.c: Protocol version: remote 16, local 16 Jan 22 13:25:45 kit pulseaudio[2934]: protocol-native.c: Got credentials: uid=1000 gid=100 success=1 Jan 22 13:25:45 kit pulseaudio[2934]: protocol-native.c: SHM possible: no Jan 22 13:25:45 kit pulseaudio[2934]: protocol-native.c: Negotiated SHM: no Jan 22 13:25:45 kit pulseaudio[2934]: module-stream-restore.c: Restoring volume for sink input sink-input-by-media-role:event. Jan 22 13:25:45 kit pulseaudio[2934]: sink.c: Suspend cause of sink alsa_output.pci-0000_00_14.2.analog-surround-51 is 0x0000, resuming Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Trying resume... Jan 22 13:25:45 kit pulseaudio[2934]: alsa-util.c: Maximum hw buffer size is 7281 ms Jan 22 13:25:45 kit pulseaudio[2934]: alsa-util.c: Set buffer size first (to 96000 samples), period size second (to 48000 samples). Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: hwbuf_unused=0 Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: setting avail_min=95041 Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Resumed successfully... Jan 22 13:25:45 kit pulseaudio[2934]: module-suspend-on-idle.c: Sink alsa_output.pci-0000_00_14.2.analog-surround-51 becomes idle, timeout in 5 seconds. Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Starting playback. Jan 22 13:25:45 kit pulseaudio[2934]: ratelimit.c: 24 events suppressed Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Cutting sleep time for the initial iterations by half. Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Cutting sleep time for the initial iterations by half. Jan 22 13:25:45 kit pulseaudio[2934]: module-suspend-on-idle.c: Sink alsa_output.pci-0000_00_14.2.analog-surround-51 becomes busy. Jan 22 13:25:45 kit pulseaudio[2934]: resampler.c: Forcing resampler 'copy', because of fixed, identical sample rates. Jan 22 13:25:45 kit pulseaudio[2934]: resampler.c: Channel matrix: Jan 22 13:25:45 kit pulseaudio[2934]: resampler.c: I00 I01 Jan 22 13:25:45 kit pulseaudio[2934]: resampler.c: +------------ Jan 22 13:25:45 kit pulseaudio[2934]: resampler.c: O00 | 1.000 0.000 Jan 22 13:25:45 kit pulseaudio[2934]: resampler.c: O01 | 0.000 1.000 Jan 22 13:25:45 kit pulseaudio[2934]: resampler.c: O02 | 1.000 0.000 Jan 22 13:25:45 kit pulseaudio[2934]: resampler.c: O03 | 0.000 1.000 Jan 22 13:25:45 kit pulseaudio[2934]: resampler.c: O04 | 0.500 0.500 Jan 22 13:25:45 kit pulseaudio[2934]: resampler.c: O05 | 0.500 0.500 Jan 22 13:25:45 kit pulseaudio[2934]: remap.c: Using generic matrix remapping Jan 22 13:25:45 kit pulseaudio[2934]: resampler.c: Using resampler 'copy' Jan 22 13:25:45 kit pulseaudio[2934]: resampler.c: Using s16le as working format. Jan 22 13:25:45 kit pulseaudio[2934]: memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=12, prebuf=0, minreq=1 maxrewind=0 Jan 22 13:25:45 kit pulseaudio[2934]: memblockq.c: memblockq sanitized: maxlength=33554436, tlength=33554436, base=12, prebuf=0, minreq=12 maxrewind=0 Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: Created input 0 "Audio Stream" on alsa_output.pci-0000_00_14.2.analog-surround-51 with sample spec s16le 2ch 48000Hz and channel map front-left,front-right Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: media.name = "Audio Stream" Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: application.name = "knotify4" Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: native- protocol.peer = "UNIX socket client" Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: native- protocol.version = "16" Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: media.role = "event" Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: phonon.streamid = "{0eb43bd1-9c05-4ff4-85ba-4c666b00cb7d}" Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: application.process.id = "3743" Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: application.process.user = "murz" Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: application.process.host = "kit" Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: application.process.binary = "knotify4" Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: application.language = "en_US.UTF-8" Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: window.x11.display = ":0.0" Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: application.process.machine_id = "a552e69c4374f22965f68c834a924e39" Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: application.process.session_id = "a552e69c4374f22965f68c834a924e39-1295683734.22308-1259993552" Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: module-stream- restore.id = "sink-input-by-media-role:event" Jan 22 13:25:45 kit pulseaudio[2934]: protocol-native.c: Requested tlength=250.00 ms, minreq=20.00 ms Jan 22 13:25:45 kit pulseaudio[2934]: protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq. Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Cutting sleep time for the initial iterations by half. Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Cutting sleep time for the initial iterations by half. Jan 22 13:25:45 kit pulseaudio[2934]: memblockq.c: memblockq requested: maxlength=4194304, tlength=48000, base=4, prebuf=44164, minreq=3840 maxrewind=0 Jan 22 13:25:45 kit pulseaudio[2934]: memblockq.c: memblockq sanitized: maxlength=4194304, tlength=48000, base=4, prebuf=44164, minreq=3840 maxrewind=0 Jan 22 13:25:45 kit pulseaudio[2934]: protocol-native.c: Final latency 460.00 ms = 210.00 ms + 2*20.00 ms + 210.00 ms Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Cutting sleep time for the initial iterations by half. Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Latency set to 210.00ms Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: hwbuf_unused=1031040 Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: setting avail_min=95041 Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Requesting rewind due to latency change. Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Requested to rewind 1152000 bytes. Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Limited to 1149828 bytes. Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: before: 95819 Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: after: 95819 Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Rewound 1149828 bytes. Jan 22 13:25:45 kit pulseaudio[2934]: sink.c: Processing rewind... Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: Have to rewind 1149828 bytes on render memblockq. Jan 22 13:25:45 kit pulseaudio[2934]: source.c: Processing rewind... Jan 22 13:25:45 kit pulseaudio[2934]: core-subscribe.c: Dropped redundant event due to change event. Jan 22 13:25:45 kit pulseaudio[2934]: protocol-native.c: Requesting rewind due to end of underrun. Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Requested to rewind 1152000 bytes. Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Limited to 111672 bytes. Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: before: 9306 Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: after: 9306 Jan 22 13:25:45 kit pulseaudio[2934]: alsa-sink.c: Rewound 111672 bytes. Jan 22 13:25:45 kit pulseaudio[2934]: sink.c: Processing rewind... Jan 22 13:25:45 kit pulseaudio[2934]: sink-input.c: Have to rewind 111672 bytes on render memblockq. Jan 22 13:25:45 kit pulseaudio[2934]: source.c: Processing rewind... Jan 22 13:25:47 kit pulseaudio[2934]: alsa-sink.c: hwbuf_unused=0 Jan 22 13:25:47 kit pulseaudio[2934]: alsa-sink.c: setting avail_min=95041 Jan 22 13:25:47 kit pulseaudio[2934]: alsa-sink.c: Requested to rewind 1152000 bytes. Jan 22 13:25:47 kit pulseaudio[2934]: alsa-sink.c: Limited to 118716 bytes. Jan 22 13:25:47 kit pulseaudio[2934]: alsa-sink.c: before: 9893 Jan 22 13:25:47 kit pulseaudio[2934]: alsa-sink.c: after: 9893 Jan 22 13:25:47 kit pulseaudio[2934]: alsa-sink.c: Rewound 118716 bytes. Jan 22 13:25:47 kit pulseaudio[2934]: sink.c: Processing rewind... Jan 22 13:25:47 kit pulseaudio[2934]: source.c: Processing rewind... Jan 22 13:25:47 kit pulseaudio[2934]: module-suspend-on-idle.c: Sink alsa_output.pci-0000_00_14.2.analog-surround-51 becomes idle, timeout in 5 seconds. Jan 22 13:25:47 kit pulseaudio[2934]: module-suspend-on-idle.c: Sink alsa_output.pci-0000_00_14.2.analog-surround-51 becomes idle, timeout in 5 seconds. Jan 22 13:25:47 kit pulseaudio[2934]: core.c: Hmm, no streams around, trying to vacuum. Jan 22 13:25:47 kit pulseaudio[2934]: sink-input.c: Freeing input 0 "Audio Stream" Jan 22 13:25:52 kit pulseaudio[2934]: module-suspend-on-idle.c: Sink alsa_output.pci-0000_00_14.2.analog-surround-51 idle for too long, suspending ... Jan 22 13:25:52 kit pulseaudio[2934]: sink.c: Suspend cause of sink alsa_output.pci-0000_00_14.2.analog-surround-51 is 0x0004, suspending Jan 22 13:25:52 kit pulseaudio[2934]: alsa-sink.c: Device suspended... Jan 22 13:25:52 kit pulseaudio[2934]: module-udev-detect.c: /dev/snd/controlC0 is accessible: yes }}} Maybe I need to give some specific permissions? Or where maybe the problem? -- Ticket URL: <http://pulseaudio.org/ticket/898> PulseAudio <http://pulseaudio.org/> The PulseAudio Sound Server _______________________________________________ pulseaudio-tickets mailing list pulseaudio-tickets@mail.0pointer.de https://tango.0pointer.de/mailman/listinfo/pulseaudio-tickets