[]waiting for first connection on #7... [INFO]znp_misc sendNPIExpectDefaultStatusZNP: subSys:1, cmdID:9, len:5 []preparing to send 5 bytes, subSys 0x01, cmdId 0x09, pData: [] 0x87[] 0x00[] 0x00[] 0x01[] 0x00[] [INFO][MUTEX] Lock SRSP Mutex[INFO] [MUTEX] SRSP Lock status: 0 [INFO]Waiting for synchronous response... [INFO][MUTEX] Wait for SRSP Cond signal... NPI SREQ: (len 8) 0x05 0x21 0x09 0x87 0x00 0x00 0x01 0x00 Send>>>>>> 0xfe 0x05 0x21 0x09 0x87 0x00 0x00 0x01 0x00 0xab ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x61, Cmd ID: 0x09, length: 1 ,Data: 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x01 0x61 0x09 0x00 0x69 NPI SRSP: (len 4) 0x01 0x61 0x09 0x00 ...sent 4 bytes to Client #5 !Done Receive message... []Received 1 bytes, subSys 0x61, cmdId 0x09, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): []client Recv data []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex []Connected to #8.(127.0.0.1 / ::) [INFO]zstackpb zspbHandlePbCb - connected: 8 [INFO]<<>>>>> 0xfe 0x02 0x25 0x3e 0xff 0xff 0x19 ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x65, Cmd ID: 0x3E, length: 1 ,Data: 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x01 0x65 0x3e 0x00 0x5a NPI SRSP: (len 4) 0x01 0x65 0x3E 0x00 ...sent 4 bytes to Client #5 !Done Receive message... []Received 1 bytes, subSys 0x65, cmdId 0x3E, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): []client Recv data []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex zstackpb config: defaultChannelList:800, configPANID:ffff, deviceType:0 [INFO]znp_misc sendNPIExpectDefaultStatusZNP: subSys:1, cmdID:9, len:8 []preparing to send 8 bytes, subSys 0x01, cmdId 0x09, pData: [] 0x84[] 0x00[] 0x00[] 0x04[] 0x00[] 0x08[] 0x00[] 0x00[] [INFO][MUTEX] Lock SRSP Mutex[INFO] [MUTEX] SRSP Lock status: 0 [INFO]Waiting for synchronous response... [INFO][MUTEX] Wait for SRSP Cond signal... NPI SREQ: (len 11) 0x08 0x21 0x09 0x84 0x00 0x00 0x04 0x00 0x08 0x00 0x00 Send>>>>>> 0xfe 0x08 0x21 0x09 0x84 0x00 0x00 0x04 0x00 0x08 0x00 0x00 0xa8 ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x61, Cmd ID: 0x09, length: 1 ,Data: 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x01 0x61 0x09 0x00 0x69 NPI SRSP: (len 4) 0x01 0x61 0x09 0x00 ...sent 4 bytes to Client #5 !Done Receive message... []Received 1 bytes, subSys 0x61, cmdId 0x09, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): []client Recv data []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex [INFO]znp_misc sendNPIExpectDefaultStatusZNP: subSys:1, cmdID:9, len:6 []preparing to send 6 bytes, subSys 0x01, cmdId 0x09, pData: [] 0x83[] 0x00[] 0x00[] 0x02[] 0xFF[] 0xFF[] [INFO][MUTEX] Lock SRSP Mutex[INFO] [MUTEX] SRSP Lock status: 0 [INFO]Waiting for synchronous response... [INFO][MUTEX] Wait for SRSP Cond signal... NPI SREQ: (len 9) 0x06 0x21 0x09 0x83 0x00 0x00 0x02 0xFF 0xFF Send>>>>>> 0xfe 0x06 0x21 0x09 0x83 0x00 0x00 0x02 0xff 0xff 0xaf ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x61, Cmd ID: 0x09, length: 1 ,Data: 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x01 0x61 0x09 0x00 0x69 NPI SRSP: (len 4) 0x01 0x61 0x09 0x00 ...sent 4 bytes to Client #5 !Done Receive message... []Received 1 bytes, subSys 0x61, cmdId 0x09, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): []client Recv data []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex [INFO]znp_misc sendNPIExpectDefaultStatusZNP: subSys:1, cmdID:9, len:5 []preparing to send 5 bytes, subSys 0x01, cmdId 0x09, pData: [] 0x87[] 0x00[] 0x00[] 0x01[] 0x00[] [INFO][MUTEX] Lock SRSP Mutex[INFO] [MUTEX] SRSP Lock status: 0 [INFO]Waiting for synchronous response... [INFO][MUTEX] Wait for SRSP Cond signal... NPI SREQ: (len 8) 0x05 0x21 0x09 0x87 0x00 0x00 0x01 0x00 Send>>>>>> 0xfe 0x05 0x21 0x09 0x87 0x00 0x00 0x01 0x00 0xab ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x61, Cmd ID: 0x09, length: 1 ,Data: 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x01 0x61 0x09 0x00 0x69 NPI SRSP: (len 4) 0x01 0x61 0x09 0x00 ...sent 4 bytes to Client #5 !Done []Received 1 bytes, subSys 0x61, cmdId 0x09, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): Receive message... []client Recv data []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex [INFO]znp_misc sendNPIExpectDefaultStatusZNP: subSys:1, cmdID:15, len:7 []preparing to send 7 bytes, subSys 0x01, cmdId 0x15, pData: [] 0x96[] 0x00[] 0xC4[] 0x64[] 0x00[] 0x00[] 0x00[] [INFO][MUTEX] Lock SRSP Mutex[INFO] [MUTEX] SRSP Lock status: 0 [INFO]Waiting for synchronous response... [INFO][MUTEX] Wait for SRSP Cond signal... NPI SREQ: (len 10) 0x07 0x21 0x15 0x96 0x00 0xC4 0x64 0x00 0x00 0x00 Send>>>>>> 0xfe 0x07 0x21 0x15 0x96 0x00 0xc4 0x64 0x00 0x00 0x00 0x05 ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x60, Cmd ID: 0x00, length: 3 ,Data: 0x00, 0x00, 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x03 0x60 0x00 0x02 0x21 0x15 0x55 NPI SRSP: (len 4) 0x01 0x61 0x15 0xFF []Received 1 bytes, subSys 0x61, cmdId 0x15, mask 0x60, pData: [INFO] 0xFF [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): ...sent 4 bytes to Client #5 !Done Receive message... []client Recv data []0xFF [] [INFO][MUTEX] Unlock SRSP Mutex [DEBUG]--> status failed: cmdID:15, status: 255 [INFO]znp_misc sendAPICZNP: subSys:5, cmdID:40, len:0 [INFO]trying to send 0 bytes, subSys 0x05, cmdId 0x40, pData: NPI AREQ: (len 3) 0x00 0x45 0x40 Send>>>>>> 0xfe 0x00 0x45 0x40 0x05 !Done Receive message... Recv 0xfd [INFO]...sent 9 bytes to Client [INFO]<<>>>>> 0xfe 0x21 0x24 0x00 0x02 0x04 0x01 0x07 0x00 0x00 0x00 0x06 0x00 0x00 0x03 0x00 0x06 0x00 0x00 0x05 0x01 0x0 5 0x02 0x05 0x06 0x06 0x00 0x09 0x00 0x20 0x00 0x00 0x05 0x01 0x05 0x02 0x05 0x2f ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x64, Cmd ID: 0x00, length: 1 ,Data: 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x01 0x64 0x00 0x00 0x65 NPI SRSP: (len 4) 0x01 0x64 0x00 0x00 ...sent 4 bytes to Client #5 !Done Receive message... []Received 1 bytes, subSys 0x64, cmdId 0x00, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): []client Recv data []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex [INFO]...sent 8 bytes to Client [INFO]!Done [INFO]<<>>>>> 0xfe 0x19 0x24 0x00 0x03 0x04 0x01 0x00 0x01 0x00 0x00 0x06 0x00 0x00 0x03 0x00 0x04 0x00 0x05 0x00 0x06 0x0 0 0x01 0x05 0x02 0x06 0x00 0x02 0x04 0x3e ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x64, Cmd ID: 0x00, length: 1 ,Data: 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x01 0x64 0x00 0x00 0x65 NPI SRSP: (len 4) 0x01 0x64 0x00 0x00 []Received 1 bytes, subSys 0x64, cmdId 0x00, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): ...sent 4 bytes to Client #5 !Done Receive message... []client Recv data []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex [INFO]...sent 8 bytes to Client [INFO]!Done [INFO]<<>>>>> 0xfe 0x19 0x24 0x00 0x04 0x04 0x01 0x01 0x01 0x00 0x00 0x06 0x00 0x00 0x03 0x00 0x04 0x00 0x05 0x00 0x06 0x0 0 0x08 0x00 0x02 0x06 0x00 0x08 0x00 0x3a ret 0 [INFO]Waiting for synchronous response... [INFO][MUTEX] Wait for SRSP Cond signal... [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x64, Cmd ID: 0x00, length: 1 ,Data: 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x01 0x64 0x00 0x00 0x65 NPI SRSP: (len 4) 0x01 0x64 0x00 0x00 ...sent 4 bytes to Client #5 !Done Receive message... []Received 1 bytes, subSys 0x64, cmdId 0x00, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): []client Recv data []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex [INFO]...sent 8 bytes to Client [INFO]!Done [INFO]<<>>>>> 0xfe 0x1d 0x24 0x00 0x05 0x04 0x01 0x02 0x01 0x00 0x00 0x07 0x00 0x00 0x03 0x00 0x04 0x00 0x05 0x00 0x06 0x0 0 0x08 0x00 0x00 0x03 0x03 0x06 0x00 0x08 0x00 0x00 0x03 0x3c ret 0 [INFO]Waiting for synchronous response... [INFO][MUTEX] Wait for SRSP Cond signal... [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x64, Cmd ID: 0x00, length: 1 ,Data: 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x01 0x64 0x00 0x00 0x65 NPI SRSP: (len 4) 0x01 0x64 0x00 0x00 ...sent 4 bytes to Client #5 !Done Receive message... []Received 1 bytes, subSys 0x64, cmdId 0x00, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): []client Recv data []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex [INFO]...sent 8 bytes to Client [INFO]!Done [INFO]<<>>>>> 0xfe 0x1d 0x24 0x00 0x06 0x04 0x01 0x02 0x01 0x00 0x00 0x07 0x00 0x00 0x03 0x00 0x04 0x00 0x05 0x00 0x06 0x0 0 0x08 0x00 0x00 0x03 0x03 0x06 0x00 0x08 0x00 0x00 0x03 0x3f ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x64, Cmd ID: 0x00, length: 1 ,Data: 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x01 0x64 0x00 0x00 0x65 NPI SRSP: (len 4) 0x01 0x64 0x00 0x00 ...sent 4 bytes to Client #5 !Done Receive message... []Received 1 bytes, subSys 0x64, cmdId 0x00, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): []client Recv data []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex [INFO]...sent 8 bytes to Client [INFO]!Done [INFO]<<>>>>> 0xfe 0x00 0x25 0x50 0x75 ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x65, Cmd ID: 0x50, length: 24 ,Data: 0x20, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x68, 0x82, 0x62, 0x00, 0x00, 0x09, 0xdb, 0x99, 0x00, 0x00, 0xce, 0xda, 0x9b, 0x17, 0x00, 0x4b, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x18 0x65 0x50 0x00 0x00 0x09 0xdb 0x99 0x00 0x00 0xce 0xda 0x9b 0x17 0x00 0x4b 0x12 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x0b 0xac NPI SRSP: (len 27) 0x18 0x65 0x50 0x00 0x00 0x09 0xDB 0x99 0x00 0x00 0xCE 0xDA 0x9B 0x17 0x00 0x4B 0x12 0x00 0x00 0x00 0 x00 0x00 0x00 0x00 0x00 0x00 0x0B ...sent 27 bytes to Client #5 !Done Receive message... []Received 24 bytes, subSys 0x65, cmdId 0x50, mask 0x60, pData: [INFO] 0x0 [INFO] 0x0 [INFO] 0x9 [INFO] 0xDB [INFO] 0x99 [INFO] 0x0 [INFO] 0x0 [INFO] 0xCE [INFO] 0xDA [INFO] 0x9B [INFO] 0x17 [INFO] 0x0 [INFO] 0x4B [INFO] 0x12 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0xB [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): []client Recv data []0x00 []0x00 []0x09 []0xDB []0x99 []0x00 []0x00 []0xCE []0xDA []0x9B []0x17 []0x00 []0x4B []0x12 []0x00 []0x00 []0x00 [ ]0x00 []0x00 []0x00 []0x00 []0x00 []0x00 []0x0B [] [INFO][MUTEX] Unlock SRSP Mutex [INFO]zstackpb Sending Network Info Response [INFO]znp_misc osal_nv_read: id:1, len:8 []preparing to send 3 bytes, subSys 0x01, cmdId 0x08, pData: [] 0x01[] 0x00[] 0x00[] [INFO][MUTEX] Lock SRSP Mutex[INFO] [MUTEX] SRSP Lock status: 0 [INFO]Waiting for synchronous response... [INFO][MUTEX] Wait for SRSP Cond signal... NPI SREQ: (len 6) 0x03 0x21 0x08 0x01 0x00 0x00 Send>>>>>> 0xfe 0x03 0x21 0x08 0x01 0x00 0x00 0x2b ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x61, Cmd ID: 0x08, length: 10 ,Data: 0x10, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x09, 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x0a 0x61 0x08 0x00 0x08 0xce 0xda 0x9b 0x17 0x00 0x4b 0x12 0x00 0xaa NPI SRSP: (len 13) 0x0A 0x61 0x08 0x00 0x08 0xCE 0xDA 0x9B 0x17 0x00 0x4B 0x12 0x00 ...sent 13 bytes to Client #5 !Done Receive message... []Received 10 bytes, subSys 0x61, cmdId 0x08, mask 0x60, pData: [INFO] 0x0 [INFO] 0x8 [INFO] 0xCE [INFO] 0xDA [INFO] 0x9B [INFO] 0x17 [INFO] 0x0 [INFO] 0x4B [INFO] 0x12 [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): []client Recv data []0x00 []0x08 []0xCE []0xDA []0x9B []0x17 []0x00 []0x4B []0x12 []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex [INFO]...sent 53 bytes to Client [INFO]!Done [INFO]<<>>Durtion 0x0 []preparing to send 0 bytes, subSys 0x05, cmdId 0x50, pData: [] [INFO][MUTEX] Lock SRSP Mutex[INFO] [MUTEX] SRSP Lock status: 0 NPI SREQ: (len 3) 0x00 0x25 0x50 Send>>>>>> 0xfe 0x00 0x25[INFO]Waiting for synchronous response... [INFO][MUTEX] Wait for SRSP Cond signal... 0x50 0x75 ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x65, Cmd ID: 0x50, length: 24 ,Data: 0x20, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x68, 0x82, 0x62, 0x00, 0x00, 0x09, 0xdb, 0x99, 0x00, 0x00, 0xce, 0xda, 0x9b, 0x17, 0x00, 0x4b, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x18 0x65 0x50 0x00 0x00 0x09 0xdb 0x99 0x00 0x00 0xce 0xda 0x9b 0x17 0x00 0x4b 0x12 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x00 0x0b 0xac NPI SRSP: (len 27) 0x18 0x65 0x50 0x00 0x00 0x09 0xDB 0x99 0x00 0x00 0xCE 0xDA 0x9B 0x17 0x00 0x4B 0x12 0x00 0x00 0x00 0 x00 0x00 0x00 0x00 0x00 0x00 0x0B ...sent 27 bytes to Client #5 !Done Receive message... []Received 24 bytes, subSys 0x65, cmdId 0x50, mask 0x60, pData: [INFO] 0x0 [INFO] 0x0 [INFO] 0x9 [INFO] 0xDB [INFO] 0x99 [INFO] 0x0 [INFO] 0x0 [INFO] 0xCE [INFO] 0xDA [INFO] 0x9B [INFO] 0x17 [INFO] 0x0 [INFO] 0x4B [INFO] 0x12 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0xB [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): []client Recv data []0x00 []0x00 []0x09 []0xDB []0x99 []0x00 []0x00 []0xCE []0xDA []0x9B []0x17 []0x00 []0x4B []0x12 []0x00 []0x00 []0x00 [ ]0x00 []0x00 []0x00 []0x00 []0x00 []0x00 []0x0B [] [INFO][MUTEX] Unlock SRSP Mutex >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>dstAddr.addr.shortAddr 0x0 [INFO]znp_misc sendNPIExpectDefaultStatusZNP: subSys:5, cmdID:36, len:5 []preparing to send 5 bytes, subSys 0x05, cmdId 0x36, pData: [] 0x02[] 0x00[] 0x00[] 0x00[] 0x00[] [INFO][MUTEX] Lock SRSP Mutex[INFO] [MUTEX] SRSP Lock status: 0 [INFO]Waiting for synchronous response... [INFO][MUTEX] Wait for SRSP Cond signal... NPI SREQ: (len 8) 0x05 0x25 0x36 0x02 0x00 0x00 0x00 0x00 Send>>>>>> 0xfe 0x05 0x25 0x36 0x02 0x00 0x00 0x00 0x00 0x14 ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x65, Cmd ID: 0x36, length: 1 ,Data: 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x45, Cmd ID: 0xCB, length: 1 ,Data: 0x00, [UART] npi_procframe signal areq callback thread (invoked by read loop) [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x45, Cmd ID: 0xFF, length: 10 ,Data: 0x10, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, [-->] 1 bytes, subSys 0x45, cmdId 0xCB, pData: 0x00 NPI SRSP: (len 4) 0x01 0x65 0x36 0x00 0x00, 0x09, 0x00, [UART] npi_procframe signal areq callback thread (invoked by read loop) Recv 0xfe 0x01 0x65 0x36 0x00 0x52 0xfe 0x01 0x45 0xcb 0x00 0x8f 0xfe 0x0a 0x45 0xff 0x00 0x00 0x00 0x36 0x80 0x00 0x00 0x00 0x00 0x00 0x06 ...sent 4 bytes to Client #5 [-->] 10 bytes, subSys 0x45, cmdId 0xFF, pData: 0x00 0x00 0x00 0x36 0x80 0x00 0x00 0x00...sent 4 bytes to Client #5 !Done []Received 1 bytes, subSys 0x65, cmdId 0x36, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set 0x00 0x00 ...sent 13 bytes to Client #5 Receive message... [INFO]Client Read: (len 0): []client Recv data []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex >>>>>>>>>>>>1dstAddr.addr.shortAddr 0xfffc [INFO]znp_misc sendNPIExpectDefaultStatusZNP: subSys:5, cmdID:36, len:5 []preparing to send 5 bytes, subSys 0x05, cmdId 0x36, pData: [] 0x02[] 0xFC[] 0xFF[] 0x00[] 0x00[] [INFO][MUTEX] Lock SRSP Mutex[INFO] [MUTEX] SRSP Lock status: 0 [INFO]Waiting for synchronous response... [INFO][MUTEX] Wait for SRSP Cond signal... NPI SREQ: (len 8) 0x05 0x25 0x36 0x02 0xFC 0xFF 0x00 0x00 Send>>>>>> 0xfe 0x05 0x25 0x36 0x02 0xfc 0xff 0x00 0x00 0x17 []Received 1 bytes, subSys 0x65, cmdId 0x36, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): ret 0 []Received 10 bytes, subSys 0x45, cmdId 0xFF, mask 0x40, pData: [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x36 [INFO] 0x80 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO]RPC_CMD_AREQ cmdId: 0xFF [INFO][MUTEX] Mutex for AREQ unlocked [INFO][MUTEX] AREQ Calling asynchMsgCback (Handle)... [DEBUG]znp_misc handleAsyncMsgs: Unrecognized subSys: 5, cmdID:ff []zstackpb Sending ZDO Rsp/Ind Msg - clusterID: 0x8036 [INFO]zstackpb Sending Mgmt Permit Join Response Ind [INFO]...sent 10 bytes to Client [INFO][MUTEX] Wait for AREQ semaphore []client Recv data []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex [INFO]...sent 8 bytes to Client [INFO]!Done [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x65, Cmd ID: 0x36, length: 1 ,Data: 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x01 0x65 0x36 0x00 0x52 NPI SRSP: (len 4) 0x01 0x65 0x36 0x00 ...sent 4 bytes to Client #5 !Done Receive message... [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x45, Cmd ID: 0xFF, length: 10 ,Data: 0x10, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x73, 0x71, [UART] npi_procframe signal areq callback thread (invoked by read loop) Recv 0xfe 0x0a 0x45 0xff 0x00 0x00 0x00 0x36 0x80 0x00 0x01 0x00 0x00 0x00 0x07 [-->] 10 bytes, subSys 0x45, cmdId 0xFF, pData: 0x00 0x00 0x00 0x36 0x80 0x00 0x01 0x00 0x00 0x00 ...sent 13 bytes to Client #5 []Received 1 bytes, subSys 0x65, cmdId 0x36, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): []Received 10 bytes, subSys 0x45, cmdId 0xFF, mask 0x40, pData: [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x36 [INFO] 0x80 [INFO] 0x0 [INFO] 0x1 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO]RPC_CMD_AREQ cmdId: 0xFF [INFO][MUTEX] Mutex for AREQ unlocked [INFO][MUTEX] AREQ Calling asynchMsgCback (Handle)... [DEBUG]znp_misc handleAsyncMsgs: Unrecognized subSys: 5, cmdID:ff []zstackpb Sending ZDO Rsp/Ind Msg - clusterID: 0x8036 [INFO]zstackpb Sending Mgmt Permit Join Response Ind [INFO]...sent 10 bytes to Client [INFO][MUTEX] Wait for AREQ semaphore [INFO]<<>>Durtion 0x19 []preparing to send 0 bytes, subSys 0x05, cmdId 0x50, pData: [] [INFO][MUTEX] Lock SRSP Mutex[INFO] [MUTEX] SRSP Lock status: 0 [INFO]Waiting for synchronous response... [INFO][MUTEX] Wait for SRSP Cond signal... NPI SREQ: (len 3) 0x00 0x25 0x50 Send>>>>>> 0xfe 0x00 0x25 0x50 0x75 ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x65, Cmd ID: 0x50, length: 24 ,Data: 0x20, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x68, 0x82, 0x62, 0x00, 0x00, 0x09, 0xdb, 0x99, 0x00, 0x00, 0xce, 0xda, 0x9b, 0x17, 0x00, 0x4b, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x18 0x65 0x50 0x00 0x00 0x09 0xdb 0x99 0x00 0x00 0xce 0xda 0x9b 0x17 0x00 0x4b 0x12 0x00 0x00 0x00 0x00 0x00 0x00NPI SRSP: (len 27) 0x18 0x65 0x50 0x00 0x00 0x09 0xDB 0x99 0x00 0x00 0xCE 0xDA 0x9B 0x17 0x00 0x4B 0x12 0x00 0x00 0 x00 0x00 0x00 0x00 0x00 0x00 0x00 0x0B 0x00 0x00 0x00 0x0b 0xac ...sent 27 bytes to Client #5 !Done Receive message... []Received 24 bytes, subSys 0x65, cmdId 0x50, mask 0x60, pData: [INFO] 0x0 [INFO] 0x0 [INFO] 0x9 [INFO] 0xDB [INFO] 0x99 [INFO] 0x0 [INFO] 0x0 [INFO] 0xCE [INFO] 0xDA [INFO] 0x9B [INFO] 0x17 [INFO] 0x0 [INFO] 0x4B [INFO] 0x12 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0xB [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 4): [][ERR] Unhandled SRSP cleared []client Recv data []0x00 []0x00 []0x09 []0xDB []0x99 []0x00 []0x00 []0xCE []0xDA []0x9B []0x17 []0x00 []0x4B []0x12 []0x00 []0x00 []0x00 [ ]0x00 []0x00 []0x00 []0x00 []0x00 []0x00 []0x0B [] [INFO][MUTEX] Unlock SRSP Mutex >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>dstAddr.addr.shortAddr 0x0 [INFO]znp_misc sendNPIExpectDefaultStatusZNP: subSys:5, cmdID:36, len:5 []preparing to send 5 bytes, subSys 0x05, cmdId 0x36, pData: [] 0x02[] 0x00[] 0x00[] 0x19[] 0x00[] [INFO][MUTEX] Lock SRSP Mutex[INFO] [MUTEX] SRSP Lock status: 0 [INFO]Waiting for synchronous response... [INFO][MUTEX] Wait for SRSP Cond signal... NPI SREQ: (len 8) 0x05 0x25 0x36 0x02 0x00 0x00 0x19 0x00 Send>>>>>> 0xfe 0x05 0x25 0x36 0x02 0x00 0x00 0x19 0x00 0x0d ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x65, Cmd ID: 0x36, length: 1 ,Data: 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x01 0x65 0x36 0x00 0x52 NPI SRSP: (len 4) 0x01 0x65 0x36 0x00 ...sent 4 bytes to Client #5 !Done Receive message... []Received 1 bytes, subSys 0x65, cmdId 0x36, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): []client Recv data []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex >>>>>>>>>>>>1dstAddr.addr.shortAddr 0xfffc [INFO]znp_misc sendNPIExpectDefaultStatusZNP: subSys:5, cmdID:36, len:5 []preparing to send 5 bytes, subSys 0x05, cmdId 0x36, pData: [] 0x02[] 0xFC[] 0xFF[] 0x19[] 0x00[] [INFO][MUTEX] Lock SRSP Mutex[INFO] [MUTEX] SRSP Lock status: 0 [INFO]Waiting for synchronous response... [INFO][MUTEX] Wait for SRSP Cond signal... NPI SREQ: (len 8) 0x05 0x25 0x36 0x02 0xFC 0xFF 0x19 0x00 Send>>>>>> 0xfe 0x05 0x25 0x36 0x02 0xfc 0xff 0x19 0x00 0x0e ret 0 [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x45, Cmd ID: 0xCB, length: 1 ,Data: 0x00, [UART] npi_procframe signal areq callback thread (invoked by read loop) [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x45, Cmd ID: 0xFF, length: 10 ,Data: 0x10, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x44, 0x65, [UART] npi_procframe signal areq callback thread (invoked by read loop) Recv 0xfe 0x01 0x45 0xcb 0x19 0x96 0xfe 0x0a 0x45 0xff 0x00 0x00 0x00 0x36 0x80 0x00 0x03 0x00 0x00 0x00 0x05 [-->] 1 bytes, subSys 0x45, cmdId 0xCB, pData: 0x19 ...sent 4 bytes to Client #5 [-->] 10 bytes, subSys 0x45, cmdId 0xFF, pData: 0x00 0x00 0x00 0x36 0x80 0x00 0x03 0x00 0x00 0x00 []Received 1 bytes, subSys 0x45, cmdId 0xCB, mask 0x40, pData: [INFO] 0x19 [INFO]RPC_CMD_AREQ cmdId: 0xCB ...sent 13 bytes to Client #5 [INFO][MUTEX] Mutex for AREQ unlocked [INFO][MUTEX] AREQ Calling asynchMsgCback (Handle)... [DEBUG]znp_misc handleAsyncMsgs: Unrecognized subSys: 5, cmdID:cb [INFO]zstackpb Sending Dev Permit Join Ind: 0x19 [INFO]...sent 9 bytes to Client [INFO][MUTEX] Wait for AREQ semaphore [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x65, Cmd ID: 0x36, length: 1 ,Data: 0x00, [UART] npi_procframe signal synch response received (invoked by read loop) Recv 0xfe 0x01 0x65 0x36 0x00 0x52 NPI SRSP: (len 4) 0x01 0x65 0x36 0x00 ...sent 4 bytes to Client #5 !Done Receive message... [UART] npi_parseframe: found frame, going to npi_procframe [UART] npi_procframe, subsys: 0x45, Cmd ID: 0xFF, length: 10 ,Data: 0x10, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x6d, 0x61, [UART] npi_procframe signal areq callback thread (invoked by read loop) Recv 0xfe 0x0a 0x45 0xff 0x00 0x00 0x00 0x36 0x80 0x00 0x04 0x00 0x00 0x00 0x02 [-->] 10 bytes, subSys 0x45, cmdId 0xFF, pData: 0x00 0x00 0x00 0x36 0x80 0x00 0x04 0x00 0x00 0x00 ...sent 13 bytes to Client #5 []Received 10 bytes, subSys 0x45, cmdId 0xFF, mask 0x40, pData: [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x36 [INFO] 0x80 [INFO] 0x0 [INFO] 0x3 [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO]RPC_CMD_AREQ cmdId: 0xFF []Received 1 bytes, subSys 0x65, cmdId 0x36, mask 0x60, pData: [INFO] 0x0 [INFO][MUTEX] SRSP Cond signal set [INFO]Client Read: (len 0): []Received 10 bytes, subSys 0x45, cmdId 0xFF, mask 0x40, pData: [INFO] 0x0 [INFO] 0x0 [INFO] 0x0 [INFO] 0x36 [INFO] 0x80 [INFO] 0x0 [INFO] 0x4 []client Recv data [INFO][MUTEX] Mutex for AREQ unlocked [INFO][MUTEX] AREQ Calling asynchMsgCback (Handle)... [INFO] 0x0 []0x00 [] [INFO][MUTEX] Unlock SRSP Mutex [INFO] 0x0 [INFO] 0x0 [INFO]RPC_CMD_AREQ cmdId: 0xFF [INFO]...sent 8 bytes to Client [INFO]!Done [DEBUG]znp_misc handleAsyncMsgs: Unrecognized subSys: 5, cmdID:ff []zstackpb Sending ZDO Rsp/Ind Msg - clusterID: 0x8036 [INFO]zstackpb Sending Mgmt Permit Join Response Ind [INFO]...sent 10 bytes to Client [INFO][MUTEX] Wait for AREQ semaphore [INFO][MUTEX] Mutex for AREQ unlocked [INFO][MUTEX] AREQ Calling asynchMsgCback (Handle)... [DEBUG]znp_misc handleAsyncMsgs: Unrecognized subSys: 5, cmdID:ff []zstackpb Sending ZDO Rsp/Ind Msg - clusterID: 0x8036 [INFO]zstackpb Sending Mgmt Permit Join Response Ind [INFO]...sent 10 bytes to Client [INFO][MUTEX] Wait for AREQ semaphore Recv 0xfd Recv 0xfd Recv 0xfd 0xfd 0xfd Recv 0xfd 0xfd 0xfd Recv 0xfd 0xfd Recv 0xfd 0xfd 0xfd Recv 0xfd 0xfd Recv 0xfd Recv 0xfd Recv 0xfd 0xfd 0xfd 0xfd Recv 0xfd 0xfd Recv 0xfd 0xfd Recv 0xfd 0xfd Recv 0xfd 0xfd Recv 0xfd 0xfd Recv 0xfd Recv 0xfd 0xfd Recv 0xfd 0xfd Recv 0xfd 0xfd Recv 0xfd Recv 0xfd Recv 0xfd 0xfd Recv 0xfd 0xfd Recv 0xfd Recv 0xfd Recv 0xfd 0xfd Recv 0xfd Recv 0xfd 0xfd Recv 0xfd 0xfd Recv 0xfd 0xfd 0xfd Recv 0xfd Recv 0xfd ^C