[Pkg-bluetooth-maintainers] Bug#664528: [bluez-alsa] Fails to connect to bluetooth audio device

[Franz Schrober]

Package: bluez-alsa
Version: 4.99-1
Severity: normal

My ~/.asoundrc looks like this:

@hooks [
       {
               func load
               files [
                       "/usr/share/alsa/bluetooth.conf"
               ]
               errors false
       }
]

I try to attach my bluetooth headset (sco) to my laptop using bluedevil and then start arecord. This worked fine with 3.x (from squeeze), but not with the current version from wheezy. I can reproduce this with all bluetooth headsets I got in my hand and with different laptops running debian wheezy. So it seems to be a common problem and not only happen here.

Here is the interesting part of "strace arecord -D pcm.bluetooth"

connect(3, {sa_family=AF_FILE, path=@"/org/bluez/audio"}, 110) = -1 ECONNREFUSED (Connection refused)
open("/usr/share/locale/locale.alias", O_RDONLY) = 4
fstat64(4, {st_mode=S_IFREG|0644, st_size=2570, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7782000
read(4, "# Locale name alias data base.\n#"..., 4096) = 2570
read(4, "", 4096)                       = 0
close(4)

The output of bluetoothd when I connect the the headphone:

bluetoothd[18428]: audio/headset.c:headset_set_state() State changed /org/bluez/18428/hci0/dev_01_02_03_04_05_06: HEADSET_STATE_DISCONNECTED -> HEADSET_STATE_CONNECTING
bluetoothd[18428]: plugins/hciops.c:link_key_request() hci0 dba 01:02:03:04:05:06
bluetoothd[18428]: plugins/hciops.c:get_auth_info() hci0 dba 01:02:03:04:05:06
bluetoothd[18428]: plugins/hciops.c:link_key_request() kernel auth requirements = 0x00
bluetoothd[18428]: plugins/hciops.c:link_key_request() Matching key found
bluetoothd[18428]: plugins/hciops.c:link_key_request() link key type 0x00
bluetoothd[18428]: plugins/hciops.c:conn_complete() status 0x00
bluetoothd[18428]: src/adapter.c:adapter_get_device() 01:02:03:04:05:06
bluetoothd[18428]: plugins/hciops.c:bonding_complete() status 0x00
bluetoothd[18428]: src/adapter.c:adapter_get_device() 01:02:03:04:05:06
bluetoothd[18428]: src/device.c:device_bonding_complete() bonding (nil) status 0x00
bluetoothd[18428]: plugins/hciops.c:remote_features_information() hci0 status 0
bluetoothd[18428]: plugins/hciops.c:remote_name_information() hci0 status 0
bluetoothd[18428]: audio/headset.c:headset_set_channel() Discovered Handsfree service on channel 2
bluetoothd[18428]: audio/headset.c:rfcomm_connect() /org/bluez/18428/hci0/dev_01_02_03_04_05_06: Connecting to 01:02:03:04:05:06 channel 2
bluetoothd[18428]: plugins/hciops.c:link_key_request() hci0 dba 01:02:03:04:05:06
bluetoothd[18428]: plugins/hciops.c:get_auth_info() hci0 dba 01:02:03:04:05:06
bluetoothd[18428]: plugins/hciops.c:link_key_request() kernel auth requirements = 0x04
bluetoothd[18428]: plugins/hciops.c:link_key_request() Matching key found
bluetoothd[18428]: plugins/hciops.c:link_key_request() link key type 0x00
bluetoothd[18428]: plugins/hciops.c:auth_complete() hci0 status 0
bluetoothd[18428]: plugins/hciops.c:bonding_complete() status 0x00
bluetoothd[18428]: src/adapter.c:adapter_get_device() 01:02:03:04:05:06
bluetoothd[18428]: src/device.c:device_bonding_complete() bonding (nil) status 0x00
bluetoothd[18428]: audio/headset.c:headset_connect_cb() /org/bluez/18428/hci0/dev_01_02_03_04_05_06: Connected to 01:02:03:04:05:06
bluetoothd[18428]: audio/headset.c:handle_event() Received AT+BRSF=26
bluetoothd[18428]: audio/headset.c:print_hf_features() HFP HF features: "Call waiting and 3-way calling" "Voice recognition activation" "Remote volume control" 
bluetoothd[18428]: audio/headset.c:handle_event() Received AT+CIND=?
bluetoothd[18428]: audio/headset.c:handle_event() Received AT+CIND?
bluetoothd[18428]: audio/headset.c:handle_event() Received AT+CMER=3, 0, 0, 1
bluetoothd[18428]: audio/headset.c:event_reporting() Event reporting (CMER): mode=3, ind=1
bluetoothd[18428]: audio/headset.c:hfp_slc_complete() HFP Service Level Connection established
bluetoothd[18428]: audio/telephony.c:telephony_device_connected() telephony-dummy: device 0xb7d1eef0 connected
bluetoothd[18428]: audio/headset.c:headset_set_state() State changed /org/bluez/18428/hci0/dev_01_02_03_04_05_06: HEADSET_STATE_CONNECTING -> HEADSET_STATE_CONNECTED
bluetoothd[18428]: audio/headset.c:handle_event() Received AT+VGS=09




--- System information. ---
Architecture: i386
Kernel:       Linux 3.2.0-2-686-pae
Debian Release: wheezy/sid
500 testing         www.debian-multimedia.org 
500 testing         ftp.debian.org 
500 stable          ftp.debian.org 
1 experimental    ftp.debian.org 

--- Package information. ---
Depends          (Version) | Installed
==========================-+-============
libasound2     (>= 1.0.16) | 1.0.25-2
libc6             (>= 2.7) | 2.13-27
bluez                      | 4.99-1
Package's Recommends field is empty.
Package's Suggests field is empty.