0 14aa9740 2022-8-14 5:38:22 0/0/000.000 zb_init_ncp.c:141 [INFO1] FFD build 1 14aa9740 2022-8-14 5:38:22 0/0/000.000 zb_init_ncp.c:144 [INFO1] sizes: g_zb 11664 sched 1952 bpool 6660 addr 1612 2 14aa9740 2022-8-14 5:38:22 0/0/000.000 zb_init_ncp.c:147 [INFO1] zcl 1088 3 14aa9740 2022-8-14 5:38:22 0/0/000.000 zb_init_ncp.c:156 [INFO1] nvram 240 4 14aa9740 2022-8-14 5:38:22 0/0/000.000 zb_init_ncp.c:162 [INFO1] err_ind 8 5 14aa9740 2022-8-14 5:38:22 0/0/000.000 zb_init_ncp.c:169 [INFO1] scheduler q size 64 6 14aa9740 2022-8-14 5:38:22 0/0/000.000 zb_init_ncp.c:175 [INFO1] ZB_IOBUF_POOL_SIZE 40 zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480702570 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480702570 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_poll: @ time 1660480703585 [ack size 0] zbncp_crc8: CRC8 init 00 data 0x55b79d53953a size 4 -> crc 0xde zbncp_crc16: CRC16 init 0000 data 0x55b79d539541 size 6 --> crc 0x20ae zbncp_ll_tx_alloc_pkt: (TX-IDLE) size 15 frame #0 zbncp_ll_tx_start_sending: (TX-IDLE) size 15 zbncp_ll_tx_set_state: (TX-IDLE --> TX-SENDING-PKT) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480703585 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_tx_set_state: (TX-SENDING-PKT --> TX-PKT-SENT) zbncp_ll_send_complete: (RX-RECEIVING-HDR : TX-SENDING-PKT --> TX-PKT-SENT) zbncp_ll_poll: @ time 1660480703585 [ack size 0] zbncp_ll_tx_start_waiting_ack: (TX-PKT-SENT) (RX-RECEIVING-HDR) zbncp_ll_alarm_set: 500 zbncp_ll_tx_set_state: (TX-PKT-SENT --> TX-IDLE) zbncp_ll_poll: >>> timeout 500/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480703585 [ack size 0] zbncp_ll_poll: >>> timeout 500 [ack size 0] zbncp_ll_poll: @ time 1660480704091 [ack size 0] zbncp_ll_alarm_cancel: alerting zbncp_ll_alert_wait_ack: (RX-RECEIVING-HDR : TX-IDLE) zbncp_ll_poll: >>> timeout 0/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480704091 [ack size 0] zbncp_ll_tx_start_sending: (TX-IDLE) size 15 zbncp_ll_tx_set_state: (TX-IDLE --> TX-SENDING-PKT) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480704092 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_tx_set_state: (TX-SENDING-PKT --> TX-PKT-SENT) zbncp_ll_send_complete: (RX-RECEIVING-HDR : TX-SENDING-PKT --> TX-PKT-SENT) zbncp_ll_poll: @ time 1660480704092 [ack size 0] zbncp_ll_tx_start_waiting_ack: (TX-PKT-SENT) (RX-RECEIVING-HDR) zbncp_ll_alarm_set: 500 zbncp_ll_tx_set_state: (TX-PKT-SENT --> TX-IDLE) zbncp_ll_poll: >>> timeout 500/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480704092 [ack size 0] zbncp_ll_poll: >>> timeout 500 [ack size 0] zbncp_ll_poll: @ time 1660480704598 [ack size 0] zbncp_ll_alarm_cancel: alerting zbncp_ll_alert_wait_ack: (RX-RECEIVING-HDR : TX-IDLE) zbncp_ll_poll: >>> timeout 0/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480704599 [ack size 0] zbncp_ll_tx_start_sending: (TX-IDLE) size 15 zbncp_ll_tx_set_state: (TX-IDLE --> TX-SENDING-PKT) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480704599 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_tx_set_state: (TX-SENDING-PKT --> TX-PKT-SENT) zbncp_ll_send_complete: (RX-RECEIVING-HDR : TX-SENDING-PKT --> TX-PKT-SENT) zbncp_ll_poll: @ time 1660480704599 [ack size 0] zbncp_ll_tx_start_waiting_ack: (TX-PKT-SENT) (RX-RECEIVING-HDR) zbncp_ll_alarm_set: 500 zbncp_ll_tx_set_state: (TX-PKT-SENT --> TX-IDLE) zbncp_ll_poll: >>> timeout 500/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480704599 [ack size 0] zbncp_ll_poll: >>> timeout 500 [ack size 0] zbncp_ll_poll: @ time 1660480705106 [ack size 0] zbncp_ll_alarm_cancel: alerting zbncp_ll_alert_wait_ack: (RX-RECEIVING-HDR : TX-IDLE) zbncp_ll_poll: >>> timeout 0/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480705106 [ack size 0] zbncp_ll_alarm_cancel: 18446744073709551615 zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 7 14aa9740 2022-8-14 5:39:0 2222/34129/038.364 zb_osif_serial_common.c:263 [ERROR] read error, errno: 0 8 14aa9740 2022-8-14 5:39:0 2222/34129/038.364 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2050 9 14aa9740 2022-8-14 5:39:0 2222/34129/038.364 zb_error_indication.c:121 [ERROR] call a stack handler 10 14aa9740 2022-8-14 5:39:0 2222/34129/038.364 high_level/host/ncp_host_startup.c:2026 [ERROR] read error, SoC reset expected 11 14aa9740 2022-8-14 5:39:0 2222/34129/038.364 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 12 14aa9740 2022-8-14 5:39:0 2222/34129/038.364 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 13 14aa9740 2022-8-14 5:39:0 2222/34129/038.364 zb_error_indication.c:121 [ERROR] call a stack handler 14 14aa9740 2022-8-14 5:39:0 2222/34129/038.364 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) 15 14aa9740 2022-8-14 5:39:0 2222/34129/038.364 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_poll: @ time 1660480740921 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 16 14aa9740 2022-8-14 5:39:0 2497/38353/038.364 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480740921 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 17 14aa9740 2022-8-14 5:39:0 2497/38353/038.364 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 18 14aa9740 2022-8-14 5:39:0 2497/38353/038.364 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 19 14aa9740 2022-8-14 5:39:0 2497/38353/038.364 zb_error_indication.c:121 [ERROR] call a stack handler 20 14aa9740 2022-8-14 5:39:0 2497/38353/038.364 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480740921 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 21 14aa9740 2022-8-14 5:39:0 2497/38353/038.364 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480740922 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 22 14aa9740 2022-8-14 5:39:1 2504/38461/038.472 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 23 14aa9740 2022-8-14 5:39:1 2504/38461/038.472 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 24 14aa9740 2022-8-14 5:39:1 2504/38461/038.472 zb_error_indication.c:121 [ERROR] call a stack handler 25 14aa9740 2022-8-14 5:39:1 2504/38461/038.472 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480741029 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 26 14aa9740 2022-8-14 5:39:1 2504/38461/038.472 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480741029 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 27 14aa9740 2022-8-14 5:39:1 2511/38568/038.579 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 28 14aa9740 2022-8-14 5:39:1 2511/38568/038.579 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 29 14aa9740 2022-8-14 5:39:1 2511/38568/038.579 zb_error_indication.c:121 [ERROR] call a stack handler 30 14aa9740 2022-8-14 5:39:1 2511/38568/038.579 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480741136 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 31 14aa9740 2022-8-14 5:39:1 2511/38568/038.579 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480741136 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 32 14aa9740 2022-8-14 5:39:1 2518/38676/038.687 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 33 14aa9740 2022-8-14 5:39:1 2518/38676/038.687 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 34 14aa9740 2022-8-14 5:39:1 2518/38676/038.687 zb_error_indication.c:121 [ERROR] call a stack handler 35 14aa9740 2022-8-14 5:39:1 2518/38676/038.687 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480741244 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 36 14aa9740 2022-8-14 5:39:1 2518/38676/038.687 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480741244 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 37 14aa9740 2022-8-14 5:39:1 2525/38784/038.795 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 38 14aa9740 2022-8-14 5:39:1 2525/38784/038.795 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 39 14aa9740 2022-8-14 5:39:1 2525/38784/038.795 zb_error_indication.c:121 [ERROR] call a stack handler 40 14aa9740 2022-8-14 5:39:1 2525/38784/038.795 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480741351 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 41 14aa9740 2022-8-14 5:39:1 2525/38784/038.795 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480741351 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 42 14aa9740 2022-8-14 5:39:1 2532/38891/038.902 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 43 14aa9740 2022-8-14 5:39:1 2532/38891/038.902 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 44 14aa9740 2022-8-14 5:39:1 2532/38891/038.902 zb_error_indication.c:121 [ERROR] call a stack handler 45 14aa9740 2022-8-14 5:39:1 2532/38891/038.902 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480741459 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 46 14aa9740 2022-8-14 5:39:1 2532/38891/038.902 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480741459 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 47 14aa9740 2022-8-14 5:39:1 2539/38999/039.009 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 48 14aa9740 2022-8-14 5:39:1 2539/38999/039.009 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 49 14aa9740 2022-8-14 5:39:1 2539/38999/039.009 zb_error_indication.c:121 [ERROR] call a stack handler 50 14aa9740 2022-8-14 5:39:1 2539/38999/039.009 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480741566 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 51 14aa9740 2022-8-14 5:39:1 2539/38999/039.009 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480741566 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 52 14aa9740 2022-8-14 5:39:1 2546/39106/039.117 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 53 14aa9740 2022-8-14 5:39:1 2546/39106/039.117 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 54 14aa9740 2022-8-14 5:39:1 2546/39106/039.117 zb_error_indication.c:121 [ERROR] call a stack handler 55 14aa9740 2022-8-14 5:39:1 2546/39106/039.117 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480741674 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 56 14aa9740 2022-8-14 5:39:1 2546/39106/039.117 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480741674 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 57 14aa9740 2022-8-14 5:39:1 2553/39214/039.224 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 58 14aa9740 2022-8-14 5:39:1 2553/39214/039.224 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 59 14aa9740 2022-8-14 5:39:1 2553/39214/039.224 zb_error_indication.c:121 [ERROR] call a stack handler 60 14aa9740 2022-8-14 5:39:1 2553/39214/039.224 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480741782 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 61 14aa9740 2022-8-14 5:39:1 2553/39214/039.224 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480741782 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 62 14aa9740 2022-8-14 5:39:1 2560/39321/039.332 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 63 14aa9740 2022-8-14 5:39:1 2560/39321/039.333 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 64 14aa9740 2022-8-14 5:39:1 2560/39321/039.333 zb_error_indication.c:121 [ERROR] call a stack handler 65 14aa9740 2022-8-14 5:39:1 2560/39321/039.333 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480741890 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 66 14aa9740 2022-8-14 5:39:1 2560/39321/039.333 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480741890 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 67 14aa9740 2022-8-14 5:39:1 2567/39429/039.440 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 68 14aa9740 2022-8-14 5:39:1 2567/39429/039.440 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 69 14aa9740 2022-8-14 5:39:1 2567/39429/039.440 zb_error_indication.c:121 [ERROR] call a stack handler 70 14aa9740 2022-8-14 5:39:1 2567/39429/039.440 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480741997 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 71 14aa9740 2022-8-14 5:39:1 2567/39429/039.440 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480741997 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 72 14aa9740 2022-8-14 5:39:2 2574/39536/039.548 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 73 14aa9740 2022-8-14 5:39:2 2574/39536/039.548 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 74 14aa9740 2022-8-14 5:39:2 2574/39536/039.548 zb_error_indication.c:121 [ERROR] call a stack handler 75 14aa9740 2022-8-14 5:39:2 2574/39536/039.548 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480742105 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 76 14aa9740 2022-8-14 5:39:2 2574/39536/039.548 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480742105 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 77 14aa9740 2022-8-14 5:39:2 2581/39644/039.656 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 78 14aa9740 2022-8-14 5:39:2 2581/39644/039.656 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 79 14aa9740 2022-8-14 5:39:2 2581/39644/039.656 zb_error_indication.c:121 [ERROR] call a stack handler 80 14aa9740 2022-8-14 5:39:2 2581/39644/039.656 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480742213 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 81 14aa9740 2022-8-14 5:39:2 2581/39644/039.656 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480742213 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 82 14aa9740 2022-8-14 5:39:2 2588/39751/039.764 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 83 14aa9740 2022-8-14 5:39:2 2588/39751/039.764 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 84 14aa9740 2022-8-14 5:39:2 2588/39751/039.764 zb_error_indication.c:121 [ERROR] call a stack handler 85 14aa9740 2022-8-14 5:39:2 2588/39751/039.764 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480742320 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 86 14aa9740 2022-8-14 5:39:2 2588/39751/039.764 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480742320 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 87 14aa9740 2022-8-14 5:39:2 2595/39859/039.871 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 88 14aa9740 2022-8-14 5:39:2 2595/39859/039.871 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 89 14aa9740 2022-8-14 5:39:2 2595/39859/039.871 zb_error_indication.c:121 [ERROR] call a stack handler 90 14aa9740 2022-8-14 5:39:2 2595/39859/039.871 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480742428 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 91 14aa9740 2022-8-14 5:39:2 2595/39859/039.871 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480742428 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 92 14aa9740 2022-8-14 5:39:2 2602/39966/039.979 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 93 14aa9740 2022-8-14 5:39:2 2602/39966/039.979 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 94 14aa9740 2022-8-14 5:39:2 2602/39966/039.979 zb_error_indication.c:121 [ERROR] call a stack handler 95 14aa9740 2022-8-14 5:39:2 2602/39966/039.979 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480742536 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 96 14aa9740 2022-8-14 5:39:2 2602/39966/039.979 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480742536 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 97 14aa9740 2022-8-14 5:39:2 2609/40074/040.086 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 98 14aa9740 2022-8-14 5:39:2 2609/40074/040.086 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 99 14aa9740 2022-8-14 5:39:2 2609/40074/040.086 zb_error_indication.c:121 [ERROR] call a stack handler 100 14aa9740 2022-8-14 5:39:2 2609/40074/040.086 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480742643 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 101 14aa9740 2022-8-14 5:39:2 2609/40074/040.086 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480742643 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 102 14aa9740 2022-8-14 5:39:2 2616/40181/040.193 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 103 14aa9740 2022-8-14 5:39:2 2616/40181/040.193 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 104 14aa9740 2022-8-14 5:39:2 2616/40181/040.193 zb_error_indication.c:121 [ERROR] call a stack handler 105 14aa9740 2022-8-14 5:39:2 2616/40181/040.193 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480742750 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 106 14aa9740 2022-8-14 5:39:2 2616/40181/040.193 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480742750 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 107 14aa9740 2022-8-14 5:39:2 2623/40289/040.301 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 108 14aa9740 2022-8-14 5:39:2 2623/40289/040.301 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 109 14aa9740 2022-8-14 5:39:2 2623/40289/040.301 zb_error_indication.c:121 [ERROR] call a stack handler 110 14aa9740 2022-8-14 5:39:2 2623/40289/040.301 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480742858 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 111 14aa9740 2022-8-14 5:39:2 2623/40289/040.301 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480742858 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 112 14aa9740 2022-8-14 5:39:2 2630/40396/040.408 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 113 14aa9740 2022-8-14 5:39:2 2630/40396/040.408 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 114 14aa9740 2022-8-14 5:39:2 2630/40396/040.408 zb_error_indication.c:121 [ERROR] call a stack handler 115 14aa9740 2022-8-14 5:39:2 2630/40396/040.408 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480742966 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 116 14aa9740 2022-8-14 5:39:2 2630/40396/040.408 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480742966 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 117 14aa9740 2022-8-14 5:39:3 2637/40504/040.516 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 118 14aa9740 2022-8-14 5:39:3 2637/40504/040.516 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 119 14aa9740 2022-8-14 5:39:3 2637/40504/040.516 zb_error_indication.c:121 [ERROR] call a stack handler 120 14aa9740 2022-8-14 5:39:3 2637/40504/040.516 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480743073 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 121 14aa9740 2022-8-14 5:39:3 2637/40504/040.516 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480743073 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 122 14aa9740 2022-8-14 5:39:3 2644/40611/040.623 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 123 14aa9740 2022-8-14 5:39:3 2644/40611/040.623 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 124 14aa9740 2022-8-14 5:39:3 2644/40611/040.623 zb_error_indication.c:121 [ERROR] call a stack handler 125 14aa9740 2022-8-14 5:39:3 2644/40611/040.623 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480743180 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 126 14aa9740 2022-8-14 5:39:3 2644/40611/040.623 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480743180 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 127 14aa9740 2022-8-14 5:39:3 2651/40719/040.732 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 128 14aa9740 2022-8-14 5:39:3 2651/40719/040.732 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 129 14aa9740 2022-8-14 5:39:3 2651/40719/040.732 zb_error_indication.c:121 [ERROR] call a stack handler 130 14aa9740 2022-8-14 5:39:3 2651/40719/040.732 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480743288 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 131 14aa9740 2022-8-14 5:39:3 2651/40719/040.732 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480743288 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 132 14aa9740 2022-8-14 5:39:3 2658/40826/040.839 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 133 14aa9740 2022-8-14 5:39:3 2658/40826/040.839 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 134 14aa9740 2022-8-14 5:39:3 2658/40826/040.839 zb_error_indication.c:121 [ERROR] call a stack handler 135 14aa9740 2022-8-14 5:39:3 2658/40826/040.839 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480743395 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 136 14aa9740 2022-8-14 5:39:3 2658/40826/040.839 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480743396 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 137 14aa9740 2022-8-14 5:39:3 2665/40934/040.946 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 138 14aa9740 2022-8-14 5:39:3 2665/40934/040.946 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 139 14aa9740 2022-8-14 5:39:3 2665/40934/040.946 zb_error_indication.c:121 [ERROR] call a stack handler 140 14aa9740 2022-8-14 5:39:3 2665/40934/040.946 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480743503 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 141 14aa9740 2022-8-14 5:39:3 2665/40934/040.947 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480743503 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 142 14aa9740 2022-8-14 5:39:3 2672/41041/041.053 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 143 14aa9740 2022-8-14 5:39:3 2672/41041/041.053 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 144 14aa9740 2022-8-14 5:39:3 2672/41041/041.053 zb_error_indication.c:121 [ERROR] call a stack handler 145 14aa9740 2022-8-14 5:39:3 2672/41041/041.053 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480743610 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 146 14aa9740 2022-8-14 5:39:3 2672/41041/041.053 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480743610 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 147 14aa9740 2022-8-14 5:39:3 2679/41149/041.160 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 148 14aa9740 2022-8-14 5:39:3 2679/41149/041.160 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 149 14aa9740 2022-8-14 5:39:3 2679/41149/041.160 zb_error_indication.c:121 [ERROR] call a stack handler 150 14aa9740 2022-8-14 5:39:3 2679/41149/041.160 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480743717 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 151 14aa9740 2022-8-14 5:39:3 2679/41149/041.160 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480743717 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 152 14aa9740 2022-8-14 5:39:3 2686/41256/041.268 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 153 14aa9740 2022-8-14 5:39:3 2686/41256/041.268 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 154 14aa9740 2022-8-14 5:39:3 2686/41256/041.268 zb_error_indication.c:121 [ERROR] call a stack handler 155 14aa9740 2022-8-14 5:39:3 2686/41256/041.268 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480743825 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 156 14aa9740 2022-8-14 5:39:3 2686/41256/041.268 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480743825 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 157 14aa9740 2022-8-14 5:39:3 2693/41364/041.375 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 158 14aa9740 2022-8-14 5:39:3 2693/41364/041.375 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 159 14aa9740 2022-8-14 5:39:3 2693/41364/041.375 zb_error_indication.c:121 [ERROR] call a stack handler 160 14aa9740 2022-8-14 5:39:3 2693/41364/041.375 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480743932 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 161 14aa9740 2022-8-14 5:39:3 2693/41364/041.375 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480743932 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 162 14aa9740 2022-8-14 5:39:4 2700/41472/041.482 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 163 14aa9740 2022-8-14 5:39:4 2700/41472/041.482 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 164 14aa9740 2022-8-14 5:39:4 2700/41472/041.482 zb_error_indication.c:121 [ERROR] call a stack handler 165 14aa9740 2022-8-14 5:39:4 2700/41472/041.482 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480744040 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 166 14aa9740 2022-8-14 5:39:4 2700/41472/041.482 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480744040 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 167 14aa9740 2022-8-14 5:39:4 2707/41579/041.590 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 168 14aa9740 2022-8-14 5:39:4 2707/41579/041.590 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 169 14aa9740 2022-8-14 5:39:4 2707/41579/041.590 zb_error_indication.c:121 [ERROR] call a stack handler 170 14aa9740 2022-8-14 5:39:4 2707/41579/041.590 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480744147 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 171 14aa9740 2022-8-14 5:39:4 2707/41579/041.590 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480744147 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 172 14aa9740 2022-8-14 5:39:4 2714/41687/041.698 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 173 14aa9740 2022-8-14 5:39:4 2714/41687/041.698 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 174 14aa9740 2022-8-14 5:39:4 2714/41687/041.698 zb_error_indication.c:121 [ERROR] call a stack handler 175 14aa9740 2022-8-14 5:39:4 2714/41687/041.698 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480744254 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 176 14aa9740 2022-8-14 5:39:4 2714/41687/041.698 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480744254 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 177 14aa9740 2022-8-14 5:39:4 2721/41794/041.806 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 178 14aa9740 2022-8-14 5:39:4 2721/41794/041.806 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 179 14aa9740 2022-8-14 5:39:4 2721/41794/041.806 zb_error_indication.c:121 [ERROR] call a stack handler 180 14aa9740 2022-8-14 5:39:4 2721/41794/041.806 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480744362 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 181 14aa9740 2022-8-14 5:39:4 2721/41794/041.806 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480744362 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 182 14aa9740 2022-8-14 5:39:4 2728/41902/041.914 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 183 14aa9740 2022-8-14 5:39:4 2728/41902/041.914 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 184 14aa9740 2022-8-14 5:39:4 2728/41902/041.914 zb_error_indication.c:121 [ERROR] call a stack handler 185 14aa9740 2022-8-14 5:39:4 2728/41902/041.914 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480744470 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 186 14aa9740 2022-8-14 5:39:4 2728/41902/041.914 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480744470 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 187 14aa9740 2022-8-14 5:39:4 2735/42009/042.020 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 188 14aa9740 2022-8-14 5:39:4 2735/42009/042.020 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 189 14aa9740 2022-8-14 5:39:4 2735/42009/042.020 zb_error_indication.c:121 [ERROR] call a stack handler 190 14aa9740 2022-8-14 5:39:4 2735/42009/042.020 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480744577 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 191 14aa9740 2022-8-14 5:39:4 2735/42009/042.020 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480744577 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 192 14aa9740 2022-8-14 5:39:4 2742/42117/042.128 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 193 14aa9740 2022-8-14 5:39:4 2742/42117/042.128 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 194 14aa9740 2022-8-14 5:39:4 2742/42117/042.128 zb_error_indication.c:121 [ERROR] call a stack handler 195 14aa9740 2022-8-14 5:39:4 2742/42117/042.128 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480744686 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 196 14aa9740 2022-8-14 5:39:4 2742/42117/042.128 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480744686 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 197 14aa9740 2022-8-14 5:39:4 2749/42224/042.236 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 198 14aa9740 2022-8-14 5:39:4 2749/42224/042.236 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 199 14aa9740 2022-8-14 5:39:4 2749/42224/042.236 zb_error_indication.c:121 [ERROR] call a stack handler 200 14aa9740 2022-8-14 5:39:4 2749/42224/042.236 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480744793 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 201 14aa9740 2022-8-14 5:39:4 2749/42224/042.236 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480744793 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 202 14aa9740 2022-8-14 5:39:4 2756/42332/042.343 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 203 14aa9740 2022-8-14 5:39:4 2756/42332/042.344 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 204 14aa9740 2022-8-14 5:39:4 2756/42332/042.344 zb_error_indication.c:121 [ERROR] call a stack handler 205 14aa9740 2022-8-14 5:39:4 2756/42332/042.344 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480744901 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 206 14aa9740 2022-8-14 5:39:4 2756/42332/042.344 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480744901 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 207 14aa9740 2022-8-14 5:39:5 2763/42439/042.451 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 208 14aa9740 2022-8-14 5:39:5 2763/42439/042.451 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 209 14aa9740 2022-8-14 5:39:5 2763/42439/042.451 zb_error_indication.c:121 [ERROR] call a stack handler 210 14aa9740 2022-8-14 5:39:5 2763/42439/042.451 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480745008 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 211 14aa9740 2022-8-14 5:39:5 2763/42439/042.451 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480745008 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 212 14aa9740 2022-8-14 5:39:5 2770/42547/042.558 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 213 14aa9740 2022-8-14 5:39:5 2770/42547/042.559 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 214 14aa9740 2022-8-14 5:39:5 2770/42547/042.559 zb_error_indication.c:121 [ERROR] call a stack handler 215 14aa9740 2022-8-14 5:39:5 2770/42547/042.559 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480745116 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 216 14aa9740 2022-8-14 5:39:5 2770/42547/042.559 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480745116 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 217 14aa9740 2022-8-14 5:39:5 2777/42654/042.667 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 218 14aa9740 2022-8-14 5:39:5 2777/42654/042.667 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 219 14aa9740 2022-8-14 5:39:5 2777/42654/042.667 zb_error_indication.c:121 [ERROR] call a stack handler 220 14aa9740 2022-8-14 5:39:5 2777/42654/042.667 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480745223 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 221 14aa9740 2022-8-14 5:39:5 2777/42654/042.667 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480745223 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 222 14aa9740 2022-8-14 5:39:5 2784/42762/042.775 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 223 14aa9740 2022-8-14 5:39:5 2784/42762/042.775 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 224 14aa9740 2022-8-14 5:39:5 2784/42762/042.775 zb_error_indication.c:121 [ERROR] call a stack handler 225 14aa9740 2022-8-14 5:39:5 2784/42762/042.775 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480745331 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 226 14aa9740 2022-8-14 5:39:5 2784/42762/042.775 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480745331 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 227 14aa9740 2022-8-14 5:39:5 2791/42869/042.883 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 228 14aa9740 2022-8-14 5:39:5 2791/42869/042.883 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 229 14aa9740 2022-8-14 5:39:5 2791/42869/042.883 zb_error_indication.c:121 [ERROR] call a stack handler 230 14aa9740 2022-8-14 5:39:5 2791/42869/042.883 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480745439 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 231 14aa9740 2022-8-14 5:39:5 2791/42869/042.883 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480745439 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 232 14aa9740 2022-8-14 5:39:5 2798/42977/042.991 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 233 14aa9740 2022-8-14 5:39:5 2798/42977/042.991 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 234 14aa9740 2022-8-14 5:39:5 2798/42977/042.991 zb_error_indication.c:121 [ERROR] call a stack handler 235 14aa9740 2022-8-14 5:39:5 2798/42977/042.991 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480745547 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 236 14aa9740 2022-8-14 5:39:5 2798/42977/042.991 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480745547 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 237 14aa9740 2022-8-14 5:39:5 2805/43084/043.098 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 238 14aa9740 2022-8-14 5:39:5 2805/43084/043.098 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 239 14aa9740 2022-8-14 5:39:5 2805/43084/043.098 zb_error_indication.c:121 [ERROR] call a stack handler 240 14aa9740 2022-8-14 5:39:5 2805/43084/043.098 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480745655 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 241 14aa9740 2022-8-14 5:39:5 2805/43084/043.098 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480745655 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 242 14aa9740 2022-8-14 5:39:5 2822/43345/043.353 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 243 14aa9740 2022-8-14 5:39:5 2822/43345/043.353 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 244 14aa9740 2022-8-14 5:39:5 2822/43345/043.353 zb_error_indication.c:121 [ERROR] call a stack handler 245 14aa9740 2022-8-14 5:39:5 2822/43345/043.353 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480745910 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 246 14aa9740 2022-8-14 5:39:5 2822/43345/043.353 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480745910 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 247 14aa9740 2022-8-14 5:39:6 2829/43453/043.460 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 248 14aa9740 2022-8-14 5:39:6 2829/43453/043.460 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 249 14aa9740 2022-8-14 5:39:6 2829/43453/043.460 zb_error_indication.c:121 [ERROR] call a stack handler 250 14aa9740 2022-8-14 5:39:6 2829/43453/043.460 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480746018 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 251 14aa9740 2022-8-14 5:39:6 2829/43453/043.461 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480746018 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 252 14aa9740 2022-8-14 5:39:6 2843/43668/043.672 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 253 14aa9740 2022-8-14 5:39:6 2843/43668/043.672 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 254 14aa9740 2022-8-14 5:39:6 2843/43668/043.672 zb_error_indication.c:121 [ERROR] call a stack handler 255 14aa9740 2022-8-14 5:39:6 2843/43668/043.672 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480746228 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 256 14aa9740 2022-8-14 5:39:6 2843/43668/043.672 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480746228 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] 257 14aa9740 2022-8-14 5:39:6 2850/43776/043.780 zb_osif_serial.c:117 [ERROR] failed to open file /dev/ttyACM1, errno: 2 258 14aa9740 2022-8-14 5:39:6 2850/43776/043.780 zb_error_indication.c:114 [ERROR] >> zb_error_raise severity 255, err_code -2049 259 14aa9740 2022-8-14 5:39:6 2850/43776/043.780 zb_error_indication.c:121 [ERROR] call a stack handler 260 14aa9740 2022-8-14 5:39:6 2850/43776/043.780 zb_error_indication.c:138 [ERROR] << zb_error_raise zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480746336 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) 261 14aa9740 2022-8-14 5:39:6 2850/43776/043.780 zb_osif_serial_common.c:147 [ERROR] Read error: serial transport is not initialized! zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480746336 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_init_complete: (RX-IDLE : TX-IDLE) zbncp_ll_poll: @ time 1660480746457 [ack size 0] zbncp_ll_rx_start_receiving: (RX-IDLE) zbncp_ll_rx_set_state: (RX-IDLE --> RX-RECEIVING-HDR) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480746457 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_poll: @ time 1660480750719 [ack size 0] zbncp_crc8: CRC8 init 00 data 0x55b79d53953a size 4 -> crc 0xde zbncp_crc16: CRC16 init 0000 data 0x55b79d539541 size 6 --> crc 0x47ce zbncp_ll_tx_alloc_pkt: (TX-IDLE) size 15 frame #0 zbncp_ll_tx_start_sending: (TX-IDLE) size 15 zbncp_ll_tx_set_state: (TX-IDLE --> TX-SENDING-PKT) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480750719 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_tx_set_state: (TX-SENDING-PKT --> TX-PKT-SENT) zbncp_ll_send_complete: (RX-RECEIVING-HDR : TX-SENDING-PKT --> TX-PKT-SENT) zbncp_ll_poll: @ time 1660480750719 [ack size 0] zbncp_ll_tx_start_waiting_ack: (TX-PKT-SENT) (RX-RECEIVING-HDR) zbncp_ll_alarm_set: 500 zbncp_ll_tx_set_state: (TX-PKT-SENT --> TX-IDLE) zbncp_ll_poll: >>> timeout 500/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480750719 [ack size 0] zbncp_ll_poll: >>> timeout 500 [ack size 0] zbncp_ll_poll: @ time 1660480751225 [ack size 0] zbncp_ll_alarm_cancel: alerting zbncp_ll_alert_wait_ack: (RX-RECEIVING-HDR : TX-IDLE) zbncp_ll_poll: >>> timeout 0/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480751225 [ack size 0] zbncp_ll_tx_start_sending: (TX-IDLE) size 15 zbncp_ll_tx_set_state: (TX-IDLE --> TX-SENDING-PKT) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480751225 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_tx_set_state: (TX-SENDING-PKT --> TX-PKT-SENT) zbncp_ll_send_complete: (RX-RECEIVING-HDR : TX-SENDING-PKT --> TX-PKT-SENT) zbncp_ll_poll: @ time 1660480751225 [ack size 0] zbncp_ll_tx_start_waiting_ack: (TX-PKT-SENT) (RX-RECEIVING-HDR) zbncp_ll_alarm_set: 500 zbncp_ll_tx_set_state: (TX-PKT-SENT --> TX-IDLE) zbncp_ll_poll: >>> timeout 500/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480751225 [ack size 0] zbncp_ll_poll: >>> timeout 500 [ack size 0] zbncp_ll_poll: @ time 1660480751732 [ack size 0] zbncp_ll_alarm_cancel: alerting zbncp_ll_alert_wait_ack: (RX-RECEIVING-HDR : TX-IDLE) zbncp_ll_poll: >>> timeout 0/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480752315 [ack size 0] zbncp_ll_tx_start_sending: (TX-IDLE) size 15 zbncp_ll_tx_set_state: (TX-IDLE --> TX-SENDING-PKT) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480752315 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_tx_set_state: (TX-SENDING-PKT --> TX-PKT-SENT) zbncp_ll_send_complete: (RX-RECEIVING-HDR : TX-SENDING-PKT --> TX-PKT-SENT) zbncp_ll_poll: @ time 1660480752315 [ack size 0] zbncp_ll_tx_start_waiting_ack: (TX-PKT-SENT) (RX-RECEIVING-HDR) zbncp_ll_alarm_set: 500 zbncp_ll_tx_set_state: (TX-PKT-SENT --> TX-IDLE) zbncp_ll_poll: >>> timeout 500/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480752315 [ack size 0] zbncp_ll_poll: >>> timeout 500 [ack size 0] zbncp_ll_poll: @ time 1660480752315 [ack size 0] zbncp_ll_poll: >>> timeout 500 [ack size 0] zbncp_ll_poll: @ time 1660480752821 [ack size 0] zbncp_ll_alarm_cancel: alerting zbncp_ll_alert_wait_ack: (RX-RECEIVING-HDR : TX-IDLE) zbncp_ll_poll: >>> timeout 0/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480752822 [ack size 0] zbncp_ll_alarm_cancel: 18446744073709551615 zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RECEIVING-HDR --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RECEIVING-HDR --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757616 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757617 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757618 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757618 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757618 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757618 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757618 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757618 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757725 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757726 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757727 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757728 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757729 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757730 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757731 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0] zbncp_ll_rx_set_state: (RX-RESYNC --> RX-HDR-RECEIVED) zbncp_ll_recv_complete: (RX-RESYNC --> RX-HDR-RECEIVED : TX-IDLE) zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_rx_validate_header: (RX-HDR-RECEIVED) size 7 zbncp_ll_rx_resync: (RX-HDR-RECEIVED) RESYNC!!! zbncp_ll_rx_set_state: (RX-HDR-RECEIVED --> RX-RESYNC) zbncp_ll_poll: >>> timeout 18446744073709551615/SERVICE [ack size 0] zbncp_ll_poll: @ time 1660480757732 [ack size 0] zbncp_ll_poll: >>> timeout 18446744073709551615 [ack size 0]