On Fri, Jan 6, 2012 at 3:48 PM, Marcel Holtmann <marcel@xxxxxxxxxxxx> wrote:
> Hi Scott,
>
Hey Marcel, good to hear from you.
>> Have been testing a Bluetooth 2.1 keyboard, but we don't get any
>> keypress notifications from it as the pincode is typed and the Agent's
>> DisplayPasskey D-Bus method is never called (with two or three
>> arguments).
>>
>> Any ideas where to begin debugging this?
>
> first, start with hcidump to see what commands and events are actually
> send by the keyboard. And capture the bluetoothd debug output.
>
> And I am pretty sure that a real 2.1 keyboard with Secure Simple Pairing
> is not working at all. We never managed to purchase one of these. If you
> managed to find one, then let us know where you got it from.
>
I have both of those attached, the keyboard is the Apple Wireless
Keyboard - it at least behaves in a manner consistent with 2.1 SSP
under OS X, complete with hilighting the passkey as it's typed.
One thing I noticed from the log is that neither side exchanges IO
capabilities which seems to be a pre-requisite for SSP?
Scott
--
Scott James Remnant | Chrome OS Systems | keybuk@xxxxxxxxxx | Google
HCI sniffer - Bluetooth packet analyzer ver 2.0
device: hci0 snap_len: 1028 filter: 0xffffffff
> HCI Event: Vendor (0xff) plen 2
> HCI Event: Connect Request (0x04) plen 10
bdaddr 40:30:04:0C:36:10 class 0x002540 type ACL
< HCI Command: Accept Connection Request (0x01|0x0009) plen 7
bdaddr 40:30:04:0C:36:10 role 0x00
Role: Master
> HCI Event: Command Status (0x0f) plen 4
Accept Connection Request (0x01|0x0009) status 0x00 ncmd 1
> HCI Event: Role Change (0x12) plen 8
status 0x00 bdaddr 40:30:04:0C:36:10 role 0x00
Role: Master
> HCI Event: Vendor (0xff) plen 2
> HCI Event: Vendor (0xff) plen 7
> HCI Event: Connect Complete (0x03) plen 11
status 0x00 handle 21 bdaddr 40:30:04:0C:36:10 type ACL encrypt 0x00
< HCI Command: Read Remote Supported Features (0x01|0x001b) plen 2
handle 21
> HCI Event: Vendor (0xff) plen 4
> HCI Event: Command Status (0x0f) plen 4
Read Remote Supported Features (0x01|0x001b) status 0x00 ncmd 1
> HCI Event: Read Remote Supported Features (0x0b) plen 11
status 0x00 handle 21
Features: 0xbc 0x02 0x04 0x38 0x08 0x00 0x00 0x00
< HCI Command: Remote Name Request (0x01|0x0019) plen 10
bdaddr 40:30:04:0C:36:10 mode 2 clkoffset 0x0000
> HCI Event: Vendor (0xff) plen 2
> HCI Event: Command Status (0x0f) plen 4
Remote Name Request (0x01|0x0019) status 0x00 ncmd 1
> ACL data: handle 21 flags 0x02 dlen 12
L2CAP(s): Connect req: psm 17 scid 0x0042
< ACL data: handle 21 flags 0x00 dlen 16
< ACL data: handle 21 flags 0x00 dlen 10
> HCI Event: Vendor (0xff) plen 4
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 16
L2CAP(s): Info rsp: type 2 result 0
Extended feature mask 0x0004
Bi-directional QoS
> HCI Event: Vendor (0xff) plen 2
< ACL data: handle 21 flags 0x00 dlen 16
< ACL data: handle 21 flags 0x00 dlen 12
> HCI Event: Remote Name Req Complete (0x07) plen 255
status 0x00 bdaddr 40:30:04:0C:36:10 name 'scott...s Keyboard'
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 16
L2CAP(s): Config req: dcid 0x0040 flags 0x00 clen 4
MTU 185
< ACL data: handle 21 flags 0x00 dlen 18
> ACL data: handle 21 flags 0x02 dlen 18
L2CAP(s): Config rsp: scid 0x0040 flags 0x00 result 0 clen 4
MTU 185
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 12
L2CAP(s): Connect req: psm 19 scid 0x0043
< ACL data: handle 21 flags 0x00 dlen 16
> HCI Event: Vendor (0xff) plen 4
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
< ACL data: handle 21 flags 0x00 dlen 5
< ACL data: handle 21 flags 0x00 dlen 12
< ACL data: handle 21 flags 0x00 dlen 16
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> HCI Event: Vendor (0xff) plen 7
> HCI Event: Disconn Complete (0x05) plen 4
status 0x00 handle 21 reason 0x13
Reason: Remote User Terminated Connection
< HCI Command: Create Connection (0x01|0x0005) plen 13
bdaddr 40:30:04:0C:36:10 ptype 0xcc18 rswitch 0x01 clkoffset 0x0000
Packet type: DM1 DM3 DM5 DH1 DH3 DH5
> HCI Event: Vendor (0xff) plen 2
> HCI Event: Command Status (0x0f) plen 4
Create Connection (0x01|0x0005) status 0x00 ncmd 1
> HCI Event: Vendor (0xff) plen 2
> HCI Event: Vendor (0xff) plen 7
> HCI Event: Connect Complete (0x03) plen 11
status 0x00 handle 21 bdaddr 40:30:04:0C:36:10 type ACL encrypt 0x00
< HCI Command: Read Remote Supported Features (0x01|0x001b) plen 2
handle 21
> HCI Event: Command Status (0x0f) plen 4
Read Remote Supported Features (0x01|0x001b) status 0x00 ncmd 1
> HCI Event: Read Remote Supported Features (0x0b) plen 11
status 0x00 handle 21
Features: 0xbc 0x02 0x04 0x38 0x08 0x00 0x00 0x00
< HCI Command: Remote Name Request (0x01|0x0019) plen 10
bdaddr 40:30:04:0C:36:10 mode 2 clkoffset 0x0000
> HCI Event: Vendor (0xff) plen 2
> HCI Event: Command Status (0x0f) plen 4
Remote Name Request (0x01|0x0019) status 0x00 ncmd 1
> HCI Event: Vendor (0xff) plen 2
> HCI Event: Remote Name Req Complete (0x07) plen 255
status 0x00 bdaddr 40:30:04:0C:36:10 name 'scott...s Keyboard'
< HCI Command: Authentication Requested (0x01|0x0011) plen 2
handle 21
> HCI Event: Command Status (0x0f) plen 4
Authentication Requested (0x01|0x0011) status 0x00 ncmd 1
> HCI Event: Link Key Request (0x17) plen 6
bdaddr 40:30:04:0C:36:10
< HCI Command: Link Key Request Negative Reply (0x01|0x000c) plen 6
bdaddr 40:30:04:0C:36:10
> HCI Event: Command Complete (0x0e) plen 10
Link Key Request Negative Reply (0x01|0x000c) ncmd 1
status 0x00 bdaddr 40:30:04:0C:36:10
> HCI Event: PIN Code Request (0x16) plen 6
bdaddr 40:30:04:0C:36:10
< HCI Command: PIN Code Request Reply (0x01|0x000d) plen 23
bdaddr 40:30:04:0C:36:10 len 4 pin '0000'
> HCI Event: Command Complete (0x0e) plen 10
PIN Code Request Reply (0x01|0x000d) ncmd 1
status 0x00 bdaddr 40:30:04:0C:36:10
> HCI Event: Link Key Notification (0x18) plen 23
bdaddr 40:30:04:0C:36:10 key 69A86C93EE92BEB889CBBBE903224B0D type 0
Type: Combination Key
> HCI Event: Auth Complete (0x06) plen 3
status 0x00 handle 21
< HCI Command: Authentication Requested (0x01|0x0011) plen 2
handle 21
< ACL data: handle 21 flags 0x00 dlen 10
> HCI Event: Command Status (0x0f) plen 4
Authentication Requested (0x01|0x0011) status 0x00 ncmd 1
> HCI Event: Link Key Request (0x17) plen 6
bdaddr 40:30:04:0C:36:10
< HCI Command: Link Key Request Reply (0x01|0x000b) plen 22
bdaddr 40:30:04:0C:36:10 key 69A86C93EE92BEB889CBBBE903224B0D
> HCI Event: Command Complete (0x0e) plen 10
Link Key Request Reply (0x01|0x000b) ncmd 1
status 0x00 bdaddr 40:30:04:0C:36:10
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 16
L2CAP(s): Info rsp: type 2 result 0
Extended feature mask 0x0004
Bi-directional QoS
< ACL data: handle 21 flags 0x00 dlen 12
> HCI Event: Auth Complete (0x06) plen 3
status 0x00 handle 21
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 16
L2CAP(s): Connect rsp: dcid 0x0044 scid 0x0040 result 0 status 0
Connection successful
< ACL data: handle 21 flags 0x00 dlen 12
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 18
L2CAP(s): Config rsp: scid 0x0040 flags 0x00 result 0 clen 4
MTU 185
> ACL data: handle 21 flags 0x02 dlen 16
L2CAP(s): Config req: dcid 0x0040 flags 0x00 clen 4
MTU 185
< ACL data: handle 21 flags 0x00 dlen 18
< ACL data: handle 21 flags 0x00 dlen 24
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 132
L2CAP(d): cid 0x0040 len 128 [psm 0]
< ACL data: handle 21 flags 0x00 dlen 26
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 132
L2CAP(d): cid 0x0040 len 128 [psm 0]
< ACL data: handle 21 flags 0x00 dlen 26
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 132
L2CAP(d): cid 0x0040 len 128 [psm 0]
< ACL data: handle 21 flags 0x00 dlen 26
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 132
L2CAP(d): cid 0x0040 len 128 [psm 0]
< ACL data: handle 21 flags 0x00 dlen 26
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 82
L2CAP(d): cid 0x0040 len 78 [psm 0]
< ACL data: handle 21 flags 0x00 dlen 24
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 100
L2CAP(d): cid 0x0040 len 96 [psm 0]
< ACL data: handle 21 flags 0x00 dlen 12
> HCI Event: Vendor (0xff) plen 4
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 16
L2CAP(s): Connect rsp: dcid 0x0045 scid 0x0041 result 1 status 0
Connection pending - No futher information available
> ACL data: handle 21 flags 0x02 dlen 16
L2CAP(s): Connect rsp: dcid 0x0045 scid 0x0041 result 0 status 0
Connection successful
< ACL data: handle 21 flags 0x00 dlen 12
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 18
L2CAP(s): Config rsp: scid 0x0041 flags 0x00 result 0 clen 4
MTU 185
> ACL data: handle 21 flags 0x02 dlen 16
L2CAP(s): Config req: dcid 0x0041 flags 0x00 clen 4
MTU 185
< ACL data: handle 21 flags 0x00 dlen 18
< ACL data: handle 21 flags 0x00 dlen 12
> HCI Event: Vendor (0xff) plen 4
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 16
L2CAP(s): Connect rsp: dcid 0x0046 scid 0x0042 result 0 status 0
Connection successful
< ACL data: handle 21 flags 0x00 dlen 12
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 18
L2CAP(s): Config rsp: scid 0x0042 flags 0x00 result 0 clen 4
MTU 185
> ACL data: handle 21 flags 0x02 dlen 16
L2CAP(s): Config req: dcid 0x0042 flags 0x00 clen 4
MTU 185
< ACL data: handle 21 flags 0x00 dlen 18
< HCI Command: Authentication Requested (0x01|0x0011) plen 2
handle 21
> HCI Event: Command Status (0x0f) plen 4
Authentication Requested (0x01|0x0011) status 0x00 ncmd 1
> HCI Event: Link Key Request (0x17) plen 6
bdaddr 40:30:04:0C:36:10
< HCI Command: Link Key Request Reply (0x01|0x000b) plen 22
bdaddr 40:30:04:0C:36:10 key 69A86C93EE92BEB889CBBBE903224B0D
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> HCI Event: Command Complete (0x0e) plen 10
Link Key Request Reply (0x01|0x000b) ncmd 1
status 0x00 bdaddr 40:30:04:0C:36:10
> ACL data: handle 21 flags 0x02 dlen 7
L2CAP(d): cid 0x0042 len 3 [psm 0]
> HCI Event: QoS Setup Complete (0x0d) plen 21
status 0x00 handle 21 flags 0
Service type: 1
Token rate: 28328
Peak bandwith: 28328
Latency: 12500
Delay variation: 0
> ACL data: handle 21 flags 0x02 dlen 7
L2CAP(d): cid 0x0042 len 3 [psm 0]
> HCI Event: Auth Complete (0x06) plen 3
status 0x00 handle 21
< HCI Command: Set Connection Encryption (0x01|0x0013) plen 3
handle 21 encrypt 0x01
> HCI Event: Command Status (0x0f) plen 4
Set Connection Encryption (0x01|0x0013) status 0x00 ncmd 1
> HCI Event: Mode Change (0x14) plen 6
status 0x00 handle 21 mode 0x02 interval 20
Mode: Sniff
> HCI Event: Encrypt Change (0x08) plen 4
status 0x00 handle 21 encrypt 0x01
< ACL data: handle 21 flags 0x00 dlen 14
< ACL data: handle 21 flags 0x00 dlen 7
< ACL data: handle 21 flags 0x00 dlen 7
< ACL data: handle 21 flags 0x00 dlen 7
< ACL data: handle 21 flags 0x00 dlen 7
< ACL data: handle 21 flags 0x00 dlen 9
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> HCI Event: Vendor (0xff) plen 17
< ACL data: handle 21 flags 0x00 dlen 12
> HCI Event: Number of Completed Packets (0x13) plen 5
handle 21 packets 1
> ACL data: handle 21 flags 0x02 dlen 12
L2CAP(s): Disconn rsp: dcid 0x0044 scid 0x0040
> HCI Event: Vendor (0xff) plen 17
< HCI Command: Disconnect (0x01|0x0006) plen 3
handle 21 reason 0x13
Reason: Remote User Terminated Connection
> HCI Event: Command Status (0x0f) plen 4
Disconnect (0x01|0x0006) status 0x00 ncmd 1
> HCI Event: Vendor (0xff) plen 7
> HCI Event: Disconn Complete (0x05) plen 4
status 0x00 handle 21 reason 0x16
Reason: Connection Terminated by Local Host
bluetoothd[6114]: Bluetooth daemon 4.97
bluetoothd[6114]: src/main.c:parse_config() parsing main.conf
bluetoothd[6114]: src/main.c:parse_config() discovto=0
bluetoothd[6114]: src/main.c:parse_config() pairto=0
bluetoothd[6114]: src/main.c:parse_config() pageto=8192
bluetoothd[6114]: src/main.c:parse_config() auto_to=60
bluetoothd[6114]: src/main.c:parse_config() name=%h-%d
bluetoothd[6114]: src/main.c:parse_config() class=0x000100
bluetoothd[6114]: src/main.c:parse_config() discov_interval=30
bluetoothd[6114]: src/main.c:parse_config() Key file does not have key 'DeviceID'
D-Bus setup failed: Name already in use
bluetoothd[6114]: Unable to get on D-Bus
bluetoothd[6024]: plugins/hciops.c:conn_complete() status 0x00
bluetoothd[6024]: src/adapter.c:adapter_get_device() 40:30:04:0C:36:10
bluetoothd[6024]: src/adapter.c:adapter_create_device() 40:30:04:0C:36:10
bluetoothd[6024]: src/device.c:device_create() Creating device /org/bluez/6024/hci0/dev_40_30_04_0C_36_10
bluetoothd[6024]: src/device.c:btd_device_ref() 0x7961e0a8: ref=1
bluetoothd[6024]: src/device.c:device_set_temporary() temporary 1
bluetoothd[6024]: plugins/hciops.c:remote_features_information() hci0 status 0
bluetoothd[6024]: input/server.c:connect_event_cb() Incoming connection from 40:30:04:0C:36:10 on PSM 17
bluetoothd[6024]: Refusing input device connect: No such file or directory (2)
bluetoothd[6024]: plugins/hciops.c:remote_name_information() hci0 status 0
bluetoothd[6024]: plugins/hciops.c:disconn_complete() handle 21 status 0x00
bluetoothd[6024]: src/event.c:btd_event_disconn_complete()
bluetoothd[6024]: src/adapter.c:adapter_remove_connection()
bluetoothd[6024]: src/adapter.c:adapter_remove_connection() Removing temporary device /org/bluez/6024/hci0/dev_40_30_04_0C_36_10
bluetoothd[6024]: src/device.c:device_remove() Removing device /org/bluez/6024/hci0/dev_40_30_04_0C_36_10
bluetoothd[6024]: src/device.c:btd_device_unref() 0x7961e0a8: ref=0
bluetoothd[6024]: src/device.c:device_free() 0x7961e0a8
bluetoothd[6024]: src/adapter.c:adapter_create_device() 40:30:04:0C:36:10
bluetoothd[6024]: src/device.c:device_create() Creating device /org/bluez/6024/hci0/dev_40_30_04_0C_36_10
bluetoothd[6024]: src/device.c:btd_device_ref() 0x7961c430: ref=1
bluetoothd[6024]: src/device.c:device_set_temporary() temporary 1
bluetoothd[6024]: src/device.c:bonding_request_new() Requesting bonding for 40:30:04:0C:36:10
bluetoothd[6024]: src/device.c:bonding_request_new() Temporary agent registered for 40:30:04:0C:36:10 at :1.103:/agent/40_30_04_0C_36_10
bluetoothd[6024]: plugins/hciops.c:conn_complete() status 0x00
bluetoothd[6024]: src/adapter.c:adapter_get_device() 40:30:04:0C:36:10
bluetoothd[6024]: plugins/hciops.c:remote_features_information() hci0 status 0
bluetoothd[6024]: plugins/hciops.c:remote_name_information() hci0 status 0
bluetoothd[6024]: plugins/hciops.c:link_key_request() hci0 dba 40:30:04:0C:36:10
bluetoothd[6024]: plugins/hciops.c:get_auth_info() hci0 dba 40:30:04:0C:36:10
bluetoothd[6024]: plugins/hciops.c:link_key_request() kernel auth requirements = 0x03
bluetoothd[6024]: plugins/hciops.c:link_key_request() Matching key not found
bluetoothd[6024]: plugins/hciops.c:pin_code_request() hci0 PIN request for 40:30:04:0C:36:10
bluetoothd[6024]: src/adapter.c:adapter_get_device() 40:30:04:0C:36:10
bluetoothd[6024]: src/device.c:device_request_authentication() Requesting agent authentication for 40:30:04:0C:36:10
bluetoothd[6024]: plugins/hciops.c:hciops_pincode_reply() hci0 dba 40:30:04:0C:36:10
bluetoothd[6024]: plugins/hciops.c:link_key_notify() hci0 dba 40:30:04:0C:36:10 type 0
bluetoothd[6024]: plugins/hciops.c:link_key_notify() key type 0x00 old key type 0xff
bluetoothd[6024]: plugins/hciops.c:link_key_notify() local auth 0x03 and remote auth 0xff
bluetoothd[6024]: src/adapter.c:adapter_get_device() 40:30:04:0C:36:10
bluetoothd[6024]: src/event.c:btd_event_link_key_notify() storing link key of type 0x00
bluetoothd[6024]: src/device.c:device_set_bonded() bonded 1
bluetoothd[6024]: src/device.c:device_set_temporary() temporary 0
bluetoothd[6024]: plugins/hciops.c:request_authentication() hci0
bluetoothd[6024]: plugins/hciops.c:get_handle() hci0 dba 40:30:04:0C:36:10
bluetoothd[6024]: plugins/hciops.c:auth_complete() hci0 status 0
bluetoothd[6024]: plugins/hciops.c:bonding_complete() status 0x00
bluetoothd[6024]: src/event.c:btd_event_bonding_complete() status 0x00
bluetoothd[6024]: src/adapter.c:adapter_get_device() 40:30:04:0C:36:10
bluetoothd[6024]: src/device.c:device_bonding_complete() bonding 0x795f64a0 status 0x00
bluetoothd[6024]: src/device.c:device_bonding_complete() Proceeding with service discovery
bluetoothd[6024]: src/device.c:btd_device_ref() 0x7961c430: ref=2
bluetoothd[6024]: src/adapter.c:adapter_resume_discovery() Resuming discovery
bluetoothd[6024]: src/agent.c:agent_release() Releasing agent :1.103, /agent/40_30_04_0C_36_10
bluetoothd[6024]: plugins/hciops.c:link_key_request() hci0 dba 40:30:04:0C:36:10
bluetoothd[6024]: plugins/hciops.c:get_auth_info() hci0 dba 40:30:04:0C:36:10
bluetoothd[6024]: plugins/hciops.c:link_key_request() kernel auth requirements = 0x03
bluetoothd[6024]: plugins/hciops.c:link_key_request() Matching key found
bluetoothd[6024]: plugins/hciops.c:link_key_request() link key type 0x00
bluetoothd[6024]: plugins/hciops.c:auth_complete() hci0 status 0
bluetoothd[6024]: plugins/hciops.c:bonding_complete() status 0x00
bluetoothd[6024]: src/event.c:btd_event_bonding_complete() status 0x00
bluetoothd[6024]: src/adapter.c:adapter_get_device() 40:30:04:0C:36:10
bluetoothd[6024]: src/device.c:device_bonding_complete() bonding (nil) status 0x00
bluetoothd[6024]: src/device.c:device_probe_drivers() Probing drivers for 40:30:04:0C:36:10
bluetoothd[6024]: input/manager.c:hid_device_probe() path /org/bluez/6024/hci0/dev_40_30_04_0C_36_10
bluetoothd[6024]: src/device.c:btd_device_ref() 0x7961c430: ref=3
bluetoothd[6024]: input/device.c:input_device_new() Registered interface org.bluez.Input on path /org/bluez/6024/hci0/dev_40_30_04_0C_36_10
bluetoothd[6024]: src/device.c:btd_device_unref() 0x7961c430: ref=2
bluetoothd[6024]: plugins/hciops.c:link_key_request() hci0 dba 40:30:04:0C:36:10
bluetoothd[6024]: plugins/hciops.c:get_auth_info() hci0 dba 40:30:04:0C:36:10
bluetoothd[6024]: plugins/hciops.c:link_key_request() kernel auth requirements = 0x03
bluetoothd[6024]: plugins/hciops.c:link_key_request() Matching key found
bluetoothd[6024]: plugins/hciops.c:link_key_request() link key type 0x00
bluetoothd[6024]: plugins/hciops.c:auth_complete() hci0 status 0
bluetoothd[6024]: plugins/hciops.c:bonding_complete() status 0x00
bluetoothd[6024]: src/event.c:btd_event_bonding_complete() status 0x00
bluetoothd[6024]: src/adapter.c:adapter_get_device() 40:30:04:0C:36:10
bluetoothd[6024]: src/device.c:device_bonding_complete() bonding (nil) status 0x00
bluetoothd[6024]: Terminating
bluetoothd[6024]: src/adapter.c:adapter_remove() Removing adapter /org/bluez/6024/hci0
bluetoothd[6024]: src/device.c:device_remove() Removing device /org/bluez/6024/hci0/dev_00_0A_95_02_38_B0
bluetoothd[6024]: input/manager.c:input_remove() path /org/bluez/6024/hci0/dev_00_0A_95_02_38_B0
bluetoothd[6024]: input/device.c:device_unregister() Unregistered interface org.bluez.Input on path /org/bluez/6024/hci0/dev_00_0A_95_02_38_B0
bluetoothd[6024]: src/device.c:btd_device_unref() 0x79618040: ref=1
bluetoothd[6024]: src/device.c:btd_device_unref() 0x79618040: ref=0
bluetoothd[6024]: src/device.c:device_free() 0x79618040
bluetoothd[6024]: src/device.c:device_remove() Removing device /org/bluez/6024/hci0/dev_00_22_48_86_88_16
bluetoothd[6024]: input/manager.c:input_remove() path /org/bluez/6024/hci0/dev_00_22_48_86_88_16
bluetoothd[6024]: input/device.c:device_unregister() Unregistered interface org.bluez.Input on path /org/bluez/6024/hci0/dev_00_22_48_86_88_16
bluetoothd[6024]: src/device.c:btd_device_unref() 0x79619418: ref=1
bluetoothd[6024]: src/device.c:btd_device_unref() 0x79619418: ref=0
bluetoothd[6024]: src/device.c:device_free() 0x79619418
bluetoothd[6024]: src/device.c:device_remove() Removing device /org/bluez/6024/hci0/dev_00_1F_20_24_B9_AD
bluetoothd[6024]: input/manager.c:input_remove() path /org/bluez/6024/hci0/dev_00_1F_20_24_B9_AD
bluetoothd[6024]: input/device.c:device_unregister() Unregistered interface org.bluez.Input on path /org/bluez/6024/hci0/dev_00_1F_20_24_B9_AD
bluetoothd[6024]: src/device.c:btd_device_unref() 0x7961ae98: ref=1
bluetoothd[6024]: src/device.c:btd_device_unref() 0x7961ae98: ref=0
bluetoothd[6024]: src/device.c:device_free() 0x7961ae98
bluetoothd[6024]: src/device.c:device_remove() Removing device /org/bluez/6024/hci0/dev_40_30_04_0C_36_10
bluetoothd[6024]: plugins/hciops.c:hciops_disconnect() hci0
bluetoothd[6024]: plugins/hciops.c:get_handle() hci0 dba 40:30:04:0C:36:10
bluetoothd[6024]: input/manager.c:input_remove() path /org/bluez/6024/hci0/dev_40_30_04_0C_36_10
bluetoothd[6024]: input/device.c:device_unregister() Unregistered interface org.bluez.Input on path /org/bluez/6024/hci0/dev_40_30_04_0C_36_10
bluetoothd[6024]: src/device.c:btd_device_unref() 0x7961c430: ref=1
bluetoothd[6024]: src/device.c:btd_device_unref() 0x7961c430: ref=0
bluetoothd[6024]: src/device.c:device_free() 0x7961c430
bluetoothd[6024]: src/sdpd-service.c:remove_record_from_server() Removing record with handle 0x10005
bluetoothd[6024]: audio/manager.c:avrcp_server_remove() path /org/bluez/6024/hci0
bluetoothd[6024]: src/sdpd-service.c:remove_record_from_server() Removing record with handle 0x10004
bluetoothd[6024]: src/sdpd-service.c:remove_record_from_server() Removing record with handle 0x10003
bluetoothd[6024]: audio/manager.c:audio_adapter_unref() 0x795f8690: ref=3
bluetoothd[6024]: audio/manager.c:a2dp_server_remove() path /org/bluez/6024/hci0
bluetoothd[6024]: audio/avdtp.c:avdtp_unregister_sep() SEP 0x795fb620 unregistered: type:0 codec:0 seid:1
bluetoothd[6024]: src/sdpd-service.c:remove_record_from_server() Removing record with handle 0x10002
bluetoothd[6024]: audio/manager.c:audio_adapter_unref() 0x795f8690: ref=2
bluetoothd[6024]: audio/manager.c:headset_server_remove() path /org/bluez/6024/hci0
bluetoothd[6024]: src/sdpd-service.c:remove_record_from_server() Removing record with handle 0x10000
bluetoothd[6024]: src/sdpd-service.c:remove_record_from_server() Removing record with handle 0x10001
bluetoothd[6024]: audio/manager.c:audio_adapter_unref() 0x795f8690: ref=1
bluetoothd[6024]: audio/manager.c:media_server_remove() path /org/bluez/6024/hci0
bluetoothd[6024]: audio/manager.c:audio_adapter_unref() 0x795f8690: ref=0
bluetoothd[6024]: src/adapter.c:btd_adapter_unref() 0x795fa240: ref=4
bluetoothd[6024]: src/adapter.c:btd_adapter_unref() 0x795fa240: ref=3
bluetoothd[6024]: serial/manager.c:proxy_remove() path /org/bluez/6024/hci0
bluetoothd[6024]: src/adapter.c:btd_adapter_unref() 0x795fa240: ref=2
bluetoothd[6024]: src/adapter.c:btd_adapter_unref() 0x795fa240: ref=1
bluetoothd[6024]: plugins/maemo6.c:mce_remove() path /org/bluez/6024/hci0
bluetoothd[6024]: plugins/service.c:unregister_interface() path /org/bluez/6024/hci0
bluetoothd[6024]: src/adapter.c:btd_adapter_unref() 0x795fa240: ref=0
bluetoothd[6024]: src/adapter.c:adapter_free() 0x795fa240
bluetoothd[6024]: src/plugin.c:plugin_cleanup() Cleanup plugins
bluetoothd[6024]: plugins/service.c:unregister_interface() path /org/bluez/6024/any
bluetoothd[6024]: plugins/maemo6.c:maemo6_exit() exit maemo6 plugin
bluetoothd[6024]: health/hdp.c:hdp_manager_stop() Stopped Health manager
bluetoothd[6024]: plugins/pnat.c:pnat_exit() Cleanup Phonet AT (DUN) plugin
bluetoothd[6024]: plugins/hciops.c:hciops_exit()
bluetoothd[6024]: plugins/hciops.c:hciops_cleanup()
bluetoothd[6024]: Stopping hci0 event socket
bluetoothd[6024]: Stopping SDP server
bluetoothd[6024]: Exit
