openhab>
log:tail com.zsmartsystems.zigbee
12:18:00.330 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspSendBroadcastResponse [status=EMBER_SUCCESS, sequence=227]
12:18:00.333 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspSendBroadcastResponse [status=EMBER_SUCCESS, sequence=227]
12:18:00.343 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspIncomingMessageHandler [type=EMBER_INCOMING_BROADCAST_LOOPBACK, apsFrame=EmberApsFrame [profileId=0, clusterId=54, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY], groupId=0, sequence=227], lastHopLqi=255, lastHopRssi=0, sender=0, bindingIndex=255, addressIndex=255, messageContents=00 3C 01]
12:18:00.346 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=0/0, profile=0000, cluster=54, addressMode=null, radius=0, apsSecurity=false, apsCounter=227, payload=00 3C 01]
12:18:00.349 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - RX CMD: ManagementPermitJoiningRequest [0/0 -> 0/0, cluster=0036, TID=NULL, permitDuration=60, tcSignificance=true]
12:18:00.457 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=228]
12:18:00.459 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=228]
12:18:00.466 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspIncomingMessageHandler [type=EMBER_INCOMING_UNICAST, apsFrame=EmberApsFrame [profileId=0, clusterId=54, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY], groupId=0, sequence=228], lastHopLqi=255, lastHopRssi=0, sender=0, bindingIndex=255, addressIndex=255, messageContents=00 3C 01]
12:18:00.469 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=0/0, profile=0000, cluster=54, addressMode=null, radius=0, apsSecurity=false, apsCounter=228, payload=00 3C 01]
12:18:00.471 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - RX CMD: ManagementPermitJoiningRequest [0/0 -> 0/0, cluster=0036, TID=NULL, permitDuration=60, tcSignificance=true]
12:18:00.588 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspIncomingMessageHandler [type=EMBER_INCOMING_UNICAST, apsFrame=EmberApsFrame [profileId=0, clusterId=32822, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY], groupId=0, sequence=229], lastHopLqi=255, lastHopRssi=0, sender=0, bindingIndex=255, addressIndex=255, messageContents=00 00]
12:18:00.590 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=0/0, profile=0000, cluster=32822, addressMode=null, radius=0, apsSecurity=false, apsCounter=229, payload=00 00]
12:18:00.604 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - RX CMD: ManagementPermitJoiningResponse [0/0 -> 0/0, cluster=8036, TID=NULL, status=SUCCESS]
12:18:00.611 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=0, apsFrame=EmberApsFrame [profileId=0, clusterId=54, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=228], messageTag=57, status=EMBER_SUCCESS, messageContents=]
12:18:00.613 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=0, apsFrame=EmberApsFrame [profileId=0, clusterId=54, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=228], messageTag=57, status=EMBER_SUCCESS, messageContents=]
12:18:00.616 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=230]
12:18:00.618 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=230]
12:18:01.277 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_BROADCAST, indexOrDestination=65532, apsFrame=EmberApsFrame [profileId=0, clusterId=54, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY], groupId=0, sequence=227], messageTag=56, status=EMBER_SUCCESS, messageContents=]
12:18:01.280 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_BROADCAST, indexOrDestination=65532, apsFrame=EmberApsFrame [profileId=0, clusterId=54, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY], groupId=0, sequence=227], messageTag=56, status=EMBER_SUCCESS, messageContents=]
12:18:01.510 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspIncomingRouteErrorHandler [status=EMBER_SOURCE_ROUTE_FAILURE, target=60233]
12:18:01.512 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspIncomingRouteErrorHandler [status=EMBER_SOURCE_ROUTE_FAILURE, target=60233]
12:18:02.450 [DEBUG] [discovery.ZigBeeNodeServiceDiscoverer] - 90FD9FFFFE0AE080: Node SVC Discovery: running
12:18:02.455 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ManagementRoutingRequest [0/0 -> 4118/0, cluster=0032, TID=3B, startIndex=0]
12:18:02.458 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=4118/0, profile=0000, cluster=50, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=59, payload=00 00]
12:18:02.460 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EzspSendUnicastRequest [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=0, clusterId=50, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=59], messageTag=59, messageContents=00 00]
12:18:02.571 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=231]
12:18:02.573 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=231]
12:18:02.784 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=60233, apsFrame=EmberApsFrame [profileId=0, clusterId=50, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=226], messageTag=55, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:02.786 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=60233, apsFrame=EmberApsFrame [profileId=0, clusterId=50, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=226], messageTag=55, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:05.268 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=230], messageTag=58, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:05.270 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=230], messageTag=58, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:05.968 [DEBUG] [.zigbee.transaction.ZigBeeTransaction] - Transaction timeout: ManagementRoutingRequest [0/0 -> 60233/0, cluster=0032, TID=37, startIndex=0]
12:18:05.972 [DEBUG] [discovery.ZigBeeNodeServiceDiscoverer] - 000B57FFFEF19ED5: Node SVC Discovery: ManagementRoutingRequest returned CommandResult [TIMEOUT]
12:18:05.977 [DEBUG] [discovery.ZigBeeNodeServiceDiscoverer] - 000B57FFFEF19ED5: Node SVC Discovery: request ROUTES failed. Retry 11, wait 30290ms before retry.
12:18:07.267 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=0, clusterId=50, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=231], messageTag=59, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:07.269 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=0, clusterId=50, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=231], messageTag=59, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:08.247 [DEBUG] [.zigbee.transaction.ZigBeeTransaction] - Transaction timeout: ReadAttributesCommand [Basic: 0/0 -> 4118/1, cluster=0000, TID=3A, identifiers=[4]]
12:18:08.254 [DEBUG] [m.zsmartsystems.zigbee.zcl.ZclCluster] - readSync request: ZclAttribute [cluster=BASIC, id=4, name=ManufacturerName, dataType=CHARACTER_STRING, lastValue=null]
12:18:08.257 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ReadAttributesCommand [Basic: 0/0 -> 4118/1, cluster=0000, TID=3C, identifiers=[4]]
12:18:08.259 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=60, commandId=0]
12:18:08.262 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/1, destinationAddress=4118/1, profile=0104, cluster=0, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=60, payload=00 3C 00 04 00]
12:18:08.265 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EzspSendUnicastRequest [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=60], messageTag=60, messageContents=00 3C 00 04 00]
12:18:08.377 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=232]
12:18:08.379 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=232]
12:18:10.455 [DEBUG] [.zigbee.transaction.ZigBeeTransaction] - Transaction timeout: ManagementRoutingRequest [0/0 -> 4118/0, cluster=0032, TID=3B, startIndex=0]
12:18:10.464 [DEBUG] [discovery.ZigBeeNodeServiceDiscoverer] - 90FD9FFFFE0AE080: Node SVC Discovery: ManagementRoutingRequest returned CommandResult [TIMEOUT]
12:18:10.468 [DEBUG] [discovery.ZigBeeNodeServiceDiscoverer] - 90FD9FFFFE0AE080: Node SVC Discovery: request ROUTES failed. Retry 11, wait 11050ms before retry.
12:18:13.074 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=232], messageTag=60, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:13.077 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=232], messageTag=60, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:16.257 [DEBUG] [.zigbee.transaction.ZigBeeTransaction] - Transaction timeout: ReadAttributesCommand [Basic: 0/0 -> 4118/1, cluster=0000, TID=3C, identifiers=[4]]
12:18:16.275 [DEBUG] [m.zsmartsystems.zigbee.zcl.ZclCluster] - readSync request: ZclAttribute [cluster=BASIC, id=4, name=ManufacturerName, dataType=CHARACTER_STRING, lastValue=null]
12:18:16.283 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ReadAttributesCommand [Basic: 0/0 -> 4118/1, cluster=0000, TID=3D, identifiers=[4]]
12:18:16.291 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=61, commandId=0]
12:18:16.298 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/1, destinationAddress=4118/1, profile=0104, cluster=0, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=61, payload=00 3D 00 04 00]
12:18:16.306 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EzspSendUnicastRequest [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=61], messageTag=61, messageContents=00 3D 00 04 00]
12:18:16.425 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=233]
12:18:16.434 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=233]
12:18:17.449 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspTrustCenterJoinHandler [newNodeId=60233, newNodeEui64=000B57FFFEF19ED5, status=EMBER_STANDARD_SECURITY_UNSECURED_JOIN, policyDecision=EMBER_USE_PRECONFIGURED_KEY, parentOfNewNodeId=0]
12:18:17.456 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - 000B57FFFEF19ED5: nodeStatusUpdate - node status is UNSECURED_JOIN, network address is 60233.
12:18:17.465 [DEBUG] [app.discovery.ZigBeeNetworkDiscoverer] - 000B57FFFEF19ED5: Device status updated. NWK=60233
12:18:17.474 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - 000B57FFFEF19ED5: Node 60233 update
12:18:21.121 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=233], messageTag=61, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:21.136 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=233], messageTag=61, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:21.522 [DEBUG] [discovery.ZigBeeNodeServiceDiscoverer] - 90FD9FFFFE0AE080: Node SVC Discovery: running
12:18:21.530 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ManagementRoutingRequest [0/0 -> 4118/0, cluster=0032, TID=3E, startIndex=0]
12:18:21.537 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=4118/0, profile=0000, cluster=50, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=62, payload=00 00]
12:18:21.544 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EzspSendUnicastRequest [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=0, clusterId=50, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=62], messageTag=62, messageContents=00 00]
12:18:21.660 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=235]
12:18:21.666 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=235]
12:18:24.284 [DEBUG] [.zigbee.transaction.ZigBeeTransaction] - Transaction timeout: ReadAttributesCommand [Basic: 0/0 -> 4118/1, cluster=0000, TID=3D, identifiers=[4]]
12:18:24.301 [DEBUG] [m.zsmartsystems.zigbee.zcl.ZclCluster] - readSync request: ZclAttribute [cluster=BASIC, id=5, name=ModelIdentifier, dataType=CHARACTER_STRING, lastValue=null]
12:18:24.318 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ReadAttributesCommand [Basic: 0/0 -> 4118/1, cluster=0000, TID=3F, identifiers=[5]]
12:18:24.324 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=63, commandId=0]
12:18:24.341 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/1, destinationAddress=4118/1, profile=0104, cluster=0, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=63, payload=00 3F 00 05 00]
12:18:24.352 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EzspSendUnicastRequest [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=63], messageTag=63, messageContents=00 3F 00 05 00]
12:18:24.470 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=236]
12:18:24.477 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=236]
12:18:26.362 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=0, clusterId=50, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=235], messageTag=62, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:26.375 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=0, clusterId=50, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=235], messageTag=62, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:29.173 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspTrustCenterJoinHandler [newNodeId=60233, newNodeEui64=000B57FFFEF19ED5, status=EMBER_STANDARD_SECURITY_UNSECURED_JOIN, policyDecision=EMBER_USE_PRECONFIGURED_KEY, parentOfNewNodeId=0]
12:18:29.205 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - 000B57FFFEF19ED5: nodeStatusUpdate - node status is UNSECURED_JOIN, network address is 60233.
12:18:29.214 [DEBUG] [app.discovery.ZigBeeNetworkDiscoverer] - 000B57FFFEF19ED5: Device status updated. NWK=60233
12:18:29.229 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - 000B57FFFEF19ED5: Node 60233 update
12:18:29.227 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=236], messageTag=63, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:29.260 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=236], messageTag=63, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:29.531 [DEBUG] [.zigbee.transaction.ZigBeeTransaction] - Transaction timeout: ManagementRoutingRequest [0/0 -> 4118/0, cluster=0032, TID=3E, startIndex=0]
12:18:29.565 [DEBUG] [discovery.ZigBeeNodeServiceDiscoverer] - 90FD9FFFFE0AE080: Node SVC Discovery: ManagementRoutingRequest returned CommandResult [TIMEOUT]
12:18:29.574 [DEBUG] [discovery.ZigBeeNodeServiceDiscoverer] - 90FD9FFFFE0AE080: Node SVC Discovery: request ROUTES failed. Retry 12, wait 28730ms before retry.
12:18:32.308 [DEBUG] [.zigbee.transaction.ZigBeeTransaction] - Transaction timeout: ReadAttributesCommand [Basic: 0/0 -> 4118/1, cluster=0000, TID=3F, identifiers=[5]]
12:18:32.323 [DEBUG] [m.zsmartsystems.zigbee.zcl.ZclCluster] - readSync request: ZclAttribute [cluster=BASIC, id=5, name=ModelIdentifier, dataType=CHARACTER_STRING, lastValue=null]
12:18:32.347 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ReadAttributesCommand [Basic: 0/0 -> 4118/1, cluster=0000, TID=40, identifiers=[5]]
12:18:32.367 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=64, commandId=0]
12:18:32.386 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/1, destinationAddress=4118/1, profile=0104, cluster=0, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=64, payload=00 40 00 05 00]
12:18:32.394 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EzspSendUnicastRequest [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=64], messageTag=64, messageContents=00 40 00 05 00]
12:18:32.514 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=238]
12:18:32.521 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=238]
12:18:36.270 [DEBUG] [discovery.ZigBeeNodeServiceDiscoverer] - 000B57FFFEF19ED5: Node SVC Discovery: running
12:18:36.275 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ManagementRoutingRequest [0/0 -> 60233/0, cluster=0032, TID=41, startIndex=0]
12:18:36.278 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=60233/0, profile=0000, cluster=50, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=65, payload=00 00]
12:18:36.289 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EzspSendUnicastRequest [type=EMBER_OUTGOING_DIRECT, indexOrDestination=60233, apsFrame=EmberApsFrame [profileId=0, clusterId=50, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=65], messageTag=65, messageContents=00 00]
12:18:36.401 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=239]
12:18:36.407 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=239]
12:18:36.652 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspIncomingRouteErrorHandler [status=EMBER_SOURCE_ROUTE_FAILURE, target=60233]
12:18:36.658 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspIncomingRouteErrorHandler [status=EMBER_SOURCE_ROUTE_FAILURE, target=60233]
12:18:37.213 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=238], messageTag=64, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:37.220 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=238], messageTag=64, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:38.224 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspTrustCenterJoinHandler [newNodeId=60233, newNodeEui64=000B57FFFEF19ED5, status=EMBER_STANDARD_SECURITY_UNSECURED_JOIN, policyDecision=EMBER_USE_PRECONFIGURED_KEY, parentOfNewNodeId=0]
12:18:38.231 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - 000B57FFFEF19ED5: nodeStatusUpdate - node status is UNSECURED_JOIN, network address is 60233.
12:18:38.239 [DEBUG] [app.discovery.ZigBeeNetworkDiscoverer] - 000B57FFFEF19ED5: Device status updated. NWK=60233
12:18:38.247 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - 000B57FFFEF19ED5: Node 60233 update
12:18:38.255 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspIncomingRouteErrorHandler [status=EMBER_SOURCE_ROUTE_FAILURE, target=60233]
12:18:38.278 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspIncomingRouteErrorHandler [status=EMBER_SOURCE_ROUTE_FAILURE, target=60233]
12:18:39.780 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspIncomingRouteErrorHandler [status=EMBER_SOURCE_ROUTE_FAILURE, target=60233]
12:18:39.785 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspIncomingRouteErrorHandler [status=EMBER_SOURCE_ROUTE_FAILURE, target=60233]
12:18:40.347 [DEBUG] [.zigbee.transaction.ZigBeeTransaction] - Transaction timeout: ReadAttributesCommand [Basic: 0/0 -> 4118/1, cluster=0000, TID=40, identifiers=[5]]
12:18:40.361 [DEBUG] [m.zsmartsystems.zigbee.zcl.ZclCluster] - readSync request: ZclAttribute [cluster=BASIC, id=5, name=ModelIdentifier, dataType=CHARACTER_STRING, lastValue=null]
12:18:40.369 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ReadAttributesCommand [Basic: 0/0 -> 4118/1, cluster=0000, TID=42, identifiers=[5]]
12:18:40.376 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=66, commandId=0]
12:18:40.384 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/1, destinationAddress=4118/1, profile=0104, cluster=0, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=66, payload=00 42 00 05 00]
12:18:40.391 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EzspSendUnicastRequest [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=66], messageTag=66, messageContents=00 42 00 05 00]
12:18:40.509 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=241]
12:18:40.515 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=241]
12:18:41.099 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=60233, apsFrame=EmberApsFrame [profileId=0, clusterId=50, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=239], messageTag=65, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:41.107 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=60233, apsFrame=EmberApsFrame [profileId=0, clusterId=50, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=239], messageTag=65, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:44.113 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspTrustCenterJoinHandler [newNodeId=60233, newNodeEui64=000B57FFFEF19ED5, status=EMBER_STANDARD_SECURITY_UNSECURED_JOIN, policyDecision=EMBER_USE_PRECONFIGURED_KEY, parentOfNewNodeId=0]
12:18:44.121 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - 000B57FFFEF19ED5: nodeStatusUpdate - node status is UNSECURED_JOIN, network address is 60233.
12:18:44.128 [DEBUG] [app.discovery.ZigBeeNetworkDiscoverer] - 000B57FFFEF19ED5: Device status updated. NWK=60233
12:18:44.136 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - 000B57FFFEF19ED5: Node 60233 update
12:18:44.275 [DEBUG] [.zigbee.transaction.ZigBeeTransaction] - Transaction timeout: ManagementRoutingRequest [0/0 -> 60233/0, cluster=0032, TID=41, startIndex=0]
12:18:44.291 [DEBUG] [discovery.ZigBeeNodeServiceDiscoverer] - 000B57FFFEF19ED5: Node SVC Discovery: ManagementRoutingRequest returned CommandResult [TIMEOUT]
12:18:44.298 [DEBUG] [discovery.ZigBeeNodeServiceDiscoverer] - 000B57FFFEF19ED5: Node SVC Discovery: request ROUTES failed. Retry 12, wait 20970ms before retry.
12:18:45.206 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=241], messageTag=66, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:45.213 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=241], messageTag=66, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:48.369 [DEBUG] [.zigbee.transaction.ZigBeeTransaction] - Transaction timeout: ReadAttributesCommand [Basic: 0/0 -> 4118/1, cluster=0000, TID=42, identifiers=[5]]
12:18:48.385 [DEBUG] [m.zsmartsystems.zigbee.zcl.ZclCluster] - readSync request: ZclAttribute [cluster=BASIC, id=3, name=HWVersion, dataType=UNSIGNED_8_BIT_INTEGER, lastValue=null]
12:18:48.392 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ReadAttributesCommand [Basic: 0/0 -> 4118/1, cluster=0000, TID=43, identifiers=[3]]
12:18:48.399 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=67, commandId=0]
12:18:48.406 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/1, destinationAddress=4118/1, profile=0104, cluster=0, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=67, payload=00 43 00 03 00]
12:18:48.413 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EzspSendUnicastRequest [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=67], messageTag=67, messageContents=00 43 00 03 00]
12:18:48.530 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=243]
12:18:48.536 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=243]
12:18:53.229 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=243], messageTag=67, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:53.236 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=243], messageTag=67, status=EMBER_DELIVERY_FAILED, messageContents=]
12:18:56.392 [DEBUG] [.zigbee.transaction.ZigBeeTransaction] - Transaction timeout: ReadAttributesCommand [Basic: 0/0 -> 4118/1, cluster=0000, TID=43, identifiers=[3]]
12:18:56.406 [DEBUG] [m.zsmartsystems.zigbee.zcl.ZclCluster] - readSync request: ZclAttribute [cluster=BASIC, id=2, name=StackVersion, dataType=UNSIGNED_8_BIT_INTEGER, lastValue=null]
12:18:56.412 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ReadAttributesCommand [Basic: 0/0 -> 4118/1, cluster=0000, TID=44, identifiers=[2]]
12:18:56.419 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=CLIENT_TO_SERVER, disableDefaultResponse=false, manufacturerCode=0, sequenceNumber=68, commandId=0]
12:18:56.427 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/1, destinationAddress=4118/1, profile=0104, cluster=0, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=68, payload=00 44 00 02 00]
12:18:56.434 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EzspSendUnicastRequest [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=68], messageTag=68, messageContents=00 44 00 02 00]
12:18:56.552 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=244]
12:18:56.559 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=244]
12:18:58.313 [DEBUG] [discovery.ZigBeeNodeServiceDiscoverer] - 90FD9FFFFE0AE080: Node SVC Discovery: running
12:18:58.319 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ManagementRoutingRequest [0/0 -> 4118/0, cluster=0032, TID=45, startIndex=0]
12:18:58.326 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=4118/0, profile=0000, cluster=50, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=69, payload=00 00]
12:18:58.432 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EzspSendUnicastRequest [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=0, clusterId=50, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_ENABLE_ROUTE_DISCOVERY, EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=69], messageTag=69, messageContents=00 00]
12:18:58.550 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=245]
12:18:58.557 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspSendUnicastResponse [status=EMBER_SUCCESS, sequence=245]
12:19:01.252 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=244], messageTag=68, status=EMBER_DELIVERY_FAILED, messageContents=]
12:19:01.259 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=260, clusterId=0, sourceEndpoint=1, destinationEndpoint=1, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=244], messageTag=68, status=EMBER_DELIVERY_FAILED, messageContents=]
12:19:03.247 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=0, clusterId=50, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=245], messageTag=69, status=EMBER_DELIVERY_FAILED, messageContents=]
12:19:03.254 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Unhandled EZSP Frame: EzspMessageSentHandler [type=EMBER_OUTGOING_DIRECT, indexOrDestination=4118, apsFrame=EmberApsFrame [profileId=0, clusterId=50, sourceEndpoint=0, destinationEndpoint=0, options=[EMBER_APS_OPTION_RETRY, EMBER_APS_OPTION_ENABLE_ADDRESS_DISCOVERY], groupId=0, sequence=245], messageTag=69, status=EMBER_DELIVERY_FAILED, messageContents=]