Problem running ZigBee binding

Hi all, I don’t know if I can write here or I have to start a new post.
I make a fresh installation of openhabian on a raspberry.
I added this line on /etc/default/openhab2:

EXTRA_JAVA_OPTS="-Dgnu.io.rxtx.SerialPorts=/dev/ttyUSB0:/dev/ttyS0:/dev/ttyS2:/dev/ttyACM0:/dev/ttyAMA0"

than I installed zigbee binding, installed the CC2531EMK Coordinator. It go Online but I cannot discovery any device.
I tryed with 2.4.1 and with latest snapshot.
I tested the CC2531 dongle some time ago and it worked with a xiaomi double switch, so I think is not a dongle issue.
Now I’m trying with a hue motion sensor model: 9290012607 I cannot discovery it

You would need to run a newer version than 2.5M1 - ie you need to run the snapshot version.

I think you should start a new thread since your issue seems completely different with different dongle

hi,
I changed to the latest snapshot and the error is gone.
But now another occured.
Failed installing ‘openhab-misc-restdocs’
I have not seen the rest docs in “misc” like before. So probably it is removed in the snapshot (I dont know, why I installed it) but I cannot deinstall it. Is there another method? A restart of openhab dont work.

BTW my original problem has remained with me. The motion sensor wont talk with me:
Status: OFFLINE Node has not completed discovery
Should I try something else?
Do you need debug information?
THX Kersten

The device may need to be woken up to be discovered. This depends on the device - in theory ZigBee devices should wake up every 7 seconds to receive data, but not all conform to this.

yes, I know. I have to reset the device. That is, what I have done. I even removed it and scan for new devices. The device is detected and it sends the MAC Adress, but nothing else I can see.

Sorry - you didn’t say what you were doing, so I was just trying to suggest things.

Do you have a debug log to look at?

how can I activate debug infos?

Please check the binding documentation - it describes this toward the bottom of the page.

ah, I see, sorry, I have to look there first.
Here is some Data:

2019-07-30 19:38:04.813 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:SEQ:F9

2019-07-30 19:38:04.814 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK

2019-07-30 19:38:04.815 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSendUnicastCommand [address=0, sourceEp=0, destEp=0, profileId=0, clusterId=50, messageData=00 00, messageId=249, status=SUCCESS]

2019-07-30 19:38:04.817 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=8C state=TX_ACK

2019-07-30 19:38:04.817 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=8C, state=TX_ACK, outstanding=1

2019-07-30 19:38:04.818 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state updated: TID 8C -> TX_ACK == TRANSMITTED

2019-07-30 19:38:04.819 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:RX:0000,0000,00,00,8032,50:@9,00,FF

2019-07-30 19:38:04.821 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisReceiveMessageEvent [ieeeAddress=null, networkAddress=0, profileId=0, destinationEp=0, sourceEp=0, clusterId=32818, messageData=00 00 40 00 0F 00 00 39 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00, rssi=0, lqi=255]

2019-07-30 19:38:04.822 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:ACK:F9

2019-07-30 19:38:04.822 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisAckMessageEvent [messageId=249]

2019-07-30 19:38:04.823 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=0/0, profile=0000, cluster=8032, addressMode=null, radius=0, apsSecurity=false, apsCounter=--, payload=00 00 40 00 0F 00 00 39 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00]

2019-07-30 19:38:04.824 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: ManagementRoutingResponse [0/0 -> 0/0, cluster=8032, TID=--, status=SUCCESS, routingTableEntries=64, startIndex=0, routingTableList=[RoutingTable [destinationAddress=0, status=DISCOVERY_UNDERWAY, memoryConstrained=true, manyToOne=true, routeRecordRequired=true, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0]]]

2019-07-30 19:38:04.825 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: ManagementRoutingResponse [0/0 -> 0/0, cluster=8032, TID=--, status=SUCCESS, routingTableEntries=64, startIndex=0, routingTableList=[RoutingTable [destinationAddress=0, status=DISCOVERY_UNDERWAY, memoryConstrained=true, manyToOne=true, routeRecordRequired=true, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0]]] 

2019-07-30 19:38:04.826 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: ManagementRoutingResponse [0/0 -> 0/0, cluster=8032, TID=--, status=SUCCESS, routingTableEntries=64, startIndex=0, routingTableList=[RoutingTable [destinationAddress=0, status=DISCOVERY_UNDERWAY, memoryConstrained=true, manyToOne=true, routeRecordRequired=true, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0]]] ZigBeeTransaction [queueTime=227, state=TRANSMITTED, sendCnt=1, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8C, startIndex=0]]

2019-07-30 19:38:04.827 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction response received - waiting TX_ACK: ZigBeeTransaction [queueTime=228, state=RESPONDED, sendCnt=1, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8C, startIndex=0]]

2019-07-30 19:38:04.829 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=8C state=RX_ACK

2019-07-30 19:38:04.830 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=8C, state=RX_ACK, outstanding=1

2019-07-30 19:38:04.832 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [queueTime=233, state=COMPLETE, sendCnt=1, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8C, startIndex=0]]

2019-07-30 19:38:04.833 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding

2019-07-30 19:38:04.833 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 000D6F0011145A42: transactionComplete COMPLETE 0

2019-07-30 19:38:04.834 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state updated: TID 8C -> RX_ACK == COMPLETE

2019-07-30 19:38:04.834 [DEBUG] [iscovery.ZigBeeNodeServiceDiscoverer] - 000D6F0011145A42: Node SVC Discovery: ManagementRoutingRequest returned CommandResult [SUCCESS, ManagementRoutingResponse [0/0 -> 0/0, cluster=8032, TID=--, status=SUCCESS, routingTableEntries=64, startIndex=0, routingTableList=[RoutingTable [destinationAddress=0, status=DISCOVERY_UNDERWAY, memoryConstrained=true, manyToOne=true, routeRecordRequired=true, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0]]]]

2019-07-30 19:38:04.835 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 000D6F0011145A42: Added transaction to queue, len=1, transaction=ZigBeeTransaction [queueTime=0, state=WAITING, sendCnt=0, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=--, startIndex=15]]

2019-07-30 19:38:04.836 [DEBUG] [transaction.ZigBeeTransactionManager] - 0/0: Sending ZigBeeTransaction [queueTime=1, state=WAITING, sendCnt=0, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8D, startIndex=15]]

2019-07-30 19:38:04.837 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 1 outstanding

2019-07-30 19:38:04.838 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8D, startIndex=15]

2019-07-30 19:38:04.839 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=0/0, profile=0000, cluster=0032, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=AC, payload=00 0F]

2019-07-30 19:38:04.840 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Telegesis send: TelegesisSendUnicastCommand [address=0, sourceEp=0, destEp=0, profileId=0, clusterId=50, messageData=00 0F, messageId=null]

2019-07-30 19:38:04.841 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1

2019-07-30 19:38:04.842 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSendUnicastCommand [address=0, sourceEp=0, destEp=0, profileId=0, clusterId=50, messageData=00 0F, messageId=null]

2019-07-30 19:38:04.845 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:AT+SENDUCASTB:02,0000,00,00,0000,0032



2019-07-30 19:38:05.045 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:SEQ:FB

2019-07-30 19:38:05.046 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK

2019-07-30 19:38:05.046 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSendUnicastCommand [address=0, sourceEp=0, destEp=0, profileId=0, clusterId=50, messageData=00 0F, messageId=251, status=SUCCESS]

2019-07-30 19:38:05.047 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=8D state=TX_ACK

2019-07-30 19:38:05.050 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:RX:0000,0000,00,00,8032,50:@,00,FF

2019-07-30 19:38:05.051 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=8D, state=TX_ACK, outstanding=1

2019-07-30 19:38:05.052 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisReceiveMessageEvent [ieeeAddress=null, networkAddress=0, profileId=0, destinationEp=0, sourceEp=0, clusterId=32818, messageData=00 00 40 0F 0F 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00, rssi=0, lqi=255]

2019-07-30 19:38:05.052 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state updated: TID 8D -> TX_ACK == TRANSMITTED

2019-07-30 19:38:05.054 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:ACK:FB

2019-07-30 19:38:05.055 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=0/0, profile=0000, cluster=8032, addressMode=null, radius=0, apsSecurity=false, apsCounter=--, payload=00 00 40 0F 0F 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00]

2019-07-30 19:38:05.056 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisAckMessageEvent [messageId=251]

2019-07-30 19:38:05.059 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: ManagementRoutingResponse [0/0 -> 0/0, cluster=8032, TID=--, status=SUCCESS, routingTableEntries=64, startIndex=15, routingTableList=[RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0]]]

2019-07-30 19:38:05.061 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: ManagementRoutingResponse [0/0 -> 0/0, cluster=8032, TID=--, status=SUCCESS, routingTableEntries=64, startIndex=15, routingTableList=[RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0]]] 

2019-07-30 19:38:05.063 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: ManagementRoutingResponse [0/0 -> 0/0, cluster=8032, TID=--, status=SUCCESS, routingTableEntries=64, startIndex=15, routingTableList=[RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0]]] ZigBeeTransaction [queueTime=228, state=TRANSMITTED, sendCnt=1, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8D, startIndex=15]]

2019-07-30 19:38:05.065 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction response received - waiting TX_ACK: ZigBeeTransaction [queueTime=230, state=RESPONDED, sendCnt=1, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8D, startIndex=15]]

2019-07-30 19:38:05.067 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=8D state=RX_ACK

2019-07-30 19:38:05.068 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=8D, state=RX_ACK, outstanding=1

2019-07-30 19:38:05.071 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [queueTime=236, state=COMPLETE, sendCnt=1, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8D, startIndex=15]]

2019-07-30 19:38:05.072 [DEBUG] [iscovery.ZigBeeNodeServiceDiscoverer] - 000D6F0011145A42: Node SVC Discovery: ManagementRoutingRequest returned CommandResult [SUCCESS, ManagementRoutingResponse [0/0 -> 0/0, cluster=8032, TID=--, status=SUCCESS, routingTableEntries=64, startIndex=15, routingTableList=[RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0]]]]

2019-07-30 19:38:05.073 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 000D6F0011145A42: Added transaction to queue, len=1, transaction=ZigBeeTransaction [queueTime=0, state=WAITING, sendCnt=0, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=--, startIndex=30]]

2019-07-30 19:38:05.074 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding

2019-07-30 19:38:05.074 [DEBUG] [transaction.ZigBeeTransactionManager] - 0/0: Sending ZigBeeTransaction [queueTime=1, state=WAITING, sendCnt=0, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8E, startIndex=30]]

2019-07-30 19:38:05.076 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 1 outstanding

2019-07-30 19:38:05.077 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8E, startIndex=30]

2019-07-30 19:38:05.077 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=0/0, profile=0000, cluster=0032, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=AD, payload=00 1E]

2019-07-30 19:38:05.078 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Telegesis send: TelegesisSendUnicastCommand [address=0, sourceEp=0, destEp=0, profileId=0, clusterId=50, messageData=00 1E, messageId=null]

2019-07-30 19:38:05.079 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1

2019-07-30 19:38:05.079 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 000D6F0011145A42: transactionComplete COMPLETE 1

2019-07-30 19:38:05.080 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state updated: TID 8D -> RX_ACK == COMPLETE

2019-07-30 19:38:05.080 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSendUnicastCommand [address=0, sourceEp=0, destEp=0, profileId=0, clusterId=50, messageData=00 1E, messageId=null]

2019-07-30 19:38:05.084 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:AT+SENDUCASTB:02,0000,00,00,0000,0032



2019-07-30 19:38:05.284 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:SEQ:FD

2019-07-30 19:38:05.285 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK

2019-07-30 19:38:05.287 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSendUnicastCommand [address=0, sourceEp=0, destEp=0, profileId=0, clusterId=50, messageData=00 1E, messageId=253, status=SUCCESS]

2019-07-30 19:38:05.288 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=8E state=TX_ACK

2019-07-30 19:38:05.289 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=8E, state=TX_ACK, outstanding=1

2019-07-30 19:38:05.291 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:RX:0000,0000,00,00,8032,50:@,00,FF

2019-07-30 19:38:05.292 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state updated: TID 8E -> TX_ACK == TRANSMITTED

2019-07-30 19:38:05.293 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisReceiveMessageEvent [ieeeAddress=null, networkAddress=0, profileId=0, destinationEp=0, sourceEp=0, clusterId=32818, messageData=00 00 40 1E 0F 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00, rssi=0, lqi=255]

2019-07-30 19:38:05.294 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:ACK:FD

2019-07-30 19:38:05.295 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisAckMessageEvent [messageId=253]

2019-07-30 19:38:05.295 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=0/0, profile=0000, cluster=8032, addressMode=null, radius=0, apsSecurity=false, apsCounter=--, payload=00 00 40 1E 0F 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00]

2019-07-30 19:38:05.297 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: ManagementRoutingResponse [0/0 -> 0/0, cluster=8032, TID=--, status=SUCCESS, routingTableEntries=64, startIndex=30, routingTableList=[RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0]]]

2019-07-30 19:38:05.298 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: ManagementRoutingResponse [0/0 -> 0/0, cluster=8032, TID=--, status=SUCCESS, routingTableEntries=64, startIndex=30, routingTableList=[RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0]]] 

2019-07-30 19:38:05.299 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: ManagementRoutingResponse [0/0 -> 0/0, cluster=8032, TID=--, status=SUCCESS, routingTableEntries=64, startIndex=30, routingTableList=[RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0]]] ZigBeeTransaction [queueTime=226, state=TRANSMITTED, sendCnt=1, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8E, startIndex=30]]

2019-07-30 19:38:05.301 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction response received - waiting TX_ACK: ZigBeeTransaction [queueTime=228, state=RESPONDED, sendCnt=1, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8E, startIndex=30]]

2019-07-30 19:38:05.302 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=8E state=RX_ACK

2019-07-30 19:38:05.303 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=8E, state=RX_ACK, outstanding=1

2019-07-30 19:38:05.315 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [queueTime=242, state=COMPLETE, sendCnt=1, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8E, startIndex=30]]

2019-07-30 19:38:05.315 [DEBUG] [iscovery.ZigBeeNodeServiceDiscoverer] - 000D6F0011145A42: Node SVC Discovery: ManagementRoutingRequest returned CommandResult [SUCCESS, ManagementRoutingResponse [0/0 -> 0/0, cluster=8032, TID=--, status=SUCCESS, routingTableEntries=64, startIndex=30, routingTableList=[RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0], RoutingTable [destinationAddress=0, status=INACTIVE, memoryConstrained=false, manyToOne=false, routeRecordRequired=false, nextHopAddress=0]]]]

2019-07-30 19:38:05.318 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 0 outstanding

2019-07-30 19:38:05.318 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 000D6F0011145A42: Added transaction to queue, len=1, transaction=ZigBeeTransaction [queueTime=0, state=WAITING, sendCnt=0, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=--, startIndex=45]]

2019-07-30 19:38:05.319 [DEBUG] [transaction.ZigBeeTransactionManager] - 0/0: Sending ZigBeeTransaction [queueTime=1, state=WAITING, sendCnt=0, command=ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8F, startIndex=45]]

2019-07-30 19:38:05.321 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 1 outstanding

2019-07-30 19:38:05.322 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: ManagementRoutingRequest [0/0 -> 0/0, cluster=0032, TID=8F, startIndex=45]

2019-07-30 19:38:05.323 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0/0, destinationAddress=0/0, profile=0000, cluster=0032, addressMode=DEVICE, radius=31, apsSecurity=false, apsCounter=AE, payload=00 2D]

2019-07-30 19:38:05.324 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Telegesis send: TelegesisSendUnicastCommand [address=0, sourceEp=0, destEp=0, profileId=0, clusterId=50, messageData=00 2D, messageId=null]

2019-07-30 19:38:05.325 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 000D6F0011145A42: transactionComplete COMPLETE 1

2019-07-30 19:38:05.326 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1

2019-07-30 19:38:05.326 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state updated: TID 8E -> RX_ACK == COMPLETE

2019-07-30 19:38:05.329 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSendUnicastCommand [address=0, sourceEp=0, destEp=0, profileId=0, clusterId=50, messageData=00 2D, messageId=null]

2019-07-30 19:38:05.332 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:AT+SENDUCASTB:02,0000,00,00,0000,0032

-

2019-07-30 19:38:05.422 [DEBUG] [iscovery.ZigBeeNodeServiceDiscoverer] - 000D6F000F78184C: Node SVC Discovery: running ACTIVE_ENDPOINTS

2019-07-30 19:38:05.423 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 000D6F000F78184C: Added transaction to queue, len=2, transaction=ZigBeeTransaction [queueTime=0, state=WAITING, sendCnt=0, command=ActiveEndpointsRequest [0/0 -> 38936/0, cluster=0005, TID=--, nwkAddrOfInterest=38936]]

2019-07-30 19:38:05.538 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:SEQ:FF

2019-07-30 19:38:05.540 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK

2019-07-30 19:38:05.543 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSendUnicastCommand [address=0, sourceEp=0, destEp=0, profileId=0, clusterId=50, messageData=00 2D, messageId=255, status=SUCCESS]

2019-07-30 19:38:05.545 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=8F state=TX_ACK

2019-07-30 19:38:05.548 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=8F, state=TX_ACK, outstanding=1

2019-07-30 19:38:05.550 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state updated: TID 8F -> TX_ACK == TRANSMITTED

2019-07-30 19:38:05.551 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:RX:0000,0000,00,00,8032,50:@-,00,FF

2019-07-30 19:38:05.553 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisReceiveMessageEvent [ieeeAddress=null, networkAddress=0, profileId=0, destinationEp=0, sourceEp=0, clusterId=32818, messageData=00 00 40 2D 0F 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00 00 00 03 00 00, rssi=0, lqi=255]

2019-07-30 19:38:05.555 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:ACK:FF

2019-07-30 19:38:05.556 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisAckMessageEvent [messageId=255]


äh,
how can I stop the logs. It scrolls very fast and I can see nothing else…
edit: it stops :slight_smile:
the device id is : 000D6F000F78184C
Now I think I have data, that is more meaningfull:

2019-07-30 20:00:40.812 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:NEWNODE:6495,000D6F000F78184C,0000

2019-07-30 20:00:40.815 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDeviceJoinedNetworkEvent [networkAddress=25749, ieeeAddress=000D6F000F78184C, parentAddress=0]

2019-07-30 20:00:40.818 [DEBUG] [gesis.internal.TelegesisFrameHandler] - Exception processing Telegesis frame: TelegesisDeviceJoinedNetworkEvent [networkAddress=25749, ieeeAddress=000D6F000F78184C, parentAddress=0]: 

java.util.concurrent.RejectedExecutionException: Task com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis$2@5ad129 rejected from java.util.concurrent.ThreadPoolExecutor@15850a6[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 540]

	at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1379) ~[?:?]

	at com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis.telegesisEventReceived(ZigBeeDongleTelegesis.java:739) ~[279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.notifyEventReceived(TelegesisFrameHandler.java:459) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.access$600(TelegesisFrameHandler.java:41) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler$1.run(TelegesisFrameHandler.java:187) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

2019-07-30 20:00:40.841 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:RX:000D6F000F78184C,6495,0000,00,00,0013,0C:©•dLxo

€,-23,FF

2019-07-30 20:00:40.844 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisReceiveMessageEvent [ieeeAddress=000D6F000F78184C, networkAddress=25749, profileId=0, destinationEp=0, sourceEp=0, clusterId=19, messageData=A9 95 64 4C 18 78 0F 00 6F 0D 00 80, rssi=-35, lqi=255]

2019-07-30 20:00:40.848 [DEBUG] [gesis.internal.TelegesisFrameHandler] - Exception processing Telegesis frame: TelegesisReceiveMessageEvent [ieeeAddress=000D6F000F78184C, networkAddress=25749, profileId=0, destinationEp=0, sourceEp=0, clusterId=19, messageData=A9 95 64 4C 18 78 0F 00 6F 0D 00 80, rssi=-35, lqi=255]: 

java.util.concurrent.RejectedExecutionException: Task com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis$2@d0233f rejected from java.util.concurrent.ThreadPoolExecutor@15850a6[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 540]

	at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1379) ~[?:?]

	at com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis.telegesisEventReceived(ZigBeeDongleTelegesis.java:739) ~[279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.notifyEventReceived(TelegesisFrameHandler.java:459) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.access$600(TelegesisFrameHandler.java:41) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler$1.run(TelegesisFrameHandler.java:187) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

2019-07-30 20:00:44.765 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:NODELEFT:6495,000D6F000F78184C

2019-07-30 20:00:44.768 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDeviceLeftNetworkEvent [networkAddress=25749, ieeeAddress=000D6F000F78184C]

2019-07-30 20:00:44.779 [DEBUG] [gesis.internal.TelegesisFrameHandler] - Exception processing Telegesis frame: TelegesisDeviceLeftNetworkEvent [networkAddress=25749, ieeeAddress=000D6F000F78184C]: 

java.util.concurrent.RejectedExecutionException: Task com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis$2@12acebc rejected from java.util.concurrent.ThreadPoolExecutor@15850a6[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 540]

	at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1379) ~[?:?]

	at com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis.telegesisEventReceived(ZigBeeDongleTelegesis.java:739) ~[279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.notifyEventReceived(TelegesisFrameHandler.java:459) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.access$600(TelegesisFrameHandler.java:41) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler$1.run(TelegesisFrameHandler.java:187) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

2019-07-30 20:00:51.216 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:NEWNODE:1191,000D6F000F78184C,0000

2019-07-30 20:00:51.218 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDeviceJoinedNetworkEvent [networkAddress=4497, ieeeAddress=000D6F000F78184C, parentAddress=0]

2019-07-30 20:00:51.221 [DEBUG] [gesis.internal.TelegesisFrameHandler] - Exception processing Telegesis frame: TelegesisDeviceJoinedNetworkEvent [networkAddress=4497, ieeeAddress=000D6F000F78184C, parentAddress=0]: 

java.util.concurrent.RejectedExecutionException: Task com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis$2@4a621f rejected from java.util.concurrent.ThreadPoolExecutor@15850a6[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 540]

	at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1379) ~[?:?]

	at com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis.telegesisEventReceived(ZigBeeDongleTelegesis.java:739) ~[279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.notifyEventReceived(TelegesisFrameHandler.java:459) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.access$600(TelegesisFrameHandler.java:41) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler$1.run(TelegesisFrameHandler.java:187) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

2019-07-30 20:00:51.236 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:RX:000D6F000F78184C,1191,0000,00,00,0013,0C:ª‘Lxo

€,-23,FF

2019-07-30 20:00:51.239 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisReceiveMessageEvent [ieeeAddress=000D6F000F78184C, networkAddress=4497, profileId=0, destinationEp=0, sourceEp=0, clusterId=19, messageData=AA 91 11 4C 18 78 0F 00 6F 0D 00 80, rssi=-35, lqi=255]

2019-07-30 20:00:51.242 [DEBUG] [gesis.internal.TelegesisFrameHandler] - Exception processing Telegesis frame: TelegesisReceiveMessageEvent [ieeeAddress=000D6F000F78184C, networkAddress=4497, profileId=0, destinationEp=0, sourceEp=0, clusterId=19, messageData=AA 91 11 4C 18 78 0F 00 6F 0D 00 80, rssi=-35, lqi=255]: 

java.util.concurrent.RejectedExecutionException: Task com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis$2@752e66 rejected from java.util.concurrent.ThreadPoolExecutor@15850a6[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 540]

	at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1379) ~[?:?]

	at com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis.telegesisEventReceived(ZigBeeDongleTelegesis.java:739) ~[279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.notifyEventReceived(TelegesisFrameHandler.java:459) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.access$600(TelegesisFrameHandler.java:41) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler$1.run(TelegesisFrameHandler.java:187) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

2019-07-30 20:00:55.030 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:NODELEFT:1191,000D6F000F78184C

2019-07-30 20:00:55.033 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDeviceLeftNetworkEvent [networkAddress=4497, ieeeAddress=000D6F000F78184C]

2019-07-30 20:00:55.035 [DEBUG] [gesis.internal.TelegesisFrameHandler] - Exception processing Telegesis frame: TelegesisDeviceLeftNetworkEvent [networkAddress=4497, ieeeAddress=000D6F000F78184C]: 

java.util.concurrent.RejectedExecutionException: Task com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis$2@1f327cc rejected from java.util.concurrent.ThreadPoolExecutor@15850a6[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 540]

	at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1379) ~[?:?]

	at com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis.telegesisEventReceived(ZigBeeDongleTelegesis.java:739) ~[279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.notifyEventReceived(TelegesisFrameHandler.java:459) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.access$600(TelegesisFrameHandler.java:41) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler$1.run(TelegesisFrameHandler.java:187) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

2019-07-30 20:01:02.666 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:NEWNODE:C431,000D6F000F78184C,0000

2019-07-30 20:01:02.669 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDeviceJoinedNetworkEvent [networkAddress=50225, ieeeAddress=000D6F000F78184C, parentAddress=0]

2019-07-30 20:01:02.671 [DEBUG] [gesis.internal.TelegesisFrameHandler] - Exception processing Telegesis frame: TelegesisDeviceJoinedNetworkEvent [networkAddress=50225, ieeeAddress=000D6F000F78184C, parentAddress=0]: 

java.util.concurrent.RejectedExecutionException: Task com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis$2@7144e0 rejected from java.util.concurrent.ThreadPoolExecutor@15850a6[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 540]

	at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1379) ~[?:?]

	at com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis.telegesisEventReceived(ZigBeeDongleTelegesis.java:739) ~[279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.notifyEventReceived(TelegesisFrameHandler.java:459) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.access$600(TelegesisFrameHandler.java:41) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler$1.run(TelegesisFrameHandler.java:187) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

2019-07-30 20:01:02.687 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:RX:000D6F000F78184C,C431,0000,00,00,0013,0C:«1ÄLxo

€,-23,FF

2019-07-30 20:01:02.691 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisReceiveMessageEvent [ieeeAddress=000D6F000F78184C, networkAddress=50225, profileId=0, destinationEp=0, sourceEp=0, clusterId=19, messageData=AB 31 C4 4C 18 78 0F 00 6F 0D 00 80, rssi=-35, lqi=255]

2019-07-30 20:01:02.694 [DEBUG] [gesis.internal.TelegesisFrameHandler] - Exception processing Telegesis frame: TelegesisReceiveMessageEvent [ieeeAddress=000D6F000F78184C, networkAddress=50225, profileId=0, destinationEp=0, sourceEp=0, clusterId=19, messageData=AB 31 C4 4C 18 78 0F 00 6F 0D 00 80, rssi=-35, lqi=255]: 

java.util.concurrent.RejectedExecutionException: Task com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis$2@14e8d6b rejected from java.util.concurrent.ThreadPoolExecutor@15850a6[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 540]

	at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1379) ~[?:?]

	at com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis.telegesisEventReceived(ZigBeeDongleTelegesis.java:739) ~[279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.notifyEventReceived(TelegesisFrameHandler.java:459) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.access$600(TelegesisFrameHandler.java:41) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler$1.run(TelegesisFrameHandler.java:187) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

2019-07-30 20:01:06.619 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:NODELEFT:C431,000D6F000F78184C

2019-07-30 20:01:06.622 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDeviceLeftNetworkEvent [networkAddress=50225, ieeeAddress=000D6F000F78184C]

2019-07-30 20:01:06.625 [DEBUG] [gesis.internal.TelegesisFrameHandler] - Exception processing Telegesis frame: TelegesisDeviceLeftNetworkEvent [networkAddress=50225, ieeeAddress=000D6F000F78184C]: 

java.util.concurrent.RejectedExecutionException: Task com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis$2@3b90ba rejected from java.util.concurrent.ThreadPoolExecutor@15850a6[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 540]

	at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1379) ~[?:?]

	at com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis.telegesisEventReceived(ZigBeeDongleTelegesis.java:739) ~[279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.notifyEventReceived(TelegesisFrameHandler.java:459) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.access$600(TelegesisFrameHandler.java:41) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler$1.run(TelegesisFrameHandler.java:187) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

2019-07-30 20:01:14.172 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:NEWNODE:A00D,000D6F000F78184C,0000

2019-07-30 20:01:14.176 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDeviceJoinedNetworkEvent [networkAddress=40973, ieeeAddress=000D6F000F78184C, parentAddress=0]

2019-07-30 20:01:14.178 [DEBUG] [gesis.internal.TelegesisFrameHandler] - Exception processing Telegesis frame: TelegesisDeviceJoinedNetworkEvent [networkAddress=40973, ieeeAddress=000D6F000F78184C, parentAddress=0]: 

java.util.concurrent.RejectedExecutionException: Task com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis$2@fa11f6 rejected from java.util.concurrent.ThreadPoolExecutor@15850a6[Terminated, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 540]

	at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2063) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:830) ~[?:?]

	at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1379) ~[?:?]

	at com.zsmartsystems.zigbee.dongle.telegesis.ZigBeeDongleTelegesis.telegesisEventReceived(ZigBeeDongleTelegesis.java:739) ~[279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.notifyEventReceived(TelegesisFrameHandler.java:459) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler.access$600(TelegesisFrameHandler.java:41) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

	at com.zsmartsystems.zigbee.dongle.telegesis.internal.TelegesisFrameHandler$1.run(TelegesisFrameHandler.java:187) [279:com.zsmartsystems.zigbee.dongle.telegesis:1.2.1]

2019-07-30 20:01:14.191 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:RX:000D6F000F78184C,A00D,0000,00,00,0013,0C:¬

 Lxo

€,-24,FF

2019-07-30 20:01:14.194 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisReceiveMessageEvent [ieeeAddress=000D6F000F78184C, networkAddress=40973, profileId=0, destinationEp=0, sourceEp=0, clusterId=19, messageData=AC 0D A0 4C 18 78 0F 00 6F 0D 00 80, rssi=-36, lqi=255]

hi,
can you do something with the data?
Do you need more or other ones?

The logs are really too short to be of use and they don’t show the issue that you are reporting.

hi,
OK, I tried again to collect messages but
the upload is limited to 48000 chars.
May I send you a txt file with the error messages?

edit: I put it into my dropbox as a zip file:
If you may…

is the device a battery powered device? If so it must be woken many times until the binding gets all the required information. It takes waking it over and over. Find the documentation for the device and figure out how to wake the device and do so… repeatedly

The log doesn’t really show anything happening during the join. It does show a couple of devices are joined to the network though.

Can you describe exactly what you are doing.

Eg -:

  • Put binding into join mode
  • Reset device

What is the device exactly? It depends on the device type if you need to wake it up or not - ZigBee devices work very differently to ZWave devices where they definately need to be woken up. ZigBee devices are meant to wake up automatically every 7.6 seconds so that their parent can talk to them - not all do this though.

hi,
first thank you, for your time and patience.
I try it again. The link to the newest log is here: https://www.dropbox.com/s/tm5oki358s8wm2f/ZigBeeError.txt.zip?dl=0
The device is a battery driven Osram smart+ motion sensor with ID 000D6F000F78184C. To wake it up there is a button. It has 2 LEDs (or one multicolor), a blue one and a green one
So, what did I do:
I activate the debug for zigbee at 2019-08-01 11:54:00
At 2019-08-01 11:55:00 I press the button of the device.
You can see it in the log
The blue LED biginns to blink 3 times then pause then 3 times, pause and so on.
I watched the log and every time the grenn led is on there are special outputs to the log:
eg here: 2019-08-01 11:55:18.178
that repeats some time and after a while it stops blinking. I think, its about here:
2019-08-01 11:56:05.354
I hope you can see now, what happens.
I’m on vacation for 3 weeks on Saturday. Tomorrow I can answer, but after tomorrow I cannot give further input until end of august.