- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
I am using the modus toolbox with the wiced_btsdk 2.7. I am using the HCI_Audio_Gateway demo. I can pair and connect to many different handsfree devices just fine but I cannot reconnect to some of them after a power cycle. I am only pairing/connecting with one device at a time and I am not using BLE. I am making sure to save the NVRAM data and restore it after the power cycle. I have tried adding bonding to the demo application but still not having success. The failure occurs in the SDP, the wiced callback gives us a status of 0xFFF1. I have attached logs of the process including the nvram data tracing. Please help, this is very urgent, and I can't think of anything else this could be except a bug in the BT stack.
Log from initial pairing:
TRACE EVENT: WICED 22 - inquiry started:8100
:
Command status: Success
TRACE EVENT: WICED 35 - inquiry result 74 5c 4b f6 16 a1
:
TRACE EVENT: WICED 95 - p_inquiry_result: co:34119, dev: 2215908, eir_c: 1, eir: 8393986,0, pmd: 0, pper: 0, prep: 1, :
Device found: 74:5C:4B:F6:16:A1
device_class 24:04:04 rssi:186
name: Jabra E
--
Inquiry Complete: 1
Best: RSSI: 186 name: Jabra
TRACE EVENT: WICED 37 - hci_control_proc_rx_cmd:10, 21e27c
:
TRACE EVENT: WICED 17 - cmd_opcode 0x10
:
TRACE EVENT: WICED 56 - Attempting to bond to: 74 5c 4b f6 16 a1 , status: 8100:
Command status: Success
TRACE EVENT: WICED 35 - hci_control_management_callback 8
:
TRACE EVENT: WICED 64 - BTM_PAIRING_IO_CAPABILITIES_REQUEST_EVT bda 74 5c 4b f6 16 a1
:
TRACE EVENT: WICED 35 - hci_control_management_callback 9
:
TRACE EVENT: WICED 49 -
BTM_PAIRING_IO_CAPABILITIES_BR_EDR_RESPONSE_EVT:
TRACE EVENT: WICED 87 -
peer_bd_addr: 74 5c 4b f6 16 a1 , peer_io_cap: 3, peer_oob_data: 0, peer_auth_req: 4:
TRACE EVENT: WICED 35 - hci_control_management_callback 4
:
TRACE EVENT: WICED 36 - hci_control_management_callback 18
:
TRACE EVENT: WICED 28 - hci_control_alloc_nvram_id
:
TRACE EVENT: WICED 31 - hci_control_alloc_nvram_id:16
:
TRACE EVENT: WICED 23 - Allocated NVRAM ID:16
:
TRACE EVENT: WICED 41 - Updated Addr Resolution DB:8113. ID: 16
:
TRACE EVENT: WICED 6 - key: :
TRACE EVENT: WICED 13 - 74 5c 4b f6 :
TRACE EVENT: WICED 13 - 16 a1 04 76 :
TRACE EVENT: WICED 13 - 03 3c a1 f6 :
TRACE EVENT: WICED 13 - 28 ea c0 ac :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - c0 8f ce 62 :
TRACE EVENT: WICED 13 - 44 17 28 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - 04 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 7 - 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 2 -
:
NVRAM ID: 16 Length: 138
TRACE EVENT: WICED 55 - NVRAM write:id:16 bytes:138 dev: [74 5c 4b f6 16 a1 ]
:
TRACE EVENT: WICED 36 - hci_control_management_callback 11
:
Pairing complete Success
ending the pairing complete evt: 74 5c 4b f6 16 a1 as a1 16 f6 4b 5c 74 status 0
:
DEBUG (902): New state: BT_connection_state_CONNECTING
DEBUG (698): BT_EVENT_CONNECTING
Sending AG Connect 74:5C:4B:F6:16:A1:
TRACE EVENT: WICED 36 - hci_control_proc_rx_cmd:5, 21e2a0
:
TRACE EVENT: WICED 17 - cmd_opcode 0x07
:
TRACE EVENT: WICED 21 - cancel inquiry:8105
:
Command status: Success
TRACE EVENT: WICED 37 - hci_control_proc_rx_cmd:10, 21e2e8
:
TRACE EVENT: WICED 18 - cmd_opcode 0xe01
:
TRACE EVENT: WICED 27 - advanced connection ret: 0:
TRACE EVENT: WICED 36 - Security State: status: 0, flags: 0:
TRACE EVENT: WICED 85 - Bonded Devices: status: 167, num: 1, addr_type: 33, addr: a9 05 0d 00 a0 e2 type: 0:
TRACE EVENT: WICED 85 - initiate service discovery app_handle = 1, uuid: 4382, num_attr: 4, p_scp: 21b120
:
TRACE EVENT: WICED 57 - search attribute request, 74 5c 4b f6 16 a1 , 22c794
:
TRACE EVENT: WICED 51 - hci_control_ag_sdp_cback status:0x0, p_scb 21b120
:
TRACE EVENT: WICED 25 - Looking for HFP service
:
TRACE EVENT: WICED 67 - hci_control_ag_sdp_find_attr - num of proto elements -RFCOMM =0x1
:
TRACE EVENT: WICED 65 - hci_control_ag_sdp_find_attr - found SCN in SDP record. SCN=0x1
:
TRACE EVENT: WICED 34 - HF device profile version: 0x106
:
TRACE EVENT: WICED 51 - [1]hfp_ag_rfcomm_do_open: rfc_serv_handle: 0x0000
:
TRACE EVENT: WICED 79 - [1]hfp_ag_rfcomm_do_open - rfcomm_create Res: 0x0 Port: 0x0007 UUID: 0x111e
:
TRACE EVENT: WICED 36 - hci_control_management_callback 12
:
TRACE EVENT: WICED 58 - Encryption Status Event: bd ( 74 5c 4b f6 16 a1 ) res 0
:
Encryption changed:0
TRACE EVENT: WICED 100 - [1]hfp_ag_rfcomm_control_callback : Status = 0, port: 0x0007 SCB state: 1 Srv: 0x0000 Conn: 0x000:
TRACE EVENT: WICED 39 - hfp_ag_process_open_callback status=0
:
TRACE EVENT: WICED 59 - [1]hfp_ag_hci_send_ag_event: Sending Event: 3585 to UART
:
HCI_CONTROL_AG_EVENT_OPEN HF: 0
[Handle: 1] BDA: 74:5C:4B:F6:16:A1
TRACE EVENT: WICED 61 - [1]RFCOMM Connected isInit: 1 Serv: 0x0000 Conn: 0x0007
:
TRACE EVENT: WICED 84 - hfp_ag_sco_create is_orig: 0 sco_idx: 0x0 status:0x1fa4 retry_with_sco_only: 0
:
TRACE EVENT: WICED 47 - HFP AT cmd:AT+BRSF arg_type:2 arg:159 arg:159
:
TRACE EVENT: WICED 31 - BRSF HF : 0x9f , phone : 0xa00:
TRACE EVENT: WICED 56 - [1]Sent AT response[0x06][ret 0][hndl 7]: +BRSF: 2560
:
TRACE EVENT: WICED 30 - [1]Sent AT fail[0x00][ret 3]
:
TRACE EVENT: WICED 44 - HFP AT cmd:AT+BAC arg_type:2 arg:0 arg:1,2
:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 7]: OK
:
TRACE EVENT: WICED 44 - HFP AT cmd:AT+CIND arg_type:8 arg:0 arg:=?
:
TRACE EVENT: WICED 100 - [1]Sent AT response[0x03][ret 0][hndl 7]: +CIND: ("call",(0,1)),("callsetup",(0-3)),("callheld",(0-2:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 7]: OK
:
TRACE EVENT: WICED 43 - HFP AT cmd:AT+CIND arg_type:4 arg:0 arg:?
:
TRACE EVENT: WICED 59 - [1]Sent AT response[0x03][ret 0][hndl 7]: +CIND: 1,0,0,1
:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 7]: OK
:
TRACE EVENT: WICED 52 - HFP AT cmd:AT+CMER arg_type:2 arg:0 arg:3, 0, 0, 1
:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 7]: OK
:
TRACE EVENT: WICED 59 - [1]hfp_ag_hci_send_ag_event: Sending Event: 3587 to UART
:
HCI_CONTROL_AG_EVENT_CONNECTED [Handle: 1]
features: 0x009F
BT Wideband audio supported
Echo cancel Noise reduce
Voice recognition
Volume control
TRACE EVENT: WICED 43 - HFP AT cmd:AT+VGS arg_type:2 arg:7 arg:07
:
DEBUG (937): New state: BT_connection_state_CONNECTED
DEBUG (710): BT_EVENT_CONNECTED_AFTER_PAIRING
DEBUG (695): BT_EVENT_CONNECTED
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 7]: OK
:
TRACE EVENT: WICED 43 - HFP AT cmd:AT+VGM arg_type:2 arg:9 arg:09
:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 7]: OK
:
TRACE EVENT: WICED 54 - hfp_ag_parse_AT_command: BTA_AG_ERR_OP_NOT_SUPPORTED
:
TRACE EVENT: WICED 50 - [1]Sent AT response[0x01][ret 0][hndl 7]: ERROR
:
TRACE EVENT: WICED 43 - HFP AT cmd:AT+BTRH arg_type:4 arg:0 arg:?
:
TRACE EVENT: WICED 50 - [1]Sent AT response[0x01][ret 0][hndl 7]: ERROR
:
TRACE EVENT: WICED 43 - HFP AT cmd:AT+CLIP arg_type:2 arg:1 arg:1
:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 7]: OK
:
TRACE EVENT: WICED 50 - HFP AT cmd:AT+BIA arg_type:2 arg:0 arg:1,1,1,0,0
:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 7]: OK
:
Sending AG open 74:5C:4B:F6:16:A1:
TRACE EVENT: WICED 36 - hci_control_proc_rx_cmd:6, 21e258
:
TRACE EVENT: WICED 18 - cmd_opcode 0xe03
:
TRACE EVENT: WICED 45 - hfp_ag_audio_open - state: 2 SCO inx: 0x00
:
TRACE EVENT: WICED 21 - send +BCS codec is 2:
TRACE EVENT: WICED 52 - [1]Sent AT response[0x07][ret 0][hndl 7]: +BCS: 2
:
TRACE EVENT: WICED 42 - HFP AT cmd:AT+BCS arg_type:2 arg:2 arg:2
:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 7]: OK
:
TRACE EVENT: WICED 9 - Use WBS
:
TRACE EVENT: WICED 84 - hfp_ag_sco_create is_orig: 1 sco_idx: 0x0 status:0x1fa4 retry_with_sco_only: 1
:
TRACE EVENT: WICED 36 - hci_control_management_callback 27
:
TRACE EVENT: WICED 39 - Got BTM_SCO_CONNECTED_EVT: sco_idx: 0
:
TRACE EVENT: WICED 59 - [1]hfp_ag_hci_send_ag_event: Sending Event: 3588 to UART
:
HCI_CONTROL_AG_EVENT_AUDIO_OPEN [Handle: 1]
Wideband mode selected
DEBUG (960): New state: BT_connection_state_AUDIO_CONNECTED
DEBUG (689): BT_EVENT_AUDIO_CONNECTED
TRACE EVENT: WICED 35 - hci_control_management_callback 2
:
Err
Error: Command not found.
btld Set Bluetooth state
Sending AG close 74:5C:4B:F6:16:A1:
Sending AG disconnect 74:5C:4B:F6:16:A1:
TRACE EVENT: WICED 36 - hci_control_proc_rx_cmd:6, 21e354
:
TRACE EVENT: WICED 18 - cmd_opcode 0xe04
:
TRACE EVENT: WICED 32 - hfp_ag_sco_close : sco_idx = 0
:
TRACE EVENT: WICED 36 - hci_control_proc_rx_cmd:6, 21e2e8
:
TRACE EVENT: WICED 18 - cmd_opcode 0xe02
:
TRACE EVENT: WICED 33 - [1]hfp_ag_disconnect State: 2
:
TRACE EVENT: WICED 32 - hfp_ag_sco_close : sco_idx = 0
:
TRACE EVENT: WICED 36 - hci_control_management_callback 28
:
TRACE EVENT: WICED 42 - Got BTM_SCO_DISCONNECTED_EVT: sco_idx: 0
:
TRACE EVENT: WICED 47 - [1]hfp_ag_rfcomm_do_close (0x0007) result 0x0
:
TRACE EVENT: WICED 100 - [1]hfp_ag_rfcomm_control_callback : Status = 19, port: 0x0007 SCB state: 3 Srv: 0x0000 Conn: 0x00:
TRACE EVENT: WICED 59 - [1]hfp_ag_hci_send_ag_event: Sending Event: 3586 to UART
:
HCI_CONTROL_AG_EVENT_CLOSE: unknown
TRACE EVENT: WICED 45 - [1]hfp_ag_rfcomm_closed (0x0007) result 0x0
:
TRACE EVENT: WICED 36 - hfp_ag_sco_close : sco_idx = 65535
:
TRACE EVENT: WICED 82 - [1]hfp_ag_rfcomm_start_server: rfcomm_create Res: 0x0 Port: 0x0001 UUID: 0x111e
:
DEBUG (937): New state: BT_connection_state_CONNECTED
DEBUG (695): BT_EVENT_CONNECTED
TRACE EVENT: WICED 35 - hci_control_management_callback 2
:
DEBUG (685): BT_EVENT_DISCONNECTED
DEBUG (902): New state: BT_connection_state_CONNECTING
DEBUG (698): BT_EVENT_CONNECTING
Sending AG Connect 74:5C:4B:F6:16:A1:
TRACE EVENT: WICED 37 - hci_control_proc_rx_cmd:10, 21e354
:
TRACE EVENT: WICED 18 - cmd_opcode 0xe01
:
TRACE EVENT: WICED 27 - advanced connection ret: 0:
TRACE EVENT: WICED 36 - Security State: status: 0, flags: 0:
TRACE EVENT: WICED 85 - Bonded Devices: status: 167, num: 1, addr_type: 33, addr: a9 05 0d 00 58 e2 type: 0:
TRACE EVENT: WICED 85 - initiate service discovery app_handle = 1, uuid: 4382, num_attr: 4, p_scp: 21b120
:
TRACE EVENT: WICED 57 - search attribute request, 74 5c 4b f6 16 a1 , 22bd68
:
TRACE EVENT: WICED 51 - hci_control_ag_sdp_cback status:0x0, p_scb 21b120
:
TRACE EVENT: WICED 25 - Looking for HFP service
:
TRACE EVENT: WICED 67 - hci_control_ag_sdp_find_attr - num of proto elements -RFCOMM =0x1
:
TRACE EVENT: WICED 65 - hci_control_ag_sdp_find_attr - found SCN in SDP record. SCN=0x1
:
TRACE EVENT: WICED 34 - HF device profile version: 0x106
:
TRACE EVENT: WICED 51 - [1]hfp_ag_rfcomm_do_open: rfc_serv_handle: 0x0000
:
TRACE EVENT: WICED 79 - [1]hfp_ag_rfcomm_do_open - rfcomm_create Res: 0x0 Port: 0x0002 UUID: 0x111e
:
TRACE EVENT: WICED 100 - [1]hfp_ag_rfcomm_control_callback : Status = 0, port: 0x0002 SCB state: 1 Srv: 0x0000 Conn: 0x000:
TRACE EVENT: WICED 39 - hfp_ag_process_open_callback status=0
:
TRACE EVENT: WICED 59 - [1]hfp_ag_hci_send_ag_event: Sending Event: 3585 to UART
:
HCI_CONTROL_AG_EVENT_OPEN HF: 0
[Handle: 1] BDA: 74:5C:4B:F6:16:A1
TRACE EVENT: WICED 61 - [1]RFCOMM Connected isInit: 1 Serv: 0x0000 Conn: 0x0002
:
TRACE EVENT: WICED 84 - hfp_ag_sco_create is_orig: 0 sco_idx: 0x0 status:0x1fa4 retry_with_sco_only: 0
:
TRACE EVENT: WICED 47 - HFP AT cmd:AT+BRSF arg_type:2 arg:159 arg:159
:
TRACE EVENT: WICED 31 - BRSF HF : 0x9f , phone : 0xa00:
TRACE EVENT: WICED 56 - [1]Sent AT response[0x06][ret 0][hndl 2]: +BRSF: 2560
:
TRACE EVENT: WICED 30 - [1]Sent AT fail[0x00][ret 3]
:
TRACE EVENT: WICED 44 - HFP AT cmd:AT+BAC arg_type:2 arg:0 arg:1,2
:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 2]: OK
:
TRACE EVENT: WICED 44 - HFP AT cmd:AT+CIND arg_type:8 arg:0 arg:=?
:
TRACE EVENT: WICED 100 - [1]Sent AT response[0x03][ret 0][hndl 2]: +CIND: ("call",(0,1)),("callsetup",(0-3)),("callheld",(0-2:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 2]: OK
:
TRACE EVENT: WICED 43 - HFP AT cmd:AT+CIND arg_type:4 arg:0 arg:?
:
TRACE EVENT: WICED 59 - [1]Sent AT response[0x03][ret 0][hndl 2]: +CIND: 1,0,0,1
:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 2]: OK
:
TRACE EVENT: WICED 52 - HFP AT cmd:AT+CMER arg_type:2 arg:0 arg:3, 0, 0, 1
:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 2]: OK
:
TRACE EVENT: WICED 59 - [1]hfp_ag_hci_send_ag_event: Sending Event: 3587 to UART
:
HCI_CONTROL_AG_EVENT_CONNECTED [Handle: 1]
features: 0x009F
BT Wideband audio supported
Echo cancel Noise reduce
Voice recognition
Volume control
TRACE EVENT: WICED 43 - HFP AT cmd:AT+VGS arg_type:2 arg:7 arg:07
:
DEBUG (937): New state: BT_connection_state_CONNECTED
DEBUG (695): BT_EVENT_CONNECTED
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 2]: OK
:
TRACE EVENT: WICED 43 - HFP AT cmd:AT+VGM arg_type:2 arg:9 arg:09
:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 2]: OK
:
TRACE EVENT: WICED 54 - hfp_ag_parse_AT_command: BTA_AG_ERR_OP_NOT_SUPPORTED
:
TRACE EVENT: WICED 50 - [1]Sent AT response[0x01][ret 0][hndl 2]: ERROR
:
TRACE EVENT: WICED 43 - HFP AT cmd:AT+BTRH arg_type:4 arg:0 arg:?
:
TRACE EVENT: WICED 50 - [1]Sent AT response[0x01][ret 0][hndl 2]: ERROR
:
TRACE EVENT: WICED 43 - HFP AT cmd:AT+CLIP arg_type:2 arg:1 arg:1
:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 2]: OK
:
TRACE EVENT: WICED 50 - HFP AT cmd:AT+BIA arg_type:2 arg:0 arg:1,1,1,0,0
:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 2]: OK
:
Sending AG open 74:5C:4B:F6:16:A1:
TRACE EVENT: WICED 36 - hci_control_proc_rx_cmd:6, 21e258
:
TRACE EVENT: WICED 18 - cmd_opcode 0xe03
:
TRACE EVENT: WICED 45 - hfp_ag_audio_open - state: 2 SCO inx: 0x00
:
TRACE EVENT: WICED 21 - send +BCS codec is 2:
TRACE EVENT: WICED 52 - [1]Sent AT response[0x07][ret 0][hndl 2]: +BCS: 2
:
TRACE EVENT: WICED 42 - HFP AT cmd:AT+BCS arg_type:2 arg:2 arg:2
:
TRACE EVENT: WICED 47 - [1]Sent AT response[0x00][ret 0][hndl 2]: OK
:
TRACE EVENT: WICED 9 - Use WBS
:
TRACE EVENT: WICED 84 - hfp_ag_sco_create is_orig: 1 sco_idx: 0x0 status:0x1fa4 retry_with_sco_only: 1
:
TRACE EVENT: WICED 36 - hci_control_management_callback 27
:
TRACE EVENT: WICED 39 - Got BTM_SCO_CONNECTED_EVT: sco_idx: 0
:
TRACE EVENT: WICED 59 - [1]hfp_ag_hci_send_ag_event: Sending Event: 3588 to UART
:
HCI_CONTROL_AG_EVENT_AUDIO_OPEN [Handle: 1]
Wideband mode selected
DEBUG (960): New state: BT_connection_state_AUDIO_CONNECTED
DEBUG (689): BT_EVENT_AUDIO_CONNECTED
Then I power cycle and start the module back up, here's log from startup to trying to reconnect:
DEBUG (966): New state: BT_connection_state_MODULE_STARTUP
device started
startup write NVRAM, id: 16, len: 138
TRACE EVENT: WICED 37 - hci_control_proc_rx_cmd:10, 21e27c
:
TRACE EVENT: WICED 17 - cmd_opcode 0x03
:
Command status: Success
TRACE EVENT: WICED 36 - hci_control_proc_rx_cmd:6, 21e234
:
TRACE EVENT: WICED 17 - cmd_opcode 0x08
:
Command status: Success
TRACE EVENT: WICED 36 - hci_control_proc_rx_cmd:5, 21e2a0
:
TRACE EVENT: WICED 17 - cmd_opcode 0x09
:
TRACE EVENT: WICED 32 - Set the pairing allowed to 1
:
Command status: Success
TRACE EVENT: WICED 38 - hci_control_proc_rx_cmd:144, 21f174
:
TRACE EVENT: WICED 17 - cmd_opcode 0x05
:
TRACE EVENT: WICED 41 - Updated Addr Resolution DB:8113. ID: 16
:
TRACE EVENT: WICED 6 - key: :
TRACE EVENT: WICED 13 - 74 5c 4b f6 :
TRACE EVENT: WICED 13 - 16 a1 04 76 :
TRACE EVENT: WICED 13 - 03 3c a1 f6 :
TRACE EVENT: WICED 13 - 28 ea c0 ac :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - c0 8f ce 62 :
TRACE EVENT: WICED 13 - 44 17 28 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - 04 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 13 - 00 00 00 00 :
TRACE EVENT: WICED 7 - 00 00 :
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 2 -
:
TRACE EVENT: WICED 44 - NVRAM write: 138 dev: [74 5c 4b f6 16 a1 ]
:
TRACE EVENT: WICED 36 - hci_control_proc_rx_cmd:4, 21e2c4
:
TRACE EVENT: WICED 19 - cmd_opcode 0xff02
:
Version 2.7, rev 0, build 18, Chip: 20706
Device Fully Configured
DEBUG (902): New state: BTECTINGction_state_CONNECTING
DEBUG (698): BT_EVENT_CONNECTING
Sending AG Connect 74:5C:4B:F6:16:A1:
TRACE EVENT: WICED 37 - hci_control_proc_rx_cmd:10, 21e2c4
:
TRACE EVENT: WICED 18 - cmd_opcode 0xe01
:
TRACE EVENT: WICED 27 - advanced connection ret: 0:
TRACE EVENT: WICED 36 - Security State: status: 0, flags: 0:
TRACE EVENT: WICED 85 - Bonded Devices: status: 167, num: 1, addr_type: 33, addr: a9 05 0d 00 a0 e2 type: 0:
TRACE EVENT: WICED 85 - initiate service discovery app_handle = 1, uuid: 4382, num_attr: 4, p_scp: 21b120
:
TRACE EVENT: WICED 57 - search attribute request, 74 5c 4b f6 16 a1 , 22c4ac
:
TRACE EVENT: WICED 54 - hci_control_ag_sdp_cback status:0xfff1, p_scb 21b120
:
TRACE EVENT: WICED 82 - [1]hfp_ag_rfcomm_start_server: rfcomm_create Res: 0x0 Port: 0x0005 UUID: 0x111e
:
TRACE EVENT: WICED 39 - hfp_ag_process_open_callback status=1
:
TRACE EVENT: WICED 39 - hfp_ag_process_open_callback: Try HSP
:
TRACE EVENT: WICED 85 - initiate service discovery app_handle = 1, uuid: 4360, num_attr: 4, p_scp: 21b048
:
TRACE EVENT: WICED 57 - search attribute request, 74 5c 4b f6 16 a1 , 22c3dc
:
TRACE EVENT: WICED 54 - hci_control_ag_sdp_cback status:0xfff1, p_scb 21b048
:
TRACE EVENT: WICED 82 - [1]hfp_ag_rfcomm_start_server: rfcomm_create Res: 0x0 Port: 0x0006 UUID: 0x1108
:
TRACE EVENT: WICED 39 - hfp_ag_process_open_callback status=1
:
TRACE EVENT: WICED 74 - [1]hfp_ag_rfcomm_start_server: rfcomm_create Port Already set to: 0x0006
:
TRACE EVENT: WICED 59 - [1]hfp_ag_hci_send_ag_event: Sending Event: 3585 to UART
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
Here is the btspy trace showing the issue:
11:17:05.054 Sending AG Connect
11:17:05.082 1 hci_control_proc_rx_cmd:10, 21e2c0
11:17:05.082 1 cmd_opcode 0xe01
11:17:05.082 1 Security State: status: 0, flags: 0
11:17:05.082 1 Bonded Devices: status: 8103, num: 1, addr_type: 33, addr: 01 0e 00 00 67 82 type: 0
11:17:05.101 1 initiate service discovery app_handle = 1, uuid: 4382, num_attr: 4, p_scp: 21b0a8
11:17:05.101 1 search attribute request, 74 5c 4b f6 16 a1 , 22c724
11:17:05.101 SENT [1] Command to HCI. Name: HCI_Create_Connection (Hex Code: 0x0405 Param Len: 13)
11:17:05.101 HCI_RAW cmd Data:
11:17:05.101 0000: a1 16 f6 4b 5c 74 18 cc 01 00 2a 83 01 ...K\t....*..
11:17:05.101 BD_ADDR of remote device : 74-5c-4b-f6-16-a1
11:17:05.101 Packet Types Supported : 0xcc18 ( 2-DH1 3-DH1 DM1 DH1 2-DH3 3-DH3 DM3 DH3 2-DH5 3-DH5 DM5 DH5 )
11:17:05.101 Page Scan Repetition Mode : 1 (0x01)
11:17:05.101 Page Scan Mode(BT1.1) / Reserved(BT1.2) : 0 (0x00)
11:17:05.101 Clock Offset : 33578 (0x832a)
11:17:05.101 Allow Role Switch : 1 (0x01)
11:17:05.101 HCI_RAW evt Data:
11:17:05.101 0000: 0f 04 00 01 ....
11:17:05.101 RCVD [1] Event from HCI. Name: HCI_Command_Status (Hex Code: 0x0f Param Len: 4)
11:17:05.101 Status : Success (0x00)
11:17:05.101 Num HCI Cmd Packets : 1 (0x01)
11:17:05.101 Cmd Code : 0x0405 (HCI_Create_Connection)
11:17:06.205 HCI_RAW evt Data:
11:17:06.205 0000: 03 0b 00 0c 00 a1 16 f6 4b 5c 74 ........K\t
11:17:06.205 RCVD [1] Event from HCI. Name: HCI_Connection_Complete (Hex Code: 0x03 Param Len: 11)
11:17:06.205 Status : Success (0x00)
11:17:06.205 Connection Handle : 12 (0x000c)
11:17:06.205 BD_ADDR of remote : 74-5c-4b-f6-16-a1
11:17:06.205 Link Type : 1 (0x01)
11:17:06.205 Encryption Mode : 0 (0x00)
11:17:06.205 SENT [1] Command to HCI. Name: HCI_Read_Remote_Version_Information (Hex Code: 0x041d Param Len: 2)
11:17:06.205 HCI_RAW cmd Data:
11:17:06.205 0000: 0c 00 ..
11:17:06.205 Connection Handle : 12 (0x000c)
11:17:06.205 L2CAP [0] SENT Command. Name: L2C Information Request (0x0a) ID 0x02, len 2
11:17:06.205 InfoType : Ext Features
11:17:06.205 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 10 Data: 0x06 0x00 0x01 ...
11:17:06.205 Data:
11:17:06.205 0000: 06 00 01 00 0a 02 02 00 02 00 ..........
11:17:06.205 HCI_RAW evt Data:
11:17:06.205 0000: 0f 04 00 01 ....
11:17:06.205 RCVD [1] Event from HCI. Name: HCI_Command_Status (Hex Code: 0x0f Param Len: 4)
11:17:06.205 Status : Success (0x00)
11:17:06.205 Num HCI Cmd Packets : 1 (0x01)
11:17:06.205 Cmd Code : 0x041d (HCI_Read_Remote_Version_Information)
11:17:06.227 SENT [1] Command to HCI. Name: HCI_Read_Clock_Offset (Hex Code: 0x041f Param Len: 2)
11:17:06.227 HCI_RAW cmd Data:
11:17:06.227 0000: 0c 00 ..
11:17:06.227 Connection Handle : 12 (0x000c)
11:17:06.227 HCI_RAW evt Data:
11:17:06.227 0000: 0c 08 00 0c 00 08 0a 00 ........
11:17:06.227 RCVD [1] Event from HCI. Name: HCI_Read_Remote_Version_Information_Complete (Hex Code: 0x0c Param Len: 😎
11:17:06.227 Status : Success (0x00)
11:17:06.227 Connection Handle : 12 (0x000c)
11:17:06.227 LMP Version : 8 (0x08)
11:17:06.227 Manufacturer Name : 10 (0x000a) [CSR]
11:17:06.227 LMP Subversion : 12216 (0x2fb8)
11:17:06.227 HCI_RAW evt Data:
11:17:06.227 0000: 0f 04 00 01 ....
11:17:06.227 RCVD [1] Event from HCI. Name: HCI_Command_Status (Hex Code: 0x0f Param Len: 4)
11:17:06.227 Status : Success (0x00)
11:17:06.227 Num HCI Cmd Packets : 1 (0x01)
11:17:06.227 Cmd Code : 0x041f (HCI_Read_Clock_Offset)
11:17:06.227 SENT [1] Command to HCI. Name: HCI_Read_Authent_Payload_Tout (Hex Code: 0x0c7b Param Len: 2)
11:17:06.227 HCI_RAW cmd Data:
11:17:06.227 0000: 0c 00 ..
11:17:06.227 Connection Handle : 12 (0x000c)
11:17:06.227 HCI_RAW evt Data:
11:17:06.227 0000: 20 07 a1 16 f6 4b 5c ....K\
11:17:06.227 RCVD [1] Event from HCI. Name: HCI_Page_Scan_Repetition_Mode_Change (Hex Code: 0x20 Param Len: 7)
11:17:06.227 BD_ADDR of remote : 74-5c-4b-f6-16-a1
11:17:06.227 Page Scan Repetition Mode : 1 (0x01)
11:17:06.227 HCI_RAW evt Data:
11:17:06.227 0000: 1b 03 0c ...
11:17:06.227 RCVD [1] Event from HCI. Name: HCI_Max_Slots_Changed (Hex Code: 0x1b Param Len: 3)
11:17:06.227 Connection Handle : 12 (0x000c)
11:17:06.227 LMP Max Slots : 5 (0x05)
11:17:06.227 HCI_RAW evt Data:
11:17:06.227 0000: 0e 08 01 7b 0c 00 0c 00 ........
11:17:06.227 RCVD [1] Event from HCI. Name: HCI_Command_Complete (Hex Code: 0x0e Param Len: 😎
11:17:06.227 Num HCI Cmd Packets : 1 (0x01)
11:17:06.227 Cmd Code : 0x0c7b (HCI_Read_Authent_Payload_Tout)
11:17:06.227 Status : Success (0x00)
11:17:06.227 Connection Handle : 12 (0x000c)
11:17:06.227 Auth payload timeout (10msec) : 184 (0xb8)
11:17:06.227 ERROR - parameter length wrong for the event code
11:17:06.227 SENT [1] Command to HCI. Name: HCI_Write_Link_Policy_Settings (Hex Code: 0x080d Param Len: 4)
11:17:06.227 HCI_RAW cmd Data:
11:17:06.227 0000: 0c 00 05 00 ....
11:17:06.227 Connection Handle : 12 (0x000c)
11:17:06.227 Link Policy Settings : 0x0005
11:17:06.227 : Enable Master Slave Switch
11:17:06.227 : Enable Sniff Mode
11:17:06.227 L2CAP [0] RECV Command. Name: L2C Connection Request (0x02) ID: 0x01, Len: 4
11:17:06.227 PSM : 0x1
11:17:06.227 Source CID : 0x380
11:17:06.227 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 12 Data: 0x08 0x00 0x01 ...
11:17:06.227 Data:
11:17:06.227 0000: 08 00 01 00 02 01 04 00 01 00 80 03 ............
11:17:06.227 L2CAP [0] SENT Command. Name: L2C Connection Response (0x03) ID 0x01, len 8
11:17:06.227 Destination CID : 0x4f
11:17:06.227 Source CID : 0x380
11:17:06.227 Result : 0x0
11:17:06.227 Status : 0x0
11:17:06.227 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 16 Data: 0x0c 0x00 0x01 ...
11:17:06.227 Data:
11:17:06.227 0000: 0c 00 01 00 03 01 08 00 4f 00 80 03 00 00 00 00 ........O.......
11:17:06.227 L2CAP [0] SENT Command. Name: L2C Configuration Request (0x04) ID 0x03, len 8
11:17:06.228 Destination CID : 896 (0x0380)
11:17:06.228 Flags (last request) : 0x0000
11:17:06.228 Option MTU : 64(0x0040)
11:17:06.228 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 16 Data: 0x0c 0x00 0x01 ...
11:17:06.228 Data:
11:17:06.228 0000: 0c 00 01 00 04 03 08 00 80 03 00 00 01 02 40 00 ..............@.
11:17:06.228 HCI_RAW evt Data:
11:17:06.228 0000: 0e 06 01 0d 08 00 ......
11:17:06.228 RCVD [1] Event from HCI. Name: HCI_Command_Complete (Hex Code: 0x0e Param Len: 6)
11:17:06.228 Num HCI Cmd Packets : 1 (0x01)
11:17:06.228 Cmd Code : 0x080d (HCI_Write_Link_Policy_Settings)
11:17:06.228 Status : Success (0x00)
11:17:06.228 Connection Handle : 12 (0x000c)
11:17:06.228 SENT [1] Command to HCI. Name: HCI_Write_Link_Supervision_Timeout (Hex Code: 0x0c37 Param Len: 4)
11:17:06.228 HCI_RAW cmd Data:
11:17:06.228 0000: 0c 00 00 7d ....
11:17:06.228 Connection/Physical Link Handle : 12 (0x000c)
11:17:06.228 Timeout (625us units) : 32000 (0x7d00)
11:17:06.228 L2CAP [0] RECV Command. Name: L2C Information Response (0x0b) ID: 0x02, Len: 8
11:17:06.228 InfoType : Ext Features (2)
11:17:06.228 Result : 0x0
11:17:06.228 Supported :
11:17:06.228 Enhanced Retransmission Mode
11:17:06.228 Streaming Mode
11:17:06.228 No-FCS-Check Flag Supported
11:17:06.228 Fixed Channels
11:17:06.228 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 16 Data: 0x0c 0x00 0x01 ...
11:17:06.228 Data:
11:17:06.228 0000: 0c 00 01 00 0b 02 08 00 02 00 00 00 b8 00 00 00 ................
11:17:06.247 L2CAP [0] SENT Command. Name: L2C Information Request (0x0a) ID 0x04, len 2
11:17:06.247 InfoType : Fixed Channels
11:17:06.247 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 10 Data: 0x06 0x00 0x01 ...
11:17:06.247 Data:
11:17:06.247 0000: 06 00 01 00 0a 04 02 00 03 00 ..........
11:17:06.247 HCI_RAW evt Data:
11:17:06.247 0000: 0e 06 01 37 0c 00 ...7..
11:17:06.247 RCVD [1] Event from HCI. Name: HCI_Command_Complete (Hex Code: 0x0e Param Len: 6)
11:17:06.247 Num HCI Cmd Packets : 1 (0x01)
11:17:06.247 Cmd Code : 0x0c37 (HCI_Write_Link_Supervision_Timeout)
11:17:06.247 Status : Success (0x00)
11:17:06.247 Connection Handle : 12 (0x000c)
11:17:06.247 HCI_RAW evt Data:
11:17:06.247 0000: 13 05 01 0c 00 .....
11:17:06.247 RCVD [1] Event from HCI. Name: HCI_Number_Of_Completed_Packets (Hex Code: 0x13 Param Len: 5)
11:17:06.247 0 : 12 (0x000c) - 2
11:17:06.247 HCI_RAW evt Data:
11:17:06.247 0000: 1c 05 00 0c 00 .....
11:17:06.247 RCVD [1] Event from HCI. Name: HCI_Read_Clock_Offset_Complete (Hex Code: 0x1c Param Len: 5)
11:17:06.247 Status : Success (0x00)
11:17:06.247 Connection Handle : 12 (0x000c)
11:17:06.247 Clock Offset : 812 (0x032c)
11:17:06.247 L2CAP [0] RECV Command. Name: L2C Configuration Request (0x04) ID: 0x02, Len: 8
11:17:06.247 Destination CID : 79 (0x004f)
11:17:06.247 Flags (last request) : 0x0000
11:17:06.247 Option MTU : 48(0x0030)
11:17:06.247 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 16 Data: 0x0c 0x00 0x01 ...
11:17:06.247 Data:
11:17:06.247 0000: 0c 00 01 00 04 02 08 00 4f 00 00 00 01 02 30 00 ........O.....0.
11:17:06.247 L2CAP [0] SENT Command. Name: L2C Configuration Response (0x05) ID 0x02, len 10
11:17:06.247 Source CID : 896 (0x0380)
11:17:06.247 Flags (last response) : 0x0000
11:17:06.247 Result : 0 (0x0000)
11:17:06.247 Option MTU : 48(0x0030)
11:17:06.247 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 18 Data: 0x0e 0x00 0x01 ...
11:17:06.247 Data:
11:17:06.247 0000: 0e 00 01 00 05 02 0a 00 80 03 00 00 00 00 01 02 ................
11:17:06.247 0010: 30 00 0.
11:17:06.247 HCI_RAW evt Data:
11:17:06.247 0000: 13 05 01 0c 00 .....
11:17:06.247 RCVD [1] Event from HCI. Name: HCI_Number_Of_Completed_Packets (Hex Code: 0x13 Param Len: 5)
11:17:06.247 0 : 12 (0x000c) - 2
11:17:06.247 L2CAP [0] RECV Command. Name: L2C Configuration Response (0x05) ID: 0x03, Len: 10
11:17:06.247 Source CID : 79 (0x004f)
11:17:06.247 Flags (last response) : 0x0000
11:17:06.247 Result : 0 (0x0000)
11:17:06.247 Option MTU : 64(0x0040)
11:17:06.247 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 18 Data: 0x0e 0x00 0x01 ...
11:17:06.247 Data:
11:17:06.248 0000: 0e 00 01 00 05 03 0a 00 4f 00 00 00 00 00 01 02 ........O.......
11:17:06.248 0010: 40 00 @.
11:17:06.248 L2CAP [0] RECV Command. Name: L2C Information Response (0x0b) ID: 0x04, Len: 12
11:17:06.248 InfoType : Fixed Channels (3)
11:17:06.248 Result : 0x0
11:17:06.248 L2CAP Signaling channel supported
11:17:06.248 Connectionless reception supported
11:17:06.248 No AMP Manager Protocol Channel
11:17:06.248 ATT Protocol Channel (Supported)
11:17:06.248 ULP Signalling Channel (Supported)
11:17:06.248 SMP Channel (Unsupported)
11:17:06.248 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 20 Data: 0x10 0x00 0x01 ...
11:17:06.248 Data:
11:17:06.248 0000: 10 00 01 00 0b 04 0c 00 03 00 00 00 36 00 00 00 ............6...
11:17:06.248 0010: 00 00 00 00 ....
11:17:06.248 --
11:17:06.248 Rcvd SDP message. PDU Id: SERVICE_SEARCH_ATTR_REQ (Hex: 0x06) Trans: 1 Param Len: 18
11:17:06.248 Descriptor : Data_Ele_Seq (0x06)
11:17:06.248 Length Code : 5 (In next byte)
11:17:06.248 Length : 5
11:17:06.248 Service Search Pattern:
11:17:06.248 Sequence entry : 1.1
11:17:06.248 Descriptor : UUID (0x03)
11:17:06.248 Length Code : 2 (4 bytes)
11:17:06.248 UUID value : 65279 (0x0000feff)
11:17:06.248 Max Attribute Byte Count : 38 (0x0026)
11:17:06.248 Requested Attribute ID List:
11:17:06.248 Descriptor : Data_Ele_Seq (0x06)
11:17:06.248 Length Code : 5 (In next byte)
11:17:06.248 Length : 6
11:17:06.248 Sequence entry : 1.1
11:17:06.248 Descriptor : Uint (0x01)
11:17:06.248 Length Code : 1 (2 bytes)
11:17:06.248 UINT value : 519 (0x0207)
11:17:06.248 Sequence entry : 1.2
11:17:06.248 Descriptor : Uint (0x01)
11:17:06.248 Length Code : 1 (2 bytes)
11:17:06.248 UINT value : 524 (0x020c)
11:17:06.248 Continuation State Len : 0 (0x00)
11:17:06.248 --
11:17:06.248 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 27 Data: 0x17 0x00 0x4f ...
11:17:06.248 Data:
11:17:06.248 0000: 17 00 4f 00 06 00 01 00 12 35 05 1a 00 00 fe ff ..O......5......
11:17:06.248 0010: 00 26 35 06 09 02 07 09 02 0c 00 .&5........
11:17:06.268 --
11:17:06.268 Sent SDP message. PDU Id: SERVICE_SEARCH_ATTR_RSP (Hex: 0x07) Trans: 1 Param Len: 5
11:17:06.268 Attribute Lists Byte Count : 2 (0x0002)
11:17:06.268 Attribute Lists:
11:17:06.268 Descriptor : Data_Ele_Seq (0x06)
11:17:06.268 Length Code : 5 (In next byte)
11:17:06.268 Length : 0
11:17:06.268 Continuation State Len : 0 (0x00)
11:17:06.268 --
11:17:06.268 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 14 Data: 0x0a 0x00 0x80 ...
11:17:06.268 Data:
11:17:06.268 0000: 0a 00 80 03 07 00 01 00 05 00 02 35 00 00 ...........5..
11:17:06.268 HCI_RAW evt Data:
11:17:06.268 0000: 13 05 01 0c 00 .....
11:17:06.268 RCVD [1] Event from HCI. Name: HCI_Number_Of_Completed_Packets (Hex Code: 0x13 Param Len: 5)
11:17:06.268 0 : 12 (0x000c) - 2
11:17:06.268 L2CAP [0] RECV Command. Name: L2C Disconnection Request (0x06) ID: 0x03, Len: 4
11:17:06.268 Destination CID : 0x4f
11:17:06.268 Source CID : 0x380
11:17:06.268 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 12 Data: 0x08 0x00 0x01 ...
11:17:06.268 Data:
11:17:06.268 0000: 08 00 01 00 06 03 04 00 4f 00 80 03 ........O...
11:17:06.268 L2CAP [0] SENT Command. Name: L2C Disconnection Response (0x07) ID 0x03, len 4
11:17:06.268 Destination CID : 0x4f
11:17:06.268 Source CID : 0x380
11:17:06.268 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 12 Data: 0x08 0x00 0x01 ...
11:17:06.268 Data:
11:17:06.268 0000: 08 00 01 00 07 03 04 00 4f 00 80 03 ........O...
11:17:06.268 L2CAP [0] RECV Command. Name: L2C Connection Request (0x02) ID: 0x04, Len: 4
11:17:06.268 PSM : 0x1
11:17:06.268 Source CID : 0x3c0
11:17:06.268 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 12 Data: 0x08 0x00 0x01 ...
11:17:06.268 Data:
11:17:06.268 0000: 08 00 01 00 02 04 04 00 01 00 c0 03 ............
11:17:06.268 L2CAP [0] SENT Command. Name: L2C Connection Response (0x03) ID 0x04, len 8
11:17:06.268 Destination CID : 0x50
11:17:06.268 Source CID : 0x3c0
11:17:06.268 Result : 0x0
11:17:06.268 Status : 0x0
11:17:06.268 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 16 Data: 0x0c 0x00 0x01 ...
11:17:06.268 Data:
11:17:06.268 0000: 0c 00 01 00 03 04 08 00 50 00 c0 03 00 00 00 00 ........P.......
11:17:06.269 L2CAP [0] SENT Command. Name: L2C Configuration Request (0x04) ID 0x05, len 8
11:17:06.269 Destination CID : 960 (0x03c0)
11:17:06.269 Flags (last request) : 0x0000
11:17:06.269 Option MTU : 64(0x0040)
11:17:06.269 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 16 Data: 0x0c 0x00 0x01 ...
11:17:06.269 Data:
11:17:06.269 0000: 0c 00 01 00 04 05 08 00 c0 03 00 00 01 02 40 00 ..............@.
11:17:06.269 HCI_RAW evt Data:
11:17:06.269 0000: 13 05 01 0c 00 .....
11:17:06.269 RCVD [1] Event from HCI. Name: HCI_Number_Of_Completed_Packets (Hex Code: 0x13 Param Len: 5)
11:17:06.269 0 : 12 (0x000c) - 2
11:17:06.269 L2CAP [0] RECV Command. Name: L2C Configuration Request (0x04) ID: 0x05, Len: 8
11:17:06.269 Destination CID : 80 (0x0050)
11:17:06.269 Flags (last request) : 0x0000
11:17:06.269 Option MTU : 48(0x0030)
11:17:06.269 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 16 Data: 0x0c 0x00 0x01 ...
11:17:06.269 Data:
11:17:06.269 0000: 0c 00 01 00 04 05 08 00 50 00 00 00 01 02 30 00 ........P.....0.
11:17:06.269 L2CAP [0] SENT Command. Name: L2C Configuration Response (0x05) ID 0x05, len 10
11:17:06.269 Source CID : 960 (0x03c0)
11:17:06.269 Flags (last response) : 0x0000
11:17:06.269 Result : 0 (0x0000)
11:17:06.269 Option MTU : 48(0x0030)
11:17:06.269 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 18 Data: 0x0e 0x00 0x01 ...
11:17:06.269 Data:
11:17:06.269 0000: 0e 00 01 00 05 05 0a 00 c0 03 00 00 00 00 01 02 ................
11:17:06.269 0010: 30 00 0.
11:17:06.285 L2CAP [0] RECV Command. Name: L2C Configuration Response (0x05) ID: 0x05, Len: 10
11:17:06.285 Source CID : 80 (0x0050)
11:17:06.285 Flags (last response) : 0x0000
11:17:06.285 Result : 0 (0x0000)
11:17:06.285 Option MTU : 64(0x0040)
11:17:06.285 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 18 Data: 0x0e 0x00 0x01 ...
11:17:06.285 Data:
11:17:06.285 0000: 0e 00 01 00 05 05 0a 00 50 00 00 00 00 00 01 02 ........P.......
11:17:06.285 0010: 40 00 @.
11:17:06.285 HCI_RAW evt Data:
11:17:06.285 0000: 13 05 01 0c 00 .....
11:17:06.285 RCVD [1] Event from HCI. Name: HCI_Number_Of_Completed_Packets (Hex Code: 0x13 Param Len: 5)
11:17:06.285 0 : 12 (0x000c) - 2
11:17:06.285 --
11:17:06.285 Rcvd SDP message. PDU Id: SERVICE_SEARCH_ATTR_REQ (Hex: 0x06) Trans: 1 Param Len: 30
11:17:06.285 Descriptor : Data_Ele_Seq (0x06)
11:17:06.285 Length Code : 5 (In next byte)
11:17:06.285 Length : 5
11:17:06.285 Service Search Pattern:
11:17:06.285 Sequence entry : 1.1
11:17:06.285 Descriptor : UUID (0x03)
11:17:06.285 Length Code : 2 (4 bytes)
11:17:06.285 UUID value : 4608 (0x00001200)
11:17:06.285 Max Attribute Byte Count : 38 (0x0026)
11:17:06.285 Requested Attribute ID List:
11:17:06.285 Descriptor : Data_Ele_Seq (0x06)
11:17:06.285 Length Code : 5 (In next byte)
11:17:06.285 Length : 18
11:17:06.285 Sequence entry : 1.1
11:17:06.285 Descriptor : Uint (0x01)
11:17:06.285 Length Code : 1 (2 bytes)
11:17:06.285 UINT value : 512 (0x0200) VERSION_NUMBER_LIST
11:17:06.285 Sequence entry : 1.2
11:17:06.285 Descriptor : Uint (0x01)
11:17:06.285 Length Code : 1 (2 bytes)
11:17:06.285 UINT value : 513 (0x0201)
11:17:06.285 Sequence entry : 1.3
11:17:06.285 Descriptor : Uint (0x01)
11:17:06.285 Length Code : 1 (2 bytes)
11:17:06.285 UINT value : 514 (0x0202)
11:17:06.285 Sequence entry : 1.4
11:17:06.285 Descriptor : Uint (0x01)
11:17:06.285 Length Code : 1 (2 bytes)
11:17:06.285 UINT value : 515 (0x0203)
11:17:06.285 Sequence entry : 1.5
11:17:06.285 Descriptor : Uint (0x01)
11:17:06.285 Length Code : 1 (2 bytes)
11:17:06.285 UINT value : 516 (0x0204)
11:17:06.285 Sequence entry : 1.6
11:17:06.285 Descriptor : Uint (0x01)
11:17:06.285 Length Code : 1 (2 bytes)
11:17:06.285 UINT value : 517 (0x0205)
11:17:06.285 Continuation State Len : 0 (0x00)
11:17:06.285 --
11:17:06.285 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 39 Data: 0x23 0x00 0x50 ...
11:17:06.285 Data:
11:17:06.285 0000: 23 00 50 00 06 00 01 00 1e 35 05 1a 00 00 12 00 #.P......5......
11:17:06.285 0010: 00 26 35 12 09 02 00 09 02 01 09 02 02 09 02 03 .&5.............
11:17:06.285 0020: 09 02 04 09 02 05 00 .......
11:17:06.285 --
11:17:06.285 Sent SDP message. PDU Id: SERVICE_SEARCH_ATTR_RSP (Hex: 0x07) Trans: 1 Param Len: 5
11:17:06.285 Attribute Lists Byte Count : 2 (0x0002)
11:17:06.285 Attribute Lists:
11:17:06.285 Descriptor : Data_Ele_Seq (0x06)
11:17:06.285 Length Code : 5 (In next byte)
11:17:06.285 Length : 0
11:17:06.285 Continuation State Len : 0 (0x00)
11:17:06.285 --
11:17:06.285 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 14 Data: 0x0a 0x00 0xc0 ...
11:17:06.285 Data:
11:17:06.285 0000: 0a 00 c0 03 07 00 01 00 05 00 02 35 00 00 ...........5..
11:17:06.285 L2CAP [0] RECV Command. Name: L2C Disconnection Request (0x06) ID: 0x06, Len: 4
11:17:06.285 Destination CID : 0x50
11:17:06.285 Source CID : 0x3c0
11:17:06.285 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 12 Data: 0x08 0x00 0x01 ...
11:17:06.285 Data:
11:17:06.285 0000: 08 00 01 00 06 06 04 00 50 00 c0 03 ........P...
11:17:06.286 L2CAP [0] SENT Command. Name: L2C Disconnection Response (0x07) ID 0x06, len 4
11:17:06.286 Destination CID : 0x50
11:17:06.286 Source CID : 0x3c0
11:17:06.286 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 12 Data: 0x08 0x00 0x01 ...
11:17:06.286 Data:
11:17:06.286 0000: 08 00 01 00 07 06 04 00 50 00 c0 03 ........P...
11:17:06.286 HCI_RAW evt Data:
11:17:06.286 0000: 13 05 01 0c 00 .....
11:17:06.286 RCVD [1] Event from HCI. Name: HCI_Number_Of_Completed_Packets (Hex Code: 0x13 Param Len: 5)
11:17:06.286 0 : 12 (0x000c) - 2
11:17:06.767 HCI_RAW evt Data:
11:17:06.767 0000: 05 04 00 0c ....
11:17:06.767 RCVD [1] Event from HCI. Name: HCI_Disconnection_Complete (Hex Code: 0x05 Param Len: 4)
11:17:06.767 Status : Success (0x00)
11:17:06.767 Connection Handle : 12 (0x000c)
11:17:06.767 Reason : 19 (0x13)
11:17:06.767 Remote User Terminated Connection
11:17:06.767 SENT [1] Command to HCI. Name: HCI_Create_Connection (Hex Code: 0x0405 Param Len: 13)
11:17:06.767 HCI_RAW cmd Data:
11:17:06.767 0000: a1 16 f6 4b 5c 74 18 cc 01 00 2c 83 01 ...K\t....,..
11:17:06.767 BD_ADDR of remote device : 74-5c-4b-f6-16-a1
11:17:06.767 Packet Types Supported : 0xcc18 ( 2-DH1 3-DH1 DM1 DH1 2-DH3 3-DH3 DM3 DH3 2-DH5 3-DH5 DM5 DH5 )
11:17:06.767 Page Scan Repetition Mode : 1 (0x01)
11:17:06.767 Page Scan Mode(BT1.1) / Reserved(BT1.2) : 0 (0x00)
11:17:06.767 Clock Offset : 33580 (0x832c)
11:17:06.767 Allow Role Switch : 1 (0x01)
11:17:06.767 HCI_RAW evt Data:
11:17:06.767 0000: 0f 04 00 01 ....
11:17:06.767 RCVD [1] Event from HCI. Name: HCI_Command_Status (Hex Code: 0x0f Param Len: 4)
11:17:06.767 Status : Success (0x00)
11:17:06.767 Num HCI Cmd Packets : 1 (0x01)
11:17:06.767 Cmd Code : 0x0405 (HCI_Create_Connection)
11:17:07.853 HCI_RAW evt Data:
11:17:07.853 0000: 03 0b 00 0c 00 a1 16 f6 4b 5c 74 ........K\t
11:17:07.853 RCVD [1] Event from HCI. Name: HCI_Connection_Complete (Hex Code: 0x03 Param Len: 11)
11:17:07.853 Status : Success (0x00)
11:17:07.853 Connection Handle : 12 (0x000c)
11:17:07.853 BD_ADDR of remote : 74-5c-4b-f6-16-a1
11:17:07.853 Link Type : 1 (0x01)
11:17:07.853 Encryption Mode : 0 (0x00)
11:17:07.853 SENT [1] Command to HCI. Name: HCI_Write_Link_Policy_Settings (Hex Code: 0x080d Param Len: 4)
11:17:07.853 HCI_RAW cmd Data:
11:17:07.853 0000: 0c 00 05 00 ....
11:17:07.853 Connection Handle : 12 (0x000c)
11:17:07.853 Link Policy Settings : 0x0005
11:17:07.853 : Enable Master Slave Switch
11:17:07.853 : Enable Sniff Mode
11:17:07.853 L2CAP [0] SENT Command. Name: L2C Information Request (0x0a) ID 0x06, len 2
11:17:07.853 InfoType : Ext Features
11:17:07.853 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 10 Data: 0x06 0x00 0x01 ...
11:17:07.853 Data:
11:17:07.853 0000: 06 00 01 00 0a 06 02 00 02 00 ..........
11:17:07.853 HCI_RAW evt Data:
11:17:07.853 0000: 0e 06 01 0d 08 00 ......
11:17:07.853 RCVD [1] Event from HCI. Name: HCI_Command_Complete (Hex Code: 0x0e Param Len: 6)
11:17:07.853 Num HCI Cmd Packets : 1 (0x01)
11:17:07.853 Cmd Code : 0x080d (HCI_Write_Link_Policy_Settings)
11:17:07.853 Status : Success (0x00)
11:17:07.853 Connection Handle : 12 (0x000c)
11:17:07.853 SENT [1] Command to HCI. Name: HCI_Write_Link_Supervision_Timeout (Hex Code: 0x0c37 Param Len: 4)
11:17:07.853 HCI_RAW cmd Data:
11:17:07.853 0000: 0c 00 00 7d ....
11:17:07.854 Connection/Physical Link Handle : 12 (0x000c)
11:17:07.854 Timeout (625us units) : 32000 (0x7d00)
11:17:07.854 HCI_RAW evt Data:
11:17:07.854 0000: 0e 06 01 37 0c 00 ...7..
11:17:07.854 RCVD [1] Event from HCI. Name: HCI_Command_Complete (Hex Code: 0x0e Param Len: 6)
11:17:07.854 Num HCI Cmd Packets : 1 (0x01)
11:17:07.854 Cmd Code : 0x0c37 (HCI_Write_Link_Supervision_Timeout)
11:17:07.854 Status : Success (0x00)
11:17:07.854 Connection Handle : 12 (0x000c)
11:17:07.854 HCI_RAW evt Data:
11:17:07.854 0000: 20 07 a1 16 f6 4b 5c ....K\
11:17:07.854 RCVD [1] Event from HCI. Name: HCI_Page_Scan_Repetition_Mode_Change (Hex Code: 0x20 Param Len: 7)
11:17:07.854 BD_ADDR of remote : 74-5c-4b-f6-16-a1
11:17:07.854 Page Scan Repetition Mode : 1 (0x01)
11:17:07.854 HCI_RAW evt Data:
11:17:07.854 0000: 1b 03 0c ...
11:17:07.854 RCVD [1] Event from HCI. Name: HCI_Max_Slots_Changed (Hex Code: 0x1b Param Len: 3)
11:17:07.854 Connection Handle : 12 (0x000c)
11:17:07.854 LMP Max Slots : 5 (0x05)
11:17:07.854 L2CAP [0] RECV Command. Name: L2C Connection Request (0x02) ID: 0x01, Len: 4
11:17:07.854 PSM : 0x1
11:17:07.854 Source CID : 0x400
11:17:07.854 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 12 Data: 0x08 0x00 0x01 ...
11:17:07.854 Data:
11:17:07.854 0000: 08 00 01 00 02 01 04 00 01 00 00 04 ............
11:17:07.854 L2CAP [0] SENT Command. Name: L2C Connection Response (0x03) ID 0x01, len 8
11:17:07.854 Destination CID : 0x51
11:17:07.854 Source CID : 0x400
11:17:07.854 Result : 0x0
11:17:07.854 Status : 0x0
11:17:07.854 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 16 Data: 0x0c 0x00 0x01 ...
11:17:07.854 Data:
11:17:07.854 0000: 0c 00 01 00 03 01 08 00 51 00 00 04 00 00 00 00 ........Q.......
11:17:07.875 L2CAP [0] SENT Command. Name: L2C Configuration Request (0x04) ID 0x07, len 8
11:17:07.875 Destination CID : 1024 (0x0400)
11:17:07.875 Flags (last request) : 0x0000
11:17:07.875 Option MTU : 64(0x0040)
11:17:07.875 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 16 Data: 0x0c 0x00 0x01 ...
11:17:07.875 Data:
11:17:07.875 0000: 0c 00 01 00 04 07 08 00 00 04 00 00 01 02 40 00 ..............@.
11:17:07.875 HCI_RAW evt Data:
11:17:07.875 0000: 13 05 01 0c 00 .....
11:17:07.875 RCVD [1] Event from HCI. Name: HCI_Number_Of_Completed_Packets (Hex Code: 0x13 Param Len: 5)
11:17:07.875 0 : 12 (0x000c) - 2
11:17:07.875 L2CAP [0] RECV Command. Name: L2C Information Response (0x0b) ID: 0x06, Len: 8
11:17:07.875 InfoType : Ext Features (2)
11:17:07.875 Result : 0x0
11:17:07.875 Supported :
11:17:07.875 Enhanced Retransmission Mode
11:17:07.875 Streaming Mode
11:17:07.875 No-FCS-Check Flag Supported
11:17:07.875 Fixed Channels
11:17:07.875 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 16 Data: 0x0c 0x00 0x01 ...
11:17:07.875 Data:
11:17:07.875 0000: 0c 00 01 00 0b 06 08 00 02 00 00 00 b8 00 00 00 ................
11:17:07.875 L2CAP [0] SENT Command. Name: L2C Information Request (0x0a) ID 0x08, len 2
11:17:07.875 InfoType : Fixed Channels
11:17:07.875 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 10 Data: 0x06 0x00 0x01 ...
11:17:07.875 Data:
11:17:07.875 0000: 06 00 01 00 0a 08 02 00 03 00 ..........
11:17:07.875 L2CAP [0] RECV Command. Name: L2C Configuration Request (0x04) ID: 0x02, Len: 8
11:17:07.875 Destination CID : 81 (0x0051)
11:17:07.875 Flags (last request) : 0x0000
11:17:07.875 Option MTU : 48(0x0030)
11:17:07.875 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 16 Data: 0x0c 0x00 0x01 ...
11:17:07.875 Data:
11:17:07.875 0000: 0c 00 01 00 04 02 08 00 51 00 00 00 01 02 30 00 ........Q.....0.
11:17:07.875 L2CAP [0] SENT Command. Name: L2C Configuration Response (0x05) ID 0x02, len 10
11:17:07.875 Source CID : 1024 (0x0400)
11:17:07.875 Flags (last response) : 0x0000
11:17:07.875 Result : 0 (0x0000)
11:17:07.875 Option MTU : 48(0x0030)
11:17:07.875 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 18 Data: 0x0e 0x00 0x01 ...
11:17:07.875 Data:
11:17:07.875 0000: 0e 00 01 00 05 02 0a 00 00 04 00 00 00 00 01 02 ................
11:17:07.875 0010: 30 00 0.
11:17:07.875 L2CAP [0] RECV Command. Name: L2C Configuration Response (0x05) ID: 0x07, Len: 10
11:17:07.875 Source CID : 81 (0x0051)
11:17:07.875 Flags (last response) : 0x0000
11:17:07.875 Result : 0 (0x0000)
11:17:07.875 Option MTU : 64(0x0040)
11:17:07.875 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 18 Data: 0x0e 0x00 0x01 ...
11:17:07.875 Data:
11:17:07.875 0000: 0e 00 01 00 05 07 0a 00 51 00 00 00 00 00 01 02 ........Q.......
11:17:07.875 0010: 40 00 @.
11:17:07.875 HCI_RAW evt Data:
11:17:07.875 0000: 13 05 01 0c 00 .....
11:17:07.875 RCVD [1] Event from HCI. Name: HCI_Number_Of_Completed_Packets (Hex Code: 0x13 Param Len: 5)
11:17:07.875 0 : 12 (0x000c) - 2
11:17:07.875 L2CAP [0] RECV Command. Name: L2C Information Response (0x0b) ID: 0x08, Len: 12
11:17:07.875 InfoType : Fixed Channels (3)
11:17:07.875 Result : 0x0
11:17:07.875 L2CAP Signaling channel supported
11:17:07.875 Connectionless reception supported
11:17:07.875 No AMP Manager Protocol Channel
11:17:07.875 ATT Protocol Channel (Supported)
11:17:07.875 ULP Signalling Channel (Supported)
11:17:07.875 SMP Channel (Unsupported)
11:17:07.875 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 20 Data: 0x10 0x00 0x01 ...
11:17:07.875 Data:
11:17:07.875 0000: 10 00 01 00 0b 08 0c 00 03 00 00 00 36 00 00 00 ............6...
11:17:07.875 0010: 00 00 00 00 ....
11:17:07.875 --
11:17:07.875 Rcvd SDP message. PDU Id: SERVICE_SEARCH_ATTR_REQ (Hex: 0x06) Trans: 1 Param Len: 18
11:17:07.875 Descriptor : Data_Ele_Seq (0x06)
11:17:07.875 Length Code : 5 (In next byte)
11:17:07.875 Length : 5
11:17:07.875 Service Search Pattern:
11:17:07.875 Sequence entry : 1.1
11:17:07.875 Descriptor : UUID (0x03)
11:17:07.875 Length Code : 2 (4 bytes)
11:17:07.875 UUID value : 65279 (0x0000feff)
11:17:07.875 Max Attribute Byte Count : 38 (0x0026)
11:17:07.875 Requested Attribute ID List:
11:17:07.876 Descriptor : Data_Ele_Seq (0x06)
11:17:07.876 Length Code : 5 (In next byte)
11:17:07.876 Length : 6
11:17:07.876 Sequence entry : 1.1
11:17:07.876 Descriptor : Uint (0x01)
11:17:07.876 Length Code : 1 (2 bytes)
11:17:07.876 UINT value : 519 (0x0207)
11:17:07.876 Sequence entry : 1.2
11:17:07.876 Descriptor : Uint (0x01)
11:17:07.876 Length Code : 1 (2 bytes)
11:17:07.876 UINT value : 524 (0x020c)
11:17:07.876 Continuation State Len : 0 (0x00)
11:17:07.876 --
11:17:07.876 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 27 Data: 0x17 0x00 0x51 ...
11:17:07.876 Data:
11:17:07.876 0000: 17 00 51 00 06 00 01 00 12 35 05 1a 00 00 fe ff ..Q......5......
11:17:07.876 0010: 00 26 35 06 09 02 07 09 02 0c 00 .&5........
11:17:07.894 --
11:17:07.894 Sent SDP message. PDU Id: SERVICE_SEARCH_ATTR_RSP (Hex: 0x07) Trans: 1 Param Len: 5
11:17:07.894 Attribute Lists Byte Count : 2 (0x0002)
11:17:07.894 Attribute Lists:
11:17:07.894 Descriptor : Data_Ele_Seq (0x06)
11:17:07.894 Length Code : 5 (In next byte)
11:17:07.894 Length : 0
11:17:07.894 Continuation State Len : 0 (0x00)
11:17:07.894 --
11:17:07.894 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 14 Data: 0x0a 0x00 0x00 ...
11:17:07.894 Data:
11:17:07.894 0000: 0a 00 00 04 07 00 01 00 05 00 02 35 00 00 ...........5..
11:17:07.894 HCI_RAW evt Data:
11:17:07.894 0000: 13 05 01 0c 00 .....
11:17:07.894 RCVD [1] Event from HCI. Name: HCI_Number_Of_Completed_Packets (Hex Code: 0x13 Param Len: 5)
11:17:07.894 0 : 12 (0x000c) - 2
11:17:07.894 L2CAP [0] RECV Command. Name: L2C Disconnection Request (0x06) ID: 0x03, Len: 4
11:17:07.894 Destination CID : 0x51
11:17:07.894 Source CID : 0x400
11:17:07.894 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 12 Data: 0x08 0x00 0x01 ...
11:17:07.894 Data:
11:17:07.894 0000: 08 00 01 00 06 03 04 00 51 00 00 04 ........Q...
11:17:07.894 L2CAP [0] SENT Command. Name: L2C Disconnection Response (0x07) ID 0x03, len 4
11:17:07.894 Destination CID : 0x51
11:17:07.894 Source CID : 0x400
11:17:07.894 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 12 Data: 0x08 0x00 0x01 ...
11:17:07.894 Data:
11:17:07.894 0000: 08 00 01 00 07 03 04 00 51 00 00 04 ........Q...
11:17:07.894 L2CAP [0] RECV Command. Name: L2C Connection Request (0x02) ID: 0x04, Len: 4
11:17:07.894 PSM : 0x1
11:17:07.894 Source CID : 0x440
11:17:07.894 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 12 Data: 0x08 0x00 0x01 ...
11:17:07.894 Data:
11:17:07.894 0000: 08 00 01 00 02 04 04 00 01 00 40 04 ..........@.
11:17:07.894 L2CAP [0] SENT Command. Name: L2C Connection Response (0x03) ID 0x04, len 8
11:17:07.894 Destination CID : 0x40
11:17:07.894 Source CID : 0x440
11:17:07.894 Result : 0x0
11:17:07.894 Status : 0x0
11:17:07.894 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 16 Data: 0x0c 0x00 0x01 ...
11:17:07.894 Data:
11:17:07.894 0000: 0c 00 01 00 03 04 08 00 40 00 40 04 00 00 00 00 ........@.@.....
11:17:07.894 L2CAP [0] SENT Command. Name: L2C Configuration Request (0x04) ID 0x09, len 8
11:17:07.894 Destination CID : 1088 (0x0440)
11:17:07.894 Flags (last request) : 0x0000
11:17:07.894 Option MTU : 64(0x0040)
11:17:07.894 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 16 Data: 0x0c 0x00 0x01 ...
11:17:07.894 Data:
11:17:07.894 0000: 0c 00 01 00 04 09 08 00 40 04 00 00 01 02 40 00 ........@.....@.
11:17:07.894 HCI_RAW evt Data:
11:17:07.894 0000: 13 05 01 0c 00 .....
11:17:07.894 RCVD [1] Event from HCI. Name: HCI_Number_Of_Completed_Packets (Hex Code: 0x13 Param Len: 5)
11:17:07.894 0 : 12 (0x000c) - 2
11:17:07.894 L2CAP [0] RECV Command. Name: L2C Configuration Request (0x04) ID: 0x05, Len: 8
11:17:07.894 Destination CID : 64 (0x0040)
11:17:07.894 Flags (last request) : 0x0000
11:17:07.894 Option MTU : 48(0x0030)
11:17:07.894 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 16 Data: 0x0c 0x00 0x01 ...
11:17:07.894 Data:
11:17:07.895 0000: 0c 00 01 00 04 05 08 00 40 00 00 00 01 02 30 00 ........@.....0.
11:17:07.895 L2CAP [0] SENT Command. Name: L2C Configuration Response (0x05) ID 0x05, len 10
11:17:07.895 Source CID : 1088 (0x0440)
11:17:07.895 Flags (last response) : 0x0000
11:17:07.895 Result : 0 (0x0000)
11:17:07.895 Option MTU : 48(0x0030)
11:17:07.895 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 18 Data: 0x0e 0x00 0x01 ...
11:17:07.895 Data:
11:17:07.895 0000: 0e 00 01 00 05 05 0a 00 40 04 00 00 00 00 01 02 ........@.......
11:17:07.895 0010: 30 00 0.
11:17:07.912 L2CAP [0] RECV Command. Name: L2C Configuration Response (0x05) ID: 0x09, Len: 10
11:17:07.912 Source CID : 64 (0x0040)
11:17:07.912 Flags (last response) : 0x0000
11:17:07.912 Result : 0 (0x0000)
11:17:07.912 Option MTU : 64(0x0040)
11:17:07.912 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 18 Data: 0x0e 0x00 0x01 ...
11:17:07.912 Data:
11:17:07.912 0000: 0e 00 01 00 05 09 0a 00 40 00 00 00 00 00 01 02 ........@.......
11:17:07.912 0010: 40 00 @.
11:17:07.912 HCI_RAW evt Data:
11:17:07.913 0000: 13 05 01 0c 00 .....
11:17:07.913 RCVD [1] Event from HCI. Name: HCI_Number_Of_Completed_Packets (Hex Code: 0x13 Param Len: 5)
11:17:07.913 0 : 12 (0x000c) - 2
11:17:07.913 --
11:17:07.913 Rcvd SDP message. PDU Id: SERVICE_SEARCH_ATTR_REQ (Hex: 0x06) Trans: 1 Param Len: 30
11:17:07.913 Descriptor : Data_Ele_Seq (0x06)
11:17:07.913 Length Code : 5 (In next byte)
11:17:07.913 Length : 5
11:17:07.913 Service Search Pattern:
11:17:07.913 Sequence entry : 1.1
11:17:07.913 Descriptor : UUID (0x03)
11:17:07.913 Length Code : 2 (4 bytes)
11:17:07.913 UUID value : 4608 (0x00001200)
11:17:07.913 Max Attribute Byte Count : 38 (0x0026)
11:17:07.913 Requested Attribute ID List:
11:17:07.913 Descriptor : Data_Ele_Seq (0x06)
11:17:07.913 Length Code : 5 (In next byte)
11:17:07.913 Length : 18
11:17:07.913 Sequence entry : 1.1
11:17:07.913 Descriptor : Uint (0x01)
11:17:07.913 Length Code : 1 (2 bytes)
11:17:07.913 UINT value : 512 (0x0200) VERSION_NUMBER_LIST
11:17:07.913 Sequence entry : 1.2
11:17:07.913 Descriptor : Uint (0x01)
11:17:07.913 Length Code : 1 (2 bytes)
11:17:07.913 UINT value : 513 (0x0201)
11:17:07.913 Sequence entry : 1.3
11:17:07.913 Descriptor : Uint (0x01)
11:17:07.913 Length Code : 1 (2 bytes)
11:17:07.913 UINT value : 514 (0x0202)
11:17:07.913 Sequence entry : 1.4
11:17:07.913 Descriptor : Uint (0x01)
11:17:07.913 Length Code : 1 (2 bytes)
11:17:07.913 UINT value : 515 (0x0203)
11:17:07.913 Sequence entry : 1.5
11:17:07.913 Descriptor : Uint (0x01)
11:17:07.913 Length Code : 1 (2 bytes)
11:17:07.913 UINT value : 516 (0x0204)
11:17:07.913 Sequence entry : 1.6
11:17:07.913 Descriptor : Uint (0x01)
11:17:07.913 Length Code : 1 (2 bytes)
11:17:07.913 UINT value : 517 (0x0205)
11:17:07.913 Continuation State Len : 0 (0x00)
11:17:07.913 --
11:17:07.913 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 39 Data: 0x23 0x00 0x40 ...
11:17:07.913 Data:
11:17:07.913 0000: 23 00 40 00 06 00 01 00 1e 35 05 1a 00 00 12 00 #.@......5......
11:17:07.913 0010: 00 26 35 12 09 02 00 09 02 01 09 02 02 09 02 03 .&5.............
11:17:07.913 0020: 09 02 04 09 02 05 00 .......
11:17:07.913 --
11:17:07.913 Sent SDP message. PDU Id: SERVICE_SEARCH_ATTR_RSP (Hex: 0x07) Trans: 1 Param Len: 5
11:17:07.913 Attribute Lists Byte Count : 2 (0x0002)
11:17:07.913 Attribute Lists:
11:17:07.913 Descriptor : Data_Ele_Seq (0x06)
11:17:07.913 Length Code : 5 (In next byte)
11:17:07.913 Length : 0
11:17:07.913 Continuation State Len : 0 (0x00)
11:17:07.913 --
11:17:07.913 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 14 Data: 0x0a 0x00 0x40 ...
11:17:07.913 Data:
11:17:07.913 0000: 0a 00 40 04 07 00 01 00 05 00 02 35 00 00 ..@........5..
11:17:07.913 L2CAP [0] RECV Command. Name: L2C Disconnection Request (0x06) ID: 0x06, Len: 4
11:17:07.913 Destination CID : 0x40
11:17:07.913 Source CID : 0x440
11:17:07.913 RCVD [0] ACL Data from HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 12 Data: 0x08 0x00 0x01 ...
11:17:07.913 Data:
11:17:07.913 0000: 08 00 01 00 06 06 04 00 40 00 40 04 ........@.@.
11:17:07.913 L2CAP [0] SENT Command. Name: L2C Disconnection Response (0x07) ID 0x06, len 4
11:17:07.913 Destination CID : 0x40
11:17:07.913 Source CID : 0x440
11:17:07.913 SENT [0] ACL Data to HCI. Handle: 0x00c Boundary: 2 Brdcst: 0 Len: 12 Data: 0x08 0x00 0x01 ...
11:17:07.913 Data:
11:17:07.913 0000: 08 00 01 00 07 06 04 00 40 00 40 04 ........@.@.
11:17:07.913 HCI_RAW evt Data:
11:17:07.913 0000: 13 05 01 0c 00 .....
11:17:07.913 RCVD [1] Event from HCI. Name: HCI_Number_Of_Completed_Packets (Hex Code: 0x13 Param Len: 5)
11:17:07.913 0 : 12 (0x000c) - 2
11:17:08.416 HCI_RAW evt Data:
11:17:08.416 0000: 05 04 00 0c ....
11:17:08.416 RCVD [1] Event from HCI. Name: HCI_Disconnection_Complete (Hex Code: 0x05 Param Len: 4)
11:17:08.416 Status : Success (0x00)
11:17:08.416 Connection Handle : 12 (0x000c)
11:17:08.416 Reason : 19 (0x13)
11:17:08.416 Remote User Terminated Connection
11:17:08.416 1 hci_control_ag_sdp_cback status:0xfff1, p_scb 21b0a8
11:17:08.416 1 [1]hfp_ag_rfcomm_start_server: rfcomm_create Res: 0x0 Port: 0x0007 UUID: 0x111e
11:17:08.435 1 hfp_ag_process_open_callback status=1
11:17:08.435 1 hfp_ag_process_open_callback: Try HSP
11:17:09.420 1 initiate service discovery app_handle = 1, uuid: 4360, num_attr: 4, p_scp: 21b0a8
11:17:09.420 1 search attribute request, 74 5c 4b f6 16 a1 , 22bcf8
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
The btspy trace is telling. The stack never initializes a search for the 4382 UUID. The code path is the same on reconnect as the initial connect, we call wiced_bt_sdp_init_discovery_db() and wiced_bt_sdp_service_search_attribute_request() with the exact same parameters. But for some reason in the reconnect case, the discovery database that the stack is using is incorrect. How could this be? Please support