[Bluez-users] Motorola S9 and BlueZ 4.14

public inbox for linux-bluetooth@vger.kernel.org
 help / color / mirror / Atom feed

* [Bluez-users] Motorola S9 and BlueZ 4.14
       [not found] <mailman.81198.1224358186.3608.bluez-users@lists.sourceforge.net>
@ 2008-10-18 19:48 ` Patryk Zawadzki
  2008-10-18 20:40   ` Jelle de Jong
  0 siblings, 1 reply; 10+ messages in thread
From: Patryk Zawadzki @ 2008-10-18 19:48 UTC (permalink / raw)
  To: BlueZ users

Starting the bluetoothd daemon and pressing the headset power button I
get the following (the headset is paired but it does not make a
difference):

bluetoothd[21459]: link_key_request (sba=00:1D:60:69:91:18,
dba=00:0D:FD:15:F0:3E)
bluetoothd[21459]: kernel auth requirements = 0x00
bluetoothd[21459]: stored link key type = 0x00
bluetoothd[21459]: adapter_get_device(00:0D:FD:15:F0:3E)
bluetoothd[21459]: hcid_dbus_bonding_process_complete: status=00
bluetoothd[21459]: adapter_get_device(00:0D:FD:15:F0:3E)
bluetoothd[21459]: hcid_dbus_bonding_process_complete: no pending auth request
bluetoothd[21459]: AVDTP: incoming connect from 00:0D:FD:15:F0:3E
bluetoothd[21459]: session_cb
bluetoothd[21459]: Received DISCOVER_CMD
bluetoothd[21459]: session_cb
bluetoothd[21459]: Received  GET_CAPABILITIES_CMD
bluetoothd[21459]: Source 0xb8ecb960: Get_Capability_Ind
bluetoothd[21459]: session_cb
bluetoothd[21459]: Received SET_CONFIGURATION_CMD
bluetoothd[21459]: Source 0xb8ecb960: Set_Configuration_Ind
bluetoothd[21459]: avdtp_ref(0xb8ec83f0): ref=2
bluetoothd[21459]: stream state changed: IDLE -> CONFIGURED
bluetoothd[21459]: session_cb
bluetoothd[21459]: Received OPEN_CMD
bluetoothd[21459]: Source 0xb8ecb960: Open_Ind
bluetoothd[21459]: stream state changed: CONFIGURED -> OPEN
bluetoothd[21459]: AVCTP: connected to 00:0D:FD:15:F0:3E
bluetoothd[21459]: AVRCP: uinput initialized for 00:0D:FD:15:F0:3E
bluetoothd[21459]: AVDTP: incoming connect from 00:0D:FD:15:F0:3E
bluetoothd[21459]: stream state change failed: Input/output error
bluetoothd[21459]: session_cb
bluetoothd[21459]: Received START_CMD
bluetoothd[21459]: Source 0xb8ecb960: Start_Ind
bluetoothd[21459]: avdtp_ref(0xb8ec83f0): ref=3
bluetoothd[21459]: stream state changed: OPEN -> STREAMING
bluetoothd[21459]: avdtp_unref(0xb8ec83f0): ref=2
bluetoothd[21459]: session_cb
bluetoothd[21459]: SUSPEND request succeeded
bluetoothd[21459]: stream state changed: STREAMING -> OPEN
bluetoothd[21459]: Source 0xb8ecb960: Suspend_Cfm
bluetoothd[21459]: session_cb
bluetoothd[21459]: CLOSE request succeeded
bluetoothd[21459]: stream state changed: OPEN -> CLOSING
bluetoothd[21459]: Source 0xb8ecb960: Close_Cfm
bluetoothd[21459]: stream state changed: CLOSING -> IDLE
bluetoothd[21459]: avdtp_unref(0xb8ec83f0): ref=1
bluetoothd[21459]: Disconnected from 00:0D:FD:15:F0:3E
bluetoothd[21459]: avdtp_unref(0xb8ec83f0): ref=0
bluetoothd[21459]: avdtp_unref(0xb8ec83f0): freeing session and
removing from list

Any ideas of possible causes of the "stream state change failed:
Input/output error"?

-- 
Patryk Zawadzki

-------------------------------------------------------------------------
This SF.Net email is sponsored by the Moblin Your Move Developer's challenge
Build the coolest Linux based applications with Moblin SDK & win great prizes
Grand prize is a trip for two to an Open Source event anywhere in the world
http://moblin-contest.org/redirect.php?banner_id=100&url=/
_______________________________________________
Bluez-users mailing list
Bluez-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bluez-users

^ permalink raw reply	[flat|nested] 10+ messages in thread

* Re: [Bluez-users] Motorola S9 and BlueZ 4.14
  2008-10-18 19:48 ` [Bluez-users] Motorola S9 and BlueZ 4.14 Patryk Zawadzki
@ 2008-10-18 20:40   ` Jelle de Jong
  2008-10-19 15:55     ` [Bluez-devel] " Patryk Zawadzki
  0 siblings, 1 reply; 10+ messages in thread
From: Jelle de Jong @ 2008-10-18 20:40 UTC (permalink / raw)
  To: BlueZ users

[-- Attachment #1: Type: text/plain, Size: 534 bytes --]

Patryk Zawadzki wrote:
> Starting the bluetoothd daemon and pressing the headset power button I
> get the following (the headset is paired but it does not make a
> difference):
> 
> bluetoothd[21459]: link_key_request (sba=00:1D:60:69:91:18,
<snip>
> removing from list
> 
> Any ideas of possible causes of the "stream state change failed:
> Input/output error"?
> 

I also have trouble with this headset and the bluez-utils and
bluez-gnome, both git builds of 24 hours old.

Please see the logs,

Any ideas?

Best regards,

Jelle




[-- Attachment #2: setup-bluetooth-motorola-s9.sh --]
[-- Type: application/x-sh, Size: 604 bytes --]

[-- Attachment #3: bluetoothd.log --]
[-- Type: text/x-log, Size: 32920 bytes --]

connected bluetooth headset with bluetooth-applet without any issues set
the device trusted. Did the same thing for my logitech bluetooth presenter mouse.

then rebooted the computer, when i try to do speaker-test -c2 i can hear
a short burst of sound then the sound stops, tried it sevral times...

The bluetooth presenter mouse indicates with green flashing lights it is
connected, but the mouse does nothing on the screen....

========================================================================

sudo /usr/sbin/bluetoothd --nodaemon --debug
bluetoothd[3325]: Bluetooth daemon
bluetoothd[3325]: Enabling debug information
bluetoothd[3325]: parsing main.conf
bluetoothd[3325]: offmode=NoScan
bluetoothd[3325]: discovto=0
bluetoothd[3325]: pageto=8192
bluetoothd[3325]: name=%h-%d
bluetoothd[3325]: class=0x000100
bluetoothd[3325]: inqmode=0
bluetoothd[3325]: Starting SDP server
bluetoothd[3325]: Loading plugins /usr/lib/bluetooth/plugins
bluetoothd[3325]: /usr/lib/bluetooth/plugins/service.so
bluetoothd[3325]: /usr/lib/bluetooth/plugins/hal.so
bluetoothd[3325]: /usr/lib/bluetooth/plugins/network.so
bluetoothd[3325]: Parsing /etc/bluetooth/network.conf failed: No such file or directory
bluetoothd[3325]: Config options: InterfacePrefix=bnep%d, PANU_Script=(null), GN_Script=(null), NAP_Script=(null), GN_Interface=pan0, NAP_Interface=pan1, Security=true
bluetoothd[3325]: bridge pan0 created
bluetoothd[3325]: /usr/lib/bluetooth/plugins/serial.so
bluetoothd[3325]: /usr/lib/bluetooth/plugins/input.so
bluetoothd[3325]: Parsing /etc/bluetooth/input.conf failed: No such file or directory
bluetoothd[3325]: /usr/lib/bluetooth/plugins/audio.so
bluetoothd[3325]: Unix socket created: 12
bluetoothd[3325]: Telephony plugin initialized
bluetoothd[3325]: HFP AG features: "Ability to reject a call" "Enhanced call status" "Extended Error Result Codes"
bluetoothd[3325]: HCI dev 0 registered
bluetoothd[3325]: child 3349 forked
bluetoothd[3325]: HCI dev 0 already up
bluetoothd[3325]: service_probe: path /org/bluez/hci0
bluetoothd[3325]: Registered interface org.bluez.Service on path /org/bluez/hci0
bluetoothd[3325]: network_server_probe: path /org/bluez/hci0
bluetoothd[3325]: Adding record with handle 0x10000
bluetoothd[3325]: Record pattern UUID 0000000f-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00000100-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00001002-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00001115-0000-1000-8000-00805f9
bluetoothd[3325]: register_server_record: got record id 0x10000
bluetoothd[3325]: Registered interface org.bluez.NetworkPeer on path /org/bluez/hci0
bluetoothd[3325]: network_server_probe: path /org/bluez/hci0
bluetoothd[3325]: Adding record with handle 0x10001
bluetoothd[3325]: Record pattern UUID 0000000f-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00000100-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00001002-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00001117-0000-1000-8000-00805f9
bluetoothd[3325]: register_server_record: got record id 0x10001
bluetoothd[3325]: Registered interface org.bluez.NetworkHub on path /org/bluez/hci0
bluetoothd[3325]: network_server_probe: path /org/bluez/hci0
bluetoothd[3325]: Adding record with handle 0x10002
bluetoothd[3325]: Record pattern UUID 0000000f-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00000100-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00001002-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00001116-0000-1000-8000-00805f9
bluetoothd[3325]: register_server_record: got record id 0x10002
bluetoothd[3325]: Registered interface org.bluez.NetworkRouter on path /org/bluez/hci0
bluetoothd[3325]: proxy_probe: path /org/bluez/hci0
bluetoothd[3325]: Registered interface org.bluez.SerialProxyManager on path /org/bluez/hci0
bluetoothd[3325]: headset_server_probe: path /org/bluez/hci0
bluetoothd[3325]: audio.conf: Key file does not have key 'Master'
bluetoothd[3325]: Adding record with handle 0x10003
bluetoothd[3325]: Record pattern UUID 00000003-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00000100-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00001002-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00001108-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00001112-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00001203-0000-1000-8000-00805f9
bluetoothd[3325]: audio.conf: Key file does not have key 'SCORouting'
bluetoothd[3325]: a2dp_server_probe: path /org/bluez/hci0
bluetoothd[3325]: audio.conf: Key file does not have key 'Disable'
bluetoothd[3325]: audio.conf: Key file does not have group 'A2DP'
bluetoothd[3325]: audio.conf: Key file does not have group 'A2DP'
bluetoothd[3325]: audio.conf: Key file does not have group 'A2DP'
bluetoothd[3325]: audio.conf: Key file does not have group 'A2DP'
bluetoothd[3325]: audio.conf: Key file does not have key 'Master'
bluetoothd[3325]: SEP 0xb9150088 registered: type:0 codec:0 seid:1
bluetoothd[3325]: Adding record with handle 0x10004
bluetoothd[3325]: Record pattern UUID 00000019-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00000100-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00001002-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 0000110a-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 0000110d-0000-1000-8000-00805f9
bluetoothd[3325]: avrcp_server_probe: path /org/bluez/hci0
bluetoothd[3325]: audio.conf: Key file does not have key 'Master'
bluetoothd[3325]: Adding record with handle 0x10005
bluetoothd[3325]: Record pattern UUID 00000017-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00000100-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00001002-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 0000110c-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 0000110e-0000-1000-8000-00805f9
bluetoothd[3325]: Adding record with handle 0x10006
bluetoothd[3325]: Record pattern UUID 00000017-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00000100-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 00001002-0000-1000-8000-00805f9
bluetoothd[3325]: Record pattern UUID 0000110e-0000-1000-8000-00805f9
bluetoothd[3325]: Adapter /org/bluez/hci0 has been enabled
bluetoothd[3325]: Starting security manager 0
bluetoothd[3325]: child 3349 exited
bluetoothd[3325]: Computer is classified as laptop
bluetoothd[3325]: Current device class is 0x0a0100
bluetoothd[3325]: Setting 0x00010c for major/minor device class
bluetoothd[3325]: Agent registered for hci0 at :1.11:/org/bluez/agent/hci0
bluetoothd[3325]: Discovery session 0xb914bc90 with :1.13 activated
bluetoothd[3325]: session_ref(0xb914bc90): ref=1
bluetoothd[3325]: session_unref(0xb914bc90): ref=0
bluetoothd[3325]: Discovery session 0xb914bc90 with :1.13 deactivated
bluetoothd[3325]: Stopping discovery
bluetoothd[3325]: bonding_request_new(00:0D:FD:18:6E:3C)
bluetoothd[3325]: adapter_get_device(00:0D:FD:18:6E:3C)
bluetoothd[3325]: adapter_create_device(00:0D:FD:18:6E:3C)
bluetoothd[3325]: Creating device /org/bluez/hci0/dev_00_0D_FD_18_6E_3C
bluetoothd[3325]: Temporary agent registered for hci0/00:0D:FD:18:6E:3C at :1.13:/org/bluez/agent/wizard
bluetoothd[3325]: pin_code_request (sba=00:15:AF:F4:E9:E0, dba=00:0D:FD:18:6E:3C)
bluetoothd[3325]: hcid_dbus_new_auth_request
bluetoothd[3325]: link_key_notify (sba=00:15:AF:F4:E9:E0, dba=00:0D:FD:18:6E:3C)
bluetoothd[3325]: adapter_get_device(00:0D:FD:18:6E:3C)
bluetoothd[3325]: hcid_dbus_bonding_process_complete: status=00
bluetoothd[3325]: adapter_get_device(00:0D:FD:18:6E:3C)
bluetoothd[3325]: Releasing agent :1.13, /org/bluez/agent/wizard
bluetoothd[3325]: Probe drivers for /org/bluez/hci0/dev_00_0D_FD_18_6E_3C
bluetoothd[3325]: headset_probe: path /org/bluez/hci0/dev_00_0D_FD_18_6E_3C
bluetoothd[3325]: Registered interface org.bluez.Input on path /org/bluez/hci0/dev_00_0D_FD_18_6E_3C
bluetoothd[3325]: adapter_get_device(00:0D:FD:18:6E:3C)
bluetoothd[3325]: Found Headset record
bluetoothd[3325]: Discovered Headset service on RFCOMM channel 2
bluetoothd[3325]: Registered interface org.bluez.Headset on path /org/bluez/hci0/dev_00_0D_FD_18_6E_3C
bluetoothd[3325]: audio handle_uuid: server not enabled for 0000111e-0000-1000-8000-00805f9b34fb (0x111e)
bluetoothd[3325]: Found Audio Sink
bluetoothd[3325]: Registered interface org.bluez.AudioSink on path /org/bluez/hci0/dev_00_0D_FD_18_6E_3C
bluetoothd[3325]: Found AV Target
bluetoothd[3325]: Registered interface org.bluez.Control on path /org/bluez/hci0/dev_00_0D_FD_18_6E_3C
bluetoothd[3325]: Found AV Remote
bluetoothd[3325]: Accepted new client connection on unix socket (fd=21)
bluetoothd[3325]: Audio API: received BT_GETCAPABILITIES_REQ
bluetoothd[3325]: avdtp_ref(0xb9151048): ref=2
bluetoothd[3325]: link_key_request (sba=00:15:AF:F4:E9:E0, dba=00:0D:FD:18:6E:3C)
bluetoothd[3325]: kernel auth requirements = 0x00
bluetoothd[3325]: stored link key type = 0x00
bluetoothd[3325]: adapter_get_device(00:0D:FD:18:6E:3C)
bluetoothd[3325]: AVDTP: connected signaling channel to 00:0D:FD:18:6E:3C
bluetoothd[3325]: session_cb
bluetoothd[3325]: DISCOVER request succeeded
bluetoothd[3325]: seid 1 type 1 media 0 in use 0
bluetoothd[3325]: seid 2 type 1 media 0 in use 0
bluetoothd[3325]: session_cb
bluetoothd[3325]: GET_CAPABILITIES request succeeded
bluetoothd[3325]: seid 1 type 1 media 0
bluetoothd[3325]: session_cb
bluetoothd[3325]: GET_CAPABILITIES request succeeded
bluetoothd[3325]: seid 2 type 1 media 0
bluetoothd[3325]: Audio API: sending BT_GETCAPABILITIES_RSP
bluetoothd[3325]: Audio API: received BT_SETCONFIGURATION_REQ
bluetoothd[3325]: config a2dp - device = 00:0D:FD:18:6E:3C access_mode = 2
bluetoothd[3325]: codec sbc - frequency = 1 channel_mode = 8 allocation = 1 subbands = 1 blocks = 1 bitpool = 29
bluetoothd[3325]: a2dp_source_config: selected SEP 0xb9150088
bluetoothd[3325]: avdtp_ref(0xb9151048): ref=3
bluetoothd[3325]: setup_ref(0xb914ba50): ref=1
bluetoothd[3325]: avdtp_set_configuration(0xb9151048): int_seid=1, acp_seid=1
bluetoothd[3325]: session_cb
bluetoothd[3325]: SET_CONFIGURATION request succeeded
bluetoothd[3325]: Source 0xb9150088: Set_Configuration_Cfm
bluetoothd[3325]: avdtp_ref(0xb9151048): ref=4
bluetoothd[3325]: stream state changed: IDLE -> CONFIGURED
bluetoothd[3325]: session_cb
bluetoothd[3325]: OPEN request succeeded
bluetoothd[3325]: AVCTP: connected to 00:0D:FD:18:6E:3C
bluetoothd[3325]: Can't open input device: No such file or directory (2)
bluetoothd[3325]: AVRCP: failed to init uinput for 00:0D:FD:18:6E:3C
bluetoothd[3325]: AVDTP: connected transport channel to 00:0D:FD:18:6E:3C
bluetoothd[3325]: Source 0xb9150088: Open_Cfm
bluetoothd[3325]: setup_ref(0xb914ba50): ref=2
bluetoothd[3325]: SEP 0xb9150088 locked
bluetoothd[3325]: Audio API: sending BT_SETCONFIGURATION_RSP
bluetoothd[3325]: setup_unref(0xb914ba50): ref=1
bluetoothd[3325]: setup_unref(0xb914ba50): ref=0
bluetoothd[3325]: setup_free(0xb914ba50)
bluetoothd[3325]: avdtp_unref(0xb9151048): ref=3
bluetoothd[3325]: stream state changed: CONFIGURED -> OPEN
bluetoothd[3325]: Audio API: received BT_STREAMSTART_REQ
bluetoothd[3325]: avdtp_ref(0xb9151048): ref=4
bluetoothd[3325]: setup_ref(0xb914b1b0): ref=1
bluetoothd[3325]: session_cb
bluetoothd[3325]: START request succeeded
bluetoothd[3325]: Source 0xb9150088: Start_Cfm
bluetoothd[3325]: setup_ref(0xb914b1b0): ref=2
bluetoothd[3325]: Audio API: sending BT_STREAMSTART_RSP
bluetoothd[3325]: Audio API: sending BT_STREAMFD_IND
bluetoothd[3325]: setup_unref(0xb914b1b0): ref=1
bluetoothd[3325]: setup_unref(0xb914b1b0): ref=0
bluetoothd[3325]: setup_free(0xb914b1b0)
bluetoothd[3325]: avdtp_unref(0xb9151048): ref=3
bluetoothd[3325]: stream state changed: OPEN -> STREAMING
bluetoothd[3325]: Unix client disconnected (fd=21)
bluetoothd[3325]: SEP 0xb9150088 unlocked
bluetoothd[3325]: avdtp_unref(0xb9151048): ref=2
bluetoothd[3325]: session_cb
bluetoothd[3325]: SUSPEND request succeeded
bluetoothd[3325]: stream state changed: STREAMING -> OPEN
bluetoothd[3325]: Source 0xb9150088: Suspend_Cfm
bluetoothd[3325]: Accepted new client connection on unix socket (fd=21)
bluetoothd[3325]: Audio API: received BT_GETCAPABILITIES_REQ
bluetoothd[3325]: avdtp_ref(0xb9151048): ref=3
bluetoothd[3325]: Audio API: sending BT_GETCAPABILITIES_RSP
bluetoothd[3325]: Audio API: received BT_SETCONFIGURATION_REQ
bluetoothd[3325]: config a2dp - device = 00:0D:FD:18:6E:3C access_mode = 2
bluetoothd[3325]: codec sbc - frequency = 1 channel_mode = 1 allocation = 1 subbands = 1 blocks = 1 bitpool = 44
bluetoothd[3325]: a2dp_source_config: selected SEP 0xb9150088
bluetoothd[3325]: avdtp_ref(0xb9151048): ref=4
bluetoothd[3325]: setup_ref(0xb9149a60): ref=1
bluetoothd[3325]: session_cb
bluetoothd[3325]: CLOSE request succeeded
bluetoothd[3325]: stream state changed: OPEN -> CLOSING
bluetoothd[3325]: Source 0xb9150088: Close_Cfm
bluetoothd[3325]: stream state changed: CLOSING -> IDLE
bluetoothd[3325]: avdtp_unref(0xb9151048): ref=3
bluetoothd[3325]: avdtp_set_configuration(0xb9151048): int_seid=1, acp_seid=1
bluetoothd[3325]: session_cb
bluetoothd[3325]: SET_CONFIGURATION request succeeded
bluetoothd[3325]: Source 0xb9150088: Set_Configuration_Cfm
bluetoothd[3325]: avdtp_ref(0xb9151048): ref=4
bluetoothd[3325]: stream state changed: IDLE -> CONFIGURED
bluetoothd[3325]: session_cb
bluetoothd[3325]: OPEN request succeeded
bluetoothd[3325]: AVDTP: connected transport channel to 00:0D:FD:18:6E:3C
bluetoothd[3325]: Source 0xb9150088: Open_Cfm
bluetoothd[3325]: setup_ref(0xb9149a60): ref=2
bluetoothd[3325]: SEP 0xb9150088 locked
bluetoothd[3325]: Audio API: sending BT_SETCONFIGURATION_RSP
bluetoothd[3325]: setup_unref(0xb9149a60): ref=1
bluetoothd[3325]: setup_unref(0xb9149a60): ref=0
bluetoothd[3325]: setup_free(0xb9149a60)
bluetoothd[3325]: avdtp_unref(0xb9151048): ref=3
bluetoothd[3325]: stream state changed: CONFIGURED -> OPEN
bluetoothd[3325]: Audio API: received BT_STREAMSTART_REQ
bluetoothd[3325]: avdtp_ref(0xb9151048): ref=4
bluetoothd[3325]: setup_ref(0xb9149a60): ref=1
bluetoothd[3325]: session_cb
bluetoothd[3325]: START request succeeded
bluetoothd[3325]: Source 0xb9150088: Start_Cfm
bluetoothd[3325]: setup_ref(0xb9149a60): ref=2
bluetoothd[3325]: Audio API: sending BT_STREAMSTART_RSP
bluetoothd[3325]: Audio API: sending BT_STREAMFD_IND
bluetoothd[3325]: setup_unref(0xb9149a60): ref=1
bluetoothd[3325]: setup_unref(0xb9149a60): ref=0
bluetoothd[3325]: setup_free(0xb9149a60)
bluetoothd[3325]: avdtp_unref(0xb9151048): ref=3
bluetoothd[3325]: stream state changed: OPEN -> STREAMING
bluetoothd[3325]: Unix client disconnected (fd=21)
bluetoothd[3325]: SEP 0xb9150088 unlocked
bluetoothd[3325]: avdtp_unref(0xb9151048): ref=2
bluetoothd[3325]: session_cb
bluetoothd[3325]: SUSPEND request succeeded
bluetoothd[3325]: stream state changed: STREAMING -> OPEN
bluetoothd[3325]: Source 0xb9150088: Suspend_Cfm
bluetoothd[3325]: session_cb
bluetoothd[3325]: CLOSE request succeeded
bluetoothd[3325]: stream state changed: OPEN -> CLOSING
bluetoothd[3325]: Source 0xb9150088: Close_Cfm
bluetoothd[3325]: stream state changed: CLOSING -> IDLE
bluetoothd[3325]: avdtp_unref(0xb9151048): ref=1
bluetoothd[3325]: Disconnected from 00:0D:FD:18:6E:3C
bluetoothd[3325]: avdtp_unref(0xb9151048): ref=0
bluetoothd[3325]: avdtp_unref(0xb9151048): freeing session and removing from list

========================================================================

bluetoothd[2294]: Bluetooth daemon
bluetoothd[2294]: Enabling debug information
bluetoothd[2294]: parsing main.conf
bluetoothd[2294]: offmode=NoScan
bluetoothd[2294]: discovto=0
bluetoothd[2294]: pageto=8192
bluetoothd[2294]: name=%h-%d
bluetoothd[2294]: class=0x000100
bluetoothd[2294]: inqmode=0
bluetoothd[2294]: Starting SDP server
bluetoothd[2294]: Loading plugins /usr/lib/bluetooth/plugins
bluetoothd[2294]: /usr/lib/bluetooth/plugins/service.so
bluetoothd[2294]: /usr/lib/bluetooth/plugins/hal.so
bluetoothd[2294]: /usr/lib/bluetooth/plugins/network.so
bluetoothd[2294]: Parsing /etc/bluetooth/network.conf failed: No such file or directory
bluetoothd[2294]: Config options: InterfacePrefix=bnep%d, PANU_Script=(null), GN_Script=(null), NAP_Script=(null), GN_Interface=pan0, NAP_Interface=pan1, Security=true
bluetoothd[2294]: bridge pan0 created
bluetoothd[2294]: /usr/lib/bluetooth/plugins/serial.so
bluetoothd[2294]: /usr/lib/bluetooth/plugins/input.so
bluetoothd[2294]: Parsing /etc/bluetooth/input.conf failed: No such file or directory
bluetoothd[2294]: /usr/lib/bluetooth/plugins/audio.so
bluetoothd[2294]: Unix socket created: 12
bluetoothd[2294]: Telephony plugin initialized
bluetoothd[2294]: HFP AG features: "Ability to reject a call" "Enhanced call status" "Extended Error Result Codes"
bluetoothd[2294]: HCI dev 0 registered
bluetoothd[2294]: child 2321 forked
bluetoothd[2294]: child 2321 exited
bluetoothd[2294]: HCI dev 0 up
bluetoothd[2294]: service_probe: path /org/bluez/hci0
bluetoothd[2294]: Registered interface org.bluez.Service on path /org/bluez/hci0
bluetoothd[2294]: network_server_probe: path /org/bluez/hci0
bluetoothd[2294]: Adding record with handle 0x10000
bluetoothd[2294]: Record pattern UUID 0000000f-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00000100-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00001002-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00001115-0000-1000-8000-00805f9
bluetoothd[2294]: register_server_record: got record id 0x10000
bluetoothd[2294]: Registered interface org.bluez.NetworkPeer on path /org/bluez/hci0
bluetoothd[2294]: network_server_probe: path /org/bluez/hci0
bluetoothd[2294]: Adding record with handle 0x10001
bluetoothd[2294]: Record pattern UUID 0000000f-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00000100-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00001002-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00001117-0000-1000-8000-00805f9
bluetoothd[2294]: register_server_record: got record id 0x10001
bluetoothd[2294]: Registered interface org.bluez.NetworkHub on path /org/bluez/hci0
bluetoothd[2294]: network_server_probe: path /org/bluez/hci0
bluetoothd[2294]: Adding record with handle 0x10002
bluetoothd[2294]: Record pattern UUID 0000000f-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00000100-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00001002-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00001116-0000-1000-8000-00805f9
bluetoothd[2294]: register_server_record: got record id 0x10002
bluetoothd[2294]: Registered interface org.bluez.NetworkRouter on path /org/bluez/hci0
bluetoothd[2294]: proxy_probe: path /org/bluez/hci0
bluetoothd[2294]: Registered interface org.bluez.SerialProxyManager on path /org/bluez/hci0
bluetoothd[2294]: headset_server_probe: path /org/bluez/hci0
bluetoothd[2294]: audio.conf: Key file does not have key 'Master'
bluetoothd[2294]: Adding record with handle 0x10003
bluetoothd[2294]: Record pattern UUID 00000003-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00000100-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00001002-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00001108-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00001112-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00001203-0000-1000-8000-00805f9
bluetoothd[2294]: audio.conf: Key file does not have key 'SCORouting'
bluetoothd[2294]: a2dp_server_probe: path /org/bluez/hci0
bluetoothd[2294]: audio.conf: Key file does not have key 'Disable'
bluetoothd[2294]: audio.conf: Key file does not have group 'A2DP'
bluetoothd[2294]: audio.conf: Key file does not have group 'A2DP'
bluetoothd[2294]: audio.conf: Key file does not have group 'A2DP'
bluetoothd[2294]: audio.conf: Key file does not have group 'A2DP'
bluetoothd[2294]: audio.conf: Key file does not have key 'Master'
bluetoothd[2294]: SEP 0xb98b3098 registered: type:0 codec:0 seid:1
bluetoothd[2294]: Adding record with handle 0x10004
bluetoothd[2294]: Record pattern UUID 00000019-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00000100-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00001002-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 0000110a-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 0000110d-0000-1000-8000-00805f9
bluetoothd[2294]: avrcp_server_probe: path /org/bluez/hci0
bluetoothd[2294]: audio.conf: Key file does not have key 'Master'
bluetoothd[2294]: Adding record with handle 0x10005
bluetoothd[2294]: Record pattern UUID 00000017-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00000100-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00001002-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 0000110c-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 0000110e-0000-1000-8000-00805f9
bluetoothd[2294]: Adding record with handle 0x10006
bluetoothd[2294]: Record pattern UUID 00000017-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00000100-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 00001002-0000-1000-8000-00805f9
bluetoothd[2294]: Record pattern UUID 0000110e-0000-1000-8000-00805f9
bluetoothd[2294]: Creating device /org/bluez/hci0/dev_00_0D_FD_18_6E_3C
bluetoothd[2294]: Probe drivers for /org/bluez/hci0/dev_00_0D_FD_18_6E_3C
bluetoothd[2294]: headset_probe: path /org/bluez/hci0/dev_00_0D_FD_18_6E_3C
bluetoothd[2294]: Registered interface org.bluez.Input on path /org/bluez/hci0/dev_00_0D_FD_18_6E_3C
bluetoothd[2294]: adapter_get_device(00:0D:FD:18:6E:3C)
bluetoothd[2294]: Found Headset record
bluetoothd[2294]: Discovered Headset service on RFCOMM channel 2
bluetoothd[2294]: Registered interface org.bluez.Headset on path /org/bluez/hci0/dev_00_0D_FD_18_6E_3C
bluetoothd[2294]: audio handle_uuid: server not enabled for 0000111e-0000-1000-8000-00805f9b34fb (0x111e)
bluetoothd[2294]: Found Audio Sink
bluetoothd[2294]: Registered interface org.bluez.AudioSink on path /org/bluez/hci0/dev_00_0D_FD_18_6E_3C
bluetoothd[2294]: Found AV Target
bluetoothd[2294]: Registered interface org.bluez.Control on path /org/bluez/hci0/dev_00_0D_FD_18_6E_3C
bluetoothd[2294]: Found AV Remote
bluetoothd[2294]: Creating device /org/bluez/hci0/dev_00_07_61_0F_4A_60
bluetoothd[2294]: Probe drivers for /org/bluez/hci0/dev_00_07_61_0F_4A_60
bluetoothd[2294]: hid_device_probe: path /org/bluez/hci0/dev_00_07_61_0F_4A_60
bluetoothd[2294]: Registered interface org.bluez.Input on path /org/bluez/hci0/dev_00_07_61_0F_4A_60
bluetoothd[2294]: Adapter /org/bluez/hci0 has been enabled
bluetoothd[2294]: Starting security manager 0
bluetoothd[2294]: Computer is classified as laptop
bluetoothd[2294]: Current device class is 0x0a010c
bluetoothd[2294]: Setting 0x00010c for major/minor device class
bluetoothd[2294]: Accepted new client connection on unix socket (fd=21)
bluetoothd[2294]: Audio API: received BT_GETCAPABILITIES_REQ
bluetoothd[2294]: avdtp_ref(0xb98b4700): ref=2
bluetoothd[2294]: link_key_request (sba=00:15:AF:F4:E9:E0, dba=00:0D:FD:18:6E:3C)
bluetoothd[2294]: kernel auth requirements = 0x00
bluetoothd[2294]: stored link key type = 0x00
bluetoothd[2294]: adapter_get_device(00:0D:FD:18:6E:3C)
bluetoothd[2294]: AVDTP: connected signaling channel to 00:0D:FD:18:6E:3C
bluetoothd[2294]: session_cb
bluetoothd[2294]: DISCOVER request succeeded
bluetoothd[2294]: seid 1 type 1 media 0 in use 0
bluetoothd[2294]: seid 2 type 1 media 0 in use 0
bluetoothd[2294]: session_cb
bluetoothd[2294]: GET_CAPABILITIES request succeeded
bluetoothd[2294]: seid 1 type 1 media 0
bluetoothd[2294]: session_cb
bluetoothd[2294]: GET_CAPABILITIES request succeeded
bluetoothd[2294]: seid 2 type 1 media 0
bluetoothd[2294]: Audio API: sending BT_GETCAPABILITIES_RSP
bluetoothd[2294]: Audio API: received BT_SETCONFIGURATION_REQ
bluetoothd[2294]: config a2dp - device = 00:0D:FD:18:6E:3C access_mode = 2
bluetoothd[2294]: codec sbc - frequency = 1 channel_mode = 1 allocation = 1 subbands = 1 blocks = 1 bitpool = 44
bluetoothd[2294]: a2dp_source_config: selected SEP 0xb98b3098
bluetoothd[2294]: avdtp_ref(0xb98b4700): ref=3
bluetoothd[2294]: setup_ref(0xb98b5398): ref=1
bluetoothd[2294]: avdtp_set_configuration(0xb98b4700): int_seid=1, acp_seid=1
bluetoothd[2294]: session_cb
bluetoothd[2294]: SET_CONFIGURATION request succeeded
bluetoothd[2294]: Source 0xb98b3098: Set_Configuration_Cfm
bluetoothd[2294]: avdtp_ref(0xb98b4700): ref=4
bluetoothd[2294]: stream state changed: IDLE -> CONFIGURED
bluetoothd[2294]: session_cb
bluetoothd[2294]: OPEN request succeeded
bluetoothd[2294]: AVCTP: connected to 00:0D:FD:18:6E:3C
bluetoothd[2294]: Can't open input device: No such file or directory (2)
bluetoothd[2294]: AVRCP: failed to init uinput for 00:0D:FD:18:6E:3C
bluetoothd[2294]: AVDTP: connected transport channel to 00:0D:FD:18:6E:3C
bluetoothd[2294]: Source 0xb98b3098: Open_Cfm
bluetoothd[2294]: setup_ref(0xb98b5398): ref=2
bluetoothd[2294]: SEP 0xb98b3098 locked
bluetoothd[2294]: Audio API: sending BT_SETCONFIGURATION_RSP
bluetoothd[2294]: setup_unref(0xb98b5398): ref=1
bluetoothd[2294]: setup_unref(0xb98b5398): ref=0
bluetoothd[2294]: setup_free(0xb98b5398)
bluetoothd[2294]: avdtp_unref(0xb98b4700): ref=3
bluetoothd[2294]: stream state changed: CONFIGURED -> OPEN
bluetoothd[2294]: Audio API: received BT_STREAMSTART_REQ
bluetoothd[2294]: avdtp_ref(0xb98b4700): ref=4
bluetoothd[2294]: setup_ref(0xb98b4050): ref=1
bluetoothd[2294]: session_cb
bluetoothd[2294]: START request succeeded
bluetoothd[2294]: Source 0xb98b3098: Start_Cfm
bluetoothd[2294]: setup_ref(0xb98b4050): ref=2
bluetoothd[2294]: Audio API: sending BT_STREAMSTART_RSP
bluetoothd[2294]: Audio API: sending BT_STREAMFD_IND
bluetoothd[2294]: setup_unref(0xb98b4050): ref=1
bluetoothd[2294]: setup_unref(0xb98b4050): ref=0
bluetoothd[2294]: setup_free(0xb98b4050)
bluetoothd[2294]: avdtp_unref(0xb98b4700): ref=3
bluetoothd[2294]: stream state changed: OPEN -> STREAMING
bluetoothd[2294]: Unix client disconnected (fd=21)
bluetoothd[2294]: SEP 0xb98b3098 unlocked
bluetoothd[2294]: avdtp_unref(0xb98b4700): ref=2
bluetoothd[2294]: Accepted new client connection on unix socket (fd=21)
bluetoothd[2294]: Audio API: received BT_GETCAPABILITIES_REQ
bluetoothd[2294]: avdtp_ref(0xb98b4700): ref=3
bluetoothd[2294]: Audio API: sending BT_GETCAPABILITIES_RSP
bluetoothd[2294]: Audio API: received BT_SETCONFIGURATION_REQ
bluetoothd[2294]: config a2dp - device = 00:0D:FD:18:6E:3C access_mode = 2
bluetoothd[2294]: codec sbc - frequency = 1 channel_mode = 1 allocation = 1 subbands = 1 blocks = 1 bitpool = 44
bluetoothd[2294]: a2dp_source_config: selected SEP 0xb98b3098
bluetoothd[2294]: avdtp_ref(0xb98b4700): ref=4
bluetoothd[2294]: setup_ref(0xb98b5460): ref=1
bluetoothd[2294]: setup_ref(0xb98b5460): ref=2
bluetoothd[2294]: SEP 0xb98b3098 locked
bluetoothd[2294]: Audio API: sending BT_SETCONFIGURATION_RSP
bluetoothd[2294]: setup_unref(0xb98b5460): ref=1
bluetoothd[2294]: setup_unref(0xb98b5460): ref=0
bluetoothd[2294]: setup_free(0xb98b5460)
bluetoothd[2294]: avdtp_unref(0xb98b4700): ref=3
bluetoothd[2294]: Audio API: received BT_STREAMSTART_REQ
bluetoothd[2294]: avdtp_ref(0xb98b4700): ref=4
bluetoothd[2294]: setup_ref(0xb98b5460): ref=1
bluetoothd[2294]: session_cb
bluetoothd[2294]: SUSPEND request succeeded
bluetoothd[2294]: stream state changed: STREAMING -> OPEN
bluetoothd[2294]: Source 0xb98b3098: Suspend_Cfm
bluetoothd[2294]: setup_ref(0xb98b5460): ref=2
bluetoothd[2294]: setup_unref(0xb98b5460): ref=1
bluetoothd[2294]: session_cb
bluetoothd[2294]: START request succeeded
bluetoothd[2294]: Source 0xb98b3098: Start_Cfm
bluetoothd[2294]: setup_ref(0xb98b5460): ref=2
bluetoothd[2294]: Audio API: sending BT_STREAMSTART_RSP
bluetoothd[2294]: Audio API: sending BT_STREAMFD_IND
bluetoothd[2294]: setup_unref(0xb98b5460): ref=1
bluetoothd[2294]: setup_unref(0xb98b5460): ref=0
bluetoothd[2294]: setup_free(0xb98b5460)
bluetoothd[2294]: avdtp_unref(0xb98b4700): ref=3
bluetoothd[2294]: stream state changed: OPEN -> STREAMING
bluetoothd[2294]: Unix client disconnected (fd=21)
bluetoothd[2294]: SEP 0xb98b3098 unlocked
bluetoothd[2294]: avdtp_unref(0xb98b4700): ref=2
bluetoothd[2294]: session_cb
bluetoothd[2294]: SUSPEND request succeeded
bluetoothd[2294]: stream state changed: STREAMING -> OPEN
bluetoothd[2294]: Source 0xb98b3098: Suspend_Cfm
bluetoothd[2294]: Accepted new client connection on unix socket (fd=21)
bluetoothd[2294]: Audio API: received BT_GETCAPABILITIES_REQ
bluetoothd[2294]: avdtp_ref(0xb98b4700): ref=3
bluetoothd[2294]: Audio API: sending BT_GETCAPABILITIES_RSP
bluetoothd[2294]: Audio API: received BT_SETCONFIGURATION_REQ
bluetoothd[2294]: config a2dp - device = 00:0D:FD:18:6E:3C access_mode = 2
bluetoothd[2294]: codec sbc - frequency = 1 channel_mode = 1 allocation = 1 subbands = 1 blocks = 1 bitpool = 44
bluetoothd[2294]: a2dp_source_config: selected SEP 0xb98b3098
bluetoothd[2294]: avdtp_ref(0xb98b4700): ref=4
bluetoothd[2294]: setup_ref(0xb98b16c0): ref=1
bluetoothd[2294]: setup_ref(0xb98b16c0): ref=2
bluetoothd[2294]: SEP 0xb98b3098 locked
bluetoothd[2294]: Audio API: sending BT_SETCONFIGURATION_RSP
bluetoothd[2294]: setup_unref(0xb98b16c0): ref=1
bluetoothd[2294]: setup_unref(0xb98b16c0): ref=0
bluetoothd[2294]: setup_free(0xb98b16c0)
bluetoothd[2294]: avdtp_unref(0xb98b4700): ref=3
bluetoothd[2294]: Audio API: received BT_STREAMSTART_REQ
bluetoothd[2294]: avdtp_ref(0xb98b4700): ref=4
bluetoothd[2294]: setup_ref(0xb98b16c0): ref=1
bluetoothd[2294]: session_cb
bluetoothd[2294]: START request succeeded
bluetoothd[2294]: Source 0xb98b3098: Start_Cfm
bluetoothd[2294]: setup_ref(0xb98b16c0): ref=2
bluetoothd[2294]: Audio API: sending BT_STREAMSTART_RSP
bluetoothd[2294]: Audio API: sending BT_STREAMFD_IND
bluetoothd[2294]: setup_unref(0xb98b16c0): ref=1
bluetoothd[2294]: setup_unref(0xb98b16c0): ref=0
bluetoothd[2294]: setup_free(0xb98b16c0)
bluetoothd[2294]: avdtp_unref(0xb98b4700): ref=3
bluetoothd[2294]: stream state changed: OPEN -> STREAMING
bluetoothd[2294]: Unix client disconnected (fd=21)
bluetoothd[2294]: SEP 0xb98b3098 unlocked
bluetoothd[2294]: avdtp_unref(0xb98b4700): ref=2
bluetoothd[2294]: session_cb
bluetoothd[2294]: SUSPEND request succeeded
bluetoothd[2294]: stream state changed: STREAMING -> OPEN
bluetoothd[2294]: Source 0xb98b3098: Suspend_Cfm
bluetoothd[2294]: Accepted new client connection on unix socket (fd=21)
bluetoothd[2294]: Audio API: received BT_GETCAPABILITIES_REQ
bluetoothd[2294]: avdtp_ref(0xb98b4700): ref=3
bluetoothd[2294]: Audio API: sending BT_GETCAPABILITIES_RSP
bluetoothd[2294]: Audio API: received BT_SETCONFIGURATION_REQ
bluetoothd[2294]: config a2dp - device = 00:0D:FD:18:6E:3C access_mode = 2
bluetoothd[2294]: codec sbc - frequency = 1 channel_mode = 1 allocation = 1 subbands = 1 blocks = 1 bitpool = 44
bluetoothd[2294]: a2dp_source_config: selected SEP 0xb98b3098
bluetoothd[2294]: avdtp_ref(0xb98b4700): ref=4
bluetoothd[2294]: setup_ref(0xb98b16c0): ref=1
bluetoothd[2294]: setup_ref(0xb98b16c0): ref=2
bluetoothd[2294]: SEP 0xb98b3098 locked
bluetoothd[2294]: Audio API: sending BT_SETCONFIGURATION_RSP
bluetoothd[2294]: setup_unref(0xb98b16c0): ref=1
bluetoothd[2294]: setup_unref(0xb98b16c0): ref=0
bluetoothd[2294]: setup_free(0xb98b16c0)
bluetoothd[2294]: avdtp_unref(0xb98b4700): ref=3
bluetoothd[2294]: Audio API: received BT_STREAMSTART_REQ
bluetoothd[2294]: avdtp_ref(0xb98b4700): ref=4
bluetoothd[2294]: setup_ref(0xb98b16c0): ref=1
bluetoothd[2294]: session_cb
bluetoothd[2294]: START request succeeded
bluetoothd[2294]: Source 0xb98b3098: Start_Cfm
bluetoothd[2294]: setup_ref(0xb98b16c0): ref=2
bluetoothd[2294]: Audio API: sending BT_STREAMSTART_RSP
bluetoothd[2294]: Audio API: sending BT_STREAMFD_IND
bluetoothd[2294]: setup_unref(0xb98b16c0): ref=1
bluetoothd[2294]: setup_unref(0xb98b16c0): ref=0
bluetoothd[2294]: setup_free(0xb98b16c0)
bluetoothd[2294]: avdtp_unref(0xb98b4700): ref=3
bluetoothd[2294]: stream state changed: OPEN -> STREAMING
bluetoothd[2294]: Unix client disconnected (fd=21)
bluetoothd[2294]: SEP 0xb98b3098 unlocked
bluetoothd[2294]: avdtp_unref(0xb98b4700): ref=2
bluetoothd[2294]: session_cb
bluetoothd[2294]: SUSPEND request succeeded
bluetoothd[2294]: stream state changed: STREAMING -> OPEN
bluetoothd[2294]: Source 0xb98b3098: Suspend_Cfm
bluetoothd[2294]: session_cb
bluetoothd[2294]: CLOSE request succeeded
bluetoothd[2294]: stream state changed: OPEN -> CLOSING
bluetoothd[2294]: Source 0xb98b3098: Close_Cfm
bluetoothd[2294]: stream state changed: CLOSING -> IDLE
bluetoothd[2294]: avdtp_unref(0xb98b4700): ref=1
bluetoothd[2294]: Disconnected from 00:0D:FD:18:6E:3C
bluetoothd[2294]: avdtp_unref(0xb98b4700): ref=0
bluetoothd[2294]: avdtp_unref(0xb98b4700): freeing session and removing from list

[-- Attachment #4: Type: text/plain, Size: 363 bytes --]

-------------------------------------------------------------------------
This SF.Net email is sponsored by the Moblin Your Move Developer's challenge
Build the coolest Linux based applications with Moblin SDK & win great prizes
Grand prize is a trip for two to an Open Source event anywhere in the world
http://moblin-contest.org/redirect.php?banner_id=100&url=/

[-- Attachment #5: Type: text/plain, Size: 164 bytes --]

_______________________________________________
Bluez-users mailing list
Bluez-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bluez-users

^ permalink raw reply	[flat|nested] 10+ messages in thread

* Re: [Bluez-devel] [Bluez-users] Motorola S9 and BlueZ 4.14
  2008-10-18 20:40   ` Jelle de Jong
@ 2008-10-19 15:55     ` Patryk Zawadzki
  2008-10-19 16:09       ` Patryk Zawadzki
  0 siblings, 1 reply; 10+ messages in thread
From: Patryk Zawadzki @ 2008-10-19 15:55 UTC (permalink / raw)
  To: BlueZ users, BlueZ development

After some digging in the current GIT head:

bluetoothd[20589]: AVCTP: connected to 00:0D:FD:15:F0:3E
bluetoothd[20589]: AVRCP: uinput initialized for 00:0D:FD:15:F0:3E
bluetoothd[20589]: AVDTP: incoming connect from 00:0D:FD:15:F0:3E
DEBUG: trying to change from OPEN to OPEN
bluetoothd[20589]: stream state change failed: Input/output error

So for me it tries to change the stream state top OPEN twice.

Another debugging effort with pulseaudio bluetooth init:

bluetoothd[20589]: Received SET_CONFIGURATION_CMD
DEBUG: initializing stream sock to -1
[...]
bluetoothd[20851]: Audio API: received BT_SETCONFIGURATION_REQ
bluetoothd[20851]: config a2dp - device = 00:0D:FD:15:F0:3E access_mode = 2
bluetoothd[20851]: codec sbc - frequency = 2 channel_mode = 1
allocation = 1 subbands = 1 blocks = 1 bitpool = 44
bluetoothd[20851]: a2dp_source_config: selected SEP 0xb851c630
bluetoothd[20851]: avdtp_ref(0xb8521398): ref=4
bluetoothd[20851]: setup_ref(0xb8519490): ref=1
bluetoothd[20851]: setup_ref(0xb8519490): ref=2
bluetoothd[20851]: SEP 0xb851c630 locked
DEBUG: stream sock is -1
bluetoothd[20851]: Unable to get stream transport
bluetoothd[20851]: config failed

The stream socket does not seem to be set anywhere else along the way
(added debug prints to all stream socket changes in bluez code).
That's why get_transport returns FALSE. Still not sure if the bug is
in pulseaudio or in bluez.

Also sending this to bluez-devel, please don't shoot me for crossposting.

-- 
Patryk Zawadzki

-------------------------------------------------------------------------
This SF.Net email is sponsored by the Moblin Your Move Developer's challenge
Build the coolest Linux based applications with Moblin SDK & win great prizes
Grand prize is a trip for two to an Open Source event anywhere in the world
http://moblin-contest.org/redirect.php?banner_id=100&url=/
_______________________________________________
Bluez-devel mailing list
Bluez-devel@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bluez-devel

^ permalink raw reply	[flat|nested] 10+ messages in thread

* Re: [Bluez-devel] [Bluez-users] Motorola S9 and BlueZ 4.14
  2008-10-19 15:55     ` [Bluez-devel] " Patryk Zawadzki
@ 2008-10-19 16:09       ` Patryk Zawadzki
  2008-10-19 16:35         ` Johan Hedberg
  0 siblings, 1 reply; 10+ messages in thread
From: Patryk Zawadzki @ 2008-10-19 16:09 UTC (permalink / raw)
  To: BlueZ users, BlueZ development

And here's a full instrumented run:

bluetoothd[22394]: link_key_request (sba=00:1D:60:69:91:18,
dba=00:0D:FD:15:F0:3E)
bluetoothd[22394]: kernel auth requirements = 0x00
bluetoothd[22394]: stored link key type = 0x00
bluetoothd[22394]: adapter_get_device(00:0D:FD:15:F0:3E)
bluetoothd[22394]: hcid_dbus_bonding_process_complete: status=00
bluetoothd[22394]: adapter_get_device(00:0D:FD:15:F0:3E)
bluetoothd[22394]: hcid_dbus_bonding_process_complete: no pending auth request
bluetoothd[22394]: AVDTP: incoming connect from 00:0D:FD:15:F0:3E
bluetoothd[22394]: session_cb
bluetoothd[22394]: Received DISCOVER_CMD
bluetoothd[22394]: session_cb
bluetoothd[22394]: Received  GET_CAPABILITIES_CMD
bluetoothd[22394]: Source 0xb9232388: Get_Capability_Ind
bluetoothd[22394]: session_cb
bluetoothd[22394]: Received SET_CONFIGURATION_CMD
DEBUG: setting stream sock to -1
bluetoothd[22394]: Source 0xb9232388: Set_Configuration_Ind
bluetoothd[22394]: avdtp_ref(0xb92374d8): ref=2
bluetoothd[22394]: stream state changed: IDLE -> CONFIGURED
bluetoothd[22394]: session_cb
bluetoothd[22394]: Received OPEN_CMD
bluetoothd[22394]: Source 0xb9232388: Open_Ind
bluetoothd[22394]: stream state changed: CONFIGURED -> OPEN
bluetoothd[22394]: Accepted new client connection on unix socket (fd=24)
bluetoothd[22394]: Audio API: received BT_GETCAPABILITIES_REQ
bluetoothd[22394]: avdtp_ref(0xb92374d8): ref=3
bluetoothd[22394]: AVCTP: connected to 00:0D:FD:15:F0:3E
bluetoothd[22394]: AVRCP: uinput initialized for 00:0D:FD:15:F0:3E
bluetoothd[22394]: session_cb
bluetoothd[22394]: DISCOVER request succeeded
bluetoothd[22394]: seid 1 type 1 media 0 in use 1
bluetoothd[22394]: seid 2 type 1 media 0 in use 1
bluetoothd[22394]: session_cb
bluetoothd[22394]: GET_CAPABILITIES request succeeded
bluetoothd[22394]: seid 1 type 1 media 0
bluetoothd[22394]: Audio API: sending BT_GETCAPABILITIES_RSP
bluetoothd[22394]: Audio API: received BT_SETCONFIGURATION_REQ
bluetoothd[22394]: config a2dp - device = 00:0D:FD:15:F0:3E access_mode = 2
bluetoothd[22394]: codec sbc - frequency = 2 channel_mode = 1
allocation = 1 subbands = 1 blocks = 1 bitpool = 44
bluetoothd[22394]: a2dp_source_config: selected SEP 0xb9232388
bluetoothd[22394]: avdtp_ref(0xb92374d8): ref=4
bluetoothd[22394]: setup_ref(0xb9234250): ref=1
bluetoothd[22394]: setup_ref(0xb9234250): ref=2
bluetoothd[22394]: SEP 0xb9232388 locked
DEBUG: stream sock is -1
bluetoothd[22394]: Unable to get stream transport
bluetoothd[22394]: config failed
bluetoothd[22394]: SEP 0xb9232388 unlocked
bluetoothd[22394]: Audio API: sending BT_SETCONFIGURATION_RSP
bluetoothd[22394]: avdtp_unref(0xb92374d8): ref=3
bluetoothd[22394]: setup_unref(0xb9234250): ref=1
bluetoothd[22394]: setup_unref(0xb9234250): ref=0
bluetoothd[22394]: setup_free(0xb9234250)
bluetoothd[22394]: avdtp_unref(0xb92374d8): ref=2
bluetoothd[22394]: Unix client disconnected (fd=24)
bluetoothd[22394]: AVDTP: incoming connect from 00:0D:FD:15:F0:3E
DEBUG: setting stream sock to 24
DEBUG: trying to change stream state from 2 to 2
bluetoothd[22394]: stream state change failed: Input/output error
bluetoothd[22394]: session_cb
bluetoothd[22394]: Received START_CMD
bluetoothd[22394]: Source 0xb9232388: Start_Ind
bluetoothd[22394]: avdtp_ref(0xb92374d8): ref=3
bluetoothd[22394]: stream state changed: OPEN -> STREAMING
bluetoothd[22394]: avdtp_unref(0xb92374d8): ref=2
bluetoothd[22394]: session_cb
bluetoothd[22394]: SUSPEND request succeeded
bluetoothd[22394]: stream state changed: STREAMING -> OPEN
bluetoothd[22394]: Source 0xb9232388: Suspend_Cfm
bluetoothd[22394]: session_cb
bluetoothd[22394]: CLOSE request succeeded
bluetoothd[22394]: stream state changed: OPEN -> CLOSING
DEBUG: setting stream sock to -1
bluetoothd[22394]: Source 0xb9232388: Close_Cfm
bluetoothd[22394]: stream state changed: CLOSING -> IDLE
bluetoothd[22394]: avdtp_unref(0xb92374d8): ref=1
bluetoothd[22394]: Disconnected from 00:0D:FD:15:F0:3E
bluetoothd[22394]: avdtp_unref(0xb92374d8): ref=0
bluetoothd[22394]: avdtp_unref(0xb92374d8): freeing session and
removing from list

What's interesting is the "connected to X"/"incoming connect from X"
pair that seems to cause double stream state change to OPEN. Also
there seems to be a race condition between bluez and pulseaudio's
bluetooth-discovery agent (notice where it tries to get stream
properties long before setting the connection socket).

-- 
Patryk Zawadzki

-------------------------------------------------------------------------
This SF.Net email is sponsored by the Moblin Your Move Developer's challenge
Build the coolest Linux based applications with Moblin SDK & win great prizes
Grand prize is a trip for two to an Open Source event anywhere in the world
http://moblin-contest.org/redirect.php?banner_id=100&url=/
_______________________________________________
Bluez-devel mailing list
Bluez-devel@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bluez-devel

^ permalink raw reply	[flat|nested] 10+ messages in thread

* Re: [Bluez-devel] [Bluez-users] Motorola S9 and BlueZ 4.14
  2008-10-19 16:09       ` Patryk Zawadzki
@ 2008-10-19 16:35         ` Johan Hedberg
  2008-10-19 16:54           ` Patryk Zawadzki
  2008-10-20 20:53           ` Luiz Augusto von Dentz
  0 siblings, 2 replies; 10+ messages in thread
From: Johan Hedberg @ 2008-10-19 16:35 UTC (permalink / raw)
  To: BlueZ development

Hi,

I'm still investigating this, but it seems it's caused by patch  
e303ffce67951a29d822c8c819e74e2c70c297d7 from Luiz which forgot to  
remove set_state(OPEN) from avdtp_open_cmd() (his patch changes OPEN  
state change for the initiator case from the response reveiving to the  
stream L2CAP channel establishment). All in all looking at the AVDTP  
spec 1.2 it seems Luiz's patch isn't correct since according to figure  
6.9 (page 35) the OPEN state should be entered *before* the stream  
L2CAP channel is established.

Johan

-------------------------------------------------------------------------
This SF.Net email is sponsored by the Moblin Your Move Developer's challenge
Build the coolest Linux based applications with Moblin SDK & win great prizes
Grand prize is a trip for two to an Open Source event anywhere in the world
http://moblin-contest.org/redirect.php?banner_id=100&url=/
_______________________________________________
Bluez-devel mailing list
Bluez-devel@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bluez-devel

^ permalink raw reply	[flat|nested] 10+ messages in thread

* Re: [Bluez-devel] [Bluez-users] Motorola S9 and BlueZ 4.14
  2008-10-19 16:35         ` Johan Hedberg
@ 2008-10-19 16:54           ` Patryk Zawadzki
  2008-10-19 17:06             ` Patryk Zawadzki
  2008-10-20 20:53           ` Luiz Augusto von Dentz
  1 sibling, 1 reply; 10+ messages in thread
From: Patryk Zawadzki @ 2008-10-19 16:54 UTC (permalink / raw)
  To: BlueZ development

On Sun, Oct 19, 2008 at 6:35 PM, Johan Hedberg <johan.hedberg@gmail.com> wrote:
> Hi,
>
> I'm still investigating this, but it seems it's caused by patch
> e303ffce67951a29d822c8c819e74e2c70c297d7 from Luiz which forgot to
> remove set_state(OPEN) from avdtp_open_cmd() (his patch changes OPEN
> state change for the initiator case from the response reveiving to the
> stream L2CAP channel establishment). All in all looking at the AVDTP
> spec 1.2 it seems Luiz's patch isn't correct since according to figure
> 6.9 (page 35) the OPEN state should be entered *before* the stream
> L2CAP channel is established.

Ineed removing the set_state call from avdtp_open_cmd causes the
device to initialize correctly and even work with pulseaudio. If this
is correct according to the specification it is indeed the fix for the
case of Motorola S9.

-- 
Patryk Zawadzki

-------------------------------------------------------------------------
This SF.Net email is sponsored by the Moblin Your Move Developer's challenge
Build the coolest Linux based applications with Moblin SDK & win great prizes
Grand prize is a trip for two to an Open Source event anywhere in the world
http://moblin-contest.org/redirect.php?banner_id=100&url=/
_______________________________________________
Bluez-devel mailing list
Bluez-devel@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bluez-devel

^ permalink raw reply	[flat|nested] 10+ messages in thread

* Re: [Bluez-devel] [Bluez-users] Motorola S9 and BlueZ 4.14
  2008-10-19 16:54           ` Patryk Zawadzki
@ 2008-10-19 17:06             ` Patryk Zawadzki
  2008-10-19 17:16               ` Johan Hedberg
  0 siblings, 1 reply; 10+ messages in thread
From: Patryk Zawadzki @ 2008-10-19 17:06 UTC (permalink / raw)
  To: BlueZ development

On Sun, Oct 19, 2008 at 6:54 PM, Patryk Zawadzki <patrys@pld-linux.org> wrote:
> On Sun, Oct 19, 2008 at 6:35 PM, Johan Hedberg <johan.hedberg@gmail.com> wrote:
>> Hi,
>>
>> I'm still investigating this, but it seems it's caused by patch
>> e303ffce67951a29d822c8c819e74e2c70c297d7 from Luiz which forgot to
>> remove set_state(OPEN) from avdtp_open_cmd() (his patch changes OPEN
>> state change for the initiator case from the response reveiving to the
>> stream L2CAP channel establishment). All in all looking at the AVDTP
>> spec 1.2 it seems Luiz's patch isn't correct since according to figure
>> 6.9 (page 35) the OPEN state should be entered *before* the stream
>> L2CAP channel is established.
> Ineed removing the set_state call from avdtp_open_cmd causes the
> device to initialize correctly and even work with pulseaudio. If this
> is correct according to the specification it is indeed the fix for the
> case of Motorola S9.

Also after getting the device to connect I get a second duplicate:

bluetoothd[24705]: Audio API: sending BT_STREAMSTART_RSP
bluetoothd[24705]: Audio API: sending BT_STREAMFD_IND
bluetoothd[24705]: setup_unref(0xb9c67a70): ref=1
bluetoothd[24705]: setup_unref(0xb9c67a70): ref=0
bluetoothd[24705]: setup_free(0xb9c67a70)
bluetoothd[24705]: avdtp_unref(0xb9c5d468): ref=3
DEBUG: trying to change stream state from 3 to 3
bluetoothd[24705]: stream state change failed: Input/output error

-- 
Patryk Zawadzki

-------------------------------------------------------------------------
This SF.Net email is sponsored by the Moblin Your Move Developer's challenge
Build the coolest Linux based applications with Moblin SDK & win great prizes
Grand prize is a trip for two to an Open Source event anywhere in the world
http://moblin-contest.org/redirect.php?banner_id=100&url=/
_______________________________________________
Bluez-devel mailing list
Bluez-devel@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bluez-devel

^ permalink raw reply	[flat|nested] 10+ messages in thread

* Re: [Bluez-devel] [Bluez-users] Motorola S9 and BlueZ 4.14
  2008-10-19 17:06             ` Patryk Zawadzki
@ 2008-10-19 17:16               ` Johan Hedberg
  0 siblings, 0 replies; 10+ messages in thread
From: Johan Hedberg @ 2008-10-19 17:16 UTC (permalink / raw)
  To: BlueZ development

Hi,

On Oct 19, 2008, at 20:06, Patryk Zawadzki wrote:
> bluetoothd[24705]: Audio API: sending BT_STREAMSTART_RSP
> bluetoothd[24705]: Audio API: sending BT_STREAMFD_IND
> bluetoothd[24705]: setup_unref(0xb9c67a70): ref=1
> bluetoothd[24705]: setup_unref(0xb9c67a70): ref=0
> bluetoothd[24705]: setup_free(0xb9c67a70)
> bluetoothd[24705]: avdtp_unref(0xb9c5d468): ref=3
> DEBUG: trying to change stream state from 3 to 3
> bluetoothd[24705]: stream state change failed: Input/output error

Could you give some more info of what events triggered this than just  
these few lines? Also, if possible come to #bluez on freenode.net so  
we can discuss this in more detail there.

Johan

-------------------------------------------------------------------------
This SF.Net email is sponsored by the Moblin Your Move Developer's challenge
Build the coolest Linux based applications with Moblin SDK & win great prizes
Grand prize is a trip for two to an Open Source event anywhere in the world
http://moblin-contest.org/redirect.php?banner_id=100&url=/
_______________________________________________
Bluez-devel mailing list
Bluez-devel@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bluez-devel

^ permalink raw reply	[flat|nested] 10+ messages in thread

* Re: [Bluez-devel] [Bluez-users] Motorola S9 and BlueZ 4.14
  2008-10-19 16:35         ` Johan Hedberg
  2008-10-19 16:54           ` Patryk Zawadzki
@ 2008-10-20 20:53           ` Luiz Augusto von Dentz
  2008-10-20 21:05             ` Johan Hedberg
  1 sibling, 1 reply; 10+ messages in thread
From: Luiz Augusto von Dentz @ 2008-10-20 20:53 UTC (permalink / raw)
  To: BlueZ development

Yes and no, it could be set to OPEN state before going really
connected, but it cannot emit the signal Connected otherwise
application will just try to get the fd which could not be available
thus a race condition could cause the problem. So if Connected signal
is mapped to OPEN state it wont work always. The problem could be that
the device simple want to go to STREAMING state which probably creates
the same situation on media transport, where headset and pulse are
competing to set the same state.

Im interested to know why the spec just don't say you need the
transport to be OPEN as the state means, since from CONFIGURED to OPEN
there is nothing else relevant to do regarding the state machine or
does it? Well for now we could just create yet another state so sink.c
could be notified when the transport is connected.

-- =

Luiz Augusto von Dentz
Engenheiro de Computa=E7=E3o

-------------------------------------------------------------------------
This SF.Net email is sponsored by the Moblin Your Move Developer's challenge
Build the coolest Linux based applications with Moblin SDK & win great priz=
es
Grand prize is a trip for two to an Open Source event anywhere in the world
http://moblin-contest.org/redirect.php?banner_id=3D100&url=3D/
_______________________________________________
Bluez-devel mailing list
Bluez-devel@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bluez-devel

^ permalink raw reply	[flat|nested] 10+ messages in thread

* Re: [Bluez-devel] [Bluez-users] Motorola S9 and BlueZ 4.14
  2008-10-20 20:53           ` Luiz Augusto von Dentz
@ 2008-10-20 21:05             ` Johan Hedberg
  0 siblings, 0 replies; 10+ messages in thread
From: Johan Hedberg @ 2008-10-20 21:05 UTC (permalink / raw)
  To: BlueZ development

Hi Luiz,

On Oct 20, 2008, at 23:53, Luiz Augusto von Dentz wrote:
> Im interested to know why the spec just don't say you need the
> transport to be OPEN as the state means, since from CONFIGURED to OPEN
> there is nothing else relevant to do regarding the state machine or
> does it? Well for now we could just create yet another state so sink.c
> could be notified when the transport is connected.

I don't really understand either why the spec is as it is with regard  =

to the OPEN state. OTOH I think the current solution of going to OPEN  =

when we have the transport seems to work well enough so unless  =

something doesn't work with this approach I wouldn't go making the  =

code more complicated by adding another state.

Johan

P.S. Parab=E9ns sobre o casamento! ;)
-------------------------------------------------------------------------
This SF.Net email is sponsored by the Moblin Your Move Developer's challenge
Build the coolest Linux based applications with Moblin SDK & win great priz=
es
Grand prize is a trip for two to an Open Source event anywhere in the world
http://moblin-contest.org/redirect.php?banner_id=3D100&url=3D/
_______________________________________________
Bluez-devel mailing list
Bluez-devel@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bluez-devel

^ permalink raw reply	[flat|nested] 10+ messages in thread

end of thread, other threads:[~2008-10-20 21:05 UTC | newest]

Thread overview: 10+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
     [not found] <mailman.81198.1224358186.3608.bluez-users@lists.sourceforge.net>
2008-10-18 19:48 ` [Bluez-users] Motorola S9 and BlueZ 4.14 Patryk Zawadzki
2008-10-18 20:40   ` Jelle de Jong
2008-10-19 15:55     ` [Bluez-devel] " Patryk Zawadzki
2008-10-19 16:09       ` Patryk Zawadzki
2008-10-19 16:35         ` Johan Hedberg
2008-10-19 16:54           ` Patryk Zawadzki
2008-10-19 17:06             ` Patryk Zawadzki
2008-10-19 17:16               ` Johan Hedberg
2008-10-20 20:53           ` Luiz Augusto von Dentz
2008-10-20 21:05             ` Johan Hedberg

This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox