• State
  • Locked Locked
  • Replies 11 replies
  • Subscribers 55 subscribers
  • Views 585 views
  • Users 0 members are here
Support feedback
Options
Options
Similar topics

This thread has been locked.

If you have a related question, please click the "Ask a related question" button in the top right corner. The newly created question will be automatically linked to this question.

Original question:

Linux/CC2530: Z-Stack_Linux_Gateway porting problem

CC2530: Problem with modifying Z-Stack Linux Gateway code, Gateway server doesn't answer after a while

Ahmad.TI
Expert 1780 points
Part Number: CC2530
Other Parts Discussed in Thread: Z-STACK

Hello, I wanted to write my own application to communicate with Z-Stack Linux Gateway for sending and receiving commands or data, so I added a tcp client beside three clients that already exist in the ZSGW code and are connected to the Gateway, Network Manager, and OTA servers. My client connects to  my own server and receive commands from it and then sends it to ZSGW apis to run it and also sends data back to my server. But the problem that sometimes happen is that after some commands are sent to my client, the Gateway server doesn't answer to any commands anymore and also sending no data back to ZSGW. I have to reset Zigbee Servers in order to GW Server works as usual. Do you have any idea what is the problem?!

  • 0
    TI__Guru**** 202126 points

    Hello Ahmad,

    Can you provide any further information detailing how to replicate this issue?  It is the application's responsibility to detect client disconnections or server restarts and act accordingly.  Please make sure to borrow from the Gateway Sample Application files in source/Projects/zstack/linux/demo and reference the Overview of Gateway Application sections of the Developer's Guide: http://software-dl.ti.com/simplelink/esd/zigbee_3_0_Linux/1.0.1/exports/Documents/Z-Stack%20Linux%20Gateway%20-%20Developer's%20Guide.html#overview-of-gateway-application 

    Regards,
    Ryan

  • 0 in reply to Ryan Brown1
    Expert 1780 points

    I used the GW Sample Application and just modified the way that commands are received from user or data are sent to the user and so I used socket interface. This problem happens occasionally after some commands are sent (usually above 200 commands) for example when I send an ON/OFF command, confirmation response is received from GW server but no Report Indication is received and after that GW server doesn't answer to any commands and also doesn't accept any connection when I checked GW server logs (no disconnection error is issued). I really don't know what happens for it! Other servers (NWK_MGR and OTA) are OK but GW server goes to an unknown state. TCP port of GW server is alive but no connection is accepted.

    Thanks in advance for your help.

  • 0 in reply to Ahmad.TI
    TI__Guru**** 202126 points

    Can you please provide the GW server logs you mentioned?  How often are you sending commands?  Are you attempting to replace the user interface (keyboard to sample app) with a custom one (socket)?  The node.js works well to replace the sample application, I recommend taking the custom socket interface commands and executing them in the aforementioned sample application to compare behavior.

    Regards,
    Ryan

  • 0 in reply to Ryan Brown1
    Expert 1780 points

    These log files are for Server Logs when a Report Indication is received from a device. OK-1.txt is in the case that GW server works well, NOK-1.txt is when GW server has stopped working and doesn't send data to sample application and also doesn't receive any command from application.

    I have not used node.js sample application but I will try it.

    OK-1.txt 
    [ZSTACKZNP_SRVR/READ] INFO: Received 28 bytes,   subSys 0x44, cmdId 0x81, pData:
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x4
[ZSTACKZNP_SRVR/READ] INFO:  0xB
[ZSTACKZNP_SRVR/READ] INFO:  0x9B
[ZSTACKZNP_SRVR/READ] INFO:  0x1E
[ZSTACKZNP_SRVR/READ] INFO:  0x1
[ZSTACKZNP_SRVR/READ] INFO:  0x2
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0xBF
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x5E
[ZSTACKZNP_SRVR/READ] INFO:  0x4B
[ZSTACKZNP_SRVR/READ] INFO:  0x9
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x8
[ZSTACKZNP_SRVR/READ] INFO:  0x18
[ZSTACKZNP_SRVR/READ] INFO:  0x13
[ZSTACKZNP_SRVR/READ] INFO:  0xA
[ZSTACKZNP_SRVR/READ] INFO:  0x8
[ZSTACKZNP_SRVR/READ] INFO:  0x5
[ZSTACKZNP_SRVR/READ] INFO:  0x21
[ZSTACKZNP_SRVR/READ] INFO:  0xC8
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x9B
[ZSTACKZNP_SRVR/READ] INFO:  0x1E
[ZSTACKZNP_SRVR/READ] INFO:  0x1D
[ZSTACKZNP_SRVR/READ] INFO: RPC_CMD_AREQ cmdId: 0x81
[ZSTACKZNP_SRVR/READ] INFO:
[DBG] Allocated         @ 0x00000000B6A00550 (received  26 messages)...
[ZSTACKZNP_SRVR/READ] INFO: Filling new message (@ 0x00000000B6A00550)...
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] Processing        @ 0x00000000B6A00550
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000004, cmdId:0x0000000000000081, len:0x000000000000001C, pData:0x00000000B6A00558
[ZSTACKZNP_SRVR/MAIN] INFO: ...sent 62 bytes to Client
[GATEWAY/READ] INFO: Received 58 bytes,  subSys 0x51, cmdId 0x92, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x92
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x12
[GATEWAY/READ] INFO:  0x9
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x2
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ (Handle) (message @ 0x00000000B6A00550)...
[GATEWAY/READ] INFO:  0x10
[ZSTACKZNP_SRVR/HNDL] INFO: [DBG] Clearing              @ 0x00000000B6A00550 (processed 26 messages)...
[GATEWAY/READ] INFO:  0x9B
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Wait for AREQ semaphore
[GATEWAY/READ] INFO:  0x3D
[GATEWAY/READ] INFO:  0x20
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x28
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x20
[GATEWAY/READ] INFO:  0x84
[GATEWAY/READ] INFO:  0x16
[GATEWAY/READ] INFO:  0x28
[GATEWAY/READ] INFO:  0x9B
[GATEWAY/READ] INFO:  0x3D
[GATEWAY/READ] INFO:  0x30
[GATEWAY/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x38
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x40
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x48
[GATEWAY/READ] INFO:  0xBF
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x50
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x58
[GATEWAY/READ] INFO:  0x36
[GATEWAY/READ] INFO:  0x60
[GATEWAY/READ] INFO:  0xDE
[GATEWAY/READ] INFO:  0x96
[GATEWAY/READ] INFO:  0x25
[GATEWAY/READ] INFO:  0x68
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x70
[GATEWAY/READ] INFO:  0xD9
[GATEWAY/READ] INFO:  0x82
[GATEWAY/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x78
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x82
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0x13
[GATEWAY/READ] INFO:  0xA
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x5
[GATEWAY/READ] INFO:  0x21
[GATEWAY/READ] INFO:  0xC8
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO: RPC_CMD_AREQ cmdId: 0x92
[GATEWAY/READ] INFO:
[DBG] Allocated         @ 0x00000000B6B004A8 (received  24 messages)...
[GATEWAY/READ] INFO: Filling new message (@ 0x00000000B6B004A8)...
[GATEWAY/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[GATEWAY/HNDL] INFO:

[DBG] Processing        @ 0x00000000B6B004A8
[GATEWAY/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
[GATEWAY/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000011, cmdId:0x0000000000000092, len:0x000000000000003A, pData:0x00000000B6B004B0
[GATEWAY/HNDL] : Processing Af Incoming Message Indication
[GATEWAY/HNDL] : Incoming ZCL Command: CmdId: 10, ClusterId: 0B04, TransId: 19
[GATEWAY/HNDL] INFO: preparing to send 5 bytes, subSys 0x19, cmdId 0x00, pData:
[GATEWAY/HNDL] INFO:  0x08
[GATEWAY/HNDL] INFO:  0x00
[GATEWAY/HNDL] INFO:  0x10
[GATEWAY/HNDL] INFO:  0x9B
[GATEWAY/HNDL] INFO:  0x3D
[GATEWAY/HNDL] INFO: [MUTEX] Lock SRSP Mutex[GATEWAY/HNDL] INFO:
[MUTEX] SRSP Lock status: 0
[NWK_MGR/LSTN] INFO: Receive message...
[NWK_MGR/LSTN] :
SRVR_GET_IEEE_ADDRESS_REQ: shortAddr: 1E9B
[NWK_MGR/LSTN] INFO: ...sent 17 bytes to Client
[NWK_MGR/LSTN] INFO: !Done
[GATEWAY/READ] INFO: Received 13 bytes,  subSys 0x79, cmdId 0x01, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x19
[GATEWAY/READ] INFO:  0x2D
[GATEWAY/READ] INFO:  0x3F
[GATEWAY/READ] INFO:  0x14
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x4B
[GATEWAY/READ] INFO:  0x12
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO: [MUTEX] SRSP Cond signal set
[GATEWAY/READ] INFO: Client Read: (len 0): [GATEWAY/HNDL] INFO: Waiting for synchronous response...
[GATEWAY/HNDL] INFO: [MUTEX] Wait for SRSP Cond signal...
[GATEWAY/HNDL] INFO: 0x08
[GATEWAY/HNDL] INFO: 0x01
[GATEWAY/HNDL] INFO: 0x10
[GATEWAY/HNDL] INFO: 0x00
[GATEWAY/HNDL] INFO: 0x19
[GATEWAY/HNDL] INFO: 0x2D
[GATEWAY/HNDL] INFO: 0x3F
[GATEWAY/HNDL] INFO: 0x14
[GATEWAY/HNDL] INFO: 0x10
[GATEWAY/HNDL] INFO: 0x00
[GATEWAY/HNDL] INFO: 0x4B
[GATEWAY/HNDL] INFO: 0x12
[GATEWAY/HNDL] INFO: 0x00
[GATEWAY/HNDL] INFO: [MUTEX] Unlock SRSP Mutex
[GATEWAY/HNDL] : Processing Attribute Report Indication
[GATEWAY/HNDL] INFO: [MUTEX] AREQ (Handle) (message @ 0x00000000B6B004A8)...
[GATEWAY/HNDL] INFO: [DBG] Clearing             @ 0x00000000B6B004A8 (processed 24 messages)...
[GATEWAY/HNDL] INFO: [MUTEX] Wait for AREQ semaphore

    NOK-1.txt 
    [ZSTACKZNP_SRVR/READ] INFO: Received 28 bytes,   subSys 0x44, cmdId 0x81, pData:
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x4
[ZSTACKZNP_SRVR/READ] INFO:  0xB
[ZSTACKZNP_SRVR/READ] INFO:  0x9B
[ZSTACKZNP_SRVR/READ] INFO:  0x1E
[ZSTACKZNP_SRVR/READ] INFO:  0x1
[ZSTACKZNP_SRVR/READ] INFO:  0x2
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0xA0
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x60
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x33
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x8
[ZSTACKZNP_SRVR/READ] INFO:  0x18
[ZSTACKZNP_SRVR/READ] INFO:  0x14
[ZSTACKZNP_SRVR/READ] INFO:  0xA
[ZSTACKZNP_SRVR/READ] INFO:  0x8
[ZSTACKZNP_SRVR/READ] INFO:  0x5
[ZSTACKZNP_SRVR/READ] INFO:  0x21
[ZSTACKZNP_SRVR/READ] INFO:  0xC8
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x9B
[ZSTACKZNP_SRVR/READ] INFO:  0x1E
[ZSTACKZNP_SRVR/READ] INFO:  0x1D
[ZSTACKZNP_SRVR/READ] INFO: RPC_CMD_AREQ cmdId: 0x81
[ZSTACKZNP_SRVR/READ] INFO:
[DBG] Allocated         @ 0x00000000B6B005B8 (received  36012 messages)...
[ZSTACKZNP_SRVR/READ] INFO: Filling new message (@ 0x00000000B6B005B8)...
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] Processing        @ 0x00000000B6B005B8
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000004, cmdId:0x0000000000000081, len:0x000000000000001C, pData:0x00000000B6B005C0
[ZSTACKZNP_SRVR/MAIN] INFO: ...sent 72 bytes to Client
[GATEWAY/READ] INFO: Received 68 bytes,  subSys 0x51, cmdId 0x92, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x92
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x12
[GATEWAY/READ] INFO:  0x9
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x2
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ (Handle) (message @ 0x00000000B6B005B8)...
[GATEWAY/READ] INFO:  0x10
[ZSTACKZNP_SRVR/HNDL] INFO: [DBG] Clearing              @ 0x00000000B6B005B8 (processed 36012 messages)...
[GATEWAY/READ] INFO:  0x9B
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Wait for AREQ semaphore
[GATEWAY/READ] INFO:  0x3D
[GATEWAY/READ] INFO:  0x20
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x28
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x20
[GATEWAY/READ] INFO:  0x84
[GATEWAY/READ] INFO:  0x16
[GATEWAY/READ] INFO:  0x28
[GATEWAY/READ] INFO:  0x9B
[GATEWAY/READ] INFO:  0x3D
[GATEWAY/READ] INFO:  0x30
[GATEWAY/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x38
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x40
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x48
[GATEWAY/READ] INFO:  0xA0
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x50
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x58
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x60
[GATEWAY/READ] INFO:  0xE0
[GATEWAY/READ] INFO:  0x80
[GATEWAY/READ] INFO:  0xCC
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x68
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x70
[GATEWAY/READ] INFO:  0xCB
[GATEWAY/READ] INFO:  0x92
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x78
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x82
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0x14
[GATEWAY/READ] INFO:  0xA
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x5
[GATEWAY/READ] INFO:  0x21
[GATEWAY/READ] INFO:  0xC8
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO: RPC_CMD_AREQ cmdId: 0x92
[GATEWAY/READ] INFO:
[DBG] Allocated         @ 0x00000000B6B8E9F8 (received  36007 messages)...
[GATEWAY/READ] INFO: Filling new message (@ 0x00000000B6B8E9F8)...

  • 0 in reply to Ahmad.TI
    TI__Guru**** 202126 points

    You may need to debug SISreadThreadFunc of api_client.c to determine what function crashes after allocating pMsg.  Does the issue only occur after the pInstance->areqRxMsgCount reaches a high value?  Is the handle Thread function entered or does it fail while reading?

    Regards,
    Ryan

  • 0 in reply to Ryan Brown1
    Expert 1780 points

    These files are another logs when the problem occured after about 1000 ON/OFF commands sent.  OK-2.log is logs for the last successful send and receive and after that in the NOK-2.log when ON/OFF command is sent, Confirm response received in the GW application but Report Response  Indication not received and after that No command received in the GW server. In the NOK-2.log file the last log from servers is reserveActiveConnection and it seems this step isn't done completely and so no data is sent to GW application, also in the last lines, status of Sending Generic Response Indication is 4 not 0 and this is common when GW server crashes and doesn't receive commands.

    OK-2.log 
    MYLOG: apisConnectionHandle
[GATEWAY/LSTN] INFO: Receive message...
cmdId: 39
[GATEWAY/LSTN] : Processing Set On/Off State Request
[GATEWAY/LSTN] : Sending Set On/Off State Request
MYLOG1: apicSendSynchData
[GATEWAY/LSTN] INFO: preparing to send 11 bytes, subSys 0x19, cmdId 0x02, pData:
[GATEWAY/LSTN] INFO:  0x08
[GATEWAY/LSTN] INFO:  0x02
[GATEWAY/LSTN] INFO:  0x11
[GATEWAY/LSTN] INFO:  0x2D
[GATEWAY/LSTN] INFO:  0x3F
[GATEWAY/LSTN] INFO:  0x14
[GATEWAY/LSTN] INFO:  0x10
[GATEWAY/LSTN] INFO:  0x00
[GATEWAY/LSTN] INFO:  0x4B
[GATEWAY/LSTN] INFO:  0x12
[GATEWAY/LSTN] INFO:  0x00
[GATEWAY/LSTN] INFO: [MUTEX] Lock SRSP Mutex[GATEWAY/LSTN] INFO:
[MUTEX] SRSP Lock status: 0
[GATEWAY/LSTN] INFO: Waiting for synchronous response...
[GATEWAY/LSTN] INFO: [MUTEX] Wait for SRSP Cond signal...
MYLOG: apisConnectionHandle
[NWK_MGR/LSTN] INFO: Receive message...
[NWK_MGR/LSTN] :
SRVR_GET_SHORT_ADDRESS_REQ: ieeeAddr: 00124B0010143F2D
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
[NWK_MGR/LSTN] INFO: ...sent 11 bytes to Client
MYLOG: unreserveActiveConnection
[NWK_MGR/LSTN] INFO: !Done
MYLOG: aclGarbageCollect
[GATEWAY/READ] INFO: Received 7 bytes,   subSys 0x79, cmdId 0x03, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x3
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0x9B
[GATEWAY/READ] INFO:  0x3D
[GATEWAY/READ] INFO: [MUTEX] SRSP Cond signal set
[GATEWAY/READ] INFO: Client Read: (len 0): [GATEWAY/LSTN] INFO: 0x08
[GATEWAY/LSTN] INFO: 0x03
[GATEWAY/LSTN] INFO: 0x10
[GATEWAY/LSTN] INFO: 0x00
[GATEWAY/LSTN] INFO: 0x18
[GATEWAY/LSTN] INFO: 0x9B
[GATEWAY/LSTN] INFO: 0x3D
[GATEWAY/LSTN] INFO: [MUTEX] Unlock SRSP Mutex
[GATEWAY/LSTN] DEBUG: AF DstAddr Info:[GATEWAY/LSTN] DEBUG: AddrMode: 2[GATEWAY/LSTN] DEBUG: ShortAddr: 1E9B[GATEWAY/LSTN] DEBUG: EndpointId: 1
[GATEWAY/LSTN] DEBUG: Sending AF Data Request - dstAddr:1e9b, srcEp:2, dstEp:1, cID:6, bufLen:3
MYLOG1: apicSendSynchData
[GATEWAY/LSTN] INFO: preparing to send 29 bytes, subSys 0x11, cmdId 0x22, pData:
[GATEWAY/LSTN] INFO:  0x08
[GATEWAY/LSTN] INFO:  0x22
[GATEWAY/LSTN] INFO:  0x12
[GATEWAY/LSTN] INFO:  0x09
[GATEWAY/LSTN] INFO:  0x08
[GATEWAY/LSTN] INFO:  0x02
[GATEWAY/LSTN] INFO:  0x10
[GATEWAY/LSTN] INFO:  0x9B
[GATEWAY/LSTN] INFO:  0x3D
[GATEWAY/LSTN] INFO:  0x20
[GATEWAY/LSTN] INFO:  0x01
[GATEWAY/LSTN] INFO:  0x28
[GATEWAY/LSTN] INFO:  0x00
[GATEWAY/LSTN] INFO:  0x20
[GATEWAY/LSTN] INFO:  0x02
[GATEWAY/LSTN] INFO:  0x28
[GATEWAY/LSTN] INFO:  0x06
[GATEWAY/LSTN] INFO:  0x30
[GATEWAY/LSTN] INFO:  0xF5
[GATEWAY/LSTN] INFO:  0x01
[GATEWAY/LSTN] INFO:  0x3A
[GATEWAY/LSTN] INFO:  0x00
[GATEWAY/LSTN] INFO:  0x40
[GATEWAY/LSTN] INFO:  0x1E
[GATEWAY/LSTN] INFO:  0x4A
[GATEWAY/LSTN] INFO:  0x03
[GATEWAY/LSTN] INFO:  0x01
[GATEWAY/LSTN] INFO:  0xF5
[GATEWAY/LSTN] INFO:  0x01
[GATEWAY/LSTN] INFO: [MUTEX] Lock SRSP Mutex[GATEWAY/LSTN] INFO:
[MUTEX] SRSP Lock status: 0
MYLOG: apisConnectionHandle
[ZSTACKZNP_SRVR/LSTN] INFO: Receive message...
[ZSTACKZNP_SRVR/LSTN] INFO: zstackpb zspbHandlePbCb: subsystemID:31, cmdId:22
[ZSTACKZNP_SRVR/LSTN] INFO: zstackpb Rcvd AF Data Request: addrMode: 2, dstAddr:1e9b, dep:1, sep:2
[ZSTACKZNP_SRVR/LSTN] INFO: znp_misc sendNPIExpectDefaultStatusZNP: subSys:4, cmdID:2, len:23
MYLOG1: apicSendSynchData
[ZSTACKZNP_SRVR/LSTN] INFO: preparing to send 23 bytes, subSys 0x04, cmdId 0x02, pData:
[ZSTACKZNP_SRVR/LSTN] INFO:  0x02
[ZSTACKZNP_SRVR/LSTN] INFO:  0x9B
[ZSTACKZNP_SRVR/LSTN] INFO:  0x1E
[ZSTACKZNP_SRVR/LSTN] INFO:  0x01
[ZSTACKZNP_SRVR/LSTN] INFO:  0x08
[ZSTACKZNP_SRVR/LSTN] INFO:  0x02
[ZSTACKZNP_SRVR/LSTN] INFO:  0x10
[ZSTACKZNP_SRVR/LSTN] INFO:  0x9B
[ZSTACKZNP_SRVR/LSTN] INFO:  0x3D
[ZSTACKZNP_SRVR/LSTN] INFO:  0x01
[ZSTACKZNP_SRVR/LSTN] INFO:  0x00
[ZSTACKZNP_SRVR/LSTN] INFO:  0x00
[ZSTACKZNP_SRVR/LSTN] INFO:  0x02
[ZSTACKZNP_SRVR/LSTN] INFO:  0x06
[ZSTACKZNP_SRVR/LSTN] INFO:  0x00
[ZSTACKZNP_SRVR/LSTN] INFO:  0xF5
[ZSTACKZNP_SRVR/LSTN] INFO:  0x00
[ZSTACKZNP_SRVR/LSTN] INFO:  0x1E
[ZSTACKZNP_SRVR/LSTN] INFO:  0x03
[ZSTACKZNP_SRVR/LSTN] INFO:  0x00
[ZSTACKZNP_SRVR/LSTN] INFO:  0x01
[ZSTACKZNP_SRVR/LSTN] INFO:  0xF5
[ZSTACKZNP_SRVR/LSTN] INFO:  0x01
[ZSTACKZNP_SRVR/LSTN] INFO: [MUTEX] Lock SRSP Mutex[ZSTACKZNP_SRVR/LSTN] INFO:
[MUTEX] SRSP Lock status: 0
[ZSTACKZNP_SRVR/LSTN] INFO: Waiting for synchronous response...
[ZSTACKZNP_SRVR/LSTN] INFO: [MUTEX] Wait for SRSP Cond signal...
[GATEWAY/LSTN] INFO: Waiting for synchronous response...
[GATEWAY/LSTN] INFO: [MUTEX] Wait for SRSP Cond signal...
[ZSTACKZNP_SRVR/READ] INFO: Received 1 bytes,    subSys 0x64, cmdId 0x02, pData:
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO: [MUTEX] SRSP Cond signal set
[ZSTACKZNP_SRVR/READ] INFO: Client Read: (len 0): [ZSTACKZNP_SRVR/LSTN] INFO: 0x00
[ZSTACKZNP_SRVR/LSTN] INFO: [MUTEX] Unlock SRSP Mutex
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
[GATEWAY/READ] INFO: Received 4 bytes,   subSys 0x71, cmdId 0x22, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x22
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO: [MUTEX] SRSP Cond signal set
[GATEWAY/READ] INFO: Client Read: (len 0): [GATEWAY/LSTN] INFO: 0x08
[ZSTACKZNP_SRVR/LSTN] INFO: ...sent 8 bytes to Client
[ZSTACKZNP_SRVR/READ] INFO: Received 3 bytes,    subSys 0x44, cmdId 0x80, pData:
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x2
[ZSTACKZNP_SRVR/READ] INFO:  0xF5
[ZSTACKZNP_SRVR/READ] INFO: RPC_CMD_AREQ cmdId: 0x80
[ZSTACKZNP_SRVR/READ] INFO:
[DBG] Allocated         @ 0x00000000B6A00488 (received  6794 messages)...
[ZSTACKZNP_SRVR/READ] INFO: Filling new message (@ 0x00000000B6A00488)...
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] Processing        @ 0x00000000B6A00488
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
MYLOG1: asynchMsgCback
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000004, cmdId:0x0000000000000080, len:0x0000000000000003, pData:0x00000000B6A00490
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ (Handle) (message @ 0x00000000B6A00488)...
[ZSTACKZNP_SRVR/HNDL] INFO: [DBG] Clearing              @ 0x00000000B6A00488 (processed 6794 messages)...
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Wait for AREQ semaphore
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
MYLOG: unreserveActiveConnection
[ZSTACKZNP_SRVR/MAIN] INFO: ...sent 14 bytes to Client
MYLOG: unreserveActiveConnection
[ZSTACKZNP_SRVR/LSTN] INFO: !Done
[GATEWAY/LSTN] INFO: 0x22
MYLOG: aclGarbageCollect
[GATEWAY/READ] INFO: Received 10 bytes,  subSys 0x51, cmdId 0x91, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x91
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x20
[GATEWAY/READ] INFO:  0xF5
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO: RPC_CMD_AREQ cmdId: 0x91
[GATEWAY/READ] INFO:
[DBG] Allocated         @ 0x00000000B6B004A8 (received  6790 messages)...
[GATEWAY/READ] INFO: Filling new message (@ 0x00000000B6B004A8)...
[GATEWAY/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[GATEWAY/HNDL] INFO:

[DBG] Processing        @ 0x00000000B6B004A8
[GATEWAY/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
MYLOG1: asynchMsgCback
[GATEWAY/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000011, cmdId:0x0000000000000091, len:0x000000000000000A, pData:0x00000000B6B004B0
MYLOG2: handleAsyncMsgs
[GATEWAY/HNDL] : Processing AF Data Confirmation Message: status: 0, sequence number: 245
[GATEWAY/HNDL] INFO: [MUTEX] AREQ (Handle) (message @ 0x00000000B6B004A8)...
[GATEWAY/HNDL] INFO: [DBG] Clearing             @ 0x00000000B6B004A8 (processed 6790 messages)...
[GATEWAY/HNDL] INFO: [MUTEX] Wait for AREQ semaphore
[GATEWAY/LSTN] INFO: 0x10
[GATEWAY/LSTN] INFO: 0x00
[ZSTACKZNP_SRVR/READ] INFO: Received 28 bytes,   subSys 0x44, cmdId 0x81, pData:
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x6
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x9B
[ZSTACKZNP_SRVR/READ] INFO:  0x1E
[ZSTACKZNP_SRVR/READ] INFO:  0x1
[ZSTACKZNP_SRVR/READ] INFO:  0x2
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0xCA
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x16
[ZSTACKZNP_SRVR/READ] INFO:  0x75
[ZSTACKZNP_SRVR/READ] INFO:  0xC
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x8
[ZSTACKZNP_SRVR/READ] INFO:  0x18
[ZSTACKZNP_SRVR/READ] INFO:  0xDC
[ZSTACKZNP_SRVR/READ] INFO:  0xA
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x21
[ZSTACKZNP_SRVR/READ] INFO:  0x1
[GATEWAY/LSTN] INFO: [MUTEX] Unlock SRSP Mutex
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/LSTN] DEBUG: Checked transaction table size: 50
[ZSTACKZNP_SRVR/READ] INFO:  0x9B
[GATEWAY/LSTN] DEBUG: Checked transaction table number of entries: 0
[ZSTACKZNP_SRVR/READ] INFO:  0x1E
[GATEWAY/LSTN] INFO: (GW posted) cmdId: 39, zclTransId 245
[ZSTACKZNP_SRVR/READ] INFO:  0x1D
[GATEWAY/LSTN] : Sending ZigBee Generic Confirmation
MYLOG: APIS_SendData
[ZSTACKZNP_SRVR/READ] INFO: RPC_CMD_AREQ cmdId: 0x81
MYLOG: apisSendData
[ZSTACKZNP_SRVR/READ] INFO:
MYLOG: reserveActiveConnection
[DBG] Allocated         @ 0x00000000B6A00550 (received  6795 messages)...
[ZSTACKZNP_SRVR/READ] INFO: Filling new message (@ 0x00000000B6A00550)...
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] Processing        @ 0x00000000B6A00550
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
MYLOG1: asynchMsgCback
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000004, cmdId:0x0000000000000081, len:0x000000000000001C, pData:0x00000000B6A00558
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ (Handle) (message @ 0x00000000B6A00550)...
[ZSTACKZNP_SRVR/HNDL] INFO: [DBG] Clearing              @ 0x00000000B6A00550 (processed 6795 messages)...
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Wait for AREQ semaphore
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
[ZSTACKZNP_SRVR/READ] INFO: Received 25 bytes,   subSys 0x44, cmdId 0x81, pData:
[GATEWAY/READ] INFO: Received 63 bytes,  subSys 0x51, cmdId 0x92, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x92
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x12
[GATEWAY/READ] INFO:  0x9
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x9B
[GATEWAY/READ] INFO:  0x3D
[GATEWAY/READ] INFO:  0x20
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x28
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x20
[GATEWAY/READ] INFO:  0x6
[GATEWAY/READ] INFO:  0x28
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x30
[GATEWAY/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x38
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x40
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x48
[GATEWAY/READ] INFO:  0xCA
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x50
[GATEWAY/READ] INFO:  0x4
[GATEWAY/READ] INFO:  0x58
[GATEWAY/READ] INFO:  0xC0
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[ZSTACKZNP_SRVR/MAIN] INFO: ...sent 67 bytes to Client
MYLOG: unreserveActiveConnection
[GATEWAY/READ] INFO:  0xFF
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x1
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x6
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x60
[ZSTACKZNP_SRVR/READ] INFO:  0x9B
[GATEWAY/READ] INFO:  0x96
[ZSTACKZNP_SRVR/READ] INFO:  0x1E
[GATEWAY/READ] INFO:  0xEA
[ZSTACKZNP_SRVR/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x31
[ZSTACKZNP_SRVR/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x68
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x18
[ZSTACKZNP_SRVR/READ] INFO:  0xCA
[GATEWAY/READ] INFO:  0x70
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/LSTN] INFO: ...sent 11 bytes to Client
[ZSTACKZNP_SRVR/READ] INFO:  0x2A
MYLOG: unreserveActiveConnection
[ZSTACKZNP_SRVR/READ] INFO:  0x75
[GATEWAY/LSTN] INFO: !Done
[ZSTACKZNP_SRVR/READ] INFO:  0xC
MYLOG: aclGarbageCollect
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x78
[ZSTACKZNP_SRVR/READ] INFO:  0x5
[GATEWAY/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0x82
[ZSTACKZNP_SRVR/READ] INFO:  0xF5
[GATEWAY/READ] INFO:  0x1
[ZSTACKZNP_SRVR/READ] INFO:  0xB
[GATEWAY/READ] INFO:  0x8
[ZSTACKZNP_SRVR/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x18
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0xDC
[ZSTACKZNP_SRVR/READ] INFO:  0x9B
[GATEWAY/READ] INFO:  0xA
[ZSTACKZNP_SRVR/READ] INFO:  0x1E
[GATEWAY/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x1D
[GATEWAY/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO: RPC_CMD_AREQ cmdId: 0x81
[GATEWAY/READ] INFO:  0x21
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO: RPC_CMD_AREQ cmdId: 0x92
[GATEWAY/READ] INFO:
[ZSTACKZNP_SRVR/READ] INFO:
[DBG] Allocated         @ 0x00000000B6B004E0 (received  6791 messages)...
[DBG] Allocated         @ 0x00000000B6A00550 (received  6796 messages)...
[GATEWAY/READ] INFO: Filling new message (@ 0x00000000B6B004E0)...
[ZSTACKZNP_SRVR/READ] INFO: Filling new message (@ 0x00000000B6A00550)...
[GATEWAY/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[GATEWAY/HNDL] INFO:

[DBG] Processing        @ 0x00000000B6B004E0
[GATEWAY/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
MYLOG1: asynchMsgCback
[GATEWAY/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000011, cmdId:0x0000000000000092, len:0x000000000000003F, pData:0x00000000B6B004E8
MYLOG2: handleAsyncMsgs
[GATEWAY/HNDL] : Processing Af Incoming Message Indication
[GATEWAY/HNDL] : Incoming ZCL Command: CmdId: 10, ClusterId: 0006, TransId: 220
MYLOG1: apicSendSynchData
[GATEWAY/HNDL] INFO: preparing to send 5 bytes, subSys 0x19, cmdId 0x00, pData:
[GATEWAY/HNDL] INFO:  0x08
[GATEWAY/HNDL] INFO:  0x00
[GATEWAY/HNDL] INFO:  0x10
[GATEWAY/HNDL] INFO:  0x9B
[GATEWAY/HNDL] INFO:  0x3D
[GATEWAY/HNDL] INFO: [MUTEX] Lock SRSP Mutex[GATEWAY/HNDL] INFO:
[MUTEX] SRSP Lock status: 0
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] Processing        @ 0x00000000B6A00550
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
MYLOG1: asynchMsgCback
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000004, cmdId:0x0000000000000081, len:0x0000000000000019, pData:0x00000000B6A00558
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ (Handle) (message @ 0x00000000B6A00550)...
[ZSTACKZNP_SRVR/HNDL] INFO: [DBG] Clearing              @ 0x00000000B6A00550 (processed 6796 messages)...
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Wait for AREQ semaphore
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
[ZSTACKZNP_SRVR/MAIN] INFO: ...sent 67 bytes to Client
MYLOG: unreserveActiveConnection
MYLOG: apisConnectionHandle
[NWK_MGR/LSTN] INFO: Receive message...
[NWK_MGR/LSTN] :
SRVR_GET_IEEE_ADDRESS_REQ: shortAddr: 1E9B
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
[NWK_MGR/LSTN] INFO: ...sent 17 bytes to Client
MYLOG: unreserveActiveConnection
[NWK_MGR/LSTN] INFO: !Done
MYLOG: aclGarbageCollect
[GATEWAY/READ] INFO: Received 13 bytes,  subSys 0x79, cmdId 0x01, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x19
[GATEWAY/READ] INFO:  0x2D
[GATEWAY/READ] INFO:  0x3F
[GATEWAY/READ] INFO:  0x14
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x4B
[GATEWAY/READ] INFO:  0x12
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO: [MUTEX] SRSP Cond signal set
[GATEWAY/READ] INFO: Client Read: (len 0): [GATEWAY/HNDL] INFO: Waiting for synchronous response...
[GATEWAY/HNDL] INFO: [MUTEX] Wait for SRSP Cond signal...
[GATEWAY/HNDL] INFO: 0x08
[GATEWAY/HNDL] INFO: 0x01
[GATEWAY/HNDL] INFO: 0x10
[GATEWAY/HNDL] INFO: 0x00
[GATEWAY/HNDL] INFO: 0x19
[GATEWAY/HNDL] INFO: 0x2D
[GATEWAY/HNDL] INFO: 0x3F
[GATEWAY/HNDL] INFO: 0x14
[GATEWAY/HNDL] INFO: 0x10
[GATEWAY/HNDL] INFO: 0x00
[GATEWAY/HNDL] INFO: 0x4B
[GATEWAY/HNDL] INFO: 0x12
[GATEWAY/HNDL] INFO: 0x00
[GATEWAY/HNDL] INFO: [MUTEX] Unlock SRSP Mutex
[GATEWAY/HNDL] : Processing Attribute Report Indication
MYLOG: APIS_SendData
MYLOG: apisSendData
[GATEWAY/READ] INFO: Received 63 bytes,  subSys 0x51, cmdId 0x92, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x92
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x12
[GATEWAY/READ] INFO:  0x9
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x9B
[GATEWAY/READ] INFO:  0x3D
[GATEWAY/READ] INFO:  0x20
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x28
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x20
[GATEWAY/READ] INFO:  0x6
[GATEWAY/READ] INFO:  0x28
[GATEWAY/READ] INFO:  0x9B
[GATEWAY/READ] INFO:  0x3D
[GATEWAY/READ] INFO:  0x30
[GATEWAY/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x38
[GATEWAY/HNDL] INFO: [MUTEX] AREQ (Handle) (message @ 0x00000000B6B004E0)...
[GATEWAY/HNDL] INFO: [DBG] Clearing             @ 0x00000000B6B004E0 (processed 6791 messages)...
[GATEWAY/HNDL] INFO: [MUTEX] Wait for AREQ semaphore
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x40
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x48
[GATEWAY/READ] INFO:  0xCA
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x50
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x58
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x60
[GATEWAY/READ] INFO:  0xAA
[GATEWAY/READ] INFO:  0xEA
[GATEWAY/READ] INFO:  0x31
[GATEWAY/READ] INFO:  0x68
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x70
[GATEWAY/READ] INFO:  0x96
[GATEWAY/READ] INFO:  0xEA
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x78
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x82
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x5
[GATEWAY/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0xF5
[GATEWAY/READ] INFO:  0xB
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO: RPC_CMD_AREQ cmdId: 0x92
[GATEWAY/READ] INFO:
[DBG] Allocated         @ 0x00000000B6B00530 (received  6792 messages)...
[GATEWAY/READ] INFO: Filling new message (@ 0x00000000B6B00530)...
[GATEWAY/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[GATEWAY/HNDL] INFO:

[DBG] Processing        @ 0x00000000B6B00530
[GATEWAY/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
MYLOG1: asynchMsgCback
[GATEWAY/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000011, cmdId:0x0000000000000092, len:0x000000000000003F, pData:0x00000000B6B00538
MYLOG2: handleAsyncMsgs
[GATEWAY/HNDL] : Processing Af Incoming Message Indication
[GATEWAY/HNDL] : Incoming ZCL Command: CmdId: 11, ClusterId: 0006, TransId: 245
MYLOG1: apicSendSynchData
[GATEWAY/HNDL] INFO: preparing to send 5 bytes, subSys 0x19, cmdId 0x00, pData:
[GATEWAY/HNDL] INFO:  0x08
[GATEWAY/HNDL] INFO:  0x00
[GATEWAY/HNDL] INFO:  0x10
[GATEWAY/HNDL] INFO:  0x9B
[GATEWAY/HNDL] INFO:  0x3D
[GATEWAY/HNDL] INFO: [MUTEX] Lock SRSP Mutex[GATEWAY/HNDL] INFO:
[MUTEX] SRSP Lock status: 0
MYLOG: apisConnectionHandle
[NWK_MGR/LSTN] INFO: Receive message...
[NWK_MGR/LSTN] :
SRVR_GET_IEEE_ADDRESS_REQ: shortAddr: 1E9B
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
[NWK_MGR/LSTN] INFO: ...sent 17 bytes to Client
MYLOG: unreserveActiveConnection
[NWK_MGR/LSTN] INFO: !Done
MYLOG: aclGarbageCollect
[GATEWAY/READ] INFO: Received 13 bytes,  subSys 0x79, cmdId 0x01, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x19
[GATEWAY/READ] INFO:  0x2D
[GATEWAY/READ] INFO:  0x3F
[GATEWAY/READ] INFO:  0x14
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x4B
[GATEWAY/READ] INFO:  0x12
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO: [MUTEX] SRSP Cond signal set
[GATEWAY/READ] INFO: Client Read: (len 0): [GATEWAY/HNDL] INFO: Waiting for synchronous response...
[GATEWAY/HNDL] INFO: [MUTEX] Wait for SRSP Cond signal...
[GATEWAY/HNDL] INFO: 0x08
[GATEWAY/HNDL] INFO: 0x01
[GATEWAY/HNDL] INFO: 0x10
[GATEWAY/HNDL] INFO: 0x00
[GATEWAY/HNDL] INFO: 0x19
[GATEWAY/HNDL] INFO: 0x2D
[GATEWAY/HNDL] INFO: 0x3F
[GATEWAY/HNDL] INFO: 0x14
[GATEWAY/HNDL] INFO: 0x10
[GATEWAY/HNDL] INFO: 0x00
[GATEWAY/HNDL] INFO: 0x4B
[GATEWAY/HNDL] INFO: 0x12
[GATEWAY/HNDL] INFO: 0x00
[GATEWAY/HNDL] INFO: [MUTEX] Unlock SRSP Mutex
[GATEWAY/HNDL] : Processing ZCL Default Response
[GATEWAY/HNDL] : Sending Generic Response Indication: Status: 0, SequenceNumber: 2293
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
[GATEWAY/HNDL] INFO: ...sent 11 bytes to Client
MYLOG: unreserveActiveConnection
[GATEWAY/HNDL] DEBUG: (GW remove) deleted zclTransId: 245, table size: 0
[GATEWAY/HNDL] INFO: [MUTEX] AREQ (Handle) (message @ 0x00000000B6B00530)...
[GATEWAY/HNDL] INFO: [DBG] Clearing             @ 0x00000000B6B00530 (processed 6792 messages)...
[GATEWAY/HNDL] INFO: [MUTEX] Wait for AREQ semaphore

    NOK-2.log 
    MYLOG: apisConnectionHandle
[GATEWAY/LSTN] INFO: Receive message...
cmdId: 39
[GATEWAY/LSTN] : Processing Set On/Off State Request
[GATEWAY/LSTN] : Sending Set On/Off State Request
MYLOG1: apicSendSynchData
[GATEWAY/LSTN] INFO: preparing to send 11 bytes, subSys 0x19, cmdId 0x02, pData:
[GATEWAY/LSTN] INFO:  0x08
[GATEWAY/LSTN] INFO:  0x02
[GATEWAY/LSTN] INFO:  0x11
[GATEWAY/LSTN] INFO:  0x2D
[GATEWAY/LSTN] INFO:  0x3F
[GATEWAY/LSTN] INFO:  0x14
[GATEWAY/LSTN] INFO:  0x10
[GATEWAY/LSTN] INFO:  0x00
[GATEWAY/LSTN] INFO:  0x4B
[GATEWAY/LSTN] INFO:  0x12
[GATEWAY/LSTN] INFO:  0x00
[GATEWAY/LSTN] INFO: [MUTEX] Lock SRSP Mutex[GATEWAY/LSTN] INFO:
[MUTEX] SRSP Lock status: 0
MYLOG: apisConnectionHandle
[NWK_MGR/LSTN] INFO: Receive message...
[NWK_MGR/LSTN] :
SRVR_GET_SHORT_ADDRESS_REQ: ieeeAddr: 00124B0010143F2D
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
[NWK_MGR/LSTN] INFO: ...sent 11 bytes to Client
MYLOG: unreserveActiveConnection
[NWK_MGR/LSTN] INFO: !Done
MYLOG: aclGarbageCollect
[GATEWAY/READ] INFO: Received 7 bytes,   subSys 0x79, cmdId 0x03, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x3
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0x9B
[GATEWAY/READ] INFO:  0x3D
[GATEWAY/READ] INFO: [MUTEX] SRSP Cond signal set
[GATEWAY/READ] INFO: Client Read: (len 0): [GATEWAY/LSTN] INFO: Waiting for synchronous response...
[GATEWAY/LSTN] INFO: [MUTEX] Wait for SRSP Cond signal...
[GATEWAY/LSTN] INFO: 0x08
[GATEWAY/LSTN] INFO: 0x03
[GATEWAY/LSTN] INFO: 0x10
[GATEWAY/LSTN] INFO: 0x00
[GATEWAY/LSTN] INFO: 0x18
[GATEWAY/LSTN] INFO: 0x9B
[GATEWAY/LSTN] INFO: 0x3D
[GATEWAY/LSTN] INFO: [MUTEX] Unlock SRSP Mutex
[GATEWAY/LSTN] DEBUG: AF DstAddr Info:[GATEWAY/LSTN] DEBUG: AddrMode: 2[GATEWAY/LSTN] DEBUG: ShortAddr: 1E9B[GATEWAY/LSTN] DEBUG: EndpointId: 1
[GATEWAY/LSTN] DEBUG: Sending AF Data Request - dstAddr:1e9b, srcEp:2, dstEp:1, cID:6, bufLen:3
MYLOG1: apicSendSynchData
[GATEWAY/LSTN] INFO: preparing to send 29 bytes, subSys 0x11, cmdId 0x22, pData:
[GATEWAY/LSTN] INFO:  0x08
[GATEWAY/LSTN] INFO:  0x22
[GATEWAY/LSTN] INFO:  0x12
[GATEWAY/LSTN] INFO:  0x09
[GATEWAY/LSTN] INFO:  0x08
[GATEWAY/LSTN] INFO:  0x02
[GATEWAY/LSTN] INFO:  0x10
[GATEWAY/LSTN] INFO:  0x9B
[GATEWAY/LSTN] INFO:  0x3D
[GATEWAY/LSTN] INFO:  0x20
[GATEWAY/LSTN] INFO:  0x01
[GATEWAY/LSTN] INFO:  0x28
[GATEWAY/LSTN] INFO:  0x00
[GATEWAY/LSTN] INFO:  0x20
[GATEWAY/LSTN] INFO:  0x02
[GATEWAY/LSTN] INFO:  0x28
[GATEWAY/LSTN] INFO:  0x06
[GATEWAY/LSTN] INFO:  0x30
[GATEWAY/LSTN] INFO:  0xF7
[GATEWAY/LSTN] INFO:  0x01
[GATEWAY/LSTN] INFO:  0x3A
[GATEWAY/LSTN] INFO:  0x00
[GATEWAY/LSTN] INFO:  0x40
[GATEWAY/LSTN] INFO:  0x1E
[GATEWAY/LSTN] INFO:  0x4A
[GATEWAY/LSTN] INFO:  0x03
[GATEWAY/LSTN] INFO:  0x01
[GATEWAY/LSTN] INFO:  0xF7
[GATEWAY/LSTN] INFO:  0x00
[GATEWAY/LSTN] INFO: [MUTEX] Lock SRSP Mutex[GATEWAY/LSTN] INFO:
[MUTEX] SRSP Lock status: 0
MYLOG: apisConnectionHandle
[ZSTACKZNP_SRVR/LSTN] INFO: Receive message...
[ZSTACKZNP_SRVR/LSTN] INFO: zstackpb zspbHandlePbCb: subsystemID:31, cmdId:22
[ZSTACKZNP_SRVR/LSTN] INFO: zstackpb Rcvd AF Data Request: addrMode: 2, dstAddr:1e9b, dep:1, sep:2
[ZSTACKZNP_SRVR/LSTN] INFO: znp_misc sendNPIExpectDefaultStatusZNP: subSys:4, cmdID:2, len:23
MYLOG1: apicSendSynchData
[ZSTACKZNP_SRVR/LSTN] INFO: preparing to send 23 bytes, subSys 0x04, cmdId 0x02, pData:
[ZSTACKZNP_SRVR/LSTN] INFO:  0x02
[ZSTACKZNP_SRVR/LSTN] INFO:  0x9B
[ZSTACKZNP_SRVR/LSTN] INFO:  0x1E
[ZSTACKZNP_SRVR/LSTN] INFO:  0x01
[ZSTACKZNP_SRVR/LSTN] INFO:  0x08
[ZSTACKZNP_SRVR/LSTN] INFO:  0x02
[ZSTACKZNP_SRVR/LSTN] INFO:  0x10
[ZSTACKZNP_SRVR/LSTN] INFO:  0x9B
[ZSTACKZNP_SRVR/LSTN] INFO:  0x3D
[ZSTACKZNP_SRVR/LSTN] INFO:  0x01
[ZSTACKZNP_SRVR/LSTN] INFO:  0x00
[ZSTACKZNP_SRVR/LSTN] INFO:  0x00
[ZSTACKZNP_SRVR/LSTN] INFO:  0x02
[ZSTACKZNP_SRVR/LSTN] INFO:  0x06
[ZSTACKZNP_SRVR/LSTN] INFO:  0x00
[ZSTACKZNP_SRVR/LSTN] INFO:  0xF7
[ZSTACKZNP_SRVR/LSTN] INFO:  0x00
[ZSTACKZNP_SRVR/LSTN] INFO:  0x1E
[ZSTACKZNP_SRVR/LSTN] INFO:  0x03
[ZSTACKZNP_SRVR/LSTN] INFO:  0x00
[ZSTACKZNP_SRVR/LSTN] INFO:  0x01
[ZSTACKZNP_SRVR/LSTN] INFO:  0xF7
[ZSTACKZNP_SRVR/LSTN] INFO:  0x00
[ZSTACKZNP_SRVR/LSTN] INFO: [MUTEX] Lock SRSP Mutex[ZSTACKZNP_SRVR/LSTN] INFO:
[MUTEX] SRSP Lock status: 0
[ZSTACKZNP_SRVR/LSTN] INFO: Waiting for synchronous response...
[ZSTACKZNP_SRVR/LSTN] INFO: [MUTEX] Wait for SRSP Cond signal...
[GATEWAY/LSTN] INFO: Waiting for synchronous response...
[GATEWAY/LSTN] INFO: [MUTEX] Wait for SRSP Cond signal...
[ZSTACKZNP_SRVR/READ] INFO: Received 1 bytes,    subSys 0x64, cmdId 0x02, pData:
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO: [MUTEX] SRSP Cond signal set
[ZSTACKZNP_SRVR/READ] INFO: Client Read: (len 0): [ZSTACKZNP_SRVR/LSTN] INFO: 0x00
[ZSTACKZNP_SRVR/LSTN] INFO: [MUTEX] Unlock SRSP Mutex
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
[ZSTACKZNP_SRVR/LSTN] INFO: ...sent 8 bytes to Client
[GATEWAY/READ] INFO: Received 4 bytes,   subSys 0x71, cmdId 0x22, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x22
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO: [MUTEX] SRSP Cond signal set
[GATEWAY/READ] INFO: Client Read: (len 0): [GATEWAY/LSTN] INFO: 0x08
[GATEWAY/LSTN] INFO: 0x22
[GATEWAY/LSTN] INFO: 0x10
[GATEWAY/LSTN] INFO: 0x00
[GATEWAY/LSTN] INFO: [MUTEX] Unlock SRSP Mutex
[GATEWAY/LSTN] DEBUG: Checked transaction table size: 50
MYLOG: unreserveActiveConnection
[GATEWAY/LSTN] DEBUG: Checked transaction table number of entries: 0
[ZSTACKZNP_SRVR/LSTN] INFO: !Done
[GATEWAY/LSTN] INFO: (GW posted) cmdId: 39, zclTransId 247
MYLOG: aclGarbageCollect
[GATEWAY/LSTN] : Sending ZigBee Generic Confirmation
[ZSTACKZNP_SRVR/READ] INFO: Received 3 bytes,    subSys 0x44, cmdId 0x80, pData:
MYLOG: APIS_SendData
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x2
[ZSTACKZNP_SRVR/READ] INFO:  0xF7
[ZSTACKZNP_SRVR/READ] INFO: RPC_CMD_AREQ cmdId: 0x80
[ZSTACKZNP_SRVR/READ] INFO:
MYLOG: apisSendData
[DBG] Allocated         @ 0x00000000B6A00488 (received  6801 messages)...
MYLOG: reserveActiveConnection
[ZSTACKZNP_SRVR/READ] INFO: Filling new message (@ 0x00000000B6A00488)...
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] Processing        @ 0x00000000B6A00488
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
MYLOG1: asynchMsgCback
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000004, cmdId:0x0000000000000080, len:0x0000000000000003, pData:0x00000000B6A00490
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ (Handle) (message @ 0x00000000B6A00488)...
[ZSTACKZNP_SRVR/HNDL] INFO: [DBG] Clearing              @ 0x00000000B6A00488 (processed 6801 messages)...
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Wait for AREQ semaphore
[ZSTACKZNP_SRVR/MAIN] INFO: ...sent 14 bytes to Client
MYLOG: unreserveActiveConnection
[ZSTACKZNP_SRVR/READ] INFO: Received 28 bytes,   subSys 0x44, cmdId 0x81, pData:
[GATEWAY/READ] INFO: Received 10 bytes,  subSys 0x51, cmdId 0x91, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x91
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x20
[GATEWAY/READ] INFO:  0xF7
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO: RPC_CMD_AREQ cmdId: 0x91
[GATEWAY/READ] INFO:
[DBG] Allocated         @ 0x00000000B6B004A8 (received  6797 messages)...
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO: Filling new message (@ 0x00000000B6B004A8)...
[ZSTACKZNP_SRVR/READ] INFO:  0x6
[GATEWAY/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[GATEWAY/HNDL] INFO:

[DBG] Processing        @ 0x00000000B6B004A8
[GATEWAY/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
MYLOG1: asynchMsgCback
[GATEWAY/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000011, cmdId:0x0000000000000091, len:0x000000000000000A, pData:0x00000000B6B004B0
MYLOG2: handleAsyncMsgs
[GATEWAY/HNDL] : Processing AF Data Confirmation Message: status: 0, sequence number: 247
[GATEWAY/HNDL] INFO: [MUTEX] AREQ (Handle) (message @ 0x00000000B6B004A8)...
[GATEWAY/HNDL] INFO: [DBG] Clearing             @ 0x00000000B6B004A8 (processed 6797 messages)...
[GATEWAY/HNDL] INFO: [MUTEX] Wait for AREQ semaphore
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x9B
[ZSTACKZNP_SRVR/READ] INFO:  0x1E
[ZSTACKZNP_SRVR/READ] INFO:  0x1
[ZSTACKZNP_SRVR/READ] INFO:  0x2
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0xCA
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0xF5
[ZSTACKZNP_SRVR/READ] INFO:  0xB3
[ZSTACKZNP_SRVR/READ] INFO:  0xC
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x8
[ZSTACKZNP_SRVR/READ] INFO:  0x18
[ZSTACKZNP_SRVR/READ] INFO:  0xDF
[ZSTACKZNP_SRVR/READ] INFO:  0xA
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x21
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x9B
[ZSTACKZNP_SRVR/READ] INFO:  0x1E
[ZSTACKZNP_SRVR/READ] INFO:  0x1D
[ZSTACKZNP_SRVR/READ] INFO: RPC_CMD_AREQ cmdId: 0x81
[ZSTACKZNP_SRVR/READ] INFO:
[DBG] Allocated         @ 0x00000000B6A00550 (received  6802 messages)...
[ZSTACKZNP_SRVR/READ] INFO: Filling new message (@ 0x00000000B6A00550)...
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] Processing        @ 0x00000000B6A00550
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
MYLOG1: asynchMsgCback
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000004, cmdId:0x0000000000000081, len:0x000000000000001C, pData:0x00000000B6A00558
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ (Handle) (message @ 0x00000000B6A00550)...
[ZSTACKZNP_SRVR/HNDL] INFO: [DBG] Clearing              @ 0x00000000B6A00550 (processed 6802 messages)...
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Wait for AREQ semaphore
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
[ZSTACKZNP_SRVR/MAIN] INFO: ...sent 67 bytes to Client
MYLOG: unreserveActiveConnection
[ZSTACKZNP_SRVR/READ] INFO: Received 25 bytes,   subSys 0x44, cmdId 0x81, pData:
[GATEWAY/READ] INFO: Received 63 bytes,  subSys 0x51, cmdId 0x92, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x92
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x12
[GATEWAY/READ] INFO:  0x9
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x9B
[GATEWAY/READ] INFO:  0x3D
[GATEWAY/READ] INFO:  0x20
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x28
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x20
[GATEWAY/READ] INFO:  0x6
[GATEWAY/READ] INFO:  0x28
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x30
[GATEWAY/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x38
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x40
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x48
[GATEWAY/READ] INFO:  0xCA
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x50
[GATEWAY/READ] INFO:  0x4
[GATEWAY/READ] INFO:  0x58
[GATEWAY/READ] INFO:  0xC0
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0xFF
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0xFF
[ZSTACKZNP_SRVR/READ] INFO:  0x6
[GATEWAY/READ] INFO:  0xFF
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0xFF
[ZSTACKZNP_SRVR/READ] INFO:  0x9B
[GATEWAY/READ] INFO:  0xFF
[ZSTACKZNP_SRVR/READ] INFO:  0x1E
[GATEWAY/READ] INFO:  0x1
[ZSTACKZNP_SRVR/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x60
[ZSTACKZNP_SRVR/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0xF5
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0xE7
[ZSTACKZNP_SRVR/READ] INFO:  0xCA
[GATEWAY/READ] INFO:  0x32
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x68
[ZSTACKZNP_SRVR/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x18
[ZSTACKZNP_SRVR/READ] INFO:  0xB4
[GATEWAY/READ] INFO:  0x70
[ZSTACKZNP_SRVR/READ] INFO:  0xC
[GATEWAY/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x78
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x0
[ZSTACKZNP_SRVR/READ] INFO:  0x5
[GATEWAY/READ] INFO:  0x82
[ZSTACKZNP_SRVR/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0x1
[ZSTACKZNP_SRVR/READ] INFO:  0xF7
[GATEWAY/READ] INFO:  0x8
[ZSTACKZNP_SRVR/READ] INFO:  0xB
[GATEWAY/READ] INFO:  0x18
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0xDF
[ZSTACKZNP_SRVR/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0xA
[ZSTACKZNP_SRVR/READ] INFO:  0x9B
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x21
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO: RPC_CMD_AREQ cmdId: 0x92
[GATEWAY/READ] INFO:
[DBG] Allocated         @ 0x00000000B6B004E0 (received  6798 messages)...
[GATEWAY/READ] INFO: Filling new message (@ 0x00000000B6B004E0)...
[GATEWAY/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[GATEWAY/HNDL] INFO:

[DBG] Processing        @ 0x00000000B6B004E0
[GATEWAY/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
MYLOG1: asynchMsgCback
[GATEWAY/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000011, cmdId:0x0000000000000092, len:0x000000000000003F, pData:0x00000000B6B004E8
MYLOG2: handleAsyncMsgs
[GATEWAY/HNDL] : Processing Af Incoming Message Indication
[GATEWAY/HNDL] : Incoming ZCL Command: CmdId: 10, ClusterId: 0006, TransId: 223
MYLOG1: apicSendSynchData
[GATEWAY/HNDL] INFO: preparing to send 5 bytes, subSys 0x19, cmdId 0x00, pData:
[GATEWAY/HNDL] INFO:  0x08
[GATEWAY/HNDL] INFO:  0x00
[GATEWAY/HNDL] INFO:  0x10
[GATEWAY/HNDL] INFO:  0x9B
[GATEWAY/HNDL] INFO:  0x3D
[GATEWAY/HNDL] INFO: [MUTEX] Lock SRSP Mutex[GATEWAY/HNDL] INFO:
[MUTEX] SRSP Lock status: 0
[ZSTACKZNP_SRVR/READ] INFO:  0x1E
[ZSTACKZNP_SRVR/READ] INFO:  0x1D
MYLOG: apisConnectionHandle
[NWK_MGR/LSTN] INFO: Receive message...
[ZSTACKZNP_SRVR/READ] INFO: RPC_CMD_AREQ cmdId: 0x81
[ZSTACKZNP_SRVR/READ] INFO:
[DBG] Allocated         @ 0x00000000B6A00550 (received  6803 messages)...
[GATEWAY/HNDL] INFO: Waiting for synchronous response...
[NWK_MGR/LSTN] :
SRVR_GET_IEEE_ADDRESS_REQ: shortAddr: 1E9B
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
[NWK_MGR/LSTN] INFO: ...sent 17 bytes to Client
MYLOG: unreserveActiveConnection
[NWK_MGR/LSTN] INFO: !Done
MYLOG: aclGarbageCollect
[GATEWAY/HNDL] INFO: [MUTEX] Wait for SRSP Cond signal...
[ZSTACKZNP_SRVR/READ] INFO: Filling new message (@ 0x00000000B6A00550)...
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] Processing        @ 0x00000000B6A00550
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
MYLOG1: asynchMsgCback
[ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000004, cmdId:0x0000000000000081, len:0x0000000000000019, pData:0x00000000B6A00558
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ (Handle) (message @ 0x00000000B6A00550)...
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
[ZSTACKZNP_SRVR/HNDL] INFO: [DBG] Clearing              @ 0x00000000B6A00550 (processed 6803 messages)...
[ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Wait for AREQ semaphore
[ZSTACKZNP_SRVR/MAIN] INFO: ...sent 67 bytes to Client
[GATEWAY/READ] INFO: Received 13 bytes,  subSys 0x79, cmdId 0x01, pData:
MYLOG: unreserveActiveConnection
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x19
[GATEWAY/READ] INFO: Received 63 bytes,  subSys 0x51, cmdId 0x92, pData:
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x92
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x12
[GATEWAY/READ] INFO:  0x9
[GATEWAY/READ] INFO:  0x8
[GATEWAY/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x9B
[GATEWAY/READ] INFO:  0x3D
[GATEWAY/READ] INFO:  0x20
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x28
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x20
[GATEWAY/READ] INFO:  0x6
[GATEWAY/READ] INFO:  0x28
[GATEWAY/READ] INFO:  0x2D
[GATEWAY/READ] INFO:  0x3F
[GATEWAY/READ] INFO:  0x14
[GATEWAY/READ] INFO:  0x10
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x4B
[GATEWAY/READ] INFO:  0x12
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO: [MUTEX] SRSP Cond signal set
[GATEWAY/READ] INFO: Client Read: (len 0): [GATEWAY/HNDL] INFO: 0x08
[GATEWAY/HNDL] INFO: 0x01
[GATEWAY/HNDL] INFO: 0x10
[GATEWAY/HNDL] INFO: 0x00
[GATEWAY/HNDL] INFO: 0x19
[GATEWAY/HNDL] INFO: 0x2D
[GATEWAY/HNDL] INFO: 0x3F
[GATEWAY/HNDL] INFO: 0x14
[GATEWAY/HNDL] INFO: 0x10
[GATEWAY/HNDL] INFO: 0x00
[GATEWAY/HNDL] INFO: 0x4B
[GATEWAY/HNDL] INFO: 0x12
[GATEWAY/HNDL] INFO: 0x00
[GATEWAY/HNDL] INFO: [MUTEX] Unlock SRSP Mutex
[GATEWAY/HNDL] : Processing Attribute Report Indication
MYLOG: APIS_SendData
MYLOG: apisSendData
[GATEWAY/READ] INFO:  0x9B
[GATEWAY/READ] INFO:  0x3D
[GATEWAY/READ] INFO:  0x30
[GATEWAY/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x38
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x40
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x48
[GATEWAY/READ] INFO:  0xCA
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x50
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x58
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0xFF
[GATEWAY/READ] INFO:  0x1
[GATEWAY/LSTN] INFO: ...sent 11 bytes to Client
MYLOG: unreserveActiveConnection
[GATEWAY/READ] INFO:  0x60
[GATEWAY/READ] INFO:  0x82
[GATEWAY/READ] INFO:  0xE8
[GATEWAY/READ] INFO:  0x32
[GATEWAY/READ] INFO:  0x68
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x70
[GATEWAY/READ] INFO:  0xF5
[GATEWAY/READ] INFO:  0xE7
[GATEWAY/READ] INFO:  0x2
[GATEWAY/READ] INFO:  0x78
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x82
[GATEWAY/READ] INFO:  0x1
[GATEWAY/READ] INFO:  0x5
[GATEWAY/READ] INFO:  0x18
[GATEWAY/READ] INFO:  0xF7
[GATEWAY/READ] INFO:  0xB
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO:  0x0
[GATEWAY/READ] INFO: RPC_CMD_AREQ cmdId: 0x92
[GATEWAY/READ] INFO:
[DBG] Allocated         @ 0x00000000B6B00530 (received  6799 messages)...
[GATEWAY/READ] INFO: Filling new message (@ 0x00000000B6B00530)...
[GATEWAY/MAIN] INFO: (GW timer) deleted zclTransId: 247
[GATEWAY/MAIN] : Sending Generic Response Indication: Status: 4, SequenceNumber: 2295
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection    //Last log from servers,after this GW server doesn't receive any command from GW application

  • 0 in reply to Ahmad.TI
    TI__Guru**** 202126 points

    How quickly are these ON/OFF commands sent and is any other communication occurring on the network?  Now that you've debugged the issue down to reserveActiveConnection you will need to determine what variable (connection) is being passed and what the return status is.  Or if reserveActiveConnection is successful in apisSendData you should figure out what fails between this and printing "...sent [x] bytes to Client"

    Regards,
    Ryan

  • 0 in reply to Ryan Brown1
    Expert 1780 points

    I actually want (for some reasons) implement scenarios in my application (and not using Zigbee itself scenes), so my client (that is written with Node.js) may sends a packet that includes one or more commands, and in my application I receive them and split them and put them into a queue(using semaphores). In consumer function I check waiting_for_confirmation flag periodically  an if it was false so I send next command to be sent to Zigbee servers using Sample application's apis. Now after that about 80 scenarios are run (each  scenario  includes 3 on/off commands) ,Gateway server doesn't respond to any command until I restart servers. I put "printf" functions into reserveActiveConnection  function to see where it crashes, but none of them were printed after gateway server crashed!!

    I decided to debug Gateway_Server application using Visual Studio and GDB server but now I have errors with compiling it! Can you please guide me how should I do it?!

  • 0 in reply to Ahmad.TI
    Expert 1780 points

    I encountered error MSB3073 when trying to compile Gateway_Server files.

  • 0 in reply to Ahmad.TI
    TI__Guru**** 202126 points

    Please reference the Quick Start and User's Guides:

    http://software-dl.ti.com/simplelink/esd/zigbee_3_0_Linux/1.0.1/exports/Documents/Z-Stack%20Linux%20Gateway%20-%20Quick%20Start%20Guide.html 
    http://software-dl.ti.com/simplelink/esd/zigbee_3_0_Linux/1.0.1/exports/Documents/Z-Stack%20Linux%20Gateway%20-%20User's%20Guide.html 
    http://software-dl.ti.com/simplelink/esd/zigbee_3_0_Linux/1.0.1/exports/Documents/Z-Stack%20Linux%20Gateway%20-%20Developer's%20Guide.html

    Also provided is the Developer's Guide for an explanation of Protobuf usage.  These contain instructions for rebuilding the gateway servers provided the correct compilers are installed.  Otherwise, I have limited knowledge of Linux and cannot be of any further assistance.

    Regards,
    Ryan

  • 0 in reply to Ryan Brown1
    Expert 1780 points

    Thank you fro your help.

    I tested cases that the problem occurs so many times and I think I found when exactly it happens.In the log file below in the timestamp  [14:16:10.780,689] GW server is trying to send a Zigbee Generic Confirmation (for a command that already is sent from APP) to APP, and at timestamp [14:16:10.782,907] ie, 2ms later a Report Indication is received from a device that already a command is sent to it and again GW server tries to send Report Indication to APP And after this point the connection between GW server and APP is lost until restarting GW server. Meanwhile, Report Indications from other devices are received and GATEWAY/READ logs are shown but no log is shown from GATEWAY/HNDL thread! I think maybe these simultaneous tries to sending data to APP causes the GW to crash or malfunction. Even in some cases the time difference between these two sending was in order of few hundreds of microseconds!

    NOK-4.log 
    [14:16:10.780,335] [GATEWAY/LSTN] INFO: [MUTEX] Unlock SRSP Mutex
[14:16:10.780,443] [GATEWAY/LSTN] DEBUG: Checked transaction table size: 50
[14:16:10.780,529] [GATEWAY/LSTN] DEBUG: Checked transaction table number of entries: 0
[14:16:10.780,609] [GATEWAY/LSTN] INFO: (GW posted) cmdId: 39, zclTransId 68
[14:16:10.780,689] [GATEWAY/LSTN] : Sending ZigBee Generic Confirmation
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
MYLOG: OK3,1989149840,6,6
MYLOG: 6
MYLOG: OK4
MYLOG: OK1
[14:16:10.780,998] [GATEWAY/HNDL] INFO: 0x08
[14:16:10.781,884] [GATEWAY/HNDL] INFO: 0x01
[14:16:10.781,975] [GATEWAY/HNDL] INFO: 0x10
[14:16:10.782,053] [GATEWAY/HNDL] INFO: 0x00
[14:16:10.782,130] [GATEWAY/HNDL] INFO: 0x19
[14:16:10.782,205] [GATEWAY/HNDL] INFO: 0xB7
[14:16:10.782,283] [GATEWAY/HNDL] INFO: 0xAF
[14:16:10.782,358] [GATEWAY/HNDL] INFO: 0x85
[14:16:10.782,434] [GATEWAY/HNDL] INFO: 0x0D
[14:16:10.782,509] [GATEWAY/HNDL] INFO: 0x00
[14:16:10.782,584] [GATEWAY/HNDL] INFO: 0x4B
[14:16:10.782,659] [GATEWAY/HNDL] INFO: 0x12
[14:16:10.782,733] [GATEWAY/HNDL] INFO: 0x00
[14:16:10.782,807] [GATEWAY/HNDL] INFO: [MUTEX] Unlock SRSP Mutex
[14:16:10.782,907] [GATEWAY/HNDL] : Processing Attribute Report Indication
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: OK2 6
[14:16:10.783,200] [GATEWAY/LSTN] INFO: ...sent 10 bytes to Client
MYLOG: unreserveActiveConnection
[14:16:10.783,385] [GATEWAY/READ] INFO:  0x20
[14:16:10.784,512] [GATEWAY/READ] INFO:  0x6
[14:16:10.784,611] [GATEWAY/READ] INFO:  0x28
[14:16:10.784,688] [GATEWAY/READ] INFO:  0xEE
[14:16:10.784,763] [GATEWAY/READ] INFO:  0xB6
[14:16:10.784,840] [GATEWAY/READ] INFO:  0x1
[14:16:10.785,441] [GATEWAY/READ] INFO:  0x30
[14:16:10.785,535] [GATEWAY/READ] INFO:  0x2
[14:16:10.785,611] [GATEWAY/READ] INFO:  0x38
[14:16:10.785,687] [GATEWAY/READ] INFO:  0x0
[14:16:10.785,761] [GATEWAY/READ] INFO:  0x40
[14:16:10.785,835] [GATEWAY/READ] INFO:  0x0
[14:16:10.785,910] [GATEWAY/READ] INFO:  0x48
[14:16:10.785,996] [GATEWAY/READ] INFO:  0x88
[14:16:10.786,033] [GATEWAY/READ] INFO:  0x1
[14:16:10.786,064] [GATEWAY/READ] INFO:  0x50
[14:16:10.786,093] [GATEWAY/READ] INFO:  0x0
[14:16:10.786,122] [GATEWAY/READ] INFO:  0x58
[14:16:10.786,151] [GATEWAY/READ] INFO:  0xFF
[14:16:10.786,179] [GATEWAY/READ] INFO:  0xFF
[14:16:10.786,208] [GATEWAY/READ] INFO:  0xFF
[14:16:10.786,236] [GATEWAY/READ] INFO:  0xFF
[14:16:10.786,265] [GATEWAY/READ] INFO:  0xFF
[14:16:10.786,402] [GATEWAY/READ] INFO:  0xFF
[14:16:10.786,437] [GATEWAY/READ] INFO:  0xFF
[14:16:10.786,465] [GATEWAY/READ] INFO:  0xFF
[14:16:10.786,495] [GATEWAY/READ] INFO:  0xFF
[14:16:10.786,523] [GATEWAY/READ] INFO:  0x1
[14:16:10.786,551] [GATEWAY/READ] INFO:  0x60
[14:16:10.786,579] [GATEWAY/READ] INFO:  0xDE
[14:16:10.786,608] [GATEWAY/READ] INFO:  0xD7
[14:16:10.786,636] [GATEWAY/READ] INFO:  0x14
[14:16:10.786,665] [GATEWAY/READ] INFO:  0x68
[14:16:10.786,693] [GATEWAY/READ] INFO:  0x1
[14:16:10.786,775] [GATEWAY/READ] INFO:  0x70
[14:16:10.786,854] [GATEWAY/READ] INFO:  0xCC
[14:16:10.786,929] [GATEWAY/READ] INFO:  0x57
[14:16:10.787,298] [GATEWAY/READ] INFO:  0x78
[14:16:10.787,385] [GATEWAY/READ] INFO:  0x0
[14:16:10.787,461] [GATEWAY/READ] INFO:  0x82
[14:16:10.787,539] [GATEWAY/READ] INFO:  0x1
[14:16:10.788,264] [GATEWAY/READ] INFO:  0x5
[14:16:10.788,369] [GATEWAY/READ] INFO:  0x18
[14:16:10.788,447] [GATEWAY/READ] INFO:  0x44
[14:16:10.788,522] [GATEWAY/READ] INFO:  0xB
[14:16:10.788,603] [GATEWAY/READ] INFO:  0x0
[14:16:10.788,679] [GATEWAY/READ] INFO:  0x0
[14:16:10.788,757] [GATEWAY/READ] INFO: RPC_CMD_AREQ cmdId: 0x92
[14:16:10.788,834] [GATEWAY/READ] INFO:
[DBG] Allocated         @ 0x0000000076C00508 (received  211 messages)...
[14:16:10.789,010] [GATEWAY/READ] INFO: Filling new message (@ 0x0000000076C00508)...
[14:16:16.885,254] [ZSTACKZNP_SRVR/READ] INFO: Received 28 bytes,        subSys 0x44, cmdId 0x81, pData:
[14:16:16.885,442] [ZSTACKZNP_SRVR/READ] INFO:  0x0
[14:16:16.885,523] [ZSTACKZNP_SRVR/READ] INFO:  0x0
[14:16:16.885,601] [ZSTACKZNP_SRVR/READ] INFO:  0x4
[14:16:16.885,678] [ZSTACKZNP_SRVR/READ] INFO:  0xB
[14:16:16.885,753] [ZSTACKZNP_SRVR/READ] INFO:  0xD9
[14:16:16.885,828] [ZSTACKZNP_SRVR/READ] INFO:  0x76
[14:16:16.885,903] [ZSTACKZNP_SRVR/READ] INFO:  0x1
[14:16:16.885,981] [ZSTACKZNP_SRVR/READ] INFO:  0x2
[14:16:16.886,057] [ZSTACKZNP_SRVR/READ] INFO:  0x0
[14:16:16.886,132] [ZSTACKZNP_SRVR/READ] INFO:  0x88
[14:16:16.886,207] [ZSTACKZNP_SRVR/READ] INFO:  0x0
[14:16:16.886,384] [ZSTACKZNP_SRVR/READ] INFO:  0xB4
[14:16:16.886,468] [ZSTACKZNP_SRVR/READ] INFO:  0x76
[14:16:16.886,544] [ZSTACKZNP_SRVR/READ] INFO:  0x5
[14:16:16.886,621] [ZSTACKZNP_SRVR/READ] INFO:  0x0
[14:16:16.886,695] [ZSTACKZNP_SRVR/READ] INFO:  0x0
[14:16:16.886,769] [ZSTACKZNP_SRVR/READ] INFO:  0x8
[14:16:16.886,844] [ZSTACKZNP_SRVR/READ] INFO:  0x18
[14:16:16.886,919] [ZSTACKZNP_SRVR/READ] INFO:  0x7
[14:16:16.886,994] [ZSTACKZNP_SRVR/READ] INFO:  0xA
[14:16:16.887,072] [ZSTACKZNP_SRVR/READ] INFO:  0x8
[14:16:16.887,149] [ZSTACKZNP_SRVR/READ] INFO:  0x5
[14:16:16.887,225] [ZSTACKZNP_SRVR/READ] INFO:  0x21
[14:16:16.887,300] [ZSTACKZNP_SRVR/READ] INFO:  0xAC
[14:16:16.887,375] [ZSTACKZNP_SRVR/READ] INFO:  0x6
[14:16:16.887,449] [ZSTACKZNP_SRVR/READ] INFO:  0x68
[14:16:16.887,523] [ZSTACKZNP_SRVR/READ] INFO:  0xF
[14:16:16.887,598] [ZSTACKZNP_SRVR/READ] INFO:  0x1C
[14:16:16.887,673] [ZSTACKZNP_SRVR/READ] INFO: RPC_CMD_AREQ cmdId: 0x81
[14:16:16.887,749] [ZSTACKZNP_SRVR/READ] INFO:
[DBG] Allocated         @ 0x0000000076C00558 (received  215 messages)...
[14:16:16.887,962] [ZSTACKZNP_SRVR/READ] INFO: Filling new message (@ 0x0000000076C00558)...
[14:16:16.888,092] [ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Mutex for AREQ unlocked
[14:16:16.888,143] [ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] Processing        @ 0x0000000076C00558
[14:16:16.888,213] [ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ Calling asynchMsgCback (Handle)...
MYLOG1: asynchMsgCback
[14:16:16.888,263] [ZSTACKZNP_SRVR/HNDL] INFO:

[DBG] asyncCB: subSys:0x0000000000000004, cmdId:0x0000000000000081, len:0x000000000000001C, pData:0x0000000076C00560
[14:16:16.888,367] [ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] AREQ (Handle) (message @ 0x0000000076C00558)...
[14:16:16.888,407] [ZSTACKZNP_SRVR/HNDL] INFO: [DBG] Clearing           @ 0x0000000076C00558 (processed 215 messages)...
[14:16:16.888,453] [ZSTACKZNP_SRVR/HNDL] INFO: [MUTEX] Wait for AREQ semaphore
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection
MYLOG: OK3,1991247976,7,6
MYLOG: 7
MYLOG: 6
MYLOG: OK4
MYLOG: OK1
MYLOG: OK2 6
[14:16:16.888,790] [ZSTACKZNP_SRVR/MAIN] INFO: ...sent 72 bytes to Client
MYLOG: unreserveActiveConnection
[14:16:16.888,783] [GATEWAY/READ] INFO: Received 68 bytes,       subSys 0x51, cmdId 0x92, pData:
[14:16:16.888,900] [GATEWAY/READ] INFO:  0x8
[14:16:16.888,935] [GATEWAY/READ] INFO:  0x92
[14:16:16.888,968] [GATEWAY/READ] INFO:  0x1
[14:16:16.889,000] [GATEWAY/READ] INFO:  0x12
[14:16:16.889,032] [GATEWAY/READ] INFO:  0xA
[14:16:16.889,064] [GATEWAY/READ] INFO:  0x8
[14:16:16.889,096] [GATEWAY/READ] INFO:  0x2
[14:16:16.889,128] [GATEWAY/READ] INFO:  0x10
[14:16:16.889,160] [GATEWAY/READ] INFO:  0xD9
[14:16:16.889,192] [GATEWAY/READ] INFO:  0xED
[14:16:16.889,224] [GATEWAY/READ] INFO:  0x1
[14:16:16.889,256] [GATEWAY/READ] INFO:  0x20
[14:16:16.889,288] [GATEWAY/READ] INFO:  0x1
[14:16:16.889,319] [GATEWAY/READ] INFO:  0x28
[14:16:16.889,351] [GATEWAY/READ] INFO:  0x0
[14:16:16.889,383] [GATEWAY/READ] INFO:  0x18
[14:16:16.889,415] [GATEWAY/READ] INFO:  0x0
[14:16:16.889,446] [GATEWAY/READ] INFO:  0x20
[14:16:16.889,478] [GATEWAY/READ] INFO:  0x84
[14:16:16.889,509] [GATEWAY/READ] INFO:  0x16
[14:16:16.889,541] [GATEWAY/READ] INFO:  0x28
[14:16:16.889,573] [GATEWAY/READ] INFO:  0xEE
[14:16:16.889,604] [GATEWAY/READ] INFO:  0xB6
[14:16:16.889,636] [GATEWAY/READ] INFO:  0x1
[14:16:16.889,667] [GATEWAY/READ] INFO:  0x30
[14:16:16.889,699] [GATEWAY/READ] INFO:  0x2
[14:16:16.889,731] [GATEWAY/READ] INFO:  0x38
[14:16:16.889,762] [GATEWAY/READ] INFO:  0x0
[14:16:16.889,794] [GATEWAY/READ] INFO:  0x40
[14:16:16.889,826] [GATEWAY/READ] INFO:  0x0
[14:16:16.889,857] [GATEWAY/READ] INFO:  0x48
[14:16:16.889,888] [GATEWAY/READ] INFO:  0x88
[14:16:16.889,920] [GATEWAY/READ] INFO:  0x1
[14:16:16.889,951] [GATEWAY/READ] INFO:  0x50
[14:16:16.889,983] [GATEWAY/READ] INFO:  0x0
[14:16:16.890,015] [GATEWAY/READ] INFO:  0x58
[14:16:16.890,047] [GATEWAY/READ] INFO:  0xFF
[14:16:16.890,079] [GATEWAY/READ] INFO:  0xFF
[14:16:16.890,111] [GATEWAY/READ] INFO:  0xFF
[14:16:16.890,142] [GATEWAY/READ] INFO:  0xFF
[14:16:16.890,174] [GATEWAY/READ] INFO:  0xFF
[14:16:16.890,205] [GATEWAY/READ] INFO:  0xFF
[14:16:16.890,237] [GATEWAY/READ] INFO:  0xFF
[14:16:16.890,269] [GATEWAY/READ] INFO:  0xFF
[14:16:16.890,300] [GATEWAY/READ] INFO:  0xFF
[14:16:16.890,332] [GATEWAY/READ] INFO:  0x1
[14:16:16.890,363] [GATEWAY/READ] INFO:  0x60
[14:16:16.890,395] [GATEWAY/READ] INFO:  0xB4
[14:16:16.890,427] [GATEWAY/READ] INFO:  0xED
[14:16:16.890,458] [GATEWAY/READ] INFO:  0x15
[14:16:16.890,490] [GATEWAY/READ] INFO:  0x68
[14:16:16.890,521] [GATEWAY/READ] INFO:  0x1
[14:16:16.890,553] [GATEWAY/READ] INFO:  0x70
[14:16:16.890,584] [GATEWAY/READ] INFO:  0xCC
[14:16:16.890,616] [GATEWAY/READ] INFO:  0x57
[14:16:16.890,647] [GATEWAY/READ] INFO:  0x78
[14:16:16.890,679] [GATEWAY/READ] INFO:  0x0
[14:16:16.890,711] [GATEWAY/READ] INFO:  0x82
[14:16:16.890,743] [GATEWAY/READ] INFO:  0x1
[14:16:16.890,774] [GATEWAY/READ] INFO:  0x8
[14:16:16.890,806] [GATEWAY/READ] INFO:  0x18
[14:16:16.890,838] [GATEWAY/READ] INFO:  0x7
[14:16:16.890,869] [GATEWAY/READ] INFO:  0xA
[14:16:16.890,901] [GATEWAY/READ] INFO:  0x8
[14:16:16.890,932] [GATEWAY/READ] INFO:  0x5
[14:16:16.890,964] [GATEWAY/READ] INFO:  0x21
[14:16:16.890,995] [GATEWAY/READ] INFO:  0xAC
[14:16:16.891,027] [GATEWAY/READ] INFO:  0x6
[14:16:16.891,060] [GATEWAY/READ] INFO: RPC_CMD_AREQ cmdId: 0x92
[14:16:16.891,094] [GATEWAY/READ] INFO:
[DBG] Allocated         @ 0x0000000076C00558 (received  212 messages)...
[14:16:16.891,237] [GATEWAY/READ] INFO: Filling new message (@ 0x0000000076C00558)...
[14:16:19.573,388] [GATEWAY/MAIN] INFO: (GW timer) deleted zclTransId: 68
[14:16:19.573,476] [GATEWAY/MAIN] : Sending Generic Response Indication: Status: 4, SequenceNumber: 68
MYLOG: APIS_SendData
MYLOG: apisSendData
MYLOG: reserveActiveConnection