*** Booting Zephyr OS build v3.2.99-ncs1-rc1 *** GW [00:00:00.252,014] nrf5340_audio_dk_nrf5340_cpuapp: core_config: Setting gpiote latency to low power GW [00:00:00.252,075] nrf5340_audio_dk_nrf5340_cpuapp: remoteproc_mgr_boot: Network MCU released. GW [00:00:00.252,136] bt_hci_core: bt_hci_driver_register: Registered RPMsg GW [00:00:00.256,530] main: main: nRF5340 APP core started GW [00:00:00.257,110] fw_info: nRF5340 Audio nRF5340 Audio DK cpuapp NCS base version: 2.2.0-rc1 Cmake run : Mon Dec 12 19:00:40 2022 GW [00:00:00.257,110] fw_info: ------- DEBUG BUILD ------- GW [00:00:00.257,110] fw_info: Compiled for GATEWAY device GW [00:00:00.267,730] board_version: Compatible board/HW version found: 1.0.0 GW [00:00:02.302,490] bt_hci_core: hci_tx_thread: Started GW [00:00:02.302,520] bt_conn: bt_conn_prepare_events: GW [00:00:02.302,520] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.302,673] bt_hci_driver: bt_rpmsg_open: GW [00:00:02.303,344] bt_hci_core: bt_hci_cmd_create: opcode 0x0c03 param_len 0 GW [00:00:02.303,375] bt_hci_core: bt_hci_cmd_create: buf 0x2002d804 GW [00:00:02.303,375] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d804 opcode 0x0c03 len 3 GW [00:00:02.303,405] bt_hci_core: process_events: count 2 GW [00:00:02.303,405] bt_hci_core: process_events: ev->state 4 GW [00:00:02.303,405] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.303,436] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.303,466] bt_hci_core: send_cmd: Sending command 0x0c03 (buf 0x2002d804) to driver GW [00:00:02.303,466] bt_hci_core: bt_send: buf 0x2002d804 len 3 type 0 GW [00:00:02.303,466] bt_hci_driver: bt_rpmsg_send: buf 0x2002d804 type 0 len 3 GW [00:00:02.303,497] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 03 0c 00 |.... GW [00:00:02.303,52GW [00:00:02.303,527] bt_conn: bt_conn_prepare_events: GW [00:00:02.303,527] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.303,558] bt_hci_core: bt_hci_cmd_create: opcode 0xfc01 param_len 4 GW [00:00:02.303,558] bt_hci_core: bt_hci_cmd_create: buf 0x2002d820 GW [00:00:02.303,588] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d820 opcode 0xfc01 len 7 GW [00:00:02.303,588] bt_hci_core: process_events: count 2 GW [00:00:02.303,619] bt_hci_core: process_events: ev->state 4 GW [00:00:02.303,619] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.303,619] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.306,488] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 04 01 03 0c 00 |....... GW [00:00:02.306,518] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.306,518] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d804) GW [00:00:02.306,518] bt_hci_core: bt_recv: buf 0x2002d804 len 6 GW [00:00:02.306,518] bt_hci_core: hci_cmd_complete: opcode 0x0c03 GW [00:00:02.306,518] bt_hci_core: hci_cmd_done: opcode 0x0c03 status 0x00 buf 0x2002d804 GW [00:00:02.306,549] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d804 opcode 0x0c03 len 1 GW [00:00:02.306,549] bt_hci_core: hci_reset_complete: status 0x00 GW [00:00:02.306,579] bt_hci_core: bt_hci_cmd_create: opcode 0x1003 param_len 0 GW [00:00:02.306,579] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.306,579] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x1003 len 3 GW [00:00:02.306,610] bt_hci_core: send_cmd: Sending command 0xfc01 (buf 0x2002d820) to driver GW [00:00:02.306,610] bt_hci_core: bt_send: buf 0x2002d820 len 7 type 0 GW [00:00:02.306,610] bt_hci_driver: bt_rpmsg_send: buf 0x2002d820 type 0 len 7 GW [00:00:02.306,640] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 01 fc 04 10 01 1d 00 |........ GW [00:00:02.306,671] bt_hci_core: process_events: ev->state 0 GW [00:00:02.306,671] bt_conn: bt_conn_prepare_events: GW [00:00:02.306,671] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.306,701] bt_hci_core: process_events: count 2 GW [00:00:02.306,701] bt_hci_core: process_events: ev->state 4 GW [00:00:02.306,701] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.306,701] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.306,732] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 |. GW [00:00:02.306,854] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 04 01 01 fc 00 |....... GW [00:00:02.306,854] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.306,854] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d820) GW [00:00:02.306,854] bt_hci_core: bt_recv: buf 0x2002d820 len 6 GW [00:00:02.306,854] bt_hci_core: hci_cmd_complete: opcode 0xfc01 GW [00:00:02.306,884] bt_hci_core: hci_cmd_done: opcode 0xfc01 status 0x00 buf 0x2002d820 GW [00:00:02.306,884] bt_hci_core: send_cmd: Sending command 0x1003 (buf 0x2002d83c) to driver GW [00:00:02.306,915] bt_hci_core: bt_send: buf 0x2002d83c len 3 type 0 GW [00:00:02.306,915] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 3 GW [00:00:02.306,915] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 03 10 00 |.... GW [00:00:02.306,945] bt_hci_core: process_events: ev->state 0 GW [00:00:02.306,976] bt_conn: bt_conn_prepare_events: GW [00:00:02.306,976] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.307,006] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 |. GW [00:00:02.307,067] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 0c 01 03 10 00 00 00 00 00 60 00 00 00 |........ ...`... GW [00:00:02.307,067] bt_hci_driver: bt_rpmsg_evt_recv: len 12 GW [00:00:02.307,067] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.307,067] bt_hci_core: bt_recv: buf 0x2002d83c len 14 GW [00:00:02.307,098] bt_hci_core: hci_cmd_complete: opcode 0x1003 GW [00:00:02.307,098] bt_hci_core: hci_cmd_done: opcode 0x1003 status 0x00 buf 0x2002d83c GW [00:00:02.307,128] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x1003 len 9 GW [00:00:02.307,128] bt_hci_core: read_local_features_complete: status 0x00 GW [00:00:02.307,128] bt_hci_core: bt_hci_cmd_create: opcode 0x1001 param_len 0 GW [00:00:02.307,128] bt_hci_core: bt_hci_cmd_create: buf 0x2002d804 GW [00:00:02.307,128] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d804 opcode 0x1001 len 3 GW [00:00:02.307,159] bt_hci_core: process_events: count 2 GW [00:00:02.307,189] bt_hci_core: process_events: ev->state 4 GW [00:00:02.307,189] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.307,189] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.307,220] bt_hci_core: send_cmd: Sending command 0x1001 (buf 0x2002d804) to driver GW [00:00:02.307,220] bt_hci_core: bt_send: buf 0x2002d804 len 3 type 0 GW [00:00:02.307,220] bt_hci_driver: bt_rpmsg_send: buf 0x2002d804 type 0 len 3 GW [00:00:02.307,250] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 01 10 00 |.... GW [00:00:02.307,250] bt_hci_core: process_events: ev->state 0 GW [00:00:02.307,281] bt_conn: bt_conn_prepare_events: GW [00:00:02.307,281] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.307,312] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 00 00 00 00 00 00 00 00 |........ . GW [00:00:02.307,373] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 0c 01 01 10 00 0b ee 0c 0b e8 07 ee 0c |........ ....... GW [00:00:02.307,373] bt_hci_driver: bt_rpmsg_evt_recv: len 12 GW [00:00:02.307,403] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d804) GW [00:00:02.307,403] bt_hci_core: bt_recv: buf 0x2002d804 len 14 GW [00:00:02.307,403] bt_hci_core: hci_cmd_complete: opcode 0x1001 GW [00:00:02.307,403] bt_hci_core: hci_cmd_done: opcode 0x1001 status 0x00 buf 0x2002d804 GW [00:00:02.307,434] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d804 opcode 0x1001 len 9 GW [00:00:02.307,434] bt_hci_core: read_local_ver_complete: status 0x00 GW [00:00:02.307,434] bt_hci_core: bt_hci_cmd_create: opcode 0x1002 param_len 0 GW [00:00:02.307,464] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.307,464] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x1002 len 3 GW [00:00:02.307,495] bt_hci_core: process_events: count 2 GW [00:00:02.307,495] bt_hci_core: process_events: ev->state 4 GW [00:00:02.307,495] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.307,495] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.307,525] bt_hci_core: send_cmd: Sending command 0x1002 (buf 0x2002d83c) to driver GW [00:00:02.307,525] bt_hci_core: bt_send: buf 0x2002d83c len 3 type 0 GW [00:00:02.307,556] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 3 GW [00:00:02.307,556] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 02 10 00 |.... GW [00:00:02.307,586] bt_hci_core: process_events: ev->state 0 GW [00:00:02.307,586] bt_conn: bt_conn_prepare_events: GW [00:00:02.307,586] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.307,647] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 00 00 00 00 00 00 00 00 |........ . GW [00:00:02.307,678] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d820 opcode 0xfc01 len 1 GW [00:00:02.307,678] bt_hci_core: bt_hci_cmd_create: opcode 0xfc01 param_len 4 GW [00:00:02.307,708] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 44 01 02 10 00 20 00 80 00 00 c0 00 0c 00 |..D.... ........ 00 04 00 00 00 28 22 00 00 00 00 00 00 04 00 00 |.....(". ........ f7 ff ff 7f 00 00 00 30 f0 ff ff ff ff ff 1f e0 |.......0 ........ f7 ff ff 07 01 00 00 00 00 00 00 00 00 00 00 00 |........ ........ 00 00 00 00 00 00 00 |....... GW [00:00:02.307,739] bt_hci_driver: bt_rpmsg_evt_recv: len 68 GW [00:00:02.307,739] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.307,739] bt_hci_core: bt_recv: buf 0x2002d83c len 70 GW [00:00:02.307,769] bt_hci_core: hci_cmd_complete: opcode 0x1002 GW [00:00:02.307,769] bt_hci_core: hci_cmd_done: opcode 0x1002 status 0x00 buf 0x2002d83c GW [00:00:02.307,769] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x1002 len 65 GW [00:00:02.307,800] bt_hci_core: read_supported_commands_complete: status 0x00 GW [00:00:02.307,800] bt_hci_core: bt_hci_cmd_create: opcode 0x2018 param_len 0 GW [00:00:02.307,800] bt_hci_core: bt_hci_cmd_create: buf 0x2002d804 GW [00:00:02.307,800] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d804 opcode 0x2018 len 3 GW [00:00:02.307,830] bt_hci_core: process_events: count 2 GW [00:00:02.307,830] bt_hci_core: process_events: ev->state 4 GW [00:00:02.307,861] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.307,861] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.307,891] bt_hci_core: send_cmd: Sending command 0x2018 (buf 0x2002d804) to driver GW [00:00:02.307,891] bt_hci_core: bt_send: buf 0x2002d804 len 3 type 0 GW [00:00:02.307,891] bt_hci_driver: bt_rpmsg_send: buf 0x2002d804 type 0 len 3 GW [00:00:02.307,922] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 18 20 00 |.. . GW [00:00:02.307,922] bt_hci_core: process_events: ev->state 0 GW [00:00:02.307,952] bt_conn: bt_conn_prepare_events: GW [00:00:02.307,952] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.307,983] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 |........ ........ 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 |........ ........ 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 |........ ........ 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 |........ ........ 00 |. GW [00:00:02.308,013] bt_hci_core: bt_hci_cmd_create: buf 0x2002d820 GW [00:00:02.308,013] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d820 opcode 0xfc01 len 7 GW [00:00:02.308,044] bt_hci_core: process_events: count 2 GW [00:00:02.308,044] bt_hci_core: process_events: ev->state 4 GW [00:00:02.308,044] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.308,074] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.308,410] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 0c 01 18 20 00 ed 7d 93 99 69 e3 bb e2 |..... .. }..i... GW [00:00:02.308,410] bt_hci_driver: bt_rpmsg_evt_recv: len 12 GW [00:00:02.308,410] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d804) GW [00:00:02.308,410] bt_hci_core: bt_recv: buf 0x2002d804 len 14 GW [00:00:02.308,441] bt_hci_core: hci_cmd_complete: opcode 0x2018 GW [00:00:02.308,441] bt_hci_core: hci_cmd_done: opcode 0x2018 status 0x00 buf 0x2002d804 GW [00:00:02.308,471] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d804 opcode 0x2018 len 9 GW [00:00:02.309,539] bt_hci_core: bt_hci_cmd_create: opcode 0x2018 param_len 0 GW [00:00:02.309,570] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.309,570] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x2018 len 3 GW [00:00:02.309,600] bt_hci_core: send_cmd: Sending command 0xfc01 (buf 0x2002d820) to driver GW [00:00:02.309,600] bt_hci_core: bt_send: buf 0x2002d820 len 7 type 0 GW [00:00:02.309,600] bt_hci_driver: bt_rpmsg_send: buf 0x2002d820 type 0 len 7 GW [00:00:02.309,631] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 01 fc 04 11 01 1c 00 |........ GW [00:00:02.309,661] bt_hci_core: process_events: ev->state 0 GW [00:00:02.309,661] bt_conn: bt_conn_prepare_events: GW [00:00:02.309,661] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.309,692] bt_hci_core: process_events: count 2 GW [00:00:02.309,692] bt_hci_core: process_events: ev->state 4 GW [00:00:02.309,692] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.309,692] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.309,722] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 00 00 00 00 00 00 00 00 |........ . GW [00:00:02.309,814] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 04 01 01 fc 00 |....... GW [00:00:02.309,814] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.309,814] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d820) GW [00:00:02.309,814] bt_hci_core: bt_recv: buf 0x2002d820 len 6 GW [00:00:02.309,814] bt_hci_core: hci_cmd_complete: opcode 0xfc01 GW [00:00:02.309,844] bt_hci_core: hci_cmd_done: opcode 0xfc01 status 0x00 buf 0x2002d820 GW [00:00:02.309,844] bt_hci_core: send_cmd: Sending command 0x2018 (buf 0x2002d83c) to driver GW [00:00:02.309,875] bt_hci_core: bt_send: buf 0x2002d83c len 3 type 0 GW [00:00:02.309,875] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 3 GW [00:00:02.309,875] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 18 20 00 |.. . GW [00:00:02.309,906] bt_hci_core: process_events: ev->state 0 GW [00:00:02.309,936] bt_conn: bt_conn_prepare_events: GW [00:00:02.309,936] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.309,967] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 |. GW [00:00:02.309,997] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d820 opcode 0xfc01 len 1 GW [00:00:02.310,363] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 0c 01 18 20 00 64 54 4c c4 0f 71 31 5a |..... .d TL..q1Z GW [00:00:02.310,394] bt_hci_driver: bt_rpmsg_evt_recv: len 12 GW [00:00:02.310,394] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.310,394] bt_hci_core: bt_recv: buf 0x2002d83c len 14 GW [00:00:02.310,394] bt_hci_core: hci_cmd_complete: opcode 0x2018 GW [00:00:02.310,424] bt_hci_core: hci_cmd_done: opcode 0x2018 status 0x00 buf 0x2002d83c GW [00:00:02.310,424] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x2018 len 9 GW [00:00:02.310,424] bt_hci_core: bt_hci_cmd_create: opcode 0x2018 param_len 0 GW [00:00:02.310,455] bt_hci_core: bt_hci_cmd_create: buf 0x2002d820 GW [00:00:02.310,455] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d820 opcode 0x2018 len 3 GW [00:00:02.310,485] bt_hci_core: process_events: count 2 GW [00:00:02.310,485] bt_hci_core: process_events: ev->state 4 GW [00:00:02.310,485] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.310,516] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.310,516] bt_hci_core: send_cmd: Sending command 0x2018 (buf 0x2002d820) to driver GW [00:00:02.310,546] bt_hci_core: bt_send: buf 0x2002d820 len 3 type 0 GW [00:00:02.310,546] bt_hci_driver: bt_rpmsg_send: buf 0x2002d820 type 0 len 3 GW [00:00:02.310,546] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 18 20 00 |.. . GW [00:00:02.310,577] bt_hci_core: process_events: ev->state 0 GW [00:00:02.310,577] bt_conn: bt_conn_prepare_events: GW [00:00:02.310,607] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.310,638] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 00 00 00 00 00 00 00 00 |........ . GW [00:00:02.311,035] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 0c 01 18 20 00 2f f4 c2 d7 ee 62 3d 14 |..... ./ ....b=. GW [00:00:02.311,065] bt_hci_driver: bt_rpmsg_evt_recv: len 12 GW [00:00:02.311,065] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d820) GW [00:00:02.311,065] bt_hci_core: bt_recv: buf 0x2002d820 len 14 GW [00:00:02.311,065] bt_hci_core: hci_cmd_complete: opcode 0x2018 GW [00:00:02.311,096] bt_hci_core: hci_cmd_done: opcode 0x2018 status 0x00 buf 0x2002d820 GW [00:00:02.311,096] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d820 opcode 0x2018 len 9 GW [00:00:02.311,096] bt_hci_core: bt_hci_cmd_create: opcode 0x2018 param_len 0 GW [00:00:02.311,126] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.311,126] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x2018 len 3 GW [00:00:02.311,157] bt_hci_core: process_events: count 2 GW [00:00:02.311,157] bt_hci_core: process_events: ev->state 4 GW [00:00:02.311,157] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.311,187] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.311,187] bt_hci_core: send_cmd: Sending command 0x2018 (buf 0x2002d83c) to driver GW [00:00:02.311,218] bt_hci_core: bt_send: buf 0x2002d83c len 3 type 0 GW [00:00:02.311,218] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 3 GW [00:00:02.311,218] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 18 20 00 |.. . GW [00:00:02.311,248] bt_hci_core: process_events: ev->state 0 GW [00:00:02.311,248] bt_conn: bt_conn_prepare_events: GW [00:00:02.311,279] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.311,309] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 00 00 00 00 00 00 00 00 |........ . GW [00:00:02.311,706] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 0c 01 18 20 00 1e c8 b8 d3 2a 70 2d 11 |..... .. ...*p-. GW [00:00:02.311,737] bt_hci_driver: bt_rpmsg_evt_recv: len 12 GW [00:00:02.311,737] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.311,737] bt_hci_core: bt_recv: buf 0x2002d83c len 14 GW [00:00:02.311,737] bt_hci_core: hci_cmd_complete: opcode 0x2018 GW [00:00:02.311,767] bt_hci_core: hci_cmd_done: opcode 0x2018 status 0x00 buf 0x2002d83c GW [00:00:02.311,767] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x2018 len 9 GW [00:00:02.311,767] bt_hci_core: bt_hci_cmd_create: opcode 0x2018 param_len 0 GW [00:00:02.311,798] bt_hci_core: bt_hci_cmd_create: buf 0x2002d820 GW [00:00:02.311,798] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d820 opcode 0x2018 len 3 GW [00:00:02.311,828] bt_hci_core: process_events: count 2 GW [00:00:02.311,828] bt_hci_core: process_events: ev->state 4 GW [00:00:02.311,828] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.311,859] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.311,859] bt_hci_core: send_cmd: Sending command 0x2018 (buf 0x2002d820) to driver GW [00:00:02.311,889] bt_hci_core: bt_send: buf 0x2002d820 len 3 type 0 GW [00:00:02.311,889] bt_hci_driver: bt_rpmsg_send: buf 0x2002d820 type 0 len 3 GW [00:00:02.311,889] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 18 20 00 |.. . GW [00:00:02.311,920] bt_hci_core: process_events: ev->state 0 GW [00:00:02.311,920] bt_conn: bt_conn_prepare_events: GW [00:00:02.311,950] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.311,981] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 00 00 00 00 00 00 00 00 |........ . GW [00:00:02.312,377] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 0c 01 18 20 00 22 3b 26 9a e3 5f 99 ca |..... ." ;&.._.. GW [00:00:02.312,408] bt_hci_driver: bt_rpmsg_evt_recv: len 12 GW [00:00:02.312,408] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d820) GW [00:00:02.312,408] bt_hci_core: bt_recv: buf 0x2002d820 len 14 GW [00:00:02.312,408] bt_hci_core: hci_cmd_complete: opcode 0x2018 GW [00:00:02.312,408] bt_hci_core: hci_cmd_done: opcode 0x2018 status 0x00 buf 0x2002d820 GW [00:00:02.312,438] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d820 opcode 0x2018 len 9 GW [00:00:02.313,629] bt_hci_core: bt_hci_cmd_create: opcode 0x2003 param_len 0 GW [00:00:02.313,659] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.313,659] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x2003 len 3 GW [00:00:02.313,690] bt_hci_core: process_events: count 2 GW [00:00:02.313,690] bt_hci_core: process_events: ev->state 4 GW [00:00:02.313,690] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.313,720] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.313,720] bt_hci_core: send_cmd: Sending command 0x2003 (buf 0x2002d83c) to driver GW [00:00:02.313,751] bt_hci_core: bt_send: buf 0x2002d83c len 3 type 0 GW [00:00:02.313,751] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 3 GW [00:00:02.313,751] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 03 20 00 |.. . GW [00:00:02.313,781] bt_hci_core: process_events: ev->state 0 GW [00:00:02.313,812] bt_conn: bt_conn_prepare_events: GW [00:00:02.313,812] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.313,842] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 00 00 00 00 00 00 00 00 |........ . GW [00:00:02.313,903] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 0c 01 03 20 00 ff 77 01 ff 00 00 00 00 |..... .. w...... GW [00:00:02.313,903] bt_hci_driver: bt_rpmsg_evt_recv: len 12 GW [00:00:02.313,903] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.313,934] bt_hci_core: bt_recv: buf 0x2002d83c len 14 GW [00:00:02.313,934] bt_hci_core: hci_cmd_complete: opcode 0x2003 GW [00:00:02.313,934] bt_hci_core: hci_cmd_done: opcode 0x2003 status 0x00 buf 0x2002d83c GW [00:00:02.313,964] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x2003 len 9 GW [00:00:02.313,964] bt_hci_core: read_le_features_complete: status 0x00 GW [00:00:02.313,964] bt_hci_core: bt_hci_cmd_create: opcode 0x2074 param_len 2 GW [00:00:02.313,964] bt_hci_core: bt_hci_cmd_create: buf 0x2002d820 GW [00:00:02.313,995] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d820 opcode 0x2074 len 5 GW [00:00:02.314,025] bt_hci_core: process_events: count 2 GW [00:00:02.314,025] bt_hci_core: process_events: ev->state 4 GW [00:00:02.314,025] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.314,025] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.314,056] bt_hci_core: send_cmd: Sending command 0x2074 (buf 0x2002d820) to driver GW [00:00:02.314,056] bt_hci_core: bt_send: buf 0x2002d820 len 5 type 0 GW [00:00:02.314,056] bt_hci_driver: bt_rpmsg_send: buf 0x2002d820 type 0 len 5 GW [00:00:02.314,086] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 74 20 02 20 01 |.t . . GW [00:00:02.314,117] bt_hci_core: process_events: ev->state 0 GW [00:00:02.314,117] bt_conn: bt_conn_prepare_events: GW [00:00:02.314,117] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.314,147] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 00 00 00 00 00 00 00 00 |........ . GW [00:00:02.314,208] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 04 01 74 20 00 |....t . GW [00:00:02.314,208] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.314,239] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d820) GW [00:00:02.314,239] bt_hci_core: bt_recv: buf 0x2002d820 len 6 GW [00:00:02.314,239] bt_hci_core: hci_cmd_complete: opcode 0x2074 GW [00:00:02.314,239] bt_hci_core: hci_cmd_done: opcode 0x2074 status 0x00 buf 0x2002d820 GW [00:00:02.314,270] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d820 opcode 0x2074 len 1 GW [00:00:02.314,270] bt_hci_core: bt_hci_cmd_create: opcode 0x2060 param_len 0 GW [00:00:02.314,300] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.314,300] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x2060 len 3 GW [00:00:02.314,331] bt_hci_core: process_events: count 2 GW [00:00:02.314,331] bt_hci_core: process_events: ev->state 4 GW [00:00:02.314,331] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.314,331] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.314,361] bt_hci_core: send_cmd: Sending command 0x2060 (buf 0x2002d83c) to driver GW [00:00:02.314,361] bt_hci_core: bt_send: buf 0x2002d83c len 3 type 0 GW [00:00:02.314,361] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 3 GW [00:00:02.314,392] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 60 20 00 |.` . GW [00:00:02.314,422] bt_hci_core: process_events: ev->state 0 GW [00:00:02.314,422] bt_conn: bt_conn_prepare_events: GW [00:00:02.314,422] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.314,453] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 |. GW [00:00:02.314,544] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 0a 01 60 20 00 00 01 04 00 01 06 |....` .. ..... GW [00:00:02.314,575] bt_hci_driver: bt_rpmsg_evt_recv: len 10 GW [00:00:02.314,575] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.314,575] bt_hci_core: bt_recv: buf 0x2002d83c len 12 GW [00:00:02.314,575] bt_hci_core: hci_cmd_complete: opcode 0x2060 GW [00:00:02.314,605] bt_hci_core: hci_cmd_done: opcode 0x2060 status 0x00 buf 0x2002d83c GW [00:00:02.314,605] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x2060 len 7 GW [00:00:02.314,605] bt_hci_core: read_buffer_size_v2_complete: status 0 GW [00:00:02.314,636] bt_hci_core: read_buffer_size_v2_complete: ISO buffers: pkts 6 mtu 256 GW [00:00:02.314,636] bt_hci_core: bt_hci_cmd_create: opcode 0x201c param_len 0 GW [00:00:02.314,636] bt_hci_core: bt_hci_cmd_create: buf 0x2002d820 GW [00:00:02.314,636] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d820 opcode 0x201c len 3 GW [00:00:02.314,666] bt_hci_core: process_events: count 2 GW [00:00:02.314,697] bt_hci_core: process_events: ev->state 4 GW [00:00:02.314,697] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.314,697] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.314,727] bt_hci_core: send_cmd: Sending command 0x201c (buf 0x2002d820) to driver GW [00:00:02.314,727] bt_hci_core: bt_send: buf 0x2002d820 len 3 type 0 GW [00:00:02.314,727] bt_hci_driver: bt_rpmsg_send: buf 0x2002d820 type 0 len 3 GW [00:00:02.314,758] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 1c 20 00 |.. . GW [00:00:02.314,758] bt_hci_core: process_events: ev->state 0 GW [00:00:02.314,788] bt_conn: bt_conn_prepare_events: GW [00:00:02.314,788] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.314,819] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 00 00 00 00 00 00 |....... GW [00:00:02.314,880] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 0c 01 1c 20 00 ff ff ff ff ff 03 00 00 |..... .. ....... GW [00:00:02.314,880] bt_hci_driver: bt_rpmsg_evt_recv: len 12 GW [00:00:02.314,910] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d820) GW [00:00:02.314,910] bt_hci_core: bt_recv: buf 0x2002d820 len 14 GW [00:00:02.314,910] bt_hci_core: hci_cmd_complete: opcode 0x201c GW [00:00:02.314,910] bt_hci_core: hci_cmd_done: opcode 0x201c status 0x00 buf 0x2002d820 GW [00:00:02.314,941] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d820 opcode 0x201c len 9 GW [00:00:02.314,941] bt_hci_core: le_read_supp_states_complete: status 0x00 GW [00:00:02.314,941] bt_hci_core: bt_hci_cmd_create: opcode 0x2001 param_len 8 GW [00:00:02.314,971] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.314,971] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x2001 len 11 GW [00:00:02.315,002] bt_hci_core: process_events: count 2 GW [00:00:02.315,002] bt_hci_core: process_events: ev->state 4 GW [00:00:02.315,002] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.315,002] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.315,032] bt_hci_core: send_cmd: Sending command 0x2001 (buf 0x2002d83c) to driver GW [00:00:02.315,032] bt_hci_core: bt_send: buf 0x2002d83c len 11 type 0 GW [00:00:02.315,063] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 11 GW [00:00:02.315,063] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 01 20 08 02 10 07 0f 00 00 00 00 |.. ..... .... GW [00:00:02.315,093] bt_hci_core: process_events: ev->state 0 GW [00:00:02.315,093] bt_conn: bt_conn_prepare_events: GW [00:00:02.315,124] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.315,155] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 00 00 00 00 00 00 00 00 |........ . GW [00:00:02.315,216] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 04 01 01 20 00 |..... . GW [00:00:02.315,216] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.315,216] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.315,216] bt_hci_core: bt_recv: buf 0x2002d83c len 6 GW [00:00:02.315,216] bt_hci_core: hci_cmd_complete: opcode 0x2001 GW [00:00:02.315,246] bt_hci_core: hci_cmd_done: opcode 0x2001 status 0x00 buf 0x2002d83c GW [00:00:02.315,246] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x2001 len 1 GW [00:00:02.315,277] bt_hci_core: bt_hci_cmd_create: opcode 0x0c01 param_len 8 GW [00:00:02.315,277] bt_hci_core: bt_hci_cmd_create: buf 0x2002d820 GW [00:00:02.315,277] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d820 opcode 0x0c01 len 11 GW [00:00:02.315,307] bt_hci_core: process_events: count 2 GW [00:00:02.315,307] bt_hci_core: process_events: ev->state 4 GW [00:00:02.315,307] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.315,338] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.315,338] bt_hci_core: send_cmd: Sending command 0x0c01 (buf 0x2002d820) to driver GW [00:00:02.315,368] bt_hci_core: bt_send: buf 0x2002d820 len 11 type 0 GW [00:00:02.315,368] bt_hci_driver: bt_rpmsg_send: buf 0x2002d820 type 0 len 11 GW [00:00:02.315,368] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 01 0c 08 00 80 00 02 00 00 00 20 |........ ... GW [00:00:02.315,399] bt_hci_core: process_events: ev->state 0 GW [00:00:02.315,429] bt_conn: bt_conn_prepare_events: GW [00:00:02.315,429] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.315,460] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 |. GW [00:00:02.315,521] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 04 01 01 0c 00 |....... GW [00:00:02.315,521] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.315,521] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d820) GW [00:00:02.315,521] bt_hci_core: bt_recv: buf 0x2002d820 len 6 GW [00:00:02.315,551] bt_hci_core: hci_cmd_complete: opcode 0x0c01 GW [00:00:02.315,551] bt_hci_core: hci_cmd_done: opcode 0x0c01 status 0x00 buf 0x2002d820 GW [00:00:02.315,582] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d820 opcode 0x0c01 len 1 GW [00:00:02.315,582] ble: on_bt_ready: Bluetooth initialized GW [00:00:02.315,673] ble: MAC: F9:1F:05:AB:3A:5C (random) GW [00:00:02.315,673] bt_hci_core: bt_hci_cmd_create: opcode 0x1001 param_len 0 GW [00:00:02.315,673] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.315,704] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x1001 len 3 GW [00:00:02.315,734] bt_hci_core: process_events: count 2 GW [00:00:02.315,734] bt_hci_core: process_events: ev->state 4 GW [00:00:02.315,734] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.315,734] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.315,765] bt_hci_core: send_cmd: Sending command 0x1001 (buf 0x2002d83c) to driver GW [00:00:02.315,765] bt_hci_core: bt_send: buf 0x2002d83c len 3 type 0 GW [00:00:02.315,765] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 3 GW [00:00:02.315,795] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 01 10 00 |.... GW [00:00:02.315,826] bt_hci_core: process_events: ev->state 0 GW [00:00:02.315,826] bt_conn: bt_conn_prepare_events: GW [00:00:02.315,826] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.315,856] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 |. GW [00:00:02.315,917] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 0c 01 01 10 00 0b ee 0c 0b e8 07 ee 0c |........ ....... GW [00:00:02.315,948] bt_hci_driver: bt_rpmsg_evt_recv: len 12 GW [00:00:02.315,948] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.315,948] bt_hci_core: bt_recv: buf 0x2002d83c len 14 GW [00:00:02.315,948] bt_hci_core: hci_cmd_complete: opcode 0x1001 GW [00:00:02.315,948] bt_hci_core: hci_cmd_done: opcode 0x1001 status 0x00 buf 0x2002d83c GW [00:00:02.315,979] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x1001 len 9 GW [00:00:02.315,979] ble: Controller version: 3310 GW [00:00:02.316,009] bt_hci_core: bt_hci_cmd_create: opcode 0xfff3 param_len 5 GW [00:00:02.316,009] bt_hci_core: bt_hci_cmd_create: buf 0x2002d820 GW [00:00:02.316,009] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d820 opcode 0xfff3 len 8 GW [00:00:02.316,040] bt_hci_core: process_events: count 2 GW [00:00:02.316,040] bt_hci_core: process_events: ev->state 4 GW [00:00:02.316,040] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.316,070] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.316,070] bt_hci_core: send_cmd: Sending command 0xfff3 (buf 0x2002d820) to driver GW [00:00:02.316,101] bt_hci_core: bt_send: buf 0x2002d820 len 8 type 0 GW [00:00:02.316,101] bt_hci_driver: bt_rpmsg_send: buf 0x2002d820 type 0 len 8 GW [00:00:02.316,101] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 f3 ff 05 00 00 02 00 01 |........ . GW [00:00:02.316,131] bt_hci_core: process_events: ev->state 0 GW [00:00:02.316,162] bt_conn: bt_conn_prepare_events: GW [00:00:02.316,162] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.316,192] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 00 00 00 00 00 00 00 00 |........ . GW [00:00:02.316,253] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 04 01 f3 ff 00 |....... GW [00:00:02.316,253] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.316,253] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d820) GW [00:00:02.316,284] bt_hci_core: bt_recv: buf 0x2002d820 len 6 GW [00:00:02.316,284] bt_hci_core: hci_cmd_complete: opcode 0xfff3 GW [00:00:02.316,284] bt_hci_core: hci_cmd_done: opcode 0xfff3 status 0x00 buf 0x2002d820 GW [00:00:02.316,314] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d820 opcode 0xfff3 len 1 GW [00:00:02.316,314] bt_hci_core: bt_hci_cmd_create: opcode 0x1001 param_len 0 GW [00:00:02.316,314] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.316,345] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x1001 len 3 GW [00:00:02.316,375] bt_hci_core: process_events: count 2 GW [00:00:02.316,375] bt_hci_core: process_events: ev->state 4 GW [00:00:02.316,375] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.316,375] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.316,406] bt_hci_core: send_cmd: Sending command 0x1001 (buf 0x2002d83c) to driver GW [00:00:02.316,406] bt_hci_core: bt_send: buf 0x2002d83c len 3 type 0 GW [00:00:02.316,406] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 3 GW [00:00:02.316,436] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 01 10 00 |.... GW [00:00:02.316,467] bt_hci_core: process_events: ev->state 0 GW [00:00:02.316,467] bt_conn: bt_conn_prepare_events: GW [00:00:02.316,467] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.316,497] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 |. GW [00:00:02.316,558] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 0c 01 01 10 00 0b ee 0c 0b e8 07 ee 0c |........ ....... GW [00:00:02.316,589] bt_hci_driver: bt_rpmsg_evt_recv: len 12 GW [00:00:02.316,589] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.316,589] bt_hci_core: bt_recv: buf 0x2002d83c len 14 GW [00:00:02.316,589] bt_hci_core: hci_cmd_complete: opcode 0x1001 GW [00:00:02.316,589] bt_hci_core: hci_cmd_done: opcode 0x1001 status 0x00 buf 0x2002d83c GW [00:00:02.316,619] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x1001 len 9 GW [00:00:02.316,650] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 00 00 00 00 00 00 00 00 |........ . GW [00:00:02.438,171] audio_system: audio_system_init: CONFIG_FIFO_RX_FRAME_COUNT 1, CONFIG_FIFO_FRAME_SPLIT_NUM: 10 GW [00:00:02.438,171] audio_system: audio_system_init: FRAME_SIZE_BYTES: 640, CONFIG_AUDIO_FRAME_DURATION_US: 10000 GW [00:00:02.438,964] bis_gateway: initialize: Creating broadcast source GW [00:00:02.438,995] bt_audio_broadcast_source: broadcast_source_ep_init: ep 0x20017bdc GW [00:00:02.438,995] bt_audio_stream: bt_audio_stream_attach: conn (nil) stream 0x20016a1c ep 0x20017bdc codec 0x20000304 GW [00:00:02.439,025] bt_audio_broadcast_source: broadcast_source_ep_init: ep 0x20017cbc GW [00:00:02.439,025] bt_audio_stream: bt_audio_stream_attach: conn (nil) stream 0x20016a40 ep 0x20017cbc codec 0x20000304 GW [00:00:02.439,025] bt_audio_broadcast_source: broadcast_source_ep_init: ep 0x20017d9c GW [00:00:02.439,056] bt_audio_stream: bt_audio_stream_attach: conn (nil) stream 0x20016a64 ep 0x20017d9c codec 0x20000304 GW [00:00:02.439,056] bt_audio_broadcast_source: broadcast_source_ep_init: ep 0x20017e7c GW [00:00:02.439,086] bt_audio_stream: bt_audio_stream_attach: conn (nil) stream 0x20016a88 ep 0x20017e7c codec 0x20000304 GW [00:00:02.439,086] bt_audio_broadcast_source: broadcast_source_ep_init: ep 0x20017f5c GW [00:00:02.439,086] bt_audio_stream: bt_audio_stream_attach: conn (nil) stream 0x20016aac ep 0x20017f5c codec 0x20000304 GW [00:00:02.439,117] bt_audio_broadcast_source: broadcast_source_ep_init: ep 0x2001803c GW [00:00:02.439,117] bt_audio_stream: bt_audio_stream_attach: conn (nil) stream 0x20016ad0 ep 0x2001803c codec 0x20000304 GW [00:00:02.439,971] bt_audio_broadcast_source: broadcast_source_set_ep_state: ep 0x20017bdc id 0x00 idle -> qos-configured GW [00:00:02.440,002] bt_audio_broadcast_source: broadcast_source_set_ep_state: ep 0x20017cbc id 0x00 idle -> qos-configured GW [00:00:02.440,002] bt_audio_broadcast_source: broadcast_source_set_ep_state: ep 0x20017d9c id 0x00 idle -> qos-configured GW [00:00:02.440,032] bt_audio_broadcast_source: broadcast_source_set_ep_state: ep 0x20017e7c id 0x00 idle -> qos-configured GW [00:00:02.440,063] bt_audio_broadcast_source: broadcast_source_set_ep_state: ep 0x20017f5c id 0x00 idle -> qos-configured GW [00:00:02.440,093] bt_audio_broadcast_source: broadcast_source_set_ep_state: ep 0x2001803c id 0x00 idle -> qos-configured GW [00:00:02.440,093] bt_audio_broadcast_source: bt_audio_broadcast_source_create: Broadcasting with ID 0x77A4DF GW [00:00:02.440,093] bt_hci_core: bt_hci_cmd_create: opcode 0x2036 param_len 25 GW [00:00:02.440,124] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.441,009] bt_id: bt_id_set_adv_random_addr: 36:73:E5:12:97:B2 GW [00:00:02.441,009] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x2036 len 28 GW [00:00:02.441,040] bt_hci_core: process_events: count 2 GW [00:00:02.441,040] bt_hci_core: process_events: ev->state 4 GW [00:00:02.441,040] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.441,040] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.441,070] bt_hci_core: send_cmd: Sending command 0x2036 (buf 0x2002d83c) to driver GW [00:00:02.441,070] bt_hci_core: bt_send: buf 0x2002d83c len 28 type 0 GW [00:00:02.441,070] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 28 GW [00:00:02.441,101] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 36 20 19 00 00 00 a0 00 00 f0 00 00 07 01 00 |.6 ..... ........ 00 00 00 00 00 00 00 7f 01 00 02 00 00 |........ ..... GW [00:00:02.441,101] bt_hci_core: process_events: ev->state 0 GW [00:00:02.441,131] bt_conn: bt_conn_prepare_events: GW [00:00:02.441,131] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.441,497] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 05 01 36 20 00 00 |....6 .. GW [00:00:02.441,497] bt_hci_driver: bt_rpmsg_evt_recv: len 5 GW [00:00:02.441,528] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.441,528] bt_hci_core: bt_recv: buf 0x2002d83c len 7 GW [00:00:02.441,528] bt_hci_core: hci_cmd_complete: opcode 0x2036 GW [00:00:02.441,528] bt_hci_core: hci_cmd_done: opcode 0x2036 status 0x00 buf 0x2002d83c GW [00:00:02.441,558] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 00 |.. GW [00:00:02.441,589] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x2036 len 2 GW [00:00:02.441,680] bt_id: bt_id_set_adv_random_addr: 36:73:E5:12:97:B2 GW [00:00:02.441,680] bt_hci_core: bt_hci_cmd_create: opcode 0x2035 param_len 7 GW [00:00:02.441,680] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.441,680] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x2035 len 10 GW [00:00:02.441,711] bt_hci_core: process_events: count 2 GW [00:00:02.441,711] bt_hci_core: process_events: ev->state 4 GW [00:00:02.441,741] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.441,741] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.441,741] bt_hci_core: send_cmd: Sending command 0x2035 (buf 0x2002d83c) to driver GW [00:00:02.441,741] bt_hci_core: bt_send: buf 0x2002d83c len 10 type 0 GW [00:00:02.441,741] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 10 GW [00:00:02.441,772] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 35 20 07 00 b2 97 12 e5 73 36 |.5 ..... .s6 GW [00:00:02.441,802] bt_hci_core: process_events: ev->state 0 GW [00:00:02.441,802] bt_conn: bt_conn_prepare_events: GW [00:00:02.441,802] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.441,925] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 04 01 35 20 00 |....5 . GW [00:00:02.441,925] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.441,955] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.441,955] bt_hci_core: bt_recv: buf 0x2002d83c len 6 GW [00:00:02.441,955] bt_hci_core: hci_cmd_complete: opcode 0x2035 GW [00:00:02.441,955] bt_hci_core: hci_cmd_done: opcode 0x2035 status 0x00 buf 0x2002d83c GW [00:00:02.441,986] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 |. GW [00:00:02.442,016] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x2035 len 1 GW [00:00:02.442,016] bt_hci_core: bt_hci_cmd_create: opcode 0x203e param_len 7 GW [00:00:02.442,047] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.442,047] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x203e len 10 GW [00:00:02.442,077] bt_hci_core: process_events: count 2 GW [00:00:02.442,077] bt_hci_core: process_events: ev->state 4 GW [00:00:02.442,077] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.442,077] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.442,108] bt_hci_core: send_cmd: Sending command 0x203e (buf 0x2002d83c) to driver GW [00:00:02.442,108] bt_hci_core: bt_send: buf 0x2002d83c len 10 type 0 GW [00:00:02.442,108] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 10 GW [00:00:02.442,108] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 3e 20 07 00 20 03 c0 03 00 00 |.> .. .. ... GW [00:00:02.442,138] bt_hci_core: process_events: ev->state 0 GW [00:00:02.442,169] bt_conn: bt_conn_prepare_events: GW [00:00:02.442,169] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.442,291] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 04 01 3e 20 00 |....> . GW [00:00:02.442,291] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.442,291] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.442,291] bt_hci_core: bt_recv: buf 0x2002d83c len 6 GW [00:00:02.442,321] bt_hci_core: hci_cmd_complete: opcode 0x203e GW [00:00:02.442,321] bt_hci_core: hci_cmd_done: opcode 0x203e status 0x00 buf 0x2002d83c GW [00:00:02.442,352] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 |. GW [00:00:02.442,382] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x203e len 1 GW [00:00:02.442,382] bt_hci_core: bt_hci_cmd_create: opcode 0x2037 param_len 41 GW [00:00:02.442,413] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.442,413] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x2037 len 44 GW [00:00:02.442,443] bt_hci_core: process_events: count 2 GW [00:00:02.442,443] bt_hci_core: process_events: ev->state 4 GW [00:00:02.442,443] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.442,443] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.442,474] bt_hci_core: send_cmd: Sending command 0x2037 (buf 0x2002d83c) to driver GW [00:00:02.442,474] bt_hci_core: bt_send: buf 0x2002d83c len 44 type 0 GW [00:00:02.442,474] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 44 GW [00:00:02.442,474] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 37 20 29 00 03 01 25 0e 30 4e 52 46 35 33 34 |.7 )...% .0NRF534 30 5f 41 55 44 49 4f 06 16 52 18 df a4 77 0e 09 |0_AUDIO. .R...w.. 4e 52 46 35 33 34 30 5f 41 55 44 49 4f |NRF5340_ AUDIO GW [00:00:02.442,504] bt_hci_core: process_events: ev->state 0 GW [00:00:02.442,535] bt_conn: bt_conn_prepare_events: GW [00:00:02.442,535] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.442,687] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 04 01 37 20 00 |....7 . GW [00:00:02.442,687] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.442,687] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.442,687] bt_hci_core: bt_recv: buf 0x2002d83c len 6 GW [00:00:02.442,687] bt_hci_core: hci_cmd_complete: opcode 0x2037 GW [00:00:02.442,718] bt_hci_core: hci_cmd_done: opcode 0x2037 status 0x00 buf 0x2002d83c GW [00:00:02.442,718] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 |. GW [00:00:02.442,779] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x2037 len 1 GW [00:00:02.442,810] bt_hci_core: bt_hci_cmd_create: opcode 0x203f param_len 51 GW [00:00:02.442,810] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.442,840] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x203f len 54 GW [00:00:02.442,840] bt_hci_core: process_events: count 2 GW [00:00:02.442,840] bt_hci_core: process_events: ev->state 4 GW [00:00:02.442,871] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.442,871] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.442,871] bt_hci_core: send_cmd: Sending command 0x203f (buf 0x2002d83c) to driver GW [00:00:02.442,871] bt_hci_core: bt_send: buf 0x2002d83c len 54 type 0 GW [00:00:02.442,871] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 54 GW [00:00:02.442,901] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 3f 20 33 00 03 30 2f 16 51 18 40 9c 00 01 06 |.? 3..0/ .Q.@.... 06 00 00 00 00 10 02 01 03 02 02 01 05 03 01 00 |........ ........ 00 00 03 04 28 00 04 03 02 04 00 01 00 02 00 03 |....(... ........ 00 04 00 05 00 06 00 |....... GW [00:00:02.442,932] bt_hci_core: process_events: ev->state 0 GW [00:00:02.442,932] bt_conn: bt_conn_prepare_events: GW [00:00:02.442,962] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.443,084] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 04 01 3f 20 00 |....? . GW [00:00:02.443,115] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.443,115] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.443,115] bt_hci_core: bt_recv: buf 0x2002d83c len 6 GW [00:00:02.443,115] bt_hci_core: hci_cmd_complete: opcode 0x203f GW [00:00:02.443,115] bt_hci_core: hci_cmd_done: opcode 0x203f status 0x00 buf 0x2002d83c GW [00:00:02.443,145] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 |. GW [00:00:02.443,176] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x203f len 1 GW [00:00:02.444,091] bt_id: bt_id_set_adv_random_addr: 2E:0A:22:9F:D5:CE GW [00:00:02.444,122] bt_hci_core: bt_hci_cmd_create: opcode 0x2035 param_len 7 GW [00:00:02.444,122] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.444,122] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x2035 len 10 GW [00:00:02.444,152] bt_hci_core: process_events: count 2 GW [00:00:02.444,152] bt_hci_core: process_events: ev->state 4 GW [00:00:02.444,152] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.444,183] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.444,183] bt_hci_core: send_cmd: Sending command 0x2035 (buf 0x2002d83c) to driver GW [00:00:02.444,183] bt_hci_core: bt_send: buf 0x2002d83c len 10 type 0 GW [00:00:02.444,183] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 10 GW [00:00:02.444,213] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 35 20 07 00 ce d5 9f 22 0a 2e |.5 ..... ".. GW [00:00:02.444,244] bt_hci_core: process_events: ev->state 0 GW [00:00:02.444,244] bt_conn: bt_conn_prepare_events: GW [00:00:02.444,244] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.444,366] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 04 01 35 20 00 |....5 . GW [00:00:02.444,366] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.444,366] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.444,396] bt_hci_core: bt_recv: buf 0x2002d83c len 6 GW [00:00:02.444,396] bt_hci_core: hci_cmd_complete: opcode 0x2035 GW [00:00:02.444,396] bt_hci_core: hci_cmd_done: opcode 0x2035 status 0x00 buf 0x2002d83c GW [00:00:02.444,427] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 |. GW [00:00:02.444,458] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x2035 len 1 GW [00:00:02.444,458] bt_hci_core: bt_hci_cmd_create: opcode 0x2039 param_len 6 GW [00:00:02.444,488] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.444,488] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x2039 len 9 GW [00:00:02.444,519] bt_hci_core: process_events: count 2 GW [00:00:02.444,519] bt_hci_core: process_events: ev->state 4 GW [00:00:02.444,519] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.444,519] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.444,519] bt_hci_core: send_cmd: Sending command 0x2039 (buf 0x2002d83c) to driver GW [00:00:02.444,549] bt_hci_core: bt_send: buf 0x2002d83c len 9 type 0 GW [00:00:02.444,549] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 9 GW [00:00:02.444,549] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 39 20 06 01 01 00 00 00 00 |.9 ..... .. GW [00:00:02.444,580] bt_hci_core: process_events: ev->state 0 GW [00:00:02.444,610] bt_conn: bt_conn_prepare_events: GW [00:00:02.444,610] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.444,885] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 04 01 39 20 00 |....9 . GW [00:00:02.444,885] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.444,885] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.444,885] bt_hci_core: bt_recv: buf 0x2002d83c len 6 GW [00:00:02.444,915] bt_hci_core: hci_cmd_complete: opcode 0x2039 GW [00:00:02.444,915] bt_hci_core: hci_cmd_done: opcode 0x2039 status 0x00 buf 0x2002d83c GW [00:00:02.444,946] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 |. GW [00:00:02.444,976] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x2039 len 1 GW [00:00:02.444,976] bt_hci_core: bt_hci_cmd_create: opcode 0x2040 param_len 2 GW [00:00:02.444,976] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.445,007] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x2040 len 5 GW [00:00:02.445,007] bt_hci_core: process_events: count 2 GW [00:00:02.445,007] bt_hci_core: process_events: ev->state 4 GW [00:00:02.445,037] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.445,037] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.445,037] bt_hci_core: send_cmd: Sending command 0x2040 (buf 0x2002d83c) to driver GW [00:00:02.445,037] bt_hci_core: bt_send: buf 0x2002d83c len 5 type 0 GW [00:00:02.445,037] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 5 GW [00:00:02.445,068] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 40 20 02 01 00 |.@ ... GW [00:00:02.445,098] bt_hci_core: process_events: ev->state 0 GW [00:00:02.445,098] bt_conn: bt_conn_prepare_events: GW [00:00:02.445,098] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.445,373] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0e 04 01 40 20 00 |....@ . GW [00:00:02.445,373] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.445,404] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.445,404] bt_hci_core: bt_recv: buf 0x2002d83c len 6 GW [00:00:02.445,404] bt_hci_core: hci_cmd_complete: opcode 0x2040 GW [00:00:02.445,404] bt_hci_core: hci_cmd_done: opcode 0x2040 status 0x00 buf 0x2002d83c GW [00:00:02.445,434] bt_hci_driver: bt_rpmsg_rx: RX buf payload: 00 |. GW [00:00:02.445,465] bt_hci_core: bt_hci_cmd_send_sync: rsp 0x2002d83c opcode 0x2040 len 1 GW [00:00:02.445,465] bis_gateway: le_audio_enable: Starting broadcast source GW [00:00:02.445,495] bt_iso: bt_iso_chan_add: iso 0x20012548 chan 0x2001865c GW [00:00:02.445,526] bt_iso: bt_iso_chan_add: iso 0x20012610 chan 0x200186e0 GW [00:00:02.445,526] bt_iso: bt_iso_chan_add: iso 0x200126d8 chan 0x20018764 GW [00:00:02.445,556] bt_iso: bt_iso_chan_add: iso 0x200127a0 chan 0x200187e8 GW [00:00:02.445,556] bt_iso: bt_iso_chan_add: iso 0x20012868 chan 0x2001886c GW [00:00:02.445,587] bt_iso: bt_iso_chan_add: iso 0x20012930 chan 0x200188f0 GW [00:00:02.445,587] bt_hci_core: bt_hci_cmd_create: opcode 0x2068 param_len 31 GW [00:00:02.445,587] bt_hci_core: bt_hci_cmd_create: buf 0x2002d83c GW [00:00:02.445,587] bt_hci_core: bt_hci_cmd_send_sync: buf 0x2002d83c opcode 0x2068 len 34 GW [00:00:02.445,617] bt_hci_core: process_events: count 2 GW [00:00:02.445,617] bt_hci_core: process_events: ev->state 4 GW [00:00:02.445,648] bt_hci_core: send_cmd: calling net_buf_get GW [00:00:02.445,648] bt_hci_core: send_cmd: calling sem_take_wait GW [00:00:02.445,648] bt_hci_core: send_cmd: Sending command 0x2068 (buf 0x2002d83c) to driver GW [00:00:02.445,648] bt_hci_core: bt_send: buf 0x2002d83c len 34 type 0 GW [00:00:02.445,648] bt_hci_driver: bt_rpmsg_send: buf 0x2002d83c type 0 len 34 GW [00:00:02.445,678] bt_hci_driver: bt_rpmsg_send: Final HCI buffer: 01 68 20 1f 00 00 06 10 27 00 28 00 0a 00 02 02 |.h ..... '.(..... 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 |........ ........ 00 00 00 |... GW [00:00:02.445,709] bt_hci_core: process_events: ev->state 0 GW [00:00:02.445,709] bt_conn: bt_conn_prepare_events: GW [00:00:02.445,739] bt_hci_core: hci_tx_thread: Calling k_poll with 2 events GW [00:00:02.445,861] bt_hci_driver: bt_rpmsg_rx: RPMsg data: 04 0f 04 0d 01 68 20 |.....h GW [00:00:02.445,861] bt_hci_driver: bt_rpmsg_evt_recv: len 4 GW [00:00:02.445,861] bt_hci_driver: bt_rpmsg_rx: Calling bt_recv(0x2002d83c) GW [00:00:02.445,861] bt_hci_core: bt_recv: buf 0x2002d83c len 6 GW [00:00:02.445,892] bt_hci_core: hci_cmd_status: opcode 0x2068 GW [00:00:02.445,892] bt_hci_core: hci_cmd_done: opcode 0x2068 status 0x0d buf 0x2002d83c GW [00:00:02.445,922] bt_hci_driver: bt_rpmsg_rx: RX buf payload: GW [00:00:02.445,953] bt_hci_core: X opcode 0x2068 status 0x0d GW [00:00:02.445,953] bt_iso: bt_iso_big_create: Could not create BIG -5 GW [00:00:02.445,953] bt_conn: bt_conn_unref: handle 0 ref 1 -> 0 GW [00:00:02.445,953] bt_conn: bt_conn_unref: handle 0 ref 1 -> 0 GW [00:00:02.445,983] bt_conn: bt_conn_unref: handle 0 ref 1 -> 0 GW [00:00:02.445,983] bt_conn: bt_conn_unref: handle 0 ref 1 -> 0 GW [00:00:02.445,983] bt_conn: bt_conn_unref: handle 0 ref 1 -> 0 GW [00:00:02.445,983] bt_conn: bt_conn_unref: handle 0 ref 1 -> 0 GW [00:00:02.445,983] bt_audio_broadcast_source: bt_audio_broadcast_source_start: Failed to create BIG: -5 GW [00:00:02.446,014] streamctrl: Failed to enable LE Audio GW [00:00:02.446,014] streamctrl: ERR_CHK Err_code: [-5] @ line: 432 GW [00:00:02.446,014] os: r0/a1: 0x00000003 r1/a2: 0x000002a7 r2/a3: 0x000002a6 GW [00:00:02.446,014] os: r3/a4: 0x000508eb r12/ip: 0x20026d50 r14/lr: 0x00050957 GW [00:00:02.446,014] os: xpsr: 0x69100000 GW [00:00:02.446,044] os: s[ 0]: 0x00000000 s[ 1]: 0x00000000 s[ 2]: 0x00000000 s[ 3]: 0x00000000 GW [00:00:02.446,044] os: s[ 4]: 0x00000000 s[ 5]: 0x00000000 s[ 6]: 0x00000000 s[ 7]: 0x00000000 GW [00:00:02.446,044] os: s[ 8]: 0x00000000 s[ 9]: 0x00000000 s[10]: 0x00000000 s[11]: 0x00000000 GW [00:00:02.446,044] os: s[12]: 0x00000000 s[13]: 0x00000000 s[14]: 0x00000000 s[15]: 0x00000000 GW [00:00:02.446,044] os: fpscr: 0x00000000 GW [00:00:02.446,075] os: Faulting instruction address (r15/pc): 0x000062ea GW [00:00:02.446,075] os: >>> ZEPHYR FATAL ERROR 3: Kernel oops on CPU 0 GW [00:00:02.446,105] os: Current thread: 0x20012b30 (main) GW [00:00:02.446,105] error_handler: Caught system error -- reason 3. Entering infinite loop