Hi All,
We round a possible bug during 2 consecutive rounds of RFCOMM
connections in kernel 6.7.9:
(1) During the connection process, the host sends a HCI command
REMOTE_NAME_REQ to request the name of the remote device. Normally, the
controller responds to it with a HCI event
COMMAND_STATUS(REMOTE_NAME_REQ) and then sends a HCI event REMOTE_NAME
containing the remote device's name.
(2) Upon receiving COMMAND_STATUS(REMOTE_NAME_REQ), function
hci_cmd_status_evt(net/bluetooth/hci_event.c:4356) is called, which in
turn invokes function handle_cmd_cnt_and_timer to clear the timer.
(3) Since the timer has been clear, the host indefinitely waits for the
HCI event REMOTE_NAME. If the controller fails to send this packet, the
only recourse is for the user to manually terminate the connection process.
(4.1) Because the connection state is only set to CONNECTED upon
receiving the HCI event REMOTE_NAME (hci_remote_name_evt
->hci_check_pending_name->mgmt_device_connected), the remote device
remains unconnected in (3).
(4.2) We tried to reconnect for multiple times, but host is unable to
send the HCI command CREATE_CONNECTION, resulting in subsequent failures
to establish a connection with the device.
We believe it might be necessary to set a timeout while waiting for the
HCI event REMOTE_NAME.
Thank you for reading this. Appreciating for any possible reply.
Attachment 1: Log file containing HCI packet contents.
Attachment 2: ftrace records of bluetooth and rfcomm modules.
Best Wishes,
Yuxuan Hu
================================================
Round 0
================================================
[QServer] begin connect_bt()
[ 1620.628969] -> [CMD] 05 04 0D A8 25 D1 EB 27 B8 18 CC 02 00 00 00 01
[ 1620.629393] <- [EVT] 0F 04 00 01 05 04
[ 1620.630742] <- [EVT] 12 08 00 A8 25 D1 EB 27 B8 01
[ 1620.632746] <- [EVT] 03 0B 00 0B 00 A8 25 D1 EB 27 B8 01 00
[ 1620.633480] -> [CMD] 1B 04 02 0B 00
[ 1620.634774] <- [EVT] 1B 03 0B 00 05
[ 1620.651784] <- [ACL] 0B 20 0A 00 06 00 01 00 0A 01 02 00 02 00
[ 1620.652394] <- [EVT] 0F 04 00 01 1B 04
[ 1620.652742] -> [CMD] 1A 0C 01 00
[ 1620.653863] <- [EVT] 0B 0B 00 0B 00 BF FE CF FE DB FF 7B 87
[ 1620.654876] <- [EVT] 0E 04 01 1A 0C 00
[ 1620.655218] -> [CMD] 1C 04 03 0B 00 01
[ 1620.655584] <- [EVT] 0E 04 01 1A 0C 00
[ 1620.704819] <- [EVT] 0F 04 00 01 1C 04
[ 1620.706780] <- [EVT] 23 0D 00 0B 00 01 02 0B 00 00 00 00 00 00 00
[ 1620.706902] -> [CMD] 19 04 0A A8 25 D1 EB 27 B8 02 00 00 00
[ 1620.707791] <- [EVT] 0F 04 00 01 19 04
[QServer] Child terminated by signal Killed
================================================
Round 1
================================================
Device is not connected
[QServer] begin connect_bt()
[QServer] Child terminated by signal Killed
================================================
Round 2
================================================
Device is not connected
[QServer] begin connect_bt()
[QServer] Child terminated by signal Killed
root@hyx-QiTianM540-A739:/sys/kernel/debug/tracing# cat trace
# tracer: function
#
# entries-in-buffer/entries-written: 540/540 #P:2
#
# _-----=> irqs-off/BH-disabled
# / _----=> need-resched
# | / _---=> hardirq/softirq
# || / _--=> preempt-depth
# ||| / _-=> migrate-disable
# |||| / delay
# TASK-PID CPU# ||||| TIMESTAMP FUNCTION
# | | | ||||| | |
QServer-367 [000] ...1. 1620.629830: bt_sock_create <-__sock_create
QServer-367 [000] ...2. 1620.629834: rfcomm_sock_create <-bt_sock_create
QServer-367 [000] ...2. 1620.629835: bt_sock_alloc <-rfcomm_sock_create
QServer-367 [000] ...2. 1620.629883: rfcomm_dlc_alloc <-rfcomm_sock_create
QServer-367 [000] ...2. 1620.629902: bt_sock_link <-rfcomm_sock_create
QServer-367 [000] ...1. 1620.630000: rfcomm_sock_connect <-__sys_connect
QServer-367 [000] ...1. 1620.630002: rfcomm_dlc_open <-rfcomm_sock_connect
QServer-367 [000] ...1. 1620.630037: bt_sock_create <-__sock_create
QServer-367 [000] ...2. 1620.630039: l2cap_sock_create <-bt_sock_create
QServer-367 [000] ...2. 1620.630040: bt_sock_alloc <-l2cap_sock_create
QServer-367 [000] ...2. 1620.630085: l2cap_chan_create <-l2cap_sock_create
QServer-367 [000] ...2. 1620.630108: l2cap_chan_hold <-l2cap_sock_create
QServer-367 [000] ...2. 1620.630109: l2cap_chan_set_defaults <-l2cap_sock_create
QServer-367 [000] ...2. 1620.630110: bt_sock_link <-l2cap_sock_create
QServer-367 [000] ...1. 1620.630113: l2cap_sock_bind <-kernel_bind
QServer-367 [000] ...1. 1620.630114: l2cap_add_psm <-l2cap_sock_bind
QServer-367 [000] ...1. 1620.630134: l2cap_sock_connect <-kernel_connect
QServer-367 [000] ...1. 1620.630136: l2cap_chan_connect <-l2cap_sock_connect
QServer-367 [000] ...1. 1620.630137: hci_get_route <-l2cap_chan_connect
QServer-367 [000] ...1. 1620.630139: hci_connect_acl <-l2cap_chan_connect
QServer-367 [000] ...1. 1620.630252: hci_conn_add <-hci_connect_acl
QServer-367 [000] ...1. 1620.630278: hci_conn_init_sysfs <-hci_conn_add
QServer-367 [000] ...1. 1620.630282: hci_acl_create_connection <-hci_connect_acl
QServer-367 [000] ...1. 1620.630283: hci_inquiry_cache_lookup <-hci_acl_create_connection
QServer-367 [000] ...1. 1620.630284: hci_send_cmd <-hci_acl_create_connection
QServer-367 [000] ...1. 1620.630285: hci_prepare_cmd <-hci_send_cmd
QServer-367 [000] ...1. 1620.630368: l2cap_conn_add <-l2cap_chan_connect
QServer-367 [000] ...1. 1620.630370: hci_chan_create <-l2cap_conn_add
kworker/u7:1-325 [001] ...1. 1620.630376: hci_cmd_work <-process_one_work
kworker/u7:1-325 [001] ...1. 1620.630404: hci_req_status_pend <-hci_cmd_work
kworker/u7:1-325 [001] ...1. 1620.630405: hci_send_frame <-hci_cmd_work
kworker/u7:1-325 [001] ...1. 1620.630406: hci_send_to_monitor <-hci_send_frame
QServer-367 [000] ...1. 1620.630413: __l2cap_chan_add <-l2cap_chan_connect
QServer-367 [000] ...1. 1620.630415: l2cap_sock_state_change_cb <-l2cap_chan_connect
QServer-367 [000] ...1. 1620.630416: l2cap_sock_get_sndtimeo_cb <-l2cap_chan_connect
QServer-367 [000] ...1. 1620.630420: bt_sock_wait_state <-l2cap_sock_connect
QServer-367 [000] ...1. 1620.630423: bt_sock_wait_state <-rfcomm_sock_connect
kworker/1:2-300 [001] ...1. 1620.630846: hci_recv_frame <-h4_recv_buf
kworker/u7:1-325 [001] ...1. 1620.631103: hci_rx_work <-process_one_work
kworker/u7:1-325 [001] ...1. 1620.631104: hci_send_to_monitor <-hci_rx_work
kworker/u7:1-325 [001] ...1. 1620.631104: hci_event_packet <-hci_rx_work
kworker/u7:1-325 [001] ...1. 1620.631134: hci_cmd_status_evt <-hci_event_packet
kworker/u7:1-325 [001] ...1. 1620.631135: hci_cs_create_conn <-hci_cmd_status_evt
kworker/u7:1-325 [001] ...1. 1620.631135: hci_sent_cmd_data <-hci_cs_create_conn
kworker/u7:1-325 [001] ...1. 1620.631137: hci_req_cmd_complete <-hci_cmd_status_evt
kworker/1:2-300 [001] ...1. 1620.632197: hci_recv_frame <-h4_recv_buf
kworker/u7:1-325 [000] ...1. 1620.632215: hci_rx_work <-process_one_work
kworker/u7:1-325 [000] ...1. 1620.632217: hci_send_to_monitor <-hci_rx_work
kworker/u7:1-325 [000] ...1. 1620.632218: hci_event_packet <-hci_rx_work
kworker/u7:1-325 [000] ...1. 1620.632249: hci_role_change_evt <-hci_event_packet
kworker/1:2-300 [001] ...1. 1620.634196: hci_recv_frame <-h4_recv_buf
kworker/u7:1-325 [000] ...1. 1620.634214: hci_rx_work <-process_one_work
kworker/u7:1-325 [000] ...1. 1620.634216: hci_send_to_monitor <-hci_rx_work
kworker/u7:1-325 [000] ...1. 1620.634216: hci_event_packet <-hci_rx_work
kworker/u7:1-325 [000] ...1. 1620.634246: hci_conn_complete_evt <-hci_event_packet
kworker/u7:1-325 [000] ...1. 1620.634247: hci_conn_set_handle <-hci_conn_complete_evt
kworker/u7:1-325 [000] ...1. 1620.634263: hci_debugfs_create_conn <-hci_conn_complete_evt
kworker/u7:1-325 [000] ...1. 1620.634330: hci_conn_add_sysfs <-hci_conn_complete_evt
kworker/u7:1-325 [000] ...1. 1620.634670: hci_send_cmd <-hci_conn_complete_evt
kworker/u7:1-325 [000] ...1. 1620.634670: hci_prepare_cmd <-hci_send_cmd
kworker/u7:1-325 [000] ...1. 1620.634689: hci_update_scan <-hci_conn_complete_evt
kworker/u7:1-325 [000] ...1. 1620.634690: hci_cmd_sync_submit <-hci_conn_complete_evt
kworker/u7:1-325 [000] ...1. 1620.634712: hci_sco_setup <-hci_conn_complete_evt
kworker/u7:1-325 [000] ...1. 1620.634713: hci_conn_check_pending <-hci_conn_complete_evt
kworker/u7:1-325 [000] ...1. 1620.634718: hci_cmd_sync_work <-process_one_work
kworker/u7:1-325 [000] ...1. 1620.634719: update_scan_sync <-hci_cmd_sync_work
kworker/u7:1-325 [000] ...1. 1620.634719: hci_update_scan_sync <-hci_cmd_sync_work
kworker/u7:1-325 [000] ...1. 1620.634720: mgmt_powering_down <-hci_update_scan_sync
kworker/u7:1-325 [000] ...1. 1620.634720: mgmt_pending_find <-mgmt_powering_down
kworker/u7:1-325 [000] ...1. 1620.634721: __hci_cmd_sync_sk <-hci_update_scan_sync
kworker/u7:1-325 [000] ...1. 1620.634721: hci_req_init <-__hci_cmd_sync_sk
kworker/u7:0-323 [001] ...1. 1620.634835: hci_cmd_work <-process_one_work
kworker/u7:0-323 [001] ...1. 1620.634846: hci_req_status_pend <-hci_cmd_work
kworker/u7:0-323 [001] ...1. 1620.634846: hci_send_frame <-hci_cmd_work
kworker/u7:0-323 [001] ...1. 1620.634847: hci_send_to_monitor <-hci_send_frame
kworker/1:2-300 [001] ...1. 1620.636210: hci_recv_frame <-h4_recv_buf
kworker/u7:2-368 [001] ...1. 1620.636217: hci_rx_work <-process_one_work
kworker/u7:2-368 [001] ...1. 1620.636217: hci_send_to_monitor <-hci_rx_work
kworker/u7:2-368 [001] ...1. 1620.636218: hci_event_packet <-hci_rx_work
kworker/1:2-300 [001] ...1. 1620.653213: hci_recv_frame <-h4_recv_buf
kworker/u7:2-368 [001] ...1. 1620.653228: hci_rx_work <-process_one_work
kworker/u7:2-368 [001] ...1. 1620.653229: hci_send_to_monitor <-hci_rx_work
kworker/u7:2-368 [001] ...1. 1620.653231: hci_conn_enter_active_mode <-hci_rx_work
kworker/u7:2-368 [001] ...1. 1620.653232: l2cap_recv_acldata <-hci_rx_work
kworker/u7:2-368 [001] ...1. 1620.653233: l2cap_recv_frame <-hci_rx_work
kworker/1:2-300 [001] ...1. 1620.653755: hci_recv_frame <-h4_recv_buf
kworker/u7:2-368 [001] ...1. 1620.653765: hci_rx_work <-process_one_work
kworker/u7:2-368 [001] ...1. 1620.653766: hci_send_to_monitor <-hci_rx_work
kworker/u7:2-368 [001] ...1. 1620.653767: hci_event_packet <-hci_rx_work
kworker/u7:2-368 [001] ...1. 1620.653800: hci_cmd_status_evt <-hci_event_packet
kworker/u7:2-368 [001] ...1. 1620.653801: hci_cs_read_remote_features <-hci_cmd_status_evt
kworker/u7:2-368 [001] ...1. 1620.653803: hci_req_cmd_complete <-hci_cmd_status_evt
kworker/u7:2-368 [001] ...1. 1620.653820: hci_cmd_work <-process_one_work
kworker/u7:2-368 [001] ...1. 1620.653839: hci_req_status_pend <-hci_cmd_work
kworker/u7:2-368 [001] ...1. 1620.653839: hci_send_frame <-hci_cmd_work
kworker/u7:2-368 [001] ...1. 1620.653840: hci_send_to_monitor <-hci_send_frame
kworker/1:2-300 [001] ...1. 1620.655241: hci_recv_frame <-h4_recv_buf
kworker/u7:2-368 [001] ...1. 1620.655252: hci_rx_work <-process_one_work
kworker/u7:2-368 [001] ...1. 1620.655253: hci_send_to_monitor <-hci_rx_work
kworker/u7:2-368 [001] ...1. 1620.655254: hci_event_packet <-hci_rx_work
kworker/u7:2-368 [001] ...1. 1620.655276: hci_remote_features_evt <-hci_event_packet
kworker/u7:2-368 [001] ...1. 1620.655277: hci_send_cmd <-hci_remote_features_evt
kworker/u7:2-368 [001] ...1. 1620.655277: hci_prepare_cmd <-hci_send_cmd
kworker/u7:2-368 [001] ...1. 1620.655314: hci_cmd_work <-process_one_work
kworker/1:0-369 [001] ...1. 1620.656244: hci_recv_frame <-h4_recv_buf
kworker/u7:2-368 [001] ...1. 1620.656255: hci_rx_work <-process_one_work
kworker/u7:2-368 [001] ...1. 1620.656256: hci_send_to_monitor <-hci_rx_work
kworker/u7:2-368 [001] ...1. 1620.656256: hci_event_packet <-hci_rx_work
kworker/u7:2-368 [001] ...1. 1620.656286: hci_cmd_complete_evt <-hci_event_packet
kworker/u7:2-368 [001] ...1. 1620.656287: hci_cc_write_scan_enable <-hci_cmd_complete_evt
kworker/u7:2-368 [001] ...1. 1620.656287: hci_sent_cmd_data <-hci_cc_write_scan_enable
kworker/u7:2-368 [001] ...1. 1620.656289: hci_req_cmd_complete <-hci_cmd_complete_evt
kworker/u7:2-368 [001] ...1. 1620.656293: hci_cmd_sync_complete <-hci_event_packet
kworker/u7:2-368 [001] ...1. 1620.656309: hci_cmd_work <-process_one_work
kworker/u7:1-325 [000] ...1. 1620.656313: bt_to_errno <-__hci_cmd_sync_sk
kworker/u7:2-368 [001] ...1. 1620.656322: hci_req_status_pend <-hci_cmd_work
kworker/u7:2-368 [001] ...1. 1620.656322: hci_send_frame <-hci_cmd_work
kworker/u7:2-368 [001] ...1. 1620.656323: hci_send_to_monitor <-hci_send_frame
kworker/1:2-300 [001] ...1. 1620.657024: hci_recv_frame <-h4_recv_buf
kworker/u7:1-325 [000] ...1. 1620.657053: hci_rx_work <-process_one_work
kworker/u7:1-325 [000] ...1. 1620.657054: hci_send_to_monitor <-hci_rx_work
kworker/u7:1-325 [000] ...1. 1620.657055: hci_event_packet <-hci_rx_work
kworker/u7:1-325 [000] ...1. 1620.657089: hci_cmd_complete_evt <-hci_event_packet
kworker/u7:1-325 [000] ...1. 1620.657090: hci_cc_write_scan_enable <-hci_cmd_complete_evt
kworker/u7:1-325 [000] ...1. 1620.657090: hci_sent_cmd_data <-hci_cc_write_scan_enable
kworker/u7:1-325 [000] ...1. 1620.657092: hci_req_cmd_complete <-hci_cmd_complete_evt
kworker/1:2-300 [001] ...1. 1620.706250: hci_recv_frame <-h4_recv_buf
kworker/u7:1-325 [000] ...1. 1620.706310: hci_rx_work <-process_one_work
kworker/u7:1-325 [000] ...1. 1620.706312: hci_send_to_monitor <-hci_rx_work
kworker/u7:1-325 [000] ...1. 1620.706313: hci_event_packet <-hci_rx_work
kworker/u7:1-325 [000] ...1. 1620.706358: hci_cmd_status_evt <-hci_event_packet
kworker/u7:1-325 [000] ...1. 1620.706359: hci_cs_read_remote_ext_features <-hci_cmd_status_evt
kworker/u7:1-325 [000] ...1. 1620.706360: hci_req_cmd_complete <-hci_cmd_status_evt
kworker/1:2-300 [001] ...1. 1620.708217: hci_recv_frame <-h4_recv_buf
kworker/u7:1-325 [000] ...1. 1620.708245: hci_rx_work <-process_one_work
kworker/u7:1-325 [000] ...1. 1620.708246: hci_send_to_monitor <-hci_rx_work
kworker/u7:1-325 [000] ...1. 1620.708247: hci_event_packet <-hci_rx_work
kworker/u7:1-325 [000] ...1. 1620.708276: hci_remote_ext_features_evt <-hci_event_packet
kworker/u7:1-325 [000] ...1. 1620.708277: hci_inquiry_cache_lookup <-hci_remote_ext_features_evt
kworker/u7:1-325 [000] ...1. 1620.708278: hci_send_cmd <-hci_remote_ext_features_evt
kworker/u7:1-325 [000] ...1. 1620.708278: hci_prepare_cmd <-hci_send_cmd
kworker/u7:1-325 [000] ...1. 1620.708317: hci_cmd_work <-process_one_work
kworker/u7:1-325 [000] ...1. 1620.708336: hci_req_status_pend <-hci_cmd_work
kworker/u7:1-325 [000] ...1. 1620.708337: hci_send_frame <-hci_cmd_work
kworker/u7:1-325 [000] ...1. 1620.708338: hci_send_to_monitor <-hci_send_frame
kworker/1:2-300 [001] .N.1. 1620.709223: hci_recv_frame <-h4_recv_buf
kworker/u7:1-325 [000] ...1. 1620.709616: hci_rx_work <-process_one_work
kworker/u7:1-325 [000] ...1. 1620.709617: hci_send_to_monitor <-hci_rx_work
kworker/u7:1-325 [000] ...1. 1620.709618: hci_event_packet <-hci_rx_work
kworker/u7:1-325 [000] ...1. 1620.709652: hci_cmd_status_evt <-hci_event_packet
kworker/u7:1-325 [000] ...1. 1620.709653: hci_cs_remote_name_req <-hci_cmd_status_evt
kworker/u7:1-325 [000] ...1. 1620.709654: hci_req_cmd_complete <-hci_cmd_status_evt
QServer-367 [000] ...1. 1628.631276: rfcomm_sock_release <-sock_close
QServer-367 [000] ...1. 1628.631279: rfcomm_sock_shutdown <-rfcomm_sock_release
QServer-367 [000] ...1. 1628.631280: __rfcomm_sock_close <-rfcomm_sock_shutdown
QServer-367 [000] ...1. 1628.631281: rfcomm_dlc_close <-__rfcomm_sock_close
QServer-367 [000] ...1. 1628.631282: __rfcomm_dlc_close <-rfcomm_dlc_close
QServer-367 [000] ...1. 1628.631283: rfcomm_sk_state_change <-__rfcomm_dlc_close
QServer-367 [000] ...1. 1628.631286: bt_sock_unlink <-rfcomm_sock_release
QServer-367 [000] ...1. 1628.631287: rfcomm_sock_destruct <-__sk_destruct
QServer-367 [000] ...1. 1628.631288: rfcomm_dlc_free <-__sk_destruct
python3-371 [000] ..s1. 1630.673178: rfcomm_session_timeout <-call_timer_fn
krfcommd-204 [001] ...1. 1630.673205: rfcomm_process_sessions <-rfcomm_run
krfcommd-204 [001] ...1. 1630.673209: l2cap_sock_sendmsg <-sock_sendmsg
bluetoothd-247 [001] ...1. 1630.736472: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736477: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736478: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736479: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736479: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736480: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736481: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736482: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736483: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736544: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736545: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736545: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736546: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736547: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736547: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736548: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736548: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736549: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736627: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736628: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736629: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736631: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736632: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736632: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736633: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736634: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.736634: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737399: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737401: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737402: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737402: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737403: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737404: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737404: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737405: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737405: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737447: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737448: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737449: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737450: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737450: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737451: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737451: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737452: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737452: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737726: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737728: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737729: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737731: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737731: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737732: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737733: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737733: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.737734: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738257: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738259: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738259: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738260: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738261: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738261: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738262: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738266: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738268: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738320: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738322: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738322: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738323: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738323: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738324: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738325: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738325: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738326: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738435: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738436: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738437: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738438: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738439: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738440: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738441: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738441: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738442: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738822: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738824: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738825: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738825: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738826: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738826: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738827: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738828: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738828: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738889: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738890: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738890: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738891: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738892: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738892: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738893: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738893: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.738894: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739019: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739021: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739022: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739023: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739024: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739024: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739025: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739026: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739026: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739832: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739834: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739835: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739835: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739836: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739837: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739837: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739837: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739838: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739882: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739883: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739884: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739884: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739885: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739885: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739886: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739886: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739887: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739925: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739926: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739927: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739929: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739929: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739930: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739931: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739931: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1630.739932: bt_sock_poll <-sock_poll
QServer-372 [001] ...1. 1633.669049: bt_sock_create <-__sock_create
QServer-372 [001] ...2. 1633.669052: rfcomm_sock_create <-bt_sock_create
QServer-372 [001] ...2. 1633.669053: bt_sock_alloc <-rfcomm_sock_create
QServer-372 [001] ...2. 1633.669092: rfcomm_dlc_alloc <-rfcomm_sock_create
QServer-372 [001] ...2. 1633.669106: bt_sock_link <-rfcomm_sock_create
QServer-372 [001] ...1. 1633.669215: rfcomm_sock_connect <-__sys_connect
QServer-372 [001] ...1. 1633.669216: rfcomm_dlc_open <-rfcomm_sock_connect
QServer-372 [001] ...1. 1633.669220: bt_sock_wait_state <-rfcomm_sock_connect
QServer-372 [001] ...1. 1641.670208: rfcomm_sock_release <-sock_close
QServer-372 [001] ...1. 1641.670211: rfcomm_sock_shutdown <-rfcomm_sock_release
QServer-372 [001] ...1. 1641.670212: __rfcomm_sock_close <-rfcomm_sock_shutdown
QServer-372 [001] ...1. 1641.670213: rfcomm_dlc_close <-__rfcomm_sock_close
QServer-372 [001] ...1. 1641.670214: __rfcomm_dlc_close <-rfcomm_dlc_close
QServer-372 [001] ...1. 1641.670215: __rfcomm_dlc_disconn <-rfcomm_dlc_close
QServer-372 [001] ...1. 1641.670218: l2cap_sock_sendmsg <-sock_sendmsg
QServer-372 [001] ...1. 1641.670220: bt_sock_unlink <-rfcomm_sock_release
QServer-372 [001] ...1. 1641.670221: rfcomm_sock_destruct <-__sk_destruct
bluetoothd-247 [001] ...1. 1643.756324: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756329: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756329: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756330: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756331: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756331: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756332: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756333: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756333: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756376: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756377: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756377: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756377: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756378: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756378: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756378: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756379: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756379: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756406: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756407: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756407: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756408: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756409: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756409: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756409: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756410: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756410: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756621: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756622: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756623: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756623: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756624: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756624: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756624: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756624: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756625: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756647: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756648: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756648: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756648: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756649: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756649: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756649: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756649: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756650: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756942: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756943: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756943: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756944: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756945: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756945: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756945: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756946: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.756946: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757089: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757091: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757091: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757091: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757091: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757092: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757092: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757092: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757093: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757115: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757115: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757116: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757116: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757116: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757117: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757117: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757117: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757117: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757520: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757521: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757521: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757522: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757522: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757523: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757523: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757523: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757524: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757795: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757796: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757796: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757797: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757797: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757797: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757798: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757798: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757798: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757821: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757821: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757821: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757822: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757822: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757822: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757823: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757823: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757823: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757847: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757847: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757848: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757849: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757849: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757850: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757850: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757850: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757850: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.757999: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758000: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758000: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758000: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758001: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758001: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758001: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758002: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758002: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758023: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758024: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758024: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758024: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758024: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758025: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758025: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758025: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758026: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758048: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758049: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758049: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758050: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758050: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758051: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758051: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758051: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758052: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758367: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758369: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758369: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758369: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758370: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758370: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758370: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758370: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758371: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758393: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758394: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758394: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758394: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758395: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758395: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758395: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758396: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758396: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758458: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758459: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758460: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758461: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758461: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758461: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758462: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758462: bt_sock_poll <-sock_poll
bluetoothd-247 [001] ...1. 1643.758462: bt_sock_poll <-sock_poll
QServer-375 [001] ...1. 1646.719414: bt_sock_create <-__sock_create
QServer-375 [001] ...2. 1646.719418: rfcomm_sock_create <-bt_sock_create
QServer-375 [001] ...2. 1646.719419: bt_sock_alloc <-rfcomm_sock_create
QServer-375 [001] ...2. 1646.719454: rfcomm_dlc_alloc <-rfcomm_sock_create
QServer-375 [001] ...2. 1646.719467: bt_sock_link <-rfcomm_sock_create
QServer-375 [001] ...1. 1646.719539: rfcomm_sock_connect <-__sys_connect
QServer-375 [001] ...1. 1646.719540: rfcomm_dlc_open <-rfcomm_sock_connect
QServer-375 [001] ...1. 1646.719544: rfcomm_sock_release <-sock_close
QServer-375 [001] ...1. 1646.719545: rfcomm_sock_shutdown <-rfcomm_sock_release
QServer-375 [001] ...1. 1646.719546: __rfcomm_sock_close <-rfcomm_sock_shutdown
QServer-375 [001] ...1. 1646.719546: rfcomm_dlc_close <-__rfcomm_sock_close
QServer-375 [001] ...1. 1646.719547: bt_sock_wait_state <-rfcomm_sock_shutdown
QServer-375 [001] ...1. 1654.718982: bt_sock_unlink <-rfcomm_sock_release
QServer-375 [001] ...1. 1654.718985: rfcomm_sock_destruct <-__sk_destruct
QServer-375 [001] ...1. 1654.718987: rfcomm_dlc_free <-__sk_destruct
<idle>-0 [001] ..s2. 1662.097189: rfcomm_dlc_timeout <-call_timer_fn
krfcommd-204 [001] ...1. 1662.097213: rfcomm_process_sessions <-rfcomm_run
krfcommd-204 [001] ...1. 1662.097216: __rfcomm_dlc_close <-rfcomm_process_sessions
krfcommd-204 [001] ...1. 1662.097217: rfcomm_sk_state_change <-__rfcomm_dlc_close
<idle>-0 [001] ..s2. 1664.145202: rfcomm_session_timeout <-call_timer_fn
krfcommd-204 [001] ...1. 1664.145232: rfcomm_process_sessions <-rfcomm_run
kworker/0:2-53 [000] ...1. 1664.145233: l2cap_chan_timeout <-process_one_work
kworker/0:2-53 [000] ...1. 1664.145236: l2cap_chan_close <-l2cap_chan_timeout
kworker/0:2-53 [000] ...1. 1664.145236: l2cap_chan_del <-l2cap_chan_close
krfcommd-204 [001] ...1. 1664.145237: l2cap_sock_sendmsg <-sock_sendmsg
kworker/0:2-53 [000] ...1. 1664.145238: l2cap_sock_teardown_cb <-l2cap_chan_del
kworker/0:2-53 [000] ...1. 1664.145239: rfcomm_l2state_change <-l2cap_sock_teardown_cb
kworker/0:2-53 [000] ...1. 1664.145250: l2cap_chan_put <-l2cap_chan_del
kworker/0:2-53 [000] ...1. 1664.145251: l2cap_sock_close_cb <-l2cap_chan_timeout
kworker/0:2-53 [000] ...1. 1664.145252: l2cap_chan_put <-l2cap_chan_timeout
krfcommd-204 [001] ...1. 1664.145277: rfcomm_process_sessions <-rfcomm_run
krfcommd-204 [001] ...1. 1664.145279: l2cap_sock_release <-sock_release
krfcommd-204 [001] ...1. 1664.145280: l2cap_sock_cleanup_listen <-l2cap_sock_release
krfcommd-204 [001] ...1. 1664.145281: bt_accept_dequeue <-l2cap_sock_cleanup_listen
krfcommd-204 [001] ...1. 1664.145281: bt_sock_unlink <-l2cap_sock_release
krfcommd-204 [001] ...1. 1664.145283: l2cap_sock_shutdown <-l2cap_sock_release
krfcommd-204 [001] ...1. 1664.145284: l2cap_chan_hold <-l2cap_sock_shutdown
krfcommd-204 [001] ...1. 1664.145285: l2cap_chan_close <-l2cap_sock_shutdown
krfcommd-204 [001] ...1. 1664.145285: l2cap_sock_teardown_cb <-l2cap_chan_close
krfcommd-204 [001] ...1. 1664.145286: l2cap_chan_put <-l2cap_sock_shutdown
krfcommd-204 [001] ...1. 1664.145287: l2cap_chan_hold <-l2cap_sock_release
krfcommd-204 [001] ...1. 1664.145288: l2cap_chan_put <-l2cap_sock_release
krfcommd-204 [001] ...1. 1664.145289: l2cap_sock_destruct <-__sk_destruct
krfcommd-204 [001] ...1. 1664.145289: l2cap_chan_put <-l2cap_sock_destruct
krfcommd-204 [001] ...1. 1664.145330: l2cap_chan_put <-l2cap_sock_release
root@hyx-QiTianM540-A739:/sys/kernel/debug/tracing#