[maverick] pulseaudio-module-bluetooth hangs pulseaudio when connect a bluetooth headset

Bug #665388 reported by mmbossoni
34
This bug affects 6 people
Affects Status Importance Assigned to Milestone
pulseaudio (Ubuntu)
Expired
Undecided
Unassigned

Bug Description

Binary package hint: pulseaudio

I can't use my Bluetooth Headset with maverick.

Whenever I plug my bluetooth headset the pulseaudio-module-bluetooth hangs the pulseaudio sound server for about 10 to 20 seconds and then it unloads with an error (E: module-bluetooth-device.c: Received error condition: Input/Output Error )

This device works well under Lucid.

Above the log of pulseaudio (log-level=4)

D: bluetooth-util.c: dbus: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=NameAcquired
D: module-bluetooth-discover.c: Loading module-bluetooth-device address="00:11:67:80:00:14" path="/org/bluez/4105/hci0/dev_00_11_67_80_00_14"
I: card.c: Created 1 "bluez_card.00_11_67_80_00_14"
D: module-bluetooth-device.c: Connected to the bluetooth audio service
D: module-bluetooth-device.c: Sending BT_REQUEST -> BT_GET_CAPABILITIES
D: module-bluetooth-device.c: Trying to receive message from audio service...
D: module-bluetooth-device.c: Received BT_RESPONSE <- BT_GET_CAPABILITIES
D: module-bluetooth-device.c: Payload size is 9 6
D: module-bluetooth-device.c: Sending BT_REQUEST -> BT_GET_CAPABILITIES
D: module-bluetooth-device.c: Trying to receive message from audio service...
D: module-bluetooth-device.c: Received BT_RESPONSE <- BT_GET_CAPABILITIES
D: module-bluetooth-device.c: Payload size is 9 6
D: module-bluetooth-device.c: Got device capabilities
D: module-bluetooth-device.c: Sending BT_REQUEST -> BT_OPEN
D: module-bluetooth-device.c: Trying to receive message from audio service...
D: module-bluetooth-device.c: Received BT_RESPONSE <- BT_OPEN
D: module-bluetooth-device.c: Sending BT_REQUEST -> BT_SET_CONFIGURATION
D: module-bluetooth-device.c: Trying to receive message from audio service...
D: module-bluetooth-device.c: Received BT_RESPONSE <- BT_SET_CONFIGURATION
D: module-bluetooth-device.c: Connection to the device configured
D: module-bluetooth-device.c: Got the stream socket
D: core-subscribe.c: Dropped redundant event due to change event.
I: sink.c: Created sink 1 "bluez_sink.00_11_67_80_00_14" with sample spec s16le 1ch 8000Hz and channel map mono
I: sink.c: bluetooth.protocol = "sco"
I: sink.c: device.intended_roles = "phone"
I: sink.c: device.description = "BCK-08"
I: sink.c: device.string = "00:11:67:80:00:14"
I: sink.c: device.api = "bluez"
I: sink.c: device.class = "sound"
I: sink.c: device.bus = "bluetooth"
I: sink.c: device.form_factor = "headset"
I: sink.c: bluez.path = "/org/bluez/4105/hci0/dev_00_11_67_80_00_14"
I: sink.c: bluez.class = "0x240404"
I: sink.c: bluez.name = "BCK-08"
I: sink.c: device.icon_name = "audio-headset-bluetooth"
D: core-subscribe.c: Dropped redundant event due to change event.
I: source.c: Created source 2 "bluez_sink.00_11_67_80_00_14.monitor" with sample spec s16le 1ch 8000Hz and channel map mono
I: source.c: device.description = "Monitor of BCK-08"
I: source.c: device.class = "monitor"
I: source.c: device.string = "00:11:67:80:00:14"
I: source.c: device.api = "bluez"
I: source.c: device.bus = "bluetooth"
I: source.c: device.form_factor = "headset"
I: source.c: bluez.path = "/org/bluez/4105/hci0/dev_00_11_67_80_00_14"
I: source.c: bluez.class = "0x240404"
I: source.c: bluez.name = "BCK-08"
I: source.c: device.icon_name = "audio-headset-bluetooth"
D: core-subscribe.c: Dropped redundant event due to change event.
I: source.c: Created source 3 "bluez_source.00_11_67_80_00_14" with sample spec s16le 1ch 8000Hz and channel map mono
I: source.c: bluetooth.protocol = "hsp"
I: source.c: device.intended_roles = "phone"
I: source.c: device.description = "BCK-08"
I: source.c: device.string = "00:11:67:80:00:14"
I: source.c: device.api = "bluez"
I: source.c: device.class = "sound"
I: source.c: device.bus = "bluetooth"
I: source.c: device.form_factor = "headset"
I: source.c: bluez.path = "/org/bluez/4105/hci0/dev_00_11_67_80_00_14"
I: source.c: bluez.class = "0x240404"
I: source.c: bluez.name = "BCK-08"
I: source.c: device.icon_name = "audio-headset-bluetooth"
D: module-bluetooth-device.c: IO Thread starting up
D: core-util.c: RealtimeKit worked.
I: core-util.c: Successfully enabled SCHED_RR scheduling for thread, with priority 5.
D: module-bluetooth-device.c: Sending BT_REQUEST -> BT_START_STREAM
D: module-bluetooth-device.c: Trying to receive message from audio service...
D: alsa-source.c: Wakeup from ALSA!
D: alsa-source.c: Wakeup from ALSA!
D: alsa-source.c: Wakeup from ALSA!
D: alsa-source.c: Wakeup from ALSA!
D: alsa-source.c: Wakeup from ALSA!
D: alsa-source.c: Wakeup from ALSA!
D: alsa-source.c: Wakeup from ALSA!
D: alsa-source.c: Wakeup from ALSA!
D: alsa-source.c: Wakeup from ALSA!
D: alsa-source.c: Wakeup from ALSA!
D: alsa-source.c: Wakeup from ALSA!
D: alsa-source.c: Wakeup from ALSA!
D: alsa-source.c: Wakeup from ALSA!
D: module-bluetooth-device.c: Received BT_ERROR <- BT_START_STREAM
E: module-bluetooth-device.c: Received error condition: Erro de entrada/saída
D: module-bluetooth-device.c: IO thread failed
I: module.c: Loaded "module-bluetooth-device" (index: #6; argument: "address="00:11:67:80:00:14" path="/org/bluez/4105/hci0/dev_00_11_67_80_00_14"").
I: module.c: Loaded "module-bluetooth-discover" (index: #7; argument: "").
D: cli-command.c: Checking for existance of '/usr/lib/pulse-0.9.21/modules/module-esound-protocol-unix.so': success
I: module.c: Loaded "module-esound-protocol-unix" (index: #8; argument: "").
I: module.c: Loaded "module-native-protocol-unix" (index: #9; argument: "").
D: cli-command.c: Checking for existance of '/usr/lib/pulse-0.9.21/modules/module-gconf.so': failure
D: core-subscribe.c: Dropped redundant event due to change event.
I: module-default-device-restore.c: Restored default sink 'alsa_output.pci-0000_00_14.2.analog-stereo'.
D: core-subscribe.c: Dropped redundant event due to change event.
I: module-default-device-restore.c: Restored default source 'alsa_input.pci-0000_00_14.2.analog-stereo'.
I: module.c: Loaded "module-default-device-restore" (index: #10; argument: "").
I: module.c: Loaded "module-rescue-streams" (index: #11; argument: "").
I: module.c: Loaded "module-always-sink" (index: #12; argument: "").
I: module.c: Loaded "module-intended-roles" (index: #13; argument: "").
D: module-suspend-on-idle.c: Sink alsa_output.pci-0000_00_14.2.analog-stereo becomes idle, timeout in 5 seconds.
D: module-suspend-on-idle.c: Sink bluez_sink.00_11_67_80_00_14 becomes idle, timeout in 5 seconds.
D: module-suspend-on-idle.c: Source alsa_input.pci-0000_00_14.2.analog-stereo becomes idle, timeout in 5 seconds.
D: module-suspend-on-idle.c: Source bluez_source.00_11_67_80_00_14 becomes idle, timeout in 5 seconds.
I: module.c: Loaded "module-suspend-on-idle" (index: #14; argument: "").
I: client.c: Created 0 "ConsoleKit Session /org/freedesktop/ConsoleKit/Session1"
D: module-console-kit.c: Added new session /org/freedesktop/ConsoleKit/Session1
I: module.c: Loaded "module-console-kit" (index: #15; argument: "").
I: module.c: Loaded "module-position-event-sounds" (index: #16; argument: "").
D: main.c: Got org.pulseaudio.Server!
I: main.c: A partida dos Daemon está completa.
D: bluetooth-util.c: dbus: interface=(null), path=(null), member=(null)
D: module-bluetooth-device.c: dbus: interface=(null), path=(null), member=(null)
D: module-console-kit.c: dbus: interface=(null), path=(null), member=(null)
D: bluetooth-util.c: dbus: interface=(null), path=(null), member=(null)
D: module-bluetooth-device.c: dbus: interface=(null), path=(null), member=(null)
D: module-console-kit.c: dbus: interface=(null), path=(null), member=(null)
I: client.c: Created 1 "Native client (UNIX socket client)"
I: module.c: Unloading "module-bluetooth-device" (index: #6).
D: module-rescue-streams.c: No sink inputs to move away.
D: module-rescue-streams.c: No source outputs to move away.
D: module-rescue-streams.c: No source outputs to move away.
D: module-bluetooth-device.c: IO thread shutting down
I: sink.c: Freeing sink 1 "bluez_sink.00_11_67_80_00_14"
I: source.c: Freeing source 2 "bluez_sink.00_11_67_80_00_14.monitor"
I: source.c: Freeing source 3 "bluez_source.00_11_67_80_00_14"
I: card.c: Freed 1 "bluez_card.00_11_67_80_00_14"
I: module.c: Unloaded "module-bluetooth-device" (index: #6).

ProblemType: Bug
DistroRelease: Ubuntu 10.10
Package: pulseaudio-module-bluetooth 1:0.9.22~0.9.21+stable-queue-32-g8478-0ubuntu21.1
ProcVersionSignature: Ubuntu 2.6.35-22.35-generic 2.6.35.4
Uname: Linux 2.6.35-22-generic x86_64
NonfreeKernelModules: nvidia
AlsaVersion: Advanced Linux Sound Architecture Driver Version 1.0.23.
Architecture: amd64
AudioDevicesInUse:
 USER PID ACCESS COMMAND
 /dev/snd/controlC0: marcelo 4930 F.... pulseaudio
Card0.Amixer.info:
 Card hw:0 'SB'/'HDA ATI SB at 0xf9ff4000 irq 16'
   Mixer name : 'Realtek ALC888'
   Components : 'HDA:10ec0888,10192120,00100202'
   Controls : 31
   Simple ctrls : 18
Date: Fri Oct 22 20:18:23 2010
InstallationMedia: Kubuntu 10.10 "Maverick Meerkat" - Release amd64 (20101007)
ProcEnviron:
 LANGUAGE=pt_BR:pt:en
 LANG=pt_BR.UTF-8
 SHELL=/bin/bash
SourcePackage: pulseaudio
dmi.bios.date: 03/29/2010
dmi.bios.vendor: American Megatrends Inc.
dmi.bios.version: 080015
dmi.board.name: A785GM-M
dmi.board.vendor: ECS
dmi.board.version: 1.0
dmi.chassis.type: 3
dmi.chassis.vendor: ECS
dmi.modalias: dmi:bvnAmericanMegatrendsInc.:bvr080015:bd03/29/2010:svnECS:pnA785GM-M:pvr1.0:rvnECS:rnA785GM-M:rvr1.0:cvnECS:ct3:cvr:
dmi.product.name: A785GM-M
dmi.product.version: 1.0
dmi.sys.vendor: ECS

Revision history for this message
mmbossoni (mmbossoni-gmail) wrote :
Revision history for this message
Jacopo Lorenzetti (jacopol) wrote :
Download full text (3.2 KiB)

I just bought a CELLY BH4 bluetooth headset (I needed to replace as soon as possible my broken home voip phone).

I can successfully pair the headset.

When I try to connect, the gnome bluetooth menu item behaves just like it was successfully connected (it reports 'connected' and provides a menu item to 'disconnect') but some of the controls in the audio preferences dialog (e.g. the sound output device selection radio buttons) hang and don't respond to user input for about 10 or 20 seconds.
Then they start working again, but no new sound output device appears and I have no way to send audio to the bluetooth headset.

The only thing I can do is to disconnect the headset by turning it off or choosing 'disconnect' from the gnome bluetooth menu.

I'm finding the following lines in my syslog every time I try to connect:

Dec 1 20:28:13 haydn bluetoothd[1523]: link_key_request (sba=00:11:67:9A:91:21, dba=00:1A:7D:73:5C:87)
Dec 1 20:28:15 haydn rtkit-daemon[1761]: Successfully made thread 3229 of process 1754 (n/a) owned by '1000' RT at priority 5.
Dec 1 20:28:15 haydn rtkit-daemon[1761]: Supervising 6 threads of 1 processes of 1 users.
Dec 1 20:28:25 haydn pulseaudio[1754]: asyncq.c: q overrun, queuing locally
Dec 1 20:28:26 haydn pulseaudio[1754]: last message repeated 9 times
Dec 1 20:28:26 haydn pulseaudio[1754]: ratelimit.c: 17 events suppressed
Dec 1 20:28:26 haydn pulseaudio[1754]: asyncq.c: q overrun, queuing locally
Dec 1 20:28:31 haydn pulseaudio[1754]: last message repeated 10 times
Dec 1 20:28:31 haydn pulseaudio[1754]: ratelimit.c: 116 events suppressed
Dec 1 20:28:31 haydn pulseaudio[1754]: asyncq.c: q overrun, queuing locally
Dec 1 20:28:37 haydn pulseaudio[1754]: last message repeated 10 times
Dec 1 20:28:37 haydn pulseaudio[1754]: ratelimit.c: 117 events suppressed
Dec 1 20:28:37 haydn pulseaudio[1754]: asyncq.c: q overrun, queuing locally
Dec 1 20:28:42 haydn pulseaudio[1754]: last message repeated 10 times
Dec 1 20:28:42 haydn pulseaudio[1754]: ratelimit.c: 115 events suppressed
Dec 1 20:28:42 haydn pulseaudio[1754]: asyncq.c: q overrun, queuing locally
Dec 1 20:28:47 haydn pulseaudio[1754]: last message repeated 10 times
Dec 1 20:28:47 haydn pulseaudio[1754]: ratelimit.c: 116 events suppressed
Dec 1 20:28:47 haydn pulseaudio[1754]: asyncq.c: q overrun, queuing locally
Dec 1 20:28:52 haydn pulseaudio[1754]: last message repeated 10 times
Dec 1 20:28:52 haydn pulseaudio[1754]: ratelimit.c: 116 events suppressed
Dec 1 20:28:52 haydn pulseaudio[1754]: asyncq.c: q overrun, queuing locally
Dec 1 20:28:55 haydn pulseaudio[1754]: last message repeated 10 times
Dec 1 20:28:55 haydn bluetoothd[1523]: HUP or ERR on socket
Dec 1 20:28:55 haydn bluetoothd[1523]: headset_resume_complete: resume failed
Dec 1 20:28:55 haydn pulseaudio[1754]: module-bluetooth-device.c: Received error condition: Errore di I/O
Dec 1 20:28:57 haydn pulseaudio[1754]: ratelimit.c: 86 events suppressed

Please tell me if I can provide some other info or test something to help fixing this. Thank you.

DistroRelease: Ubuntu 10.10
Package: bluez 4.69-0ubuntu2
Package: pulseaudio-module-bluetooth 1:0.9.22~0.9.21+stable-queue-32-g8478-0ubuntu21....

Read more...

Revision history for this message
Jacopo Lorenzetti (jacopol) wrote :

The same CELLY BH4 bluetooth headset is working fine on Maverick on another machine.

The pc where the headset is not working has an ISSCEDRBTA usb bluetooth dongle:

Bus 003 Device 005: ID 1131:1001 Integrated System Solution Corp. KY-BT100 Bluetooth Adapter

Revision history for this message
mmbossoni (mmbossoni-gmail) wrote :

I have the same bluetooth usb adapter

1131:1001 Integrated System Solution Corp. KY-BT100 Bluetooth Adapter -

Maybe the bluetooth driver is the source of the problem?

Revision history for this message
Vladimir Tartynskyi (fon.vosi) wrote :

having the same issue with
Bus 001 Device 005: ID 0a12:0001 Cambridge Silicon Radio, Ltd Bluetooth Dongle (HCI mode)

Revision history for this message
Jacopo Lorenzetti (jacopol) wrote :

Still present in Natty.

DistroRelease: Ubuntu 11.04
Package: pulseaudio-module-bluetooth 1:0.9.22+stable-queue-24-g67d18-0ubuntu3

tags: added: natty
Revision history for this message
kotique (kotique) wrote :

Same here with:
1131:1004 Integrated System Solution Corp. Bluetooth Device

and this one doesn't even pair properly:
0a12:0001 Cambridge Silicon Radio, Ltd Bluetooth Dongle (HCI mode)

what a crappy software/hardware!

Revision history for this message
Launchpad Janitor (janitor) wrote :

Status changed to 'Confirmed' because the bug affects multiple users.

Changed in pulseaudio (Ubuntu):
status: New → Confirmed
Revision history for this message
dimovnike (dimovnike) wrote :

Still present in Oneiric. I have a fresh installed system with no major tweaks and no pulseaudio/bluez tweaks at all. The headset i am trying to connect is Motorola Motorokr HD9. I also use BT apple magic mouse via the same BT dongle.

Just to mention: This setup worked some time ago, about 2 ubuntu versions ago, then I bought a dedicated dongle for the headset, but now I have a single dongle again.

If devs need me some special tests to do - I am open.

Revision history for this message
Charbonnier (charboma38) wrote :

Well, I think that I have a similar bug.

When I connect my phone to the computer, PulseAudio hangs for several minutes at this point:

D ( 64.827| 0.000) [bluetooth][modules/bluetooth/module-bluetooth-device.c:1590 thread_func()] IO Thread starting up
D ( 64.849| 0.022) [bluetooth][pulsecore/core-util.c:684 set_scheduler()] RealtimeKit worked.
I ( 64.850| 0.000) [bluetooth][pulsecore/core-util.c:738 pa_make_realtime()] Successfully enabled SCHED_RR scheduling for thread, with priority 5.
D ( 64.850| 0.000) [bluetooth][modules/bluetooth/module-bluetooth-device.c:220 service_send()] Sending BT_REQUEST -> BT_START_STREAM
D ( 64.851| 0.000) [bluetooth][modules/bluetooth/module-bluetooth-device.c:241 service_recv()] Trying to receive message from audio service...
D ( 527.589| 462.738) [bluetooth][modules/bluetooth/module-bluetooth-device.c:271 service_recv()] Received BT_RESPONSE <- BT_START_STREAM
D ( 527.590| 0.000) [bluetooth][modules/bluetooth/module-bluetooth-device.c:241 service_recv()] Trying to receive message from audio service...
D ( 527.591| 0.000) [bluetooth][modules/bluetooth/module-bluetooth-device.c:271 service_recv()] Received BT_RESPONSE <- BT_NEW_STREAM
D ( 527.591| 0.000) [bluetooth][modules/bluetooth/module-bluetooth-device.c:806 setup_stream()] Stream properly set up, we're ready to roll!
D ( 527.592| 0.000) [pulseaudio][modules/module-suspend-on-idle.c:122 restart()] Source bluez_source.34_50_C3_87_C1_10 becomes idle, timeout in 5 seconds.

Between line 5 and line 6, one can see that nothing happens, during about 420s...
However, in my case, I don't care about headphone, I connect it for other reasons. I would be glad to avoid this collateral effect.

Regards,
Matthieu.

Revision history for this message
Charbonnier (charboma38) wrote :

Correction:

In fact, pulseaudio hangs until I disconnect my phone.

Regards

Revision history for this message
Daniel van Vugt (vanvugt) wrote :

mmbossoni,

Thank you for reporting this bug to Ubuntu.
Ubuntu 10.10 (maverick) reached end-of-life on April 10, 2012.

See this document for currently supported Ubuntu releases:
https://wiki.ubuntu.com/Releases

Please upgrade to the latest version and re-test.

Changed in pulseaudio (Ubuntu):
status: Confirmed → Incomplete
Revision history for this message
Launchpad Janitor (janitor) wrote :

[Expired for pulseaudio (Ubuntu) because there has been no activity for 60 days.]

Changed in pulseaudio (Ubuntu):
status: Incomplete → Expired
To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.