2022-03-22 09:40:00.745 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B0022289907: Initializing ZigBee thing handler zigbee:device:a521e35b6c:00124b0022289907 2022-03-22 09:40:00.746 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B0022289907: Coordinator status changed to ONLINE. 2022-03-22 09:40:00.747 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B0022289907: Coordinator is ONLINE. Starting device initialisation. 2022-03-22 09:40:00.747 [DEBUG] [pp.discovery.ZigBeeNetworkDiscoverer] - 00124B0022289907: NWK Discovery starting node rediscovery 2022-03-22 09:40:00.747 [DEBUG] [pp.discovery.ZigBeeNetworkDiscoverer] - 00124B0022289907: NWK Discovery: Rediscovery using unicast to 098E 2022-03-22 09:40:00.747 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=0, state=WAITING, sendCnt=0, command=NetworkAddressRequest [0000/0 -> 098E/0, cluster=0000, TID=--, ieeeAddr=00124B0022289907, requestType=0, startIndex=0]] 2022-03-22 09:40:00.748 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=1, sleepy=0/3 2022-03-22 09:40:00.749 [DEBUG] [transaction.ZigBeeTransactionManager] - 098E/0: Sending ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=2, state=WAITING, sendCnt=0, command=NetworkAddressRequest [0000/0 -> 098E/0, cluster=0000, TID=B1, ieeeAddr=00124B0022289907, requestType=0, startIndex=0]] 2022-03-22 09:40:00.750 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 1 outstanding 2022-03-22 09:40:00.750 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: NetworkAddressRequest [0000/0 -> 098E/0, cluster=0000, TID=B1, ieeeAddr=00124B0022289907, requestType=0, startIndex=0] 2022-03-22 09:40:00.750 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/0, destinationAddress=098E/0, profile=0000, cluster=0000, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=20, rssi=--, lqi=--, payload=B1 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:40:00.750 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=177, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=B1 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:40:00.750 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B1 state=TX_ACK 2022-03-22 09:40:00.750 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 89: XBeeTransmitRequestExplicitCommand [frameId=54, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=B1 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:40:00.751 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B1, state=TX_ACK, outstanding=1 2022-03-22 09:40:00.751 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B1, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:40:00.759 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B0022289907: Start initialising ZigBee Thing handler 2022-03-22 09:40:00.761 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B0022289907: ZigBee node property discovery start 2022-03-22 09:40:00.762 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B0022289907: ZigBee node property discovery using basic cluster on endpoint 098E/1 2022-03-22 09:40:00.762 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=0, state=WAITING, sendCnt=0, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=--, identifiers=[2]]] 2022-03-22 09:40:00.762 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=1, sleepy=1/3 2022-03-22 09:40:00.805 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=1, sleepy=1/3 2022-03-22 09:40:05.096 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B DC FF FD 00 24 40 38 2022-03-22 09:40:05.096 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=220, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=EXTENDED_TIMEOUT_DISCOVERY] 2022-03-22 09:40:05.096 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=221, ieeeAddress=00158D0007C79586, networkAddress=32720, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=78 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:40:05.096 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 DD 00 15 8D 00 07 C7 95 86 7F D0 00 00 00 00 00 00 00 00 78 86 95 C7 07 00 8D 15 00 00 00 34 2022-03-22 09:40:08.753 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B1 state=RX_NAK 2022-03-22 09:40:08.753 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8006, state=FAILED, sendCnt=1, command=NetworkAddressRequest [0000/0 -> 098E/0, cluster=0000, TID=B1, ieeeAddr=00124B0022289907, requestType=0, startIndex=0]] 2022-03-22 09:40:08.753 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B1, state=RX_NAK, outstanding=1 2022-03-22 09:40:08.753 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:40:08.753 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:40:08.753 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: Added transaction to queue, len=2, transaction=ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8006, state=WAITING, sendCnt=1, command=NetworkAddressRequest [0000/0 -> 098E/0, cluster=0000, TID=B1, ieeeAddr=00124B0022289907, requestType=0, startIndex=0]] 2022-03-22 09:40:08.753 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=1, sleepy=0/3 2022-03-22 09:40:08.753 [DEBUG] [transaction.ZigBeeTransactionManager] - 098E/0: Sending ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8006, state=WAITING, sendCnt=1, command=NetworkAddressRequest [0000/0 -> 098E/0, cluster=0000, TID=B1, ieeeAddr=00124B0022289907, requestType=0, startIndex=0]] 2022-03-22 09:40:08.753 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 1 outstanding 2022-03-22 09:40:08.753 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: NetworkAddressRequest [0000/0 -> 098E/0, cluster=0000, TID=B1, ieeeAddr=00124B0022289907, requestType=0, startIndex=0] 2022-03-22 09:40:08.753 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/0, destinationAddress=098E/0, profile=0000, cluster=0000, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=21, rssi=--, lqi=--, payload=B1 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:40:08.753 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=177, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=B1 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:40:08.753 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B1 state=TX_ACK 2022-03-22 09:40:08.753 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 89: XBeeTransmitRequestExplicitCommand [frameId=55, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=B1 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:40:08.753 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B1, state=TX_ACK, outstanding=1 2022-03-22 09:40:08.753 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B1, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:40:08.815 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=1, sleepy=1/3 2022-03-22 09:40:09.971 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B DD FF FD 00 24 02 75 2022-03-22 09:40:15.103 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - XBEE Timer: Timeout 2022-03-22 09:40:15.273 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=221, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:40:15.288 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=222, ieeeAddress=847127FFFEC6C3BA, networkAddress=46814, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=77 BA C3 C6 FE FF 27 71 84 00 00] 2022-03-22 09:40:15.288 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 DE 84 71 27 FF FE C6 C3 BA B6 DE 00 00 00 00 00 00 00 00 77 BA C3 C6 FE FF 27 71 84 00 00 4D 2022-03-22 09:40:15.288 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=223, ieeeAddress=00124B0023B4EAA9, networkAddress=18602, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=79 A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:40:15.288 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 DF 00 12 4B 00 23 B4 EA A9 48 AA 00 00 00 00 00 00 00 00 79 A9 EA B4 23 00 4B 12 00 00 00 16 2022-03-22 09:40:16.777 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B1 state=RX_NAK 2022-03-22 09:40:16.777 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16030, state=FAILED, sendCnt=2, command=NetworkAddressRequest [0000/0 -> 098E/0, cluster=0000, TID=B1, ieeeAddr=00124B0022289907, requestType=0, startIndex=0]] 2022-03-22 09:40:16.777 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B1, state=RX_NAK, outstanding=1 2022-03-22 09:40:16.777 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:40:16.777 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:40:16.777 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete exceeded max retries 2 2022-03-22 09:40:16.777 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction cancelled: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16030, state=CANCELLED, sendCnt=2, command=NetworkAddressRequest [0000/0 -> 098E/0, cluster=0000, TID=B1, ieeeAddr=00124B0022289907, requestType=0, startIndex=0]] 2022-03-22 09:40:16.777 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16030, state=CANCELLED, sendCnt=2, command=NetworkAddressRequest [0000/0 -> 098E/0, cluster=0000, TID=B1, ieeeAddr=00124B0022289907, requestType=0, startIndex=0]] 2022-03-22 09:40:16.777 [DEBUG] [pp.discovery.ZigBeeNetworkDiscoverer] - 00124B0022289907: NWK Discovery: Rediscovery using broadcast 2022-03-22 09:40:16.777 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:40:16.777 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete but not outstanding, state=CANCELLED, outstanding=0 2022-03-22 09:40:16.777 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=1, sleepy=0/3 2022-03-22 09:40:16.777 [DEBUG] [transaction.ZigBeeTransactionManager] - 098E/1: Sending ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16015, state=WAITING, sendCnt=0, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B2, identifiers=[2]]] 2022-03-22 09:40:16.777 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 1 outstanding 2022-03-22 09:40:16.777 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B2, identifiers=[2]] 2022-03-22 09:40:16.777 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=178, commandId=0] 2022-03-22 09:40:16.777 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/1, destinationAddress=098E/1, profile=0104, cluster=0000, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=22, rssi=--, lqi=--, payload=00 B2 00 02 00] 2022-03-22 09:40:16.777 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=178, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=0, profileId=260, broadcastRadius=0, options=[], data=00 B2 00 02 00] 2022-03-22 09:40:16.777 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=0, sleepy=0/3 2022-03-22 09:40:16.777 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B2 state=TX_ACK 2022-03-22 09:40:16.777 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 88: XBeeTransmitRequestExplicitCommand [frameId=56, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=0, profileId=260, broadcastRadius=0, options=[], data=00 B2 00 02 00] 2022-03-22 09:40:16.777 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Broadcast: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=null queueTime=0, state=WAITING, sendCnt=0, command=NetworkAddressRequest [0000/0 -> FFFD/0, cluster=0000, TID=--, ieeeAddr=00124B0022289907, requestType=0, startIndex=0]] 2022-03-22 09:40:16.777 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B2, state=TX_ACK, outstanding=1 2022-03-22 09:40:16.777 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=1, sleepy=0/3 2022-03-22 09:40:16.792 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B2, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:40:16.792 [DEBUG] [transaction.ZigBeeTransactionManager] - FFFD/0: Sending ZigBeeTransaction [ieeeAddress=null queueTime=15, state=WAITING, sendCnt=0, command=NetworkAddressRequest [0000/0 -> FFFD/0, cluster=0000, TID=B3, ieeeAddr=00124B0022289907, requestType=0, startIndex=0]] 2022-03-22 09:40:16.792 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 2 outstanding 2022-03-22 09:40:16.792 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: NetworkAddressRequest [0000/0 -> FFFD/0, cluster=0000, TID=B3, ieeeAddr=00124B0022289907, requestType=0, startIndex=0] 2022-03-22 09:40:16.792 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/0, destinationAddress=FFFD/0, profile=0000, cluster=0000, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=23, rssi=--, lqi=--, payload=B3 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:40:16.792 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=179, ieeeAddress=000000000000FFFF, networkAddress=65533, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=B3 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:40:16.792 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B3 state=TX_ACK 2022-03-22 09:40:16.792 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 89: XBeeTransmitRequestExplicitCommand [frameId=57, ieeeAddress=000000000000FFFF, networkAddress=65533, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=B3 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:40:16.792 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B3, state=TX_ACK, outstanding=2 2022-03-22 09:40:16.792 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=FFFD, TID=B3, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:40:20.216 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B DF FF FD 00 24 02 73 2022-03-22 09:40:20.216 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=223, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:40:20.216 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=224, ieeeAddress=00158D0007C79586, networkAddress=32720, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=78 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:40:20.216 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 E0 00 15 8D 00 07 C7 95 86 7F D0 00 00 00 00 00 00 00 00 78 86 95 C7 07 00 8D 15 00 00 00 31 2022-03-22 09:40:23.757 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B DE FF FD 00 24 40 36 2022-03-22 09:40:23.757 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=222, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=EXTENDED_TIMEOUT_DISCOVERY] 2022-03-22 09:40:23.764 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=225, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=7A BA C3 C6 FE FF 27 71 84 00 00] 2022-03-22 09:40:23.764 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 E1 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 7A BA C3 C6 FE FF 27 71 84 00 00 3B 2022-03-22 09:40:23.858 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 13 A2 00 41 B4 92 67 00 00 00 00 80 00 00 00 01 7A 00 BA C3 C6 FE FF 27 71 84 DE B6 E0 2022-03-22 09:40:23.858 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=0013A20041B49267, networkAddress=0, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=7A 00 BA C3 C6 FE FF 27 71 84 DE B6] 2022-03-22 09:40:23.858 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=0000/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=7A 00 BA C3 C6 FE FF 27 71 84 DE B6] 2022-03-22 09:40:23.858 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 0013A20041B49267: Node update. NWK Address=0000 2022-03-22 09:40:23.858 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 0013A20041B49267: Node 0000 is not updated 2022-03-22 09:40:23.858 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [0000/0 -> 0000/0, cluster=8000, TID=7A, status=SUCCESS, ieeeAddrRemoteDev=847127FFFEC6C3BA, nwkAddrRemoteDev=B6DE, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:40:23.858 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [0000/0 -> 0000/0, cluster=8000, TID=7A, status=SUCCESS, ieeeAddrRemoteDev=847127FFFEC6C3BA, nwkAddrRemoteDev=B6DE, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:40:24.798 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B2 state=RX_NAK 2022-03-22 09:40:24.798 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=24036, state=FAILED, sendCnt=1, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B2, identifiers=[2]]] 2022-03-22 09:40:24.798 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B2, state=RX_NAK, outstanding=2 2022-03-22 09:40:24.798 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 1 outstanding 2022-03-22 09:40:24.798 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:40:24.798 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=24036, state=WAITING, sendCnt=1, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B2, identifiers=[2]]] 2022-03-22 09:40:24.798 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=1, sleepy=0/3 2022-03-22 09:40:24.798 [DEBUG] [transaction.ZigBeeTransactionManager] - 098E/1: Sending ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=24036, state=WAITING, sendCnt=1, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B2, identifiers=[2]]] 2022-03-22 09:40:24.798 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 2 outstanding 2022-03-22 09:40:24.798 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B2, identifiers=[2]] 2022-03-22 09:40:24.798 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=178, commandId=0] 2022-03-22 09:40:24.798 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/1, destinationAddress=098E/1, profile=0104, cluster=0000, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=24, rssi=--, lqi=--, payload=00 B2 00 02 00] 2022-03-22 09:40:24.798 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=178, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=0, profileId=260, broadcastRadius=0, options=[], data=00 B2 00 02 00] 2022-03-22 09:40:24.798 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=null queueTime=8021, state=FAILED, sendCnt=1, command=NetworkAddressRequest [0000/0 -> FFFD/0, cluster=0000, TID=B3, ieeeAddr=00124B0022289907, requestType=0, startIndex=0]] 2022-03-22 09:40:24.798 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B2 state=TX_ACK 2022-03-22 09:40:24.798 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 88: XBeeTransmitRequestExplicitCommand [frameId=58, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=0, profileId=260, broadcastRadius=0, options=[], data=00 B2 00 02 00] 2022-03-22 09:40:24.798 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 1 outstanding 2022-03-22 09:40:24.798 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B2, state=TX_ACK, outstanding=1 2022-03-22 09:40:24.798 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Broadcast: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:40:24.798 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B2, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:40:24.798 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Broadcast: transactionComplete exceeded max retries 1 2022-03-22 09:40:24.798 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction cancelled: ZigBeeTransaction [ieeeAddress=null queueTime=8021, state=CANCELLED, sendCnt=1, command=NetworkAddressRequest [0000/0 -> FFFD/0, cluster=0000, TID=B3, ieeeAddr=00124B0022289907, requestType=0, startIndex=0]] 2022-03-22 09:40:24.798 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=null queueTime=8021, state=CANCELLED, sendCnt=1, command=NetworkAddressRequest [0000/0 -> FFFD/0, cluster=0000, TID=B3, ieeeAddr=00124B0022289907, requestType=0, startIndex=0]] 2022-03-22 09:40:24.798 [DEBUG] [pp.discovery.ZigBeeNetworkDiscoverer] - 00124B0022289907: NWK Discovery NetworkAddressRequest returned from null 2022-03-22 09:40:24.798 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 1 outstanding 2022-03-22 09:40:24.798 [DEBUG] [pp.discovery.ZigBeeNetworkDiscoverer] - 00124B0022289907: NWK Discovery node rediscovery request failed. 2022-03-22 09:40:24.798 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Broadcast: transactionComplete but not outstanding, state=CANCELLED, outstanding=0 2022-03-22 09:40:24.798 [DEBUG] [pp.discovery.ZigBeeNetworkDiscoverer] - 00124B0022289907: NWK Discovery finishing node rediscovery 2022-03-22 09:40:24.798 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=0, sleepy=1/3 2022-03-22 09:40:24.798 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=0, sleepy=1/3 2022-03-22 09:40:24.813 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B3 state=RX_NAK 2022-03-22 09:40:24.813 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B3, state=RX_NAK, outstanding=1 2022-03-22 09:40:25.030 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B E1 FF FE 00 00 00 96 2022-03-22 09:40:25.030 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=225, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:40:25.030 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=226, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=7B 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:40:25.030 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 E2 00 12 4B 00 22 28 99 07 09 8E 00 00 00 00 00 00 00 00 7B 07 99 28 22 00 4B 12 00 00 00 6C 2022-03-22 09:40:25.115 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B E0 FF FD 00 24 02 72 2022-03-22 09:40:25.115 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=224, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:40:25.115 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=227, ieeeAddress=00124B0023B4EAA9, networkAddress=18602, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=79 A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:40:25.115 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 E3 00 12 4B 00 23 B4 EA A9 48 AA 00 00 00 00 00 00 00 00 79 A9 EA B4 23 00 4B 12 00 00 00 12 2022-03-22 09:40:29.911 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B E2 FF FD 00 24 02 70 2022-03-22 09:40:32.820 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=32058, state=FAILED, sendCnt=2, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B2, identifiers=[2]]] 2022-03-22 09:40:32.820 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B2 state=RX_NAK 2022-03-22 09:40:33.872 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=226, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:40:33.872 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B2, state=RX_NAK, outstanding=1 2022-03-22 09:40:33.872 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:40:33.872 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=228, ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=7C 76 AD 6C 22 00 4B 12 00 00 00] 2022-03-22 09:40:33.872 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:40:33.872 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 E4 00 12 4B 00 22 6C AD 76 38 77 00 00 00 00 00 00 00 00 7C 76 AD 6C 22 00 4B 12 00 00 00 C3 2022-03-22 09:40:33.872 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete exceeded max retries 2 2022-03-22 09:40:33.872 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction cancelled: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=33110, state=CANCELLED, sendCnt=2, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B2, identifiers=[2]]] 2022-03-22 09:40:33.872 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B E3 FF FD 00 24 00 71 2022-03-22 09:40:33.872 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=33110, state=CANCELLED, sendCnt=2, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B2, identifiers=[2]]] 2022-03-22 09:40:33.872 [DEBUG] [.zsmartsystems.zigbee.zcl.ZclCluster] - readSync request: ZclAttribute [cluster=Basic, id=2, name=Stack Version, dataType=UNSIGNED_8_BIT_INTEGER, lastValue=null, implemented=false] 2022-03-22 09:40:33.872 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=227, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:40:33.872 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:40:33.872 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=229, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=7D 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:40:33.872 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete but not outstanding, state=CANCELLED, outstanding=0 2022-03-22 09:40:33.872 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 E5 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 7D 86 95 C7 07 00 8D 15 00 00 00 05 2022-03-22 09:40:33.872 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=0, sleepy=0/3 2022-03-22 09:40:33.872 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=0, sleepy=0/3 2022-03-22 09:40:33.872 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=0, state=WAITING, sendCnt=0, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=--, identifiers=[2]]] 2022-03-22 09:40:33.872 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=1, sleepy=0/3 2022-03-22 09:40:33.872 [DEBUG] [transaction.ZigBeeTransactionManager] - 098E/1: Sending ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=0, state=WAITING, sendCnt=0, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B4, identifiers=[2]]] 2022-03-22 09:40:33.872 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 1 outstanding 2022-03-22 09:40:33.872 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B4, identifiers=[2]] 2022-03-22 09:40:33.888 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=180, commandId=0] 2022-03-22 09:40:33.888 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/1, destinationAddress=098E/1, profile=0104, cluster=0000, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=25, rssi=--, lqi=--, payload=00 B4 00 02 00] 2022-03-22 09:40:33.888 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=180, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=0, profileId=260, broadcastRadius=0, options=[], data=00 B4 00 02 00] 2022-03-22 09:40:33.888 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B4 state=TX_ACK 2022-03-22 09:40:33.888 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 85: XBeeTransmitRequestExplicitCommand [frameId=59, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=0, profileId=260, broadcastRadius=0, options=[], data=00 B4 00 02 00] 2022-03-22 09:40:33.888 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B4, state=TX_ACK, outstanding=1 2022-03-22 09:40:33.888 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B4, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:40:33.971 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B E4 38 77 00 00 00 E1 2022-03-22 09:40:33.971 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=228, networkAddress=14455, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:40:33.971 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=230, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=7B 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:40:33.971 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 E6 00 12 4B 00 22 28 99 07 09 8E 00 00 00 00 00 00 00 00 7B 07 99 28 22 00 4B 12 00 00 00 68 2022-03-22 09:40:34.009 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 7C 00 76 AD 6C 22 00 4B 12 00 77 38 F7 2022-03-22 09:40:34.009 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=7C 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:40:34.009 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=7C 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:40:34.009 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:40:34.009 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:40:34.009 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=7C, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:40:34.009 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=7C, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:40:34.058 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 7D 00 86 95 C7 07 00 8D 15 00 D0 7F D9 2022-03-22 09:40:34.058 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=7D 00 86 95 C7 07 00 8D 15 00 D0 7F] 2022-03-22 09:40:34.058 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=7D 00 86 95 C7 07 00 8D 15 00 D0 7F] 2022-03-22 09:40:34.058 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:40:34.058 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:40:34.058 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=7D, status=SUCCESS, ieeeAddrRemoteDev=00158D0007C79586, nwkAddrRemoteDev=7FD0, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:40:34.058 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=7D, status=SUCCESS, ieeeAddrRemoteDev=00158D0007C79586, nwkAddrRemoteDev=7FD0, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:40:35.190 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B E5 FF FE 00 00 00 92 2022-03-22 09:40:35.190 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=229, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:40:35.190 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=231, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=7E A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:40:35.190 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 E7 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 7E A9 EA B4 23 00 4B 12 00 00 00 C6 2022-03-22 09:40:36.462 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B E7 FF FE 00 00 00 90 2022-03-22 09:40:36.462 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=231, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:40:36.462 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=232, ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=7C 76 AD 6C 22 00 4B 12 00 00 00] 2022-03-22 09:40:36.462 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 E8 00 12 4B 00 22 6C AD 76 38 77 00 00 00 00 00 00 00 00 7C 76 AD 6C 22 00 4B 12 00 00 00 BF 2022-03-22 09:40:36.563 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B E8 38 77 00 00 00 DD 2022-03-22 09:40:36.563 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=232, networkAddress=14455, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:40:36.563 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=233, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=7F 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:40:36.563 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 E9 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 7F 07 99 28 22 00 4B 12 00 00 00 43 2022-03-22 09:40:36.616 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 7C 00 76 AD 6C 22 00 4B 12 00 77 38 F7 2022-03-22 09:40:36.616 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=7C 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:40:36.616 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=7C 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:40:36.616 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:40:36.616 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:40:36.616 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=7C, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:40:36.616 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=7C, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:40:36.694 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 7F 00 07 99 28 22 00 4B 12 00 8E 09 D3 2022-03-22 09:40:36.694 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=7F 00 07 99 28 22 00 4B 12 00 8E 09] 2022-03-22 09:40:36.694 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=7F 00 07 99 28 22 00 4B 12 00 8E 09] 2022-03-22 09:40:36.694 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:40:36.694 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:40:36.694 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=7F, status=SUCCESS, ieeeAddrRemoteDev=00124B0022289907, nwkAddrRemoteDev=098E, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:40:36.694 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=7F, status=SUCCESS, ieeeAddrRemoteDev=00124B0022289907, nwkAddrRemoteDev=098E, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:40:37.834 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B E9 FF FE 00 00 00 8E 2022-03-22 09:40:37.834 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=233, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:40:37.834 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=234, ieeeAddress=847127FFFEC6C3BA, networkAddress=46814, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=80 BA C3 C6 FE FF 27 71 84 00 00] 2022-03-22 09:40:37.834 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 EA 84 71 27 FF FE C6 C3 BA B6 DE 00 00 00 00 00 00 00 00 80 BA C3 C6 FE FF 27 71 84 00 00 38 2022-03-22 09:40:40.039 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B E6 FF FD 00 24 43 2B 2022-03-22 09:40:40.039 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=230, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=UNKNOWN] 2022-03-22 09:40:40.039 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=235, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=81 76 AD 6C 22 00 4B 12 00 00 00] 2022-03-22 09:40:40.039 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 EB 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 81 76 AD 6C 22 00 4B 12 00 00 00 78 2022-03-22 09:40:40.169 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 81 00 76 AD 6C 22 00 4B 12 00 77 38 F2 2022-03-22 09:40:40.169 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=81 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:40:40.169 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=81 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:40:40.169 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:40:40.169 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:40:40.169 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=81, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:40:40.169 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=81, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:40:41.304 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B EB FF FE 00 00 00 8C 2022-03-22 09:40:41.304 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=235, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:40:41.304 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=236, ieeeAddress=847127FFFEC6C3BA, networkAddress=46814, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=80 BA C3 C6 FE FF 27 71 84 00 00] 2022-03-22 09:40:41.304 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 EC 84 71 27 FF FE C6 C3 BA B6 DE 00 00 00 00 00 00 00 00 80 BA C3 C6 FE FF 27 71 84 00 00 36 2022-03-22 09:40:41.889 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B4 state=RX_NAK 2022-03-22 09:40:41.889 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B4, state=RX_NAK, outstanding=1 2022-03-22 09:40:41.889 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8017, state=FAILED, sendCnt=1, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B4, identifiers=[2]]] 2022-03-22 09:40:41.889 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:40:41.889 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:40:41.889 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8017, state=WAITING, sendCnt=1, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B4, identifiers=[2]]] 2022-03-22 09:40:41.889 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=1, sleepy=0/3 2022-03-22 09:40:41.889 [DEBUG] [transaction.ZigBeeTransactionManager] - 098E/1: Sending ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8017, state=WAITING, sendCnt=1, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B4, identifiers=[2]]] 2022-03-22 09:40:41.889 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 1 outstanding 2022-03-22 09:40:41.889 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B4, identifiers=[2]] 2022-03-22 09:40:41.889 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=180, commandId=0] 2022-03-22 09:40:41.889 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/1, destinationAddress=098E/1, profile=0104, cluster=0000, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=26, rssi=--, lqi=--, payload=00 B4 00 02 00] 2022-03-22 09:40:41.889 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=180, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=0, profileId=260, broadcastRadius=0, options=[], data=00 B4 00 02 00] 2022-03-22 09:40:41.889 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B4, event=RX_NAK, state=DISPATCHED 2022-03-22 09:40:41.889 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B4 state=TX_ACK 2022-03-22 09:40:41.889 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 79: XBeeTransmitRequestExplicitCommand [frameId=60, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=0, profileId=260, broadcastRadius=0, options=[], data=00 B4 00 02 00] 2022-03-22 09:40:41.889 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B4, state=TX_ACK, outstanding=1 2022-03-22 09:40:41.889 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B4, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:40:46.321 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B EA FF FD 00 24 40 2A 2022-03-22 09:40:46.321 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=234, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=EXTENDED_TIMEOUT_DISCOVERY] 2022-03-22 09:40:46.322 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=237, ieeeAddress=00158D0007C79586, networkAddress=32720, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=82 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:40:46.323 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 ED 00 15 8D 00 07 C7 95 86 7F D0 00 00 00 00 00 00 00 00 82 86 95 C7 07 00 8D 15 00 00 00 1A 2022-03-22 09:40:49.915 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B4 state=RX_NAK 2022-03-22 09:40:49.915 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16043, state=FAILED, sendCnt=2, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B4, identifiers=[2]]] 2022-03-22 09:40:49.915 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B4, state=RX_NAK, outstanding=1 2022-03-22 09:40:49.915 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:40:49.915 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:40:49.915 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete exceeded max retries 2 2022-03-22 09:40:49.915 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction cancelled: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16043, state=CANCELLED, sendCnt=2, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B4, identifiers=[2]]] 2022-03-22 09:40:49.915 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16043, state=CANCELLED, sendCnt=2, command=ReadAttributesCommand [Basic: 0000/0 -> 098E/1, cluster=0000, TID=B4, identifiers=[2]]] 2022-03-22 09:40:49.915 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B0022289907: Stack version failed 2022-03-22 09:40:49.915 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:40:49.915 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B0022289907: Node doesn't support OTA cluster 2022-03-22 09:40:49.915 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete but not outstanding, state=CANCELLED, outstanding=0 2022-03-22 09:40:49.915 [DEBUG] [scovery.ZigBeeNodePropertyDiscoverer] - 00124B0022289907: ZigBee node property discovery complete: {zigbee_logicaltype=END_DEVICE, zigbee_powerlevel=MEDIUM, zigbee_manufacturercode=0x0000, modelId=WB01, zigbee_networkaddress=2446, zigbee_powersource=RECHARGABLE_BATTERY, zigbee_datecode=20200718, zigbee_zclversion=0, zigbee_routes=[], zigbee_lastupdate=, zigbee_stkcompliance=0, vendor=eWeLink, zigbee_powermode=RECEIVER_ON_PERIODICALLY, zigbee_powersources=[RECHARGABLE_BATTERY], hardwareVersion=0, zigbee_neighbors=[], zigbee_applicationVersion=5, zigbee_device_initialised=true, zigbee_devices=[]} 2022-03-22 09:40:49.915 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=0, sleepy=0/3 2022-03-22 09:40:49.915 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=0, sleepy=0/3 2022-03-22 09:40:49.915 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B0022289907: Checking endpoint 1 channels 2022-03-22 09:40:49.915 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=0, state=WAITING, sendCnt=0, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=--, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:40:49.915 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=1, sleepy=0/3 2022-03-22 09:40:49.915 [DEBUG] [transaction.ZigBeeTransactionManager] - 098E/1: Sending ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=0, state=WAITING, sendCnt=0, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B5, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:40:49.915 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 1 outstanding 2022-03-22 09:40:49.915 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B5, startAttributeIdentifier=0, maximumAttributeIdentifiers=10] 2022-03-22 09:40:49.915 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=181, commandId=12] 2022-03-22 09:40:49.915 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/1, destinationAddress=098E/1, profile=0104, cluster=0001, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=27, rssi=--, lqi=--, payload=00 B5 0C 00 00 0A] 2022-03-22 09:40:49.915 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=181, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=1, profileId=260, broadcastRadius=0, options=[], data=00 B5 0C 00 00 0A] 2022-03-22 09:40:49.915 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 79: XBeeTransmitRequestExplicitCommand [frameId=61, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=1, profileId=260, broadcastRadius=0, options=[], data=00 B5 0C 00 00 0A] 2022-03-22 09:40:49.915 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B5 state=TX_ACK 2022-03-22 09:40:49.915 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B5, state=TX_ACK, outstanding=1 2022-03-22 09:40:49.915 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B5, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:40:51.215 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B ED FF FD 00 24 02 65 2022-03-22 09:40:51.215 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=237, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:40:51.215 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=238, ieeeAddress=00124B0023B4EAA9, networkAddress=18602, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=83 A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:40:51.215 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 EE 00 12 4B 00 23 B4 EA A9 48 AA 00 00 00 00 00 00 00 00 83 A9 EA B4 23 00 4B 12 00 00 00 FD 2022-03-22 09:40:54.709 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B EC FF FD 00 24 42 26 2022-03-22 09:40:54.709 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=236, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=UNKNOWN] 2022-03-22 09:40:54.712 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=239, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=84 BA C3 C6 FE FF 27 71 84 00 00] 2022-03-22 09:40:54.712 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 EF 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 84 BA C3 C6 FE FF 27 71 84 00 00 23 2022-03-22 09:40:54.810 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 13 A2 00 41 B4 92 67 00 00 00 00 80 00 00 00 01 84 00 BA C3 C6 FE FF 27 71 84 DE B6 D6 2022-03-22 09:40:54.811 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=0013A20041B49267, networkAddress=0, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=84 00 BA C3 C6 FE FF 27 71 84 DE B6] 2022-03-22 09:40:54.811 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=0000/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=84 00 BA C3 C6 FE FF 27 71 84 DE B6] 2022-03-22 09:40:54.811 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 0013A20041B49267: Node update. NWK Address=0000 2022-03-22 09:40:54.811 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 0013A20041B49267: Node 0000 is not updated 2022-03-22 09:40:54.811 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [0000/0 -> 0000/0, cluster=8000, TID=84, status=SUCCESS, ieeeAddrRemoteDev=847127FFFEC6C3BA, nwkAddrRemoteDev=B6DE, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:40:54.811 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [0000/0 -> 0000/0, cluster=8000, TID=84, status=SUCCESS, ieeeAddrRemoteDev=847127FFFEC6C3BA, nwkAddrRemoteDev=B6DE, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:40:55.996 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B EF FF FE 00 00 00 88 2022-03-22 09:40:55.996 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=239, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:40:55.996 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=240, ieeeAddress=00158D0007C79586, networkAddress=32720, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=82 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:40:55.996 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 F0 00 15 8D 00 07 C7 95 86 7F D0 00 00 00 00 00 00 00 00 82 86 95 C7 07 00 8D 15 00 00 00 17 2022-03-22 09:40:56.080 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B EE FF FD 00 24 00 66 2022-03-22 09:40:56.080 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=238, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:40:56.080 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=241, ieeeAddress=00124B0023B4EAA9, networkAddress=18602, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=83 A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:40:56.080 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 F1 00 12 4B 00 23 B4 EA A9 48 AA 00 00 00 00 00 00 00 00 83 A9 EA B4 23 00 4B 12 00 00 00 FA 2022-03-22 09:40:57.938 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B5 state=RX_NAK 2022-03-22 09:40:57.938 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8023, state=FAILED, sendCnt=1, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B5, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:40:57.938 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B5, state=RX_NAK, outstanding=1 2022-03-22 09:40:57.938 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:40:57.938 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:40:57.938 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8023, state=WAITING, sendCnt=1, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B5, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:40:57.938 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=1, sleepy=0/3 2022-03-22 09:40:57.938 [DEBUG] [transaction.ZigBeeTransactionManager] - 098E/1: Sending ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8023, state=WAITING, sendCnt=1, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B5, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:40:57.938 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 1 outstanding 2022-03-22 09:40:57.938 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B5, startAttributeIdentifier=0, maximumAttributeIdentifiers=10] 2022-03-22 09:40:57.938 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=181, commandId=12] 2022-03-22 09:40:57.938 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/1, destinationAddress=098E/1, profile=0104, cluster=0001, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=28, rssi=--, lqi=--, payload=00 B5 0C 00 00 0A] 2022-03-22 09:40:57.938 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=181, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=1, profileId=260, broadcastRadius=0, options=[], data=00 B5 0C 00 00 0A] 2022-03-22 09:40:57.938 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B5 state=TX_ACK 2022-03-22 09:40:57.938 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 76: XBeeTransmitRequestExplicitCommand [frameId=62, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=1, profileId=260, broadcastRadius=0, options=[], data=00 B5 0C 00 00 0A] 2022-03-22 09:40:57.938 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B5, state=TX_ACK, outstanding=1 2022-03-22 09:40:57.938 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B5, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:41:00.872 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B F0 FF FD 00 24 02 62 2022-03-22 09:41:00.872 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=240, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:41:00.872 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=242, ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=85 76 AD 6C 22 00 4B 12 00 00 00] 2022-03-22 09:41:00.872 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 F2 00 12 4B 00 22 6C AD 76 38 77 00 00 00 00 00 00 00 00 85 76 AD 6C 22 00 4B 12 00 00 00 AC 2022-03-22 09:41:00.949 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B F1 FF FD 00 24 00 63 2022-03-22 09:41:00.949 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=241, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:00.949 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=243, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=86 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:41:00.949 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 F3 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 86 86 95 C7 07 00 8D 15 00 00 00 EE 2022-03-22 09:41:00.964 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B F2 38 77 00 00 00 D3 2022-03-22 09:41:00.964 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=242, networkAddress=14455, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:00.964 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=244, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=87 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:41:00.964 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 F4 00 12 4B 00 22 28 99 07 09 8E 00 00 00 00 00 00 00 00 87 07 99 28 22 00 4B 12 00 00 00 4E 2022-03-22 09:41:01.027 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 85 00 76 AD 6C 22 00 4B 12 00 77 38 EE 2022-03-22 09:41:01.027 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=85 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:41:01.027 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=85 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:41:01.027 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:41:01.027 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:41:01.027 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=85, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:01.027 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=85, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:01.080 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 86 00 86 95 C7 07 00 8D 15 00 D0 7F D0 2022-03-22 09:41:01.080 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=86 00 86 95 C7 07 00 8D 15 00 D0 7F] 2022-03-22 09:41:01.080 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=86 00 86 95 C7 07 00 8D 15 00 D0 7F] 2022-03-22 09:41:01.083 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:41:01.083 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:41:01.083 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=86, status=SUCCESS, ieeeAddrRemoteDev=00158D0007C79586, nwkAddrRemoteDev=7FD0, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:01.083 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=86, status=SUCCESS, ieeeAddrRemoteDev=00158D0007C79586, nwkAddrRemoteDev=7FD0, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:02.229 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B F3 FF FE 00 00 00 84 2022-03-22 09:41:02.229 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=243, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:02.229 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=245, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=88 A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:41:02.229 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 F5 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 88 A9 EA B4 23 00 4B 12 00 00 00 AE 2022-03-22 09:41:03.500 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B F5 FF FE 00 00 00 82 2022-03-22 09:41:03.500 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=245, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:03.500 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=246, ieeeAddress=847127FFFEC6C3BA, networkAddress=46814, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=89 BA C3 C6 FE FF 27 71 84 00 00] 2022-03-22 09:41:03.500 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 F6 84 71 27 FF FE C6 C3 BA B6 DE 00 00 00 00 00 00 00 00 89 BA C3 C6 FE FF 27 71 84 00 00 23 2022-03-22 09:41:05.860 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B F4 FF FD 00 24 02 5E 2022-03-22 09:41:05.860 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=244, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:41:05.860 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=247, ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=85 76 AD 6C 22 00 4B 12 00 00 00] 2022-03-22 09:41:05.860 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 F7 00 12 4B 00 22 6C AD 76 38 77 00 00 00 00 00 00 00 00 85 76 AD 6C 22 00 4B 12 00 00 00 A7 2022-03-22 09:41:05.960 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16045, state=FAILED, sendCnt=2, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B5, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:05.960 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B5 state=RX_NAK 2022-03-22 09:41:05.960 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B F7 38 77 00 00 00 CE 2022-03-22 09:41:05.960 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B5, state=RX_NAK, outstanding=1 2022-03-22 09:41:05.960 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=247, networkAddress=14455, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:05.960 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:41:05.960 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=248, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=87 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:41:05.960 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:41:05.960 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 F8 00 12 4B 00 22 28 99 07 09 8E 00 00 00 00 00 00 00 00 87 07 99 28 22 00 4B 12 00 00 00 4A 2022-03-22 09:41:05.960 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete exceeded max retries 2 2022-03-22 09:41:05.960 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction cancelled: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16045, state=CANCELLED, sendCnt=2, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B5, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:05.965 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16050, state=CANCELLED, sendCnt=2, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B5, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:05.966 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:41:05.966 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete but not outstanding, state=CANCELLED, outstanding=0 2022-03-22 09:41:05.966 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=0, sleepy=0/3 2022-03-22 09:41:05.966 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=0, sleepy=0/3 2022-03-22 09:41:05.966 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=0, state=WAITING, sendCnt=0, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=--, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:05.966 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=1, sleepy=0/3 2022-03-22 09:41:05.966 [DEBUG] [transaction.ZigBeeTransactionManager] - 098E/1: Sending ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=0, state=WAITING, sendCnt=0, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B6, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:05.966 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 1 outstanding 2022-03-22 09:41:05.966 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B6, startAttributeIdentifier=0, maximumAttributeIdentifiers=10] 2022-03-22 09:41:05.966 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=182, commandId=12] 2022-03-22 09:41:05.966 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/1, destinationAddress=098E/1, profile=0104, cluster=0001, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=29, rssi=--, lqi=--, payload=00 B6 0C 00 00 0A] 2022-03-22 09:41:05.966 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=182, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=1, profileId=260, broadcastRadius=0, options=[], data=00 B6 0C 00 00 0A] 2022-03-22 09:41:05.966 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B6 state=TX_ACK 2022-03-22 09:41:05.966 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B6, state=TX_ACK, outstanding=1 2022-03-22 09:41:05.966 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 70: XBeeTransmitRequestExplicitCommand [frameId=63, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=1, profileId=260, broadcastRadius=0, options=[], data=00 B6 0C 00 00 0A] 2022-03-22 09:41:05.966 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B6, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:41:06.015 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 85 00 76 AD 6C 22 00 4B 12 00 77 38 EE 2022-03-22 09:41:06.016 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=85 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:41:06.018 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=85 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:41:06.018 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:41:06.019 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:41:06.019 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=85, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:06.019 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=85, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:10.833 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B F8 FF FD 00 24 02 5A 2022-03-22 09:41:10.833 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=248, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:41:10.833 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=249, ieeeAddress=847127FFFEC6C3BA, networkAddress=46814, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=89 BA C3 C6 FE FF 27 71 84 00 00] 2022-03-22 09:41:10.833 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 F9 84 71 27 FF FE C6 C3 BA B6 DE 00 00 00 00 00 00 00 00 89 BA C3 C6 FE FF 27 71 84 00 00 20 2022-03-22 09:41:11.975 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B F6 FF FD 00 24 40 1E 2022-03-22 09:41:11.975 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=246, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=EXTENDED_TIMEOUT_DISCOVERY] 2022-03-22 09:41:11.975 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=250, ieeeAddress=00158D0007C79586, networkAddress=32720, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=8A 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:41:11.975 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 FA 00 15 8D 00 07 C7 95 86 7F D0 00 00 00 00 00 00 00 00 8A 86 95 C7 07 00 8D 15 00 00 00 05 2022-03-22 09:41:13.980 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B6 state=RX_NAK 2022-03-22 09:41:13.980 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8014, state=FAILED, sendCnt=1, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B6, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:13.980 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B6, state=RX_NAK, outstanding=1 2022-03-22 09:41:13.980 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:41:13.980 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:41:13.980 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8014, state=WAITING, sendCnt=1, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B6, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:13.980 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=1, sleepy=0/3 2022-03-22 09:41:13.980 [DEBUG] [transaction.ZigBeeTransactionManager] - 098E/1: Sending ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8014, state=WAITING, sendCnt=1, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B6, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:13.980 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 1 outstanding 2022-03-22 09:41:13.980 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B6, startAttributeIdentifier=0, maximumAttributeIdentifiers=10] 2022-03-22 09:41:13.980 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=182, commandId=12] 2022-03-22 09:41:13.980 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/1, destinationAddress=098E/1, profile=0104, cluster=0001, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=2A, rssi=--, lqi=--, payload=00 B6 0C 00 00 0A] 2022-03-22 09:41:13.980 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=182, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=1, profileId=260, broadcastRadius=0, options=[], data=00 B6 0C 00 00 0A] 2022-03-22 09:41:13.980 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 69: XBeeTransmitRequestExplicitCommand [frameId=64, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=1, profileId=260, broadcastRadius=0, options=[], data=00 B6 0C 00 00 0A] 2022-03-22 09:41:13.980 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B6 state=TX_ACK 2022-03-22 09:41:13.980 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B6, state=TX_ACK, outstanding=1 2022-03-22 09:41:13.989 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B6, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:41:14.196 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 19 91 00 12 4B 00 22 6C AD 76 38 77 01 FF 00 06 01 04 00 08 08 0A 00 00 10 01 7B 2022-03-22 09:41:14.196 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=1, destinationEndpoint=255, clusterId=6, profileId=260, receiveOptions=UNKNOWN, data=08 08 0A 00 00 10 01] 2022-03-22 09:41:14.196 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/1, destinationAddress=0000/255, profile=0104, cluster=0006, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=08 08 0A 00 00 10 01] 2022-03-22 09:41:14.196 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:41:14.196 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:41:14.196 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=SERVER_TO_CLIENT, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=8, commandId=10] 2022-03-22 09:41:14.196 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: ReportAttributesCommand [On/Off: 3877/1 -> 0000/255, cluster=0006, TID=08, reports=[AttributeReport [attributeDataType=BOOLEAN, attributeIdentifier=0, attributeValue=true]]] 2022-03-22 09:41:14.196 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: ReportAttributesCommand [On/Off: 3877/1 -> 0000/255, cluster=0006, TID=08, reports=[AttributeReport [attributeDataType=BOOLEAN, attributeIdentifier=0, attributeValue=true]]] 2022-03-22 09:41:14.196 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B00226CAD76: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B00226CAD76 queueTime=0, state=WAITING, sendCnt=0, command=DefaultResponse [On/Off: 0000/0 -> 3877/1, cluster=0006, TID=08, commandIdentifier=10, statusCode=SUCCESS]] 2022-03-22 09:41:14.196 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=1, sleepy=1/3 2022-03-22 09:41:14.196 [DEBUG] [transaction.ZigBeeTransactionManager] - 3877/1: Sending ZigBeeTransaction [ieeeAddress=00124B00226CAD76 queueTime=0, state=WAITING, sendCnt=0, command=DefaultResponse [On/Off: 0000/0 -> 3877/1, cluster=0006, TID=08, commandIdentifier=10, statusCode=SUCCESS]] 2022-03-22 09:41:14.196 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 2 outstanding 2022-03-22 09:41:14.196 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: DefaultResponse [On/Off: 0000/0 -> 3877/1, cluster=0006, TID=08, commandIdentifier=10, statusCode=SUCCESS] 2022-03-22 09:41:14.196 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=true, manufacturerCode=0, sequenceNumber=8, commandId=11] 2022-03-22 09:41:14.196 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/1, destinationAddress=3877/1, profile=0104, cluster=0006, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=2B, rssi=--, lqi=--, payload=10 08 0B 0A 00] 2022-03-22 09:41:14.196 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=8, ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=1, destinationEndpoint=1, cluster=6, profileId=260, broadcastRadius=0, options=[], data=10 08 0B 0A 00] 2022-03-22 09:41:14.196 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=08 state=TX_ACK 2022-03-22 09:41:14.196 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 70: XBeeTransmitRequestExplicitCommand [frameId=65, ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=1, destinationEndpoint=1, cluster=6, profileId=260, broadcastRadius=0, options=[], data=10 08 0B 0A 00] 2022-03-22 09:41:14.196 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=08, state=TX_ACK, outstanding=2 2022-03-22 09:41:14.196 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=3877, TID=08, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:41:16.851 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B FA FF FD 00 24 02 58 2022-03-22 09:41:16.851 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=250, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:41:16.851 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=251, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=8B 76 AD 6C 22 00 4B 12 00 00 00] 2022-03-22 09:41:16.851 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 FB 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 8B 76 AD 6C 22 00 4B 12 00 00 00 5E 2022-03-22 09:41:16.989 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 8B 00 76 AD 6C 22 00 4B 12 00 77 38 E8 2022-03-22 09:41:16.989 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=8B 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:41:16.989 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=8B 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:41:16.989 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:41:16.989 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:41:16.989 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=8B, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:16.989 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=8B, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:18.125 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B FB FF FE 00 00 00 7C 2022-03-22 09:41:18.125 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=251, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:18.125 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=252, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=8C 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:41:18.125 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 FC 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 8C 07 99 28 22 00 4B 12 00 00 00 23 2022-03-22 09:41:18.272 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 8C 00 07 99 28 22 00 4B 12 00 8E 09 C6 2022-03-22 09:41:18.272 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=8C 00 07 99 28 22 00 4B 12 00 8E 09] 2022-03-22 09:41:18.272 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=8C 00 07 99 28 22 00 4B 12 00 8E 09] 2022-03-22 09:41:18.272 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:41:18.272 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:41:18.272 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=8C, status=SUCCESS, ieeeAddrRemoteDev=00124B0022289907, nwkAddrRemoteDev=098E, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:18.272 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=8C, status=SUCCESS, ieeeAddrRemoteDev=00124B0022289907, nwkAddrRemoteDev=098E, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:19.398 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B FC FF FE 00 00 00 7B 2022-03-22 09:41:19.398 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=252, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:19.398 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=253, ieeeAddress=00158D0007C79586, networkAddress=32720, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=8A 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:41:19.398 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 FD 00 15 8D 00 07 C7 95 86 7F D0 00 00 00 00 00 00 00 00 8A 86 95 C7 07 00 8D 15 00 00 00 02 2022-03-22 09:41:20.402 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B F9 FF FD 00 24 40 1B 2022-03-22 09:41:20.402 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=249, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=EXTENDED_TIMEOUT_DISCOVERY] 2022-03-22 09:41:20.402 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=254, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=8D BA C3 C6 FE FF 27 71 84 00 00] 2022-03-22 09:41:20.402 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 FE 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 8D BA C3 C6 FE FF 27 71 84 00 00 0B 2022-03-22 09:41:20.502 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 13 A2 00 41 B4 92 67 00 00 00 00 80 00 00 00 01 8D 00 BA C3 C6 FE FF 27 71 84 DE B6 CD 2022-03-22 09:41:20.502 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=0013A20041B49267, networkAddress=0, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=8D 00 BA C3 C6 FE FF 27 71 84 DE B6] 2022-03-22 09:41:20.502 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=0000/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=8D 00 BA C3 C6 FE FF 27 71 84 DE B6] 2022-03-22 09:41:20.502 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 0013A20041B49267: Node update. NWK Address=0000 2022-03-22 09:41:20.502 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 0013A20041B49267: Node 0000 is not updated 2022-03-22 09:41:20.502 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [0000/0 -> 0000/0, cluster=8000, TID=8D, status=SUCCESS, ieeeAddrRemoteDev=847127FFFEC6C3BA, nwkAddrRemoteDev=B6DE, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:20.502 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [0000/0 -> 0000/0, cluster=8000, TID=8D, status=SUCCESS, ieeeAddrRemoteDev=847127FFFEC6C3BA, nwkAddrRemoteDev=B6DE, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:21.667 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B FE FF FE 00 00 00 79 2022-03-22 09:41:21.667 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=254, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:21.667 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=255, ieeeAddress=00124B0023B4EAA9, networkAddress=18602, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=8E A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:41:21.667 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 FF 00 12 4B 00 23 B4 EA A9 48 AA 00 00 00 00 00 00 00 00 8E A9 EA B4 23 00 4B 12 00 00 00 E1 2022-03-22 09:41:22.003 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B6 state=RX_NAK 2022-03-22 09:41:22.003 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16037, state=FAILED, sendCnt=2, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B6, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:22.003 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B6, state=RX_NAK, outstanding=2 2022-03-22 09:41:22.004 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 1 outstanding 2022-03-22 09:41:22.004 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:41:22.004 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete exceeded max retries 2 2022-03-22 09:41:22.004 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction cancelled: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16038, state=CANCELLED, sendCnt=2, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B6, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:22.004 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16038, state=CANCELLED, sendCnt=2, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B6, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:22.004 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 1 outstanding 2022-03-22 09:41:22.004 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete but not outstanding, state=CANCELLED, outstanding=0 2022-03-22 09:41:22.004 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=0, sleepy=0/3 2022-03-22 09:41:22.004 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=0, sleepy=0/3 2022-03-22 09:41:22.004 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=0, state=WAITING, sendCnt=0, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=--, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:22.004 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=1, sleepy=0/3 2022-03-22 09:41:22.004 [DEBUG] [transaction.ZigBeeTransactionManager] - 098E/1: Sending ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=0, state=WAITING, sendCnt=0, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B7, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:22.004 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 2 outstanding 2022-03-22 09:41:22.004 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B7, startAttributeIdentifier=0, maximumAttributeIdentifiers=10] 2022-03-22 09:41:22.004 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=183, commandId=12] 2022-03-22 09:41:22.004 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/1, destinationAddress=098E/1, profile=0104, cluster=0001, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=2C, rssi=--, lqi=--, payload=00 B7 0C 00 00 0A] 2022-03-22 09:41:22.004 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=183, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=1, profileId=260, broadcastRadius=0, options=[], data=00 B7 0C 00 00 0A] 2022-03-22 09:41:22.004 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B7 state=TX_ACK 2022-03-22 09:41:22.004 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 66: XBeeTransmitRequestExplicitCommand [frameId=66, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=1, profileId=260, broadcastRadius=0, options=[], data=00 B7 0C 00 00 0A] 2022-03-22 09:41:22.004 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B7, state=TX_ACK, outstanding=2 2022-03-22 09:41:22.004 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B7, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:41:22.206 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=08 state=RX_NAK 2022-03-22 09:41:22.206 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B00226CAD76 queueTime=8010, state=FAILED, sendCnt=1, command=DefaultResponse [On/Off: 0000/0 -> 3877/1, cluster=0006, TID=08, commandIdentifier=10, statusCode=SUCCESS]] 2022-03-22 09:41:22.206 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=08, state=RX_NAK, outstanding=2 2022-03-22 09:41:22.208 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 1 outstanding 2022-03-22 09:41:22.208 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B00226CAD76: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:41:22.208 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B00226CAD76: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B00226CAD76 queueTime=8012, state=WAITING, sendCnt=1, command=DefaultResponse [On/Off: 0000/0 -> 3877/1, cluster=0006, TID=08, commandIdentifier=10, statusCode=SUCCESS]] 2022-03-22 09:41:22.208 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=1, sleepy=1/3 2022-03-22 09:41:22.208 [DEBUG] [transaction.ZigBeeTransactionManager] - 3877/1: Sending ZigBeeTransaction [ieeeAddress=00124B00226CAD76 queueTime=8012, state=WAITING, sendCnt=1, command=DefaultResponse [On/Off: 0000/0 -> 3877/1, cluster=0006, TID=08, commandIdentifier=10, statusCode=SUCCESS]] 2022-03-22 09:41:22.208 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 2 outstanding 2022-03-22 09:41:22.208 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: DefaultResponse [On/Off: 0000/0 -> 3877/1, cluster=0006, TID=08, commandIdentifier=10, statusCode=SUCCESS] 2022-03-22 09:41:22.208 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=true, manufacturerCode=0, sequenceNumber=8, commandId=11] 2022-03-22 09:41:22.208 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/1, destinationAddress=3877/1, profile=0104, cluster=0006, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=2D, rssi=--, lqi=--, payload=10 08 0B 0A 00] 2022-03-22 09:41:22.208 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=8, ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=1, destinationEndpoint=1, cluster=6, profileId=260, broadcastRadius=0, options=[], data=10 08 0B 0A 00] 2022-03-22 09:41:22.208 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=08 state=TX_ACK 2022-03-22 09:41:22.208 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 67: XBeeTransmitRequestExplicitCommand [frameId=67, ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=1, destinationEndpoint=1, cluster=6, profileId=260, broadcastRadius=0, options=[], data=10 08 0B 0A 00] 2022-03-22 09:41:22.208 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=08, state=TX_ACK, outstanding=2 2022-03-22 09:41:22.208 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=3877, TID=08, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:41:24.274 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B FD FF FD 00 24 02 55 2022-03-22 09:41:24.274 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=253, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:41:24.274 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=1, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=8F 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:41:24.274 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 01 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 8F 86 95 C7 07 00 8D 15 00 00 00 D7 2022-03-22 09:41:24.411 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 8F 00 86 95 C7 07 00 8D 15 00 D0 7F C7 2022-03-22 09:41:24.411 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=8F 00 86 95 C7 07 00 8D 15 00 D0 7F] 2022-03-22 09:41:24.411 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=8F 00 86 95 C7 07 00 8D 15 00 D0 7F] 2022-03-22 09:41:24.411 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:41:24.411 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:41:24.411 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=8F, status=SUCCESS, ieeeAddrRemoteDev=00158D0007C79586, nwkAddrRemoteDev=7FD0, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:24.411 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=8F, status=SUCCESS, ieeeAddrRemoteDev=00158D0007C79586, nwkAddrRemoteDev=7FD0, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:25.545 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 01 FF FE 00 00 00 76 2022-03-22 09:41:25.545 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=1, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:25.545 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=2, ieeeAddress=00124B0023B4EAA9, networkAddress=18602, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=8E A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:41:25.545 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 02 00 12 4B 00 23 B4 EA A9 48 AA 00 00 00 00 00 00 00 00 8E A9 EA B4 23 00 4B 12 00 00 00 DE 2022-03-22 09:41:26.531 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B FF FF FD 00 24 00 55 2022-03-22 09:41:26.531 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=255, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:26.531 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=3, ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=90 76 AD 6C 22 00 4B 12 00 00 00] 2022-03-22 09:41:26.531 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 03 00 12 4B 00 22 6C AD 76 38 77 00 00 00 00 00 00 00 00 90 76 AD 6C 22 00 4B 12 00 00 00 90 2022-03-22 09:41:26.631 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 03 38 77 00 00 00 C2 2022-03-22 09:41:26.631 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=3, networkAddress=14455, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:26.631 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=4, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=91 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:41:26.631 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 04 00 12 4B 00 22 28 99 07 09 8E 00 00 00 00 00 00 00 00 91 07 99 28 22 00 4B 12 00 00 00 34 2022-03-22 09:41:26.662 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 90 00 76 AD 6C 22 00 4B 12 00 77 38 E3 2022-03-22 09:41:26.662 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=90 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:41:26.662 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=90 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:41:26.662 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:41:26.662 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:41:26.662 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=90, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:26.662 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=90, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:30.025 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B7 state=RX_NAK 2022-03-22 09:41:30.025 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8021, state=FAILED, sendCnt=1, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B7, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:30.025 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B7, state=RX_NAK, outstanding=2 2022-03-22 09:41:30.027 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 1 outstanding 2022-03-22 09:41:30.027 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:41:30.027 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8023, state=WAITING, sendCnt=1, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B7, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:30.027 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=1, sleepy=0/3 2022-03-22 09:41:30.027 [DEBUG] [transaction.ZigBeeTransactionManager] - 098E/1: Sending ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8023, state=WAITING, sendCnt=1, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B7, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:30.027 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 2 outstanding 2022-03-22 09:41:30.027 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B7, startAttributeIdentifier=0, maximumAttributeIdentifiers=10] 2022-03-22 09:41:30.027 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=183, commandId=12] 2022-03-22 09:41:30.027 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/1, destinationAddress=098E/1, profile=0104, cluster=0001, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=2E, rssi=--, lqi=--, payload=00 B7 0C 00 00 0A] 2022-03-22 09:41:30.027 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=183, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=1, profileId=260, broadcastRadius=0, options=[], data=00 B7 0C 00 00 0A] 2022-03-22 09:41:30.027 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B7 state=TX_ACK 2022-03-22 09:41:30.027 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 64: XBeeTransmitRequestExplicitCommand [frameId=68, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=1, destinationEndpoint=1, cluster=1, profileId=260, broadcastRadius=0, options=[], data=00 B7 0C 00 00 0A] 2022-03-22 09:41:30.027 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B7, state=TX_ACK, outstanding=2 2022-03-22 09:41:30.027 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B7, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:41:30.226 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=08 state=RX_NAK 2022-03-22 09:41:30.226 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B00226CAD76 queueTime=16030, state=FAILED, sendCnt=2, command=DefaultResponse [On/Off: 0000/0 -> 3877/1, cluster=0006, TID=08, commandIdentifier=10, statusCode=SUCCESS]] 2022-03-22 09:41:30.226 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=08, state=RX_NAK, outstanding=2 2022-03-22 09:41:30.226 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 1 outstanding 2022-03-22 09:41:30.226 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B00226CAD76: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:41:30.226 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B00226CAD76: transactionComplete exceeded max retries 2 2022-03-22 09:41:30.226 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction cancelled: ZigBeeTransaction [ieeeAddress=00124B00226CAD76 queueTime=16030, state=CANCELLED, sendCnt=2, command=DefaultResponse [On/Off: 0000/0 -> 3877/1, cluster=0006, TID=08, commandIdentifier=10, statusCode=SUCCESS]] 2022-03-22 09:41:30.226 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B00226CAD76 queueTime=16030, state=CANCELLED, sendCnt=2, command=DefaultResponse [On/Off: 0000/0 -> 3877/1, cluster=0006, TID=08, commandIdentifier=10, statusCode=SUCCESS]] 2022-03-22 09:41:30.226 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 1 outstanding 2022-03-22 09:41:30.226 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B00226CAD76: transactionComplete but not outstanding, state=CANCELLED, outstanding=0 2022-03-22 09:41:30.226 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=0, sleepy=1/3 2022-03-22 09:41:30.226 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=1, outstandingQueues=0, sleepy=1/3 2022-03-22 09:41:31.344 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 02 FF FD 00 24 00 52 2022-03-22 09:41:31.344 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=2, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:31.344 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=5, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=92 A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:41:31.344 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 05 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 92 A9 EA B4 23 00 4B 12 00 00 00 94 2022-03-22 09:41:31.507 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 04 FF FD 00 24 02 4E 2022-03-22 09:41:31.507 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=4, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:41:31.507 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=6, ieeeAddress=847127FFFEC6C3BA, networkAddress=46814, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=93 BA C3 C6 FE FF 27 71 84 00 00] 2022-03-22 09:41:31.507 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 06 84 71 27 FF FE C6 C3 BA B6 DE 00 00 00 00 00 00 00 00 93 BA C3 C6 FE FF 27 71 84 00 00 09 2022-03-22 09:41:32.633 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 05 FF FE 00 00 00 72 2022-03-22 09:41:32.633 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=5, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:32.633 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=7, ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=90 76 AD 6C 22 00 4B 12 00 00 00] 2022-03-22 09:41:32.633 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 07 00 12 4B 00 22 6C AD 76 38 77 00 00 00 00 00 00 00 00 90 76 AD 6C 22 00 4B 12 00 00 00 8C 2022-03-22 09:41:32.734 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 07 38 77 00 00 00 BE 2022-03-22 09:41:32.734 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=7, networkAddress=14455, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:32.734 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=8, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=91 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:41:32.734 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 08 00 12 4B 00 22 28 99 07 09 8E 00 00 00 00 00 00 00 00 91 07 99 28 22 00 4B 12 00 00 00 30 2022-03-22 09:41:32.775 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 90 00 76 AD 6C 22 00 4B 12 00 77 38 E3 2022-03-22 09:41:32.775 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=90 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:41:32.775 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=90 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:41:32.775 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:41:32.781 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:41:32.781 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=90, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:32.782 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=90, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:37.613 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 08 FF FD 00 24 02 4A 2022-03-22 09:41:37.613 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=8, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:41:37.613 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=9, ieeeAddress=847127FFFEC6C3BA, networkAddress=46814, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=93 BA C3 C6 FE FF 27 71 84 00 00] 2022-03-22 09:41:37.613 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 09 84 71 27 FF FE C6 C3 BA B6 DE 00 00 00 00 00 00 00 00 93 BA C3 C6 FE FF 27 71 84 00 00 06 2022-03-22 09:41:38.034 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B7 state=RX_NAK 2022-03-22 09:41:38.034 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16030, state=FAILED, sendCnt=2, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B7, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:38.035 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B7, state=RX_NAK, outstanding=1 2022-03-22 09:41:38.035 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:41:38.037 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:41:38.037 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete exceeded max retries 2 2022-03-22 09:41:38.037 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction cancelled: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16033, state=CANCELLED, sendCnt=2, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B7, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:38.037 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16033, state=CANCELLED, sendCnt=2, command=DiscoverAttributesCommand [Power Configuration: 0000/0 -> 098E/1, cluster=0001, TID=B7, startAttributeIdentifier=0, maximumAttributeIdentifiers=10]] 2022-03-22 09:41:38.037 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:41:38.037 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete but not outstanding, state=CANCELLED, outstanding=0 2022-03-22 09:41:38.037 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B0022289907: Dynamically created 1 channels 2022-03-22 09:41:38.037 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=0, sleepy=0/3 2022-03-22 09:41:38.037 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=0, sleepy=0/3 2022-03-22 09:41:38.037 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B0022289907: Device initialization will be skipped as the device is already initialized 2022-03-22 09:41:38.037 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B0022289907: Channel initialisation complete 2022-03-22 09:41:38.037 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B0022289907: Thing is RFD, using long poll period of 1800sec 2022-03-22 09:41:38.037 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B0022289907: Setting ONLINE/OFFLINE timeout interval to: 28 2022-03-22 09:41:38.037 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker added for thingUID=zigbee:device:a521e35b6c:00124b0022289907 2022-03-22 09:41:38.037 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker reset for handler with thingUID=zigbee:device:a521e35b6c:00124b0022289907 2022-03-22 09:41:38.037 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker scheduled task for thingUID=zigbee:device:a521e35b6c:00124b0022289907 in 28 seconds 2022-03-22 09:41:38.037 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=0, state=WAITING, sendCnt=0, command=ManagementBindRequest [0000/0 -> 098E/0, cluster=0033, TID=--, startIndex=0]] 2022-03-22 09:41:38.037 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=1, sleepy=0/3 2022-03-22 09:41:38.037 [DEBUG] [transaction.ZigBeeTransactionManager] - 098E/0: Sending ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=0, state=WAITING, sendCnt=0, command=ManagementBindRequest [0000/0 -> 098E/0, cluster=0033, TID=B8, startIndex=0]] 2022-03-22 09:41:38.037 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 1 outstanding 2022-03-22 09:41:38.037 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ManagementBindRequest [0000/0 -> 098E/0, cluster=0033, TID=B8, startIndex=0] 2022-03-22 09:41:38.037 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/0, destinationAddress=098E/0, profile=0000, cluster=0033, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=2F, rssi=--, lqi=--, payload=B8 00] 2022-03-22 09:41:38.037 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=184, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=51, profileId=0, broadcastRadius=0, options=[], data=B8 00] 2022-03-22 09:41:38.037 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B8 state=TX_ACK 2022-03-22 09:41:38.037 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 60: XBeeTransmitRequestExplicitCommand [frameId=69, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=51, profileId=0, broadcastRadius=0, options=[], data=B8 00] 2022-03-22 09:41:38.037 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B8, state=TX_ACK, outstanding=1 2022-03-22 09:41:38.037 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B8, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:41:39.972 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 06 FF FD 00 24 40 0E 2022-03-22 09:41:39.972 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=6, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=EXTENDED_TIMEOUT_DISCOVERY] 2022-03-22 09:41:39.972 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=10, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=94 76 AD 6C 22 00 4B 12 00 00 00] 2022-03-22 09:41:39.972 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 0A 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 94 76 AD 6C 22 00 4B 12 00 00 00 46 2022-03-22 09:41:40.108 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 94 00 76 AD 6C 22 00 4B 12 00 77 38 DF 2022-03-22 09:41:40.108 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=94 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:41:40.108 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=94 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:41:40.108 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:41:40.108 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:41:40.108 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=94, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:40.108 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=94, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:41.238 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 0A FF FE 00 00 00 6D 2022-03-22 09:41:41.238 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=10, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:41.238 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=11, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=95 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:41:41.238 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 0B 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 95 07 99 28 22 00 4B 12 00 00 00 0B 2022-03-22 09:41:41.391 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 95 00 07 99 28 22 00 4B 12 00 8E 09 BD 2022-03-22 09:41:41.391 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=95 00 07 99 28 22 00 4B 12 00 8E 09] 2022-03-22 09:41:41.391 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=95 00 07 99 28 22 00 4B 12 00 8E 09] 2022-03-22 09:41:41.391 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:41:41.391 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:41:41.391 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=95, status=SUCCESS, ieeeAddrRemoteDev=00124B0022289907, nwkAddrRemoteDev=098E, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:41.391 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=95, status=SUCCESS, ieeeAddrRemoteDev=00124B0022289907, nwkAddrRemoteDev=098E, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:42.510 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 0B FF FE 00 00 00 6C 2022-03-22 09:41:42.510 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=11, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:42.510 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=12, ieeeAddress=00158D0007C79586, networkAddress=32720, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=96 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:41:42.510 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 0C 00 15 8D 00 07 C7 95 86 7F D0 00 00 00 00 00 00 00 00 96 86 95 C7 07 00 8D 15 00 00 00 E7 2022-03-22 09:41:46.054 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B8 state=RX_NAK 2022-03-22 09:41:46.054 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8017, state=FAILED, sendCnt=1, command=ManagementBindRequest [0000/0 -> 098E/0, cluster=0033, TID=B8, startIndex=0]] 2022-03-22 09:41:46.054 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:41:46.054 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B8, state=RX_NAK, outstanding=0 2022-03-22 09:41:46.054 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:41:46.054 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8017, state=WAITING, sendCnt=1, command=ManagementBindRequest [0000/0 -> 098E/0, cluster=0033, TID=B8, startIndex=0]] 2022-03-22 09:41:46.054 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=0, outstandingQueues=1, sleepy=0/3 2022-03-22 09:41:46.054 [DEBUG] [transaction.ZigBeeTransactionManager] - 098E/0: Sending ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=8017, state=WAITING, sendCnt=1, command=ManagementBindRequest [0000/0 -> 098E/0, cluster=0033, TID=B8, startIndex=0]] 2022-03-22 09:41:46.054 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 1 outstanding 2022-03-22 09:41:46.054 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ManagementBindRequest [0000/0 -> 098E/0, cluster=0033, TID=B8, startIndex=0] 2022-03-22 09:41:46.054 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/0, destinationAddress=098E/0, profile=0000, cluster=0033, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=30, rssi=--, lqi=--, payload=B8 00] 2022-03-22 09:41:46.054 [DEBUG] [.zigbee.dongle.xbee.ZigBeeDongleXBee] - XBee send: XBeeTransmitRequestExplicitCommand [frameId=184, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=51, profileId=0, broadcastRadius=0, options=[], data=B8 00] 2022-03-22 09:41:46.054 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B8 state=TX_ACK 2022-03-22 09:41:46.054 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE queue: 58: XBeeTransmitRequestExplicitCommand [frameId=70, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=51, profileId=0, broadcastRadius=0, options=[], data=B8 00] 2022-03-22 09:41:46.054 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B8, state=TX_ACK, outstanding=1 2022-03-22 09:41:46.060 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=098E, TID=B8, event=TX_ACK, state=TRANSMITTED 2022-03-22 09:41:47.381 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 0C FF FD 00 24 02 46 2022-03-22 09:41:47.381 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=12, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:41:47.381 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=13, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=97 BA C3 C6 FE FF 27 71 84 00 00] 2022-03-22 09:41:47.381 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 0D 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 97 BA C3 C6 FE FF 27 71 84 00 00 F2 2022-03-22 09:41:47.481 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 13 A2 00 41 B4 92 67 00 00 00 00 80 00 00 00 01 97 00 BA C3 C6 FE FF 27 71 84 DE B6 C3 2022-03-22 09:41:47.481 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=0013A20041B49267, networkAddress=0, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=97 00 BA C3 C6 FE FF 27 71 84 DE B6] 2022-03-22 09:41:47.481 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=0000/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=97 00 BA C3 C6 FE FF 27 71 84 DE B6] 2022-03-22 09:41:47.481 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 0013A20041B49267: Node update. NWK Address=0000 2022-03-22 09:41:47.481 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 0013A20041B49267: Node 0000 is not updated 2022-03-22 09:41:47.481 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [0000/0 -> 0000/0, cluster=8000, TID=97, status=SUCCESS, ieeeAddrRemoteDev=847127FFFEC6C3BA, nwkAddrRemoteDev=B6DE, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:47.481 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [0000/0 -> 0000/0, cluster=8000, TID=97, status=SUCCESS, ieeeAddrRemoteDev=847127FFFEC6C3BA, nwkAddrRemoteDev=B6DE, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:48.384 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 09 FF FD 00 24 41 0A 2022-03-22 09:41:48.384 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=9, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=UNKNOWN] 2022-03-22 09:41:48.384 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=14, ieeeAddress=00124B0023B4EAA9, networkAddress=18602, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=98 A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:41:48.384 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 0E 00 12 4B 00 23 B4 EA A9 48 AA 00 00 00 00 00 00 00 00 98 A9 EA B4 23 00 4B 12 00 00 00 C8 2022-03-22 09:41:48.648 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 0D FF FE 00 00 00 6A 2022-03-22 09:41:48.648 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=13, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:48.648 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=15, ieeeAddress=00158D0007C79586, networkAddress=32720, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=96 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:41:48.648 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 0F 00 15 8D 00 07 C7 95 86 7F D0 00 00 00 00 00 00 00 00 96 86 95 C7 07 00 8D 15 00 00 00 E4 2022-03-22 09:41:53.258 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 0E FF FD 00 24 00 46 2022-03-22 09:41:53.258 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=14, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:41:53.259 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=16, ieeeAddress=00124B0023B4EAA9, networkAddress=18602, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=98 A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:41:53.259 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 10 00 12 4B 00 23 B4 EA A9 48 AA 00 00 00 00 00 00 00 00 98 A9 EA B4 23 00 4B 12 00 00 00 C6 2022-03-22 09:41:53.521 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 0F FF FD 00 24 02 43 2022-03-22 09:41:53.521 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=15, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:41:53.521 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=17, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=99 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:41:53.521 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 11 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 99 86 95 C7 07 00 8D 15 00 00 00 BD 2022-03-22 09:41:53.659 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 99 00 86 95 C7 07 00 8D 15 00 D0 7F BD 2022-03-22 09:41:53.659 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=99 00 86 95 C7 07 00 8D 15 00 D0 7F] 2022-03-22 09:41:53.659 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=99 00 86 95 C7 07 00 8D 15 00 D0 7F] 2022-03-22 09:41:53.659 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:41:53.659 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:41:53.659 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=99, status=SUCCESS, ieeeAddrRemoteDev=00158D0007C79586, nwkAddrRemoteDev=7FD0, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:53.659 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=99, status=SUCCESS, ieeeAddrRemoteDev=00158D0007C79586, nwkAddrRemoteDev=7FD0, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:41:54.061 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=B8 state=RX_NAK 2022-03-22 09:41:54.061 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00124B0022289907 queueTime=16024, state=FAILED, sendCnt=2, command=ManagementBindRequest [0000/0 -> 098E/0, cluster=0033, TID=B8, startIndex=0]] 2022-03-22 09:41:54.061 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding 2022-03-22 09:41:54.061 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=B8, state=RX_NAK, outstanding=0 2022-03-22 09:41:54.061 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00124B0022289907: transactionComplete, state=FAILED, outstanding=0 2022-03-22 09:41:58.130 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=22, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=9D 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:41:58.130 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 16 00 12 4B 00 22 28 99 07 09 8E 00 00 00 00 00 00 00 00 9D 07 99 28 22 00 4B 12 00 00 00 16 2022-03-22 09:42:02.999 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 16 FF FD 00 24 02 3C 2022-03-22 09:42:02.999 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=22, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:42:03.002 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=23, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=9E 76 AD 6C 22 00 4B 12 00 00 00] 2022-03-22 09:42:03.006 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 17 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 9E 76 AD 6C 22 00 4B 12 00 00 00 2F 2022-03-22 09:42:03.130 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 9E 00 76 AD 6C 22 00 4B 12 00 77 38 D5 2022-03-22 09:42:03.130 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=9E 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:42:03.130 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=9E 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:42:03.130 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:42:03.130 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:42:03.130 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=9E, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:03.130 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=9E, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:04.271 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 17 FF FE 00 00 00 60 2022-03-22 09:42:04.271 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=23, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:42:04.271 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=24, ieeeAddress=847127FFFEC6C3BA, networkAddress=46814, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=9C BA C3 C6 FE FF 27 71 84 00 00] 2022-03-22 09:42:04.271 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 18 84 71 27 FF FE C6 C3 BA B6 DE 00 00 00 00 00 00 00 00 9C BA C3 C6 FE FF 27 71 84 00 00 EE 2022-03-22 09:42:04.734 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 15 FF FD 00 24 40 FF 2022-03-22 09:42:04.734 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=21, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=EXTENDED_TIMEOUT_DISCOVERY] 2022-03-22 09:42:04.734 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=25, ieeeAddress=00158D0007C79586, networkAddress=32720, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=9F 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:42:04.734 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 19 00 15 8D 00 07 C7 95 86 7F D0 00 00 00 00 00 00 00 00 9F 86 95 C7 07 00 8D 15 00 00 00 D1 2022-03-22 09:42:06.052 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker LastChance Timeout has been reached for thingUID=zigbee:device:a521e35b6c:00124b0022289907 2022-03-22 09:42:06.052 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B0022289907: Polling stopped 2022-03-22 09:42:06.052 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 00124B0022289907: Polling initialised at 1875095ms 2022-03-22 09:42:09.614 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 19 FF FD 00 24 02 39 2022-03-22 09:42:09.614 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=25, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:42:09.614 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=26, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=9D 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:42:09.614 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 1A 00 12 4B 00 22 28 99 07 09 8E 00 00 00 00 00 00 00 00 9D 07 99 28 22 00 4B 12 00 00 00 12 2022-03-22 09:42:13.145 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 18 FF FD 00 24 40 FC 2022-03-22 09:42:13.145 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=24, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=EXTENDED_TIMEOUT_DISCOVERY] 2022-03-22 09:42:13.145 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=27, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=A0 BA C3 C6 FE FF 27 71 84 00 00] 2022-03-22 09:42:13.148 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 1B 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 A0 BA C3 C6 FE FF 27 71 84 00 00 DB 2022-03-22 09:42:13.243 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 13 A2 00 41 B4 92 67 00 00 00 00 80 00 00 00 01 A0 00 BA C3 C6 FE FF 27 71 84 DE B6 BA 2022-03-22 09:42:13.243 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=0013A20041B49267, networkAddress=0, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=A0 00 BA C3 C6 FE FF 27 71 84 DE B6] 2022-03-22 09:42:13.243 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=0000/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=A0 00 BA C3 C6 FE FF 27 71 84 DE B6] 2022-03-22 09:42:13.243 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 0013A20041B49267: Node update. NWK Address=0000 2022-03-22 09:42:13.243 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 0013A20041B49267: Node 0000 is not updated 2022-03-22 09:42:13.243 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [0000/0 -> 0000/0, cluster=8000, TID=A0, status=SUCCESS, ieeeAddrRemoteDev=847127FFFEC6C3BA, nwkAddrRemoteDev=B6DE, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:13.243 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [0000/0 -> 0000/0, cluster=8000, TID=A0, status=SUCCESS, ieeeAddrRemoteDev=847127FFFEC6C3BA, nwkAddrRemoteDev=B6DE, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:14.428 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 1B FF FE 00 00 00 5C 2022-03-22 09:42:14.428 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=27, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:42:14.428 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=28, ieeeAddress=00158D0007C79586, networkAddress=32720, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=9F 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:42:14.428 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 1C 00 15 8D 00 07 C7 95 86 7F D0 00 00 00 00 00 00 00 00 9F 86 95 C7 07 00 8D 15 00 00 00 CE 2022-03-22 09:42:14.495 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 1A FF FD 00 24 02 38 2022-03-22 09:42:14.495 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=26, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:42:14.495 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=29, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=A1 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:42:14.495 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 1D 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 A1 07 99 28 22 00 4B 12 00 00 00 ED 2022-03-22 09:42:14.629 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 A1 00 07 99 28 22 00 4B 12 00 8E 09 B1 2022-03-22 09:42:14.629 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=A1 00 07 99 28 22 00 4B 12 00 8E 09] 2022-03-22 09:42:14.629 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=A1 00 07 99 28 22 00 4B 12 00 8E 09] 2022-03-22 09:42:14.629 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:42:14.629 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:42:14.629 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=A1, status=SUCCESS, ieeeAddrRemoteDev=00124B0022289907, nwkAddrRemoteDev=098E, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:14.629 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=A1, status=SUCCESS, ieeeAddrRemoteDev=00124B0022289907, nwkAddrRemoteDev=098E, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:15.768 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 1D FF FE 00 00 00 5A 2022-03-22 09:42:15.768 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=29, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:42:15.768 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=30, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=A2 86 95 C7 07 00 8D 15 00 00 00] 2022-03-22 09:42:15.768 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 1E 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 A2 86 95 C7 07 00 8D 15 00 00 00 A7 2022-03-22 09:42:15.933 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 A2 00 86 95 C7 07 00 8D 15 00 D0 7F B4 2022-03-22 09:42:15.933 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=A2 00 86 95 C7 07 00 8D 15 00 D0 7F] 2022-03-22 09:42:15.933 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=A2 00 86 95 C7 07 00 8D 15 00 D0 7F] 2022-03-22 09:42:15.933 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:42:15.933 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:42:15.933 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=A2, status=SUCCESS, ieeeAddrRemoteDev=00158D0007C79586, nwkAddrRemoteDev=7FD0, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:15.933 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=A2, status=SUCCESS, ieeeAddrRemoteDev=00158D0007C79586, nwkAddrRemoteDev=7FD0, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:17.057 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 1E FF FE 00 00 00 59 2022-03-22 09:42:17.057 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=30, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:42:17.057 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=31, ieeeAddress=00124B0023B4EAA9, networkAddress=18602, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=A3 A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:42:17.057 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 1F 00 12 4B 00 23 B4 EA A9 48 AA 00 00 00 00 00 00 00 00 A3 A9 EA B4 23 00 4B 12 00 00 00 AC 2022-03-22 09:42:21.702 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 1C FF FD 00 24 43 F5 2022-03-22 09:42:21.702 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=28, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=UNKNOWN] 2022-03-22 09:42:21.702 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=32, ieeeAddress=00124B0023B4EAA9, networkAddress=18602, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=A3 A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:42:21.702 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 20 00 12 4B 00 23 B4 EA A9 48 AA 00 00 00 00 00 00 00 00 A3 A9 EA B4 23 00 4B 12 00 00 00 AB 2022-03-22 09:42:21.943 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 1F FF FD 00 24 00 35 2022-03-22 09:42:21.943 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=31, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:42:21.943 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=33, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=A4 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:42:21.943 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 21 00 12 4B 00 22 28 99 07 09 8E 00 00 00 00 00 00 00 00 A4 07 99 28 22 00 4B 12 00 00 00 04 2022-03-22 09:42:26.731 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 20 FF FD 00 24 02 32 2022-03-22 09:42:26.731 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=32, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:42:26.731 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=34, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=A5 A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:42:26.738 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 22 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 A5 A9 EA B4 23 00 4B 12 00 00 00 64 2022-03-22 09:42:26.816 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 21 FF FD 00 24 02 31 2022-03-22 09:42:26.816 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=33, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=ROUTE_DISCOVERY] 2022-03-22 09:42:26.816 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=35, ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=A6 76 AD 6C 22 00 4B 12 00 00 00] 2022-03-22 09:42:26.816 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 23 00 12 4B 00 22 6C AD 76 38 77 00 00 00 00 00 00 00 00 A6 76 AD 6C 22 00 4B 12 00 00 00 5A 2022-03-22 09:42:26.916 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 23 38 77 00 00 00 A2 2022-03-22 09:42:26.916 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=35, networkAddress=14455, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:42:26.916 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=36, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=A4 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:42:26.916 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 24 00 12 4B 00 22 28 99 07 09 8E 00 00 00 00 00 00 00 00 A4 07 99 28 22 00 4B 12 00 00 00 01 2022-03-22 09:42:26.953 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 A6 00 76 AD 6C 22 00 4B 12 00 77 38 CD 2022-03-22 09:42:26.953 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=A6 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:42:26.953 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=A6 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:42:26.953 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:42:26.953 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:42:26.953 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=A6, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:26.953 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=A6, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:28.003 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 22 FF FE 00 00 00 55 2022-03-22 09:42:28.003 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=34, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:42:28.003 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=37, ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=A6 76 AD 6C 22 00 4B 12 00 00 00] 2022-03-22 09:42:28.003 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 25 00 12 4B 00 22 6C AD 76 38 77 00 00 00 00 00 00 00 00 A6 76 AD 6C 22 00 4B 12 00 00 00 58 2022-03-22 09:42:28.103 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 25 38 77 00 00 00 A0 2022-03-22 09:42:28.103 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=37, networkAddress=14455, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:42:28.103 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=38, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=A7 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:42:28.103 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 26 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 A7 07 99 28 22 00 4B 12 00 00 00 DE 2022-03-22 09:42:28.156 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 A6 00 76 AD 6C 22 00 4B 12 00 77 38 CD 2022-03-22 09:42:28.156 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=A6 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:42:28.156 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=A6 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:42:28.156 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:42:28.156 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:42:28.156 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=A6, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:28.156 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=A6, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:28.234 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 A7 00 07 99 28 22 00 4B 12 00 8E 09 AB 2022-03-22 09:42:28.234 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=A7 00 07 99 28 22 00 4B 12 00 8E 09] 2022-03-22 09:42:28.234 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=A7 00 07 99 28 22 00 4B 12 00 8E 09] 2022-03-22 09:42:28.234 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:42:28.234 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:42:28.234 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=A7, status=SUCCESS, ieeeAddrRemoteDev=00124B0022289907, nwkAddrRemoteDev=098E, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:28.234 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=A7, status=SUCCESS, ieeeAddrRemoteDev=00124B0022289907, nwkAddrRemoteDev=098E, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:29.391 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 26 FF FE 00 00 00 51 2022-03-22 09:42:29.391 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=38, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:42:29.391 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=39, ieeeAddress=000000000000FFFF, networkAddress=65535, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=A8 76 AD 6C 22 00 4B 12 00 00 00] 2022-03-22 09:42:29.392 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 27 00 00 00 00 00 00 FF FF FF FF 00 00 00 00 00 00 00 00 A8 76 AD 6C 22 00 4B 12 00 00 00 15 2022-03-22 09:42:29.523 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 1E 91 00 12 4B 00 22 6C AD 76 38 77 00 00 80 00 00 00 01 A8 00 76 AD 6C 22 00 4B 12 00 77 38 CB 2022-03-22 09:42:29.523 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeReceivePacketExplicitEvent [ieeeAddress=00124B00226CAD76, networkAddress=14455, sourceEndpoint=0, destinationEndpoint=0, clusterId=32768, profileId=0, receiveOptions=PACKET_ACKNOWLEDGED, data=A8 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:42:29.523 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=3877/0, destinationAddress=0000/0, profile=0000, cluster=8000, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=A8 00 76 AD 6C 22 00 4B 12 00 77 38] 2022-03-22 09:42:29.523 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node update. NWK Address=3877 2022-03-22 09:42:29.526 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00226CAD76: Node 3877 is not updated 2022-03-22 09:42:29.526 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=A8, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:29.526 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: NetworkAddressResponse [3877/0 -> 0000/0, cluster=8000, TID=A8, status=SUCCESS, ieeeAddrRemoteDev=00124B00226CAD76, nwkAddrRemoteDev=3877, startIndex=null, nwkAddrAssocDevList=[]] 2022-03-22 09:42:30.663 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 27 FF FE 00 00 00 50 2022-03-22 09:42:30.663 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=39, networkAddress=65534, transmitRetryCount=0, deliveryStatus=SUCCESS, discoveryStatus=NO_DISCOVERY_OVERHEAD] 2022-03-22 09:42:30.663 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=40, ieeeAddress=00124B0022289907, networkAddress=2446, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=A9 07 99 28 22 00 4B 12 00 00 00] 2022-03-22 09:42:30.663 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 28 00 12 4B 00 22 28 99 07 09 8E 00 00 00 00 00 00 00 00 A9 07 99 28 22 00 4B 12 00 00 00 F8 2022-03-22 09:42:34.191 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE Data: 00 07 8B 24 FF FD 00 24 43 ED 2022-03-22 09:42:34.191 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - RX XBEE: XBeeTransmitStatusResponse [frameId=36, networkAddress=65533, transmitRetryCount=0, deliveryStatus=ADDRESS_NOT_FOUND, discoveryStatus=UNKNOWN] 2022-03-22 09:42:34.191 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE: XBeeTransmitRequestExplicitCommand [frameId=41, ieeeAddress=00124B0023B4EAA9, networkAddress=18602, sourceEndpoint=0, destinationEndpoint=0, cluster=0, profileId=0, broadcastRadius=0, options=[], data=AA A9 EA B4 23 00 4B 12 00 00 00] 2022-03-22 09:42:34.191 [DEBUG] [ongle.xbee.internal.XBeeFrameHandler] - TX XBEE Data: 00 1F 11 29 00 12 4B 00 23 B4 EA A9 48 AA 00 00 00 00 00 00 00 00 AA A9 EA B4 23 00 4B 12 00 00 00 9B 2022-03-22 09:42:36.063 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - IsAlive Tracker Timeout has been reached for thingUID=zigbee:device:a521e35b6c:00124b0022289907