gistfile1.txt

[00:00:00.000,000] <dbg> bt_hci_core: bt_hci_driver_register: Registered Controller
[00:00:00.000,122] <dbg> zmk: kscan_matrix_init_input_inst: Configured pin 0 on gpio@50000300 for input
[00:00:00.000,183] <dbg> zmk: kscan_matrix_init_input_inst: Configured pin 20 on gpio@50000000 for input
[00:00:00.000,213] <dbg> zmk: kscan_matrix_init_input_inst: Configured pin 17 on gpio@50000000 for input
[00:00:00.000,274] <dbg> zmk: kscan_matrix_init_input_inst: Configured pin 22 on gpio@50000000 for input
[00:00:00.000,305] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 3 on 74HC595 for output
[00:00:00.000,457] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 4 on 74HC595 for output
[00:00:00.000,396] <dbg> temp_nrf5: temp_nrf5_sample_fetch: sample: 90
[00:00:00.000,427] <dbg> temp_nrf5: temp_nrf5_channel_get: Temperature:22,500000
[00:00:00.000,488] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 5 on 74HC595 for output
[00:00:00.000,518] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 7 on 74HC595 for output
[00:00:00.000,579] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 15 on 74HC595 for output
[00:00:00.000,610] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 8 on 74HC595 for output
[00:00:00.000,640] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 9 on 74HC595 for output
[00:00:00.000,701] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 10 on 74HC595 for output
[00:00:00.000,732] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 11 on 74HC595 for output
[00:00:00.000,762] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 12 on 74HC595 for output
[00:00:00.000,823] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 13 on 74HC595 for output
[00:00:00.000,854] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 14 on 74HC595 for output
[00:00:00.000,885] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 6 on 74HC595 for output
[00:00:00.000,946] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 0 on 74HC595 for output
[00:00:00.000,976] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 1 on 74HC595 for output
[00:00:00.001,007] <dbg> zmk: kscan_matrix_init_output_inst: Configured pin 2 on 74HC595 for output
[00:00:00.003,845] <dbg> zmk: bvd_init: AIN2 setup returned 0
[00:00:00.003,875] <dbg> EC11: ec11_init: A: gpio@50000000 24 B: gpio@50000000 13 resolution 1
[00:00:00.003,936] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.003,936] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.003,936] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.003,967] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.003,967] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.003,997] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.003,997] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,028] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,028] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,058] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,058] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,089] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,089] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,119] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,119] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,119] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,150] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,150] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,180] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,180] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,211] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,211] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,241] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,241] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,272] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,272] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,272] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,302] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,302] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,333] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,333] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,364] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,364] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,394] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,394] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,425] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,425] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,455] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,455] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,486] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,486] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,516] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,516] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,516] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,547] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,547] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,577] <inf> usb_cdc_acm: USB device not ready, drop data
[00:00:00.004,577] <dbg> bt_settings: bt_settings_init: 
[00:00:00.011,413] <inf> fs_nvs: 8 Sectors of 4096 bytes
[00:00:00.011,444] <inf> fs_nvs: alloc wra: 0, f78
[00:00:00.011,444] <inf> fs_nvs: data wra: 0, 98
[00:00:00.011,505] <dbg> bt_hci_core: hci_tx_thread: Started
[00:00:00.011,535] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.011,535] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.011,749] <dbg> bt_ctlr_hci_driver: prio_recv_thread: sem take...
[00:00:00.011,779] <dbg> bt_ctlr_hci_driver: recv_thread: blocking
[00:00:00.011,810] <dbg> bt_ctlr_hci_driver: hci_driver_open: Success.
[00:00:00.011,810] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x0c03 param_len 0
[00:00:00.011,840] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.011,840] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x0c03 len 3
[00:00:00.011,871] <dbg> bt_hci_core: process_events: count 2
[00:00:00.011,901] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.011,901] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.011,932] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.011,932] <dbg> bt_hci_core: send_cmd: Sending command 0x0c03 (buf 0x2001a83c) to driver
[00:00:00.011,962] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 3 type 0
[00:00:00.011,962] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.012,329] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 6 bytes
[00:00:00.012,329] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x0c03
[00:00:00.012,359] <dbg> bt_hci_core: hci_cmd_done: opcode 0x0c03 status 0x00 buf 0x2001a83c
[00:00:00.012,390] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.012,390] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.012,420] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.012,420] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.012,451] <dbg> bt_ctlr_hci_driver: recv_thread: unblocked
[00:00:00.012,481] <dbg> bt_ctlr_hci_driver: recv_thread: blocking
[00:00:00.012,481] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x0c03 len 1
[00:00:00.012,512] <dbg> bt_hci_core: hci_reset_complete: status 0x00
[00:00:00.012,542] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x1003 param_len 0
[00:00:00.012,542] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.012,573] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x1003 len 3
[00:00:00.012,603] <dbg> bt_hci_core: process_events: count 2
[00:00:00.012,603] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.012,634] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.012,634] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.012,664] <dbg> bt_hci_core: send_cmd: Sending command 0x1003 (buf 0x2001a83c) to driver
[00:00:00.012,664] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 3 type 0
[00:00:00.012,695] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.012,695] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 14 bytes
[00:00:00.012,725] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x1003
[00:00:00.012,725] <dbg> bt_hci_core: hci_cmd_done: opcode 0x1003 status 0x00 buf 0x2001a83c
[00:00:00.012,756] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.012,786] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.012,786] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.012,817] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.012,847] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x1003 len 9
[00:00:00.012,847] <dbg> bt_hci_core: read_local_features_complete: status 0x00
[00:00:00.012,878] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x1001 param_len 0
[00:00:00.012,908] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.012,908] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x1001 len 3
[00:00:00.012,939] <dbg> bt_hci_core: process_events: count 2
[00:00:00.012,969] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.012,969] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.013,000] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.013,000] <dbg> bt_hci_core: send_cmd: Sending command 0x1001 (buf 0x2001a83c) to driver
[00:00:00.013,031] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 3 type 0
[00:00:00.013,031] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.013,061] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 14 bytes
[00:00:00.013,061] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x1001
[00:00:00.013,092] <dbg> bt_hci_core: hci_cmd_done: opcode 0x1001 status 0x00 buf 0x2001a83c
[00:00:00.013,122] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.013,122] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.013,153] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.013,153] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.013,183] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x1001 len 9
[00:00:00.013,214] <dbg> bt_hci_core: read_local_ver_complete: status 0x00
[00:00:00.013,214] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x1002 param_len 0
[00:00:00.013,244] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.013,275] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x1002 len 3
[00:00:00.013,275] <dbg> bt_hci_core: process_events: count 2
[00:00:00.013,305] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.013,305] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.013,336] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.013,336] <dbg> bt_hci_core: send_cmd: Sending command 0x1002 (buf 0x2001a83c) to driver
[00:00:00.013,366] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 3 type 0
[00:00:00.013,366] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.013,397] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 70 bytes
[00:00:00.013,427] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x1002
[00:00:00.013,427] <dbg> bt_hci_core: hci_cmd_done: opcode 0x1002 status 0x00 buf 0x2001a83c
[00:00:00.013,458] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.013,488] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.013,488] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.013,519] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.013,549] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x1002 len 65
[00:00:00.013,549] <dbg> bt_hci_core: read_supported_commands_complete: status 0x00
[00:00:00.013,580] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x2003 param_len 0
[00:00:00.013,610] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.013,610] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x2003 len 3
[00:00:00.013,641] <dbg> bt_hci_core: process_events: count 2
[00:00:00.013,671] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.013,671] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.013,702] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.013,702] <dbg> bt_hci_core: send_cmd: Sending command 0x2003 (buf 0x2001a83c) to driver
[00:00:00.013,732] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 3 type 0
[00:00:00.013,732] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.013,763] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 14 bytes
[00:00:00.013,793] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x2003
[00:00:00.013,793] <dbg> bt_hci_core: hci_cmd_done: opcode 0x2003 status 0x00 buf 0x2001a83c
[00:00:00.013,824] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.013,824] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.013,854] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.013,885] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.013,885] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x2003 len 9
[00:00:00.013,916] <dbg> bt_hci_core: read_le_features_complete: status 0x00
[00:00:00.013,946] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x2002 param_len 0
[00:00:00.013,946] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.013,977] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x2002 len 3
[00:00:00.014,007] <dbg> bt_hci_core: process_events: count 2
[00:00:00.014,007] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.014,038] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.014,038] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.014,068] <dbg> bt_hci_core: send_cmd: Sending command 0x2002 (buf 0x2001a83c) to driver
[00:00:00.014,068] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 3 type 0
[00:00:00.014,099] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.014,099] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 9 bytes
[00:00:00.014,129] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x2002
[00:00:00.014,129] <dbg> bt_hci_core: hci_cmd_done: opcode 0x2002 status 0x00 buf 0x2001a83c
[00:00:00.014,160] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.014,190] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.014,190] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.014,221] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.014,251] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x2002 len 4
[00:00:00.014,251] <dbg> bt_hci_core: le_read_buffer_size_complete: status 0x00
[00:00:00.014,282] <dbg> bt_hci_core: le_read_buffer_size_complete: ACL LE buffers: pkts 3 mtu 27
[00:00:00.014,312] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x201c param_len 0
[00:00:00.014,312] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.014,343] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x201c len 3
[00:00:00.014,373] <dbg> bt_hci_core: process_events: count 2
[00:00:00.014,373] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.014,404] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.014,404] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.014,434] <dbg> bt_hci_core: send_cmd: Sending command 0x201c (buf 0x2001a83c) to driver
[00:00:00.014,434] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 3 type 0
[00:00:00.014,465] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.014,465] <dbg> bt_ctlr_hci: le_read_supp_states: states: 0x000001c0ec30cc8f
[00:00:00.014,495] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 14 bytes
[00:00:00.014,495] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x201c
[00:00:00.014,526] <dbg> bt_hci_core: hci_cmd_done: opcode 0x201c status 0x00 buf 0x2001a83c
[00:00:00.014,556] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.014,556] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.014,587] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.014,587] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.014,617] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x201c len 9
[00:00:00.014,648] <dbg> bt_hci_core: le_read_supp_states_complete: status 0x00
[00:00:00.014,648] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x202f param_len 0
[00:00:00.014,678] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.014,709] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x202f len 3
[00:00:00.014,739] <dbg> bt_hci_core: process_events: count 2
[00:00:00.014,739] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.014,739] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.014,770] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.014,770] <dbg> bt_hci_core: send_cmd: Sending command 0x202f (buf 0x2001a83c) to driver
[00:00:00.014,801] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 3 type 0
[00:00:00.014,801] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.014,831] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 14 bytes
[00:00:00.014,862] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x202f
[00:00:00.014,862] <dbg> bt_hci_core: hci_cmd_done: opcode 0x202f status 0x00 buf 0x2001a83c
[00:00:00.014,892] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.014,892] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.014,923] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.014,953] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.014,984] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x202f len 9
[00:00:00.014,984] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x2024 param_len 4
[00:00:00.015,014] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.015,045] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x2024 len 7
[00:00:00.015,045] <dbg> bt_hci_core: process_events: count 2
[00:00:00.015,075] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.015,075] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.015,106] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.015,106] <dbg> bt_hci_core: send_cmd: Sending command 0x2024 (buf 0x2001a83c) to driver
[00:00:00.015,136] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 7 type 0
[00:00:00.015,136] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.015,167] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 6 bytes
[00:00:00.015,197] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x2024
[00:00:00.015,197] <dbg> bt_hci_core: hci_cmd_done: opcode 0x2024 status 0x00 buf 0x2001a83c
[00:00:00.015,228] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.015,228] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.015,258] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.015,289] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.015,319] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x2024 len 1
[00:00:00.015,319] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x2001 param_len 8
[00:00:00.015,350] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.015,350] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x2001 len 11
[00:00:00.015,380] <dbg> bt_hci_core: process_events: count 2
[00:00:00.015,411] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.015,411] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.015,441] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.015,441] <dbg> bt_hci_core: send_cmd: Sending command 0x2001 (buf 0x2001a83c) to driver
[00:00:00.015,472] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 11 type 0
[00:00:00.015,472] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.015,502] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 6 bytes
[00:00:00.015,533] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x2001
[00:00:00.015,533] <dbg> bt_hci_core: hci_cmd_done: opcode 0x2001 status 0x00 buf 0x2001a83c
[00:00:00.015,563] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.015,563] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.015,594] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.015,625] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.015,625] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x2001 len 1
[00:00:00.015,655] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x0c01 param_len 8
[00:00:00.015,686] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.015,686] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x0c01 len 11
[00:00:00.015,716] <dbg> bt_hci_core: process_events: count 2
[00:00:00.015,747] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.015,747] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.015,777] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.015,777] <dbg> bt_hci_core: send_cmd: Sending command 0x0c01 (buf 0x2001a83c) to driver
[00:00:00.015,808] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 11 type 0
[00:00:00.015,808] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.015,838] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 6 bytes
[00:00:00.015,838] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x0c01
[00:00:00.015,869] <dbg> bt_hci_core: hci_cmd_done: opcode 0x0c01 status 0x00 buf 0x2001a83c
[00:00:00.015,899] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.015,899] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.015,930] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.015,930] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.015,960] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x0c01 len 1
[00:00:00.015,991] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0xfc01 param_len 0
[00:00:00.016,021] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.016,021] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0xfc01 len 3
[00:00:00.016,052] <dbg> bt_hci_core: process_events: count 2
[00:00:00.016,082] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.016,082] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.016,113] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.016,113] <dbg> bt_hci_core: send_cmd: Sending command 0xfc01 (buf 0x2001a83c) to driver
[00:00:00.016,143] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 3 type 0
[00:00:00.016,143] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.016,174] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 18 bytes
[00:00:00.016,174] <dbg> bt_hci_core: hci_cmd_complete: opcode 0xfc01
[00:00:00.016,204] <dbg> bt_hci_core: hci_cmd_done: opcode 0xfc01 status 0x00 buf 0x2001a83c
[00:00:00.016,235] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.016,235] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.016,265] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.016,265] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.016,296] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0xfc01 len 13
[00:00:00.016,326] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0xfc02 param_len 0
[00:00:00.016,357] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.016,357] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0xfc02 len 3
[00:00:00.016,387] <dbg> bt_hci_core: process_events: count 2
[00:00:00.016,418] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.016,418] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.016,448] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.016,448] <dbg> bt_hci_core: send_cmd: Sending command 0xfc02 (buf 0x2001a83c) to driver
[00:00:00.016,479] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 3 type 0
[00:00:00.016,479] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.016,510] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 70 bytes
[00:00:00.016,540] <dbg> bt_hci_core: hci_cmd_complete: opcode 0xfc02
[00:00:00.016,540] <dbg> bt_hci_core: hci_cmd_done: opcode 0xfc02 status 0x00 buf 0x2001a83c
[00:00:00.016,571] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.016,571] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.016,601] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.016,601] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.016,632] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0xfc02 len 65
[00:00:00.016,662] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0xfc03 param_len 0
[00:00:00.016,693] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.016,693] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0xfc03 len 3
[00:00:00.016,723] <dbg> bt_hci_core: process_events: count 2
[00:00:00.016,754] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.016,754] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.016,784] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.016,784] <dbg> bt_hci_core: send_cmd: Sending command 0xfc03 (buf 0x2001a83c) to driver
[00:00:00.016,815] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 3 type 0
[00:00:00.016,815] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.016,845] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 14 bytes
[00:00:00.016,845] <dbg> bt_hci_core: hci_cmd_complete: opcode 0xfc03
[00:00:00.016,876] <dbg> bt_hci_core: hci_cmd_done: opcode 0xfc03 status 0x00 buf 0x2001a83c
[00:00:00.016,906] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.016,906] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.016,937] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.016,937] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.016,967] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0xfc03 len 9
[00:00:00.017,059] <dbg> bt_smp: bt_smp_init: LE SC enabled
[00:00:00.017,089] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x2025 param_len 0
[00:00:00.017,089] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.017,120] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x2025 len 3
[00:00:00.017,150] <dbg> bt_hci_core: process_events: count 2
[00:00:00.017,150] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.017,181] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.017,181] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.017,211] <dbg> bt_hci_core: send_cmd: Sending command 0x2025 (buf 0x2001a83c) to driver
[00:00:00.017,211] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 3 type 0
[00:00:00.017,242] <dbg> bt_hci_ecc: send_cmd_status: opcode 2025 status 0
[00:00:00.017,272] <dbg> bt_hci_core: hci_cmd_status: opcode 0x2025
[00:00:00.017,272] <dbg> bt_hci_core: hci_cmd_done: opcode 0x2025 status 0x00 buf 0x2001a83c
[00:00:00.017,303] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.017,333] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.017,333] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.017,364] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x2025 len 0
[00:00:00.017,395] <inf> bt_hci_core: No ID address. App must call settings_load()
[00:00:00.017,639] <dbg> zmk: ble_profiles_handle_set: Setting BLE value active_profile
[00:00:00.018,341] <dbg> bt_gatt: db_hash_set: Stored Hash: 
                                  34 83 59 c2 73 41 21 2c  87 17 c7 05 38 97 e4 14 |4.Y.sA!, ....8...
[00:00:00.018,371] <dbg> bt_settings: commit: 
[00:00:00.018,371] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x1009 param_len 0
[00:00:00.018,402] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.018,432] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x1009 len 3
[00:00:00.018,463] <dbg> bt_hci_core: process_events: count 2
[00:00:00.018,463] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.018,493] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.018,493] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.018,524] <dbg> bt_hci_core: send_cmd: Sending command 0x1009 (buf 0x2001a83c) to driver
[00:00:00.018,524] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 3 type 0
[00:00:00.018,554] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.018,554] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 12 bytes
[00:00:00.018,585] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x1009
[00:00:00.018,585] <dbg> bt_hci_core: hci_cmd_done: opcode 0x1009 status 0x00 buf 0x2001a83c
[00:00:00.018,615] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.018,646] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.018,646] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.018,676] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.018,707] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x1009 len 7
[00:00:00.018,707] <dbg> bt_id: bt_id_read_public_addr: Controller has no public address
[00:00:00.018,737] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0xfc09 param_len 0
[00:00:00.018,768] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.018,768] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0xfc09 len 3
[00:00:00.018,798] <dbg> bt_hci_core: process_events: count 2
[00:00:00.018,829] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.018,829] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.018,859] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.018,859] <dbg> bt_hci_core: send_cmd: Sending command 0xfc09 (buf 0x2001a83c) to driver
[00:00:00.018,890] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 3 type 0
[00:00:00.018,890] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.018,920] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 29 bytes
[00:00:00.018,920] <dbg> bt_hci_core: hci_cmd_complete: opcode 0xfc09
[00:00:00.018,951] <dbg> bt_hci_core: hci_cmd_done: opcode 0xfc09 status 0x00 buf 0x2001a83c
[00:00:00.018,981] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.018,981] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.019,012] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.019,012] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.019,042] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0xfc09 len 24
[00:00:00.019,104] <dbg> zmk: zmk_ble_ready: ready? 0
[00:00:00.019,134] <dbg> zmk: update_advertising: advertising from 0 to 2
[00:00:00.019,195] <dbg> bt_id: set_random_address: DA:56:80:C2:EA:CC
[00:00:00.019,226] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x2005 param_len 6
[00:00:00.019,226] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.019,256] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x2005 len 9
[00:00:00.019,287] <dbg> bt_hci_core: process_events: count 2
[00:00:00.019,287] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.019,317] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.019,317] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.019,348] <dbg> bt_hci_core: send_cmd: Sending command 0x2005 (buf 0x2001a83c) to driver
[00:00:00.019,348] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 9 type 0
[00:00:00.019,378] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.019,409] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 6 bytes
[00:00:00.019,409] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x2005
[00:00:00.019,439] <dbg> bt_hci_core: hci_cmd_done: opcode 0x2005 status 0x00 buf 0x2001a83c
[00:00:00.019,439] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.019,470] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.019,500] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.019,500] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.019,531] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x2005 len 1
[00:00:00.019,561] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x2006 param_len 15
[00:00:00.019,592] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.019,592] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x2006 len 18
[00:00:00.019,622] <dbg> bt_hci_core: process_events: count 2
[00:00:00.019,653] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.019,653] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.019,683] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.019,683] <dbg> bt_hci_core: send_cmd: Sending command 0x2006 (buf 0x2001a83c) to driver
[00:00:00.019,714] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 18 type 0
[00:00:00.019,714] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.019,744] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 6 bytes
[00:00:00.019,744] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x2006
[00:00:00.019,775] <dbg> bt_hci_core: hci_cmd_done: opcode 0x2006 status 0x00 buf 0x2001a83c
[00:00:00.019,805] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.019,805] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.019,836] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.019,836] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.019,866] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x2006 len 1
[00:00:00.019,897] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x2008 param_len 32
[00:00:00.019,927] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.019,958] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x2008 len 35
[00:00:00.019,958] <dbg> bt_hci_core: process_events: count 2
[00:00:00.019,989] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.019,989] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.020,019] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.020,019] <dbg> bt_hci_core: send_cmd: Sending command 0x2008 (buf 0x2001a83c) to driver
[00:00:00.020,050] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 35 type 0
[00:00:00.020,050] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.020,080] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 6 bytes
[00:00:00.020,111] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x2008
[00:00:00.020,111] <dbg> bt_hci_core: hci_cmd_done: opcode 0x2008 status 0x00 buf 0x2001a83c
[00:00:00.020,141] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.020,172] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.020,172] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.020,202] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.020,233] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x2008 len 1
[00:00:00.020,233] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x2009 param_len 32
[00:00:00.020,263] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.020,294] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x2009 len 35
[00:00:00.020,324] <dbg> bt_hci_core: process_events: count 2
[00:00:00.020,324] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.020,355] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.020,355] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.020,385] <dbg> bt_hci_core: send_cmd: Sending command 0x2009 (buf 0x2001a83c) to driver
[00:00:00.020,385] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 35 type 0
[00:00:00.020,385] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.020,416] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 6 bytes
[00:00:00.020,446] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x2009
[00:00:00.020,446] <dbg> bt_hci_core: hci_cmd_done: opcode 0x2009 status 0x00 buf 0x2001a83c
[00:00:00.020,477] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.020,507] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.020,507] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.020,538] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.020,568] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x2009 len 1
[00:00:00.020,629] <dbg> bt_conn: bt_conn_set_state: disconnected -> connecting-adv
[00:00:00.020,660] <dbg> bt_conn: bt_conn_ref: handle 0 ref 1 -> 2
[00:00:00.020,660] <dbg> bt_hci_core: bt_hci_cmd_create: opcode 0x200a param_len 1
[00:00:00.020,690] <dbg> bt_hci_core: bt_hci_cmd_create: buf 0x2001a83c
[00:00:00.020,690] <dbg> bt_hci_core: bt_hci_cmd_send_sync: buf 0x2001a83c opcode 0x200a len 4
[00:00:00.020,721] <dbg> bt_hci_core: process_events: count 2
[00:00:00.020,751] <dbg> bt_hci_core: process_events: ev->state 4
[00:00:00.020,751] <dbg> bt_hci_core: send_cmd: calling net_buf_get
[00:00:00.020,782] <dbg> bt_hci_core: send_cmd: calling sem_take_wait
[00:00:00.020,782] <dbg> bt_hci_core: send_cmd: Sending command 0x200a (buf 0x2001a83c) to driver
[00:00:00.020,812] <dbg> bt_hci_core: bt_send: buf 0x2001a83c len 4 type 0
[00:00:00.020,812] <dbg> bt_ctlr_hci_driver: hci_driver_send: enter
[00:00:00.020,904] <dbg> bt_ctlr_hci_driver: cmd_handle: Replying with event of 6 bytes
[00:00:00.020,935] <dbg> bt_hci_core: hci_cmd_complete: opcode 0x200a
[00:00:00.020,935] <dbg> bt_hci_core: hci_cmd_done: opcode 0x200a status 0x00 buf 0x2001a83c
[00:00:00.020,965] <dbg> bt_ctlr_hci_driver: hci_driver_send: exit: 0
[00:00:00.021,118] <dbg> bt_hci_core: process_events: ev->state 0
[00:00:00.021,148] <dbg> bt_conn: bt_conn_prepare_events: 
[00:00:00.021,148] <dbg> bt_hci_core: hci_tx_thread: Calling k_poll with 2 events
[00:00:00.021,179] <dbg> bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2001a83c opcode 0x200a len 1
[00:00:00.021,209] <dbg> bt_conn: bt_conn_unref: handle 0 ref 2 -> 1
[00:00:00.021,423] <dbg> zmk: zmk_sensors_init_item: Init sensor at index 0
[00:00:00.021,453] <dbg> EC11: setup_int: enabled false
[00:00:00.021,514] <dbg> bt_hci_ecc: emulate_le_p256_public_key_cmd: 
[00:00:00.022,369] <wrn> usb_hid: Device data not found for cfg 0x200014d8
[00:00:00.022,399] <dbg> zmk: zmk_usb_get_conn_state: state: 2
[00:00:00.022,430] <dbg> zmk: zmk_usb_get_conn_state: state: 2
[00:00:00.022,430] <dbg> zmk: get_selected_transport: No endpoint transports are ready.
[00:00:00.022,460] <dbg> zmk: zmk_endpoints_send_report: usage page 0x07
[00:00:00.022,491] <wrn> usb_hid: Device is not configured
[00:00:00.022,491] <err> zmk: FAILED TO SEND OVER USB: -11
[00:00:00.022,491] <dbg> zmk: zmk_endpoints_send_report: usage page 0x0C
[00:00:00.022,521] <wrn> usb_hid: Device is not configured
[00:00:00.022,552] <err> zmk: FAILED TO SEND OVER USB: -11
[00:00:00.022,583] <inf> zmk: Endpoint changed: BLE:1
[00:00:00.025,482] <inf> usb_cdc_acm: Device suspended
[00:00:00.025,482] <wrn> usb_hid: Device data not found for cfg 0x200014d8
[00:00:00.025,543] <dbg> zmk: zmk_usb_get_conn_state: state: 5
[00:00:00.025,573] <dbg> zmk: zmk_usb_get_conn_state: state: 5
[00:00:00.025,573] <dbg> zmk: get_selected_transport: Only USB is ready.
[00:00:00.025,604] <dbg> zmk: zmk_endpoints_send_report: usage page 0x07
[00:00:00.025,634] <dbg> zmk: zmk_endpoints_send_report: usage page 0x0C
[00:00:00.025,665] <inf> zmk: Endpoint changed: USB
[00:00:00.025,756] <dbg> zmk: destination_connection: Address pointer 0x2000e045
[00:00:00.025,756] <wrn> zmk: Not sending, no active address for current profile
[00:00:00.025,787] <dbg> zmk: destination_connection: Address pointer 0x2000e045
[00:00:00.025,787] <wrn> zmk: Not sending, no active address for current profile
[00:00:00.026,580] <dbg> EC11: setup_int: enabled true
[00:00:00.026,977] <dbg> zmk: endpoints_handle_set: Setting endpoint value preferred
[00:00:00.027,069] <dbg> zmk: zmk_usb_get_conn_state: state: 5
[00:00:00.027,069] <dbg> zmk: get_selected_transport: Only USB is ready.
[00:00:00.027,221] <dbg> zmk: zmk_usb_get_conn_state: state: 5
[00:00:00.027,221] <dbg> zmk: get_selected_transport: Only USB is ready.
[00:00:00.027,282] <inf> zmk: Welcome to ZMK!

[00:00:00.094,085] <dbg> EC11: ec11_b_gpio_callback: 
[00:00:00.094,116] <dbg> EC11: setup_int: enabled false
[00:00:00.094,146] <dbg> EC11: ec11_a_gpio_callback: 
[00:00:00.094,177] <dbg> EC11: setup_int: enabled false
[00:00:00.094,207] <dbg> EC11: ec11_work_cb: 
[00:00:00.094,238] <dbg> EC11: ec11_sample_fetch: prev: 3, new: 0
[00:00:00.094,238] <dbg> EC11: ec11_sample_fetch: Delta: 0
[00:00:00.094,329] <dbg> zmk: zmk_keymap_sensor_event: layer: 0 sensor_index: 0, binding name: ENC_KEY_PRESS
[00:00:00.094,390] <dbg> zmk: zmk_behavior_sensor_rotate_common_accept_data: val1: 0, val2: 0, remainder: 0/0 triggers: 0 inc keycode 0xC00E9 dec keycode 0xC00EA
[00:00:00.094,451] <dbg> EC11: setup_int: enabled true
[00:00:00.096,343] <dbg> EC11: ec11_a_gpio_callback: 
[00:00:00.096,405] <dbg> EC11: setup_int: enabled false
[00:00:00.096,435] <dbg> EC11: ec11_work_cb: 
[00:00:00.096,435] <dbg> EC11: ec11_sample_fetch: prev: 0, new: 2
[00:00:00.096,466] <dbg> EC11: ec11_sample_fetch: Delta: -1
[00:00:00.096,527] <dbg> zmk: zmk_keymap_sensor_event: layer: 0 sensor_index: 0, binding name: ENC_KEY_PRESS
[00:00:00.096,588] <dbg> zmk: zmk_behavior_sensor_rotate_common_accept_data: val1: -18, val2: 0, remainder: 0/0 triggers: -1 inc keycode 0xC00E9 dec keycode 0xC00EA
[00:00:00.096,649] <dbg> zmk: zmk_behavior_sensor_rotate_common_process: Sensor binding: ENC_KEY_PRESS
[00:00:00.096,679] <dbg> zmk: behavior_queue_process_next: Invoking KEY_PRESS: 0xc00ea 0x00
[00:00:00.096,710] <dbg> zmk: on_keymap_binding_pressed: position 0 keycode 0xC00EA
[00:00:00.096,740] <dbg> zmk: hid_listener_keycode_pressed: usage_page 0x0C keycode 0xEA implicit_mods 0x00 explicit_mods 0x00
[00:00:00.096,771] <dbg> zmk: zmk_hid_implicit_modifiers_press: Modifiers set to 0x00
[00:00:00.096,771] <dbg> zmk: zmk_endpoints_send_report: usage page 0x0C
[00:00:00.096,801] <err> zmk: FAILED TO SEND OVER USB: -13
[00:00:00.096,832] <dbg> zmk: behavior_queue_process_next: Processing next queued behavior in 5ms
[00:00:00.096,862] <dbg> zmk: zmk_keymap_sensor_event: sensor event processing complete, behavior response was opaque
[00:00:00.096,893] <dbg> EC11: setup_int: enabled true
[00:00:00.102,416] <dbg> zmk: behavior_queue_process_next: Invoking KEY_PRESS: 0xc00ea 0x00
[00:00:00.102,447] <dbg> zmk: on_keymap_binding_released: position 0 keycode 0xC00EA
[00:00:00.102,478] <dbg> zmk: hid_listener_keycode_released: usage_page 0x0C keycode 0xEA implicit_mods 0x00 explicit_mods 0x00
[00:00:00.102,478] <dbg> zmk: zmk_hid_implicit_modifiers_release: Modifiers set to 0x00
[00:00:00.102,508] <dbg> zmk: zmk_endpoints_send_report: usage page 0x0C
[00:00:00.102,508] <err> zmk: FAILED TO SEND OVER USB: -13
[00:00:00.102,539] <dbg> zmk: behavior_queue_process_next: Processing next queued behavior in 0ms
[00:00:00.365,325] <dbg> bt_hci_core: bt_recv: buf 0x2001a64c len 68
[00:00:00.365,325] <dbg> bt_hci_core: hci_event: event 0x3e
[00:00:00.365,356] <dbg> bt_hci_core: hci_le_meta_event: subevent 0x08
[00:00:00.365,356] <dbg> bt_ecc: bt_hci_evt_le_pkey_complete: status: 0x00
[00:00:00.365,386] <dbg> bt_smp: bt_smp_pkey_ready: 
[00:00:00.365,417] <dbg> zmk: bvd_sample_fetch: ADC raw 3472 ~ 3051 mV => 4280 mV
[00:00:00.365,447] <dbg> zmk: bvd_sample_fetch: Percent: 100
[00:00:00.365,447] <dbg> zmk: zmk_battery_update: Setting BAS GATT battery level to 100.
[00:00:00.365,753] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 2
[00:00:00.365,783] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.366,058] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.366,302] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.366,333] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 2
[00:00:00.366,333] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.366,607] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.366,851] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.366,882] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 2
[00:00:00.367,248] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.367,614] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 2
[00:00:00.367,645] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.368,072] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.368,103] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.368,469] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 2
[00:00:00.368,560] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.368,957] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.368,988] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.369,415] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.369,781] <dbg> bt_gatt: bt_gatt_attr_read: handle 0x0000 offset 0 length 5
[00:00:00.370,239] <dbg> bt_gatt: db_hash_gen: Hash: 
                                  34 83 59 c2 73 41 21 2c  87 17 c7 05 38 97 e4 14 |4.Y.sA!, ....8...
[00:00:00.370,239] <dbg> bt_gatt: db_hash_process: Database Hash matches
[00:00:01.199,737] <inf> usb_hid: Device reset detected
[00:00:01.199,768] <inf> usb_cdc_acm: Device resumed
[00:00:01.199,768] <inf> usb_hid: Device resumed
[00:00:01.202,880] <dbg> zmk: zmk_usb_get_conn_state: state: 6
[00:00:01.202,911] <dbg> zmk: zmk_usb_get_conn_state: state: 6
[00:00:01.202,941] <dbg> zmk: get_selected_transport: Only USB is ready.
[00:00:01.339,752] <inf> usb_cdc_acm: Device configured
[00:00:01.339,782] <inf> usb_hid: Device configured
[00:00:01.342,895] <dbg> zmk: zmk_usb_get_conn_state: state: 3
[00:00:01.342,956] <dbg> zmk: zmk_usb_get_conn_state: state: 3
[00:00:01.342,956] <dbg> zmk: get_selected_transport: Only USB is ready.
[00:00:04.033,508] <dbg> temp_nrf5: temp_nrf5_sample_fetch: sample: 91
[00:00:04.033,538] <dbg> temp_nrf5: temp_nrf5_channel_get: Temperature:22,750000
[00:00:08.033,660] <dbg> temp_nrf5: temp_nrf5_sample_fetch: sample: 91
[00:00:08.033,691] <dbg> temp_nrf5: temp_nrf5_channel_get: Temperature:22,750000
[00:00:12.065,490] <dbg> temp_nrf5: temp_nrf5_sample_fetch: sample: 91
[00:00:12.065,490] <dbg> temp_nrf5: temp_nrf5_channel_get: Temperature:22,750000
[00:00:16.065,612] <dbg> temp_nrf5: temp_nrf5_sample_fetch: sample: 91
[00:00:16.065,612] <dbg> temp_nrf5: temp_nrf5_channel_get: Temperature:22,750000
[00:00:20.102,905] <dbg> temp_nrf5: temp_nrf5_sample_fetch: sample: 91
[00:00:20.102,935] <dbg> temp_nrf5: temp_nrf5_channel_get: Temperature:22,750000
[00:00:24.103,088] <dbg> temp_nrf5: temp_nrf5_sample_fetch: sample: 91
[00:00:24.103,088] <dbg> temp_nrf5: temp_nrf5_channel_get: Temperature:22,750000
[00:00:28.134,887] <dbg> temp_nrf5: temp_nrf5_sample_fetch: sample: 91
[00:00:28.134,918] <dbg> temp_nrf5: temp_nrf5_channel_get: Temperature:22,750000
[00:00:32.135,070] <dbg> temp_nrf5: temp_nrf5_sample_fetch: sample: 91
[00:00:32.135,070] <dbg> temp_nrf5: temp_nrf5_channel_get: Temperature:22,750000
[00:00:36.166,900] <dbg> temp_nrf5: temp_nrf5_sample_fetch: sample: 91
[00:00:36.166,931] <dbg> temp_nrf5: temp_nrf5_channel_get: Temperature:22,750000
[00:00:40.167,083] <dbg> temp_nrf5: temp_nrf5_sample_fetch: sample: 91
[00:00:40.167,114] <dbg> temp_nrf5: temp_nrf5_channel_get: Temperature:22,750000
[00:00:44.202,911] <dbg> temp_nrf5: temp_nrf5_sample_fetch: sample: 91
[00:00:44.202,941] <dbg> temp_nrf5: temp_nrf5_channel_get: Temperature:22,750000