COMMUNICATION_ERROR with Qivicon zigbee stick (Qivicon) after migration from 2.5 to 3.3

Add-ons Bindings
1

Today I switched from OpenHAB 2.5 to OpenHAB 3.3 - more or less everything is working. Only my Zigbee stick is not working / recognized :frowning:

I switched from an Pi4b to a new Pi4b and restored the 2.5 backup into the new 3.3 environment.
The image is based on Openhabian.

The stick seems to be available:

ls -la /dev/serial/by-id/
total 0
drwxr-xr-x 2 root root 80 Dec 11 12:02 .
drwxr-xr-x 4 root root 80 Dec 11 12:02 ..
lrwxrwxrwx 1 root root 13 Dec 11 12:02 usb-busware.de_CUL868-if00 -> ../../ttyACM0
lrwxrwxrwx 1 root root 13 Dec 11 12:02 usb-Silicon_Labs_Qivicon_ZigBee_Device_0500201F-if00-port0 -> ../../ttyUSB0

After installing the Zigbee binding, no autodiscovery happens.

Adding the stick manually as

  • Telegesis Coordinator
  • Port : /dev/ttyUSB0
  • Baudrate : 19200
  • everything else with default parameter

the thing is offline with a " COMMUNICATION_ERROR"

After enabling the debug level for the zigbee binding, I see the following log:

2022-12-11 12:13:12.492 [ERROR] [ngle.telegesis.ZigBeeDongleTelegesis] - Error while initialising Telegesis dongle and forming network.
2022-12-11 12:13:12.495 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2022-12-11 12:13:17.499 [INFO ] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee dongle inactivity timer. Reinitializing ZigBee
2022-12-11 12:13:17.503 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2022-12-11 12:13:17.574 [DEBUG] [nding.zigbee.serial.ZigBeeSerialPort] - Serial port '/dev/ttyUSB0' closed.
2022-12-11 12:13:17.577 [DEBUG] [e.telegesis.handler.TelegesisHandler] - Initializing ZigBee Telegesis serial bridge handler.
2022-12-11 12:13:17.580 [DEBUG] [e.telegesis.handler.TelegesisHandler] - ZigBee Telegesis Coordinator opening Port:'/dev/ttyUSB0' PAN:21a9, EPAN:256D0C37C7216B84, Channel:11
2022-12-11 12:13:17.582 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Scheduling ZigBee start
2022-12-11 12:13:18.584 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee network starting
2022-12-11 12:13:18.587 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2022-12-11 12:13:18.591 [DEBUG] [nding.zigbee.serial.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB0] at 19200 baud, flow control FLOWCONTROL_OUT_NONE.
2022-12-11 12:13:18.591 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
2022-12-11 12:13:18.650 [DEBUG] [nding.zigbee.serial.ZigBeeSerialPort] - Serial port [/dev/ttyUSB0] is initialized.
2022-12-11 12:13:19.218 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Mesh Update Period 86400
2022-12-11 12:13:19.237 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee Initialise: Previous device configuration was: channel=null, PanID=0, EPanId=null
2022-12-11 12:13:19.240 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Link key initialise 5A6967426565416C6C69616xxxxxxxxx
2022-12-11 12:13:19.243 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Network key initialise 9A07CC2808F2BE3CB7A8C30xxxxxxxxx
2022-12-11 12:13:19.361 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Config: zigbee_trustcentremode=TC_JOIN_SECURE
2022-12-11 12:13:28.321 [ERROR] [ngle.telegesis.ZigBeeDongleTelegesis] - Error while initialising Telegesis dongle and forming network.
2022-12-11 12:13:28.324 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE

What can I do?
What could be the issue?

2

Please enable debug logging so we can see what’s going on with the communications. You should run the following command in addition to what you’ve already set -:

log:set debug com.zsmartsystems.zigbee
3

Okay, here the output:

2022-12-11 13:25:57.008 [ERROR] [ngle.telegesis.ZigBeeDongleTelegesis] - Error while initialising Telegesis dongle and forming network.
2022-12-11 13:25:57.011 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to OFFLINE
2022-12-11 13:26:02.015 [INFO ] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee dongle inactivity timer. Reinitializing ZigBee
2022-12-11 13:26:02.018 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager shutdown: networkState=OFFLINE
2022-12-11 13:26:02.021 [DEBUG] [atabase.ZigBeeNetworkDatabaseManager] - Data store: Deferred Write Time set to 0ms
2022-12-11 13:26:02.023 [DEBUG] [atabase.ZigBeeNetworkDatabaseManager] - Data store: Deferred Write Time set less than Max Deferred Write Time
2022-12-11 13:26:02.025 [DEBUG] [atabase.ZigBeeNetworkDatabaseManager] - Data store: Max Deferred Write Time set to 0ms
2022-12-11 13:26:02.031 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to SHUTDOWN
2022-12-11 13:26:02.035 [DEBUG] [p.discovery.ZigBeeDiscoveryExtension] - DISCOVERY Extension: Shutdown
2022-12-11 13:26:02.037 [DEBUG] [atabase.ZigBeeNetworkDatabaseManager] - Data store: Shutdown
2022-12-11 13:26:02.039 [DEBUG] [gesis.internal.TelegesisFrameHandler] - Telegesis interrupted in waitEventAsync class com.zsmartsystems.zigbee.dongle.telegesis.internal.protocol.TelegesisNetworkJoinedEvent
2022-12-11 13:26:02.040 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TelegesisFrameHandler thread exited.
2022-12-11 13:26:02.044 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TelegesisFrameHandler closed.
2022-12-11 13:26:02.170 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Telegesis dongle shutdown.
2022-12-11 13:26:02.172 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Shutdown
2022-12-11 13:26:02.174 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Broadcast: Queue shutdown
2022-12-11 13:26:02.176 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Multicast: Queue shutdown
2022-12-11 13:26:03.180 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Default: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=1, interTransactionDelay=50, maxRetries=2]
2022-12-11 13:26:03.183 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Broadcast: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=2, interTransactionDelay=4000, maxRetries=0]
2022-12-11 13:26:03.185 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Multicast: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=3, interTransactionDelay=1200, maxRetries=0]
2022-12-11 13:26:03.187 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager initialize: networkState=UNINITIALISED
2022-12-11 13:26:03.190 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to INITIALISING
2022-12-11 13:26:03.193 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Telegesis dongle initialize.
2022-12-11 13:26:03.254 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TelegesisFrameHandler thread started
2022-12-11 13:26:03.255 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:03.256 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=18, bit=4, state=true, password=null]
2022-12-11 13:26:03.282 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS124=1
2022-12-11 13:26:03.285 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:03.286 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=18, bit=4, state=true, password=null, status=SUCCESS]
2022-12-11 13:26:03.288 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:03.290 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=1, state=false, password=null]
2022-12-11 13:26:03.304 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:03.312 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0E1=0
2022-12-11 13:26:03.314 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=1, state=false, password=null, status=SUCCESS]
2022-12-11 13:26:03.316 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:03.317 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=0, state=false, password=null]
2022-12-11 13:26:03.330 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:03.340 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0E0=0
2022-12-11 13:26:03.342 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=0, state=false, password=null, status=SUCCESS]
2022-12-11 13:26:03.345 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:03.347 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSoftwareResetCommand []
2022-12-11 13:26:03.372 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATZ
2022-12-11 13:26:03.629 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:
2022-12-11 13:26:03.631 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:03.633 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSoftwareResetCommand [status=SUCCESS]
2022-12-11 13:26:03.635 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:03.637 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=18, bit=4, state=true, password=null]
2022-12-11 13:26:03.650 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:03.660 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS124=1
2022-12-11 13:26:03.662 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=18, bit=4, state=true, password=null, status=SUCCESS]
2022-12-11 13:26:03.664 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:03.666 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=1, state=false, password=null]
2022-12-11 13:26:03.680 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:03.681 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0E1=0
2022-12-11 13:26:03.682 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=1, state=false, password=null, status=SUCCESS]
2022-12-11 13:26:03.684 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:03.686 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=0, state=false, password=null]
2022-12-11 13:26:03.702 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0E0=0
2022-12-11 13:26:03.703 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:03.705 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=0, state=false, password=null, status=SUCCESS]
2022-12-11 13:26:03.707 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:03.709 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetPromptEnable1Command [configuration=8804]
2022-12-11 13:26:03.725 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:03.731 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0E=8804
2022-12-11 13:26:03.733 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetPromptEnable1Command [configuration=8804, status=SUCCESS]
2022-12-11 13:26:03.735 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:03.737 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetMainFunctionCommand [configuration=350, password=password]
2022-12-11 13:26:03.757 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:03.761 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0A=015E:password
2022-12-11 13:26:03.763 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetMainFunctionCommand [configuration=350, password=password, status=SUCCESS]
2022-12-11 13:26:03.765 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:03.767 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetExtendedFunctionCommand [configuration=56A9]
2022-12-11 13:26:03.781 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:03.792 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS10=56A9
2022-12-11 13:26:03.794 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetExtendedFunctionCommand [configuration=56A9, status=SUCCESS]
2022-12-11 13:26:03.795 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:03.797 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetPromptEnable2Command [configuration=6B3C]
2022-12-11 13:26:03.811 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:03.822 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0F=6B3C
2022-12-11 13:26:03.824 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetPromptEnable2Command [configuration=6B3C, status=SUCCESS]
2022-12-11 13:26:03.826 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:03.827 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisDisplayProductIdentificationCommand [deviceName=null, firmwareRevision=null, ieeeAddress=null]
2022-12-11 13:26:03.851 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATI
2022-12-11 13:26:03.869 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:Telegesis ETRX357
2022-12-11 13:26:03.872 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:R309C-DTAG build12S
2022-12-11 13:26:03.874 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:000D6F000AF8E2B3
2022-12-11 13:26:03.876 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:03.878 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDisplayProductIdentificationCommand [deviceName=ETRX357, firmwareRevision=309C-DTAG build12S, ieeeAddress=000D6F000AF8E2B3, status=SUCCESS]
2022-12-11 13:26:03.880 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0500
2022-12-11 13:26:03.882 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher starting for endpoint 1 with profile ID 0104 (ZIGBEE_HOME_AUTOMATION)
2022-12-11 13:26:03.884 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0500
2022-12-11 13:26:03.885 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0019
2022-12-11 13:26:03.887 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0019
2022-12-11 13:26:03.893 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0001
2022-12-11 13:26:03.894 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0001
2022-12-11 13:26:03.896 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0006
2022-12-11 13:26:03.898 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0006
2022-12-11 13:26:03.900 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0008
2022-12-11 13:26:03.901 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0008
2022-12-11 13:26:03.903 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 000F
2022-12-11 13:26:03.905 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 000F
2022-12-11 13:26:03.906 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0101
2022-12-11 13:26:03.908 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0101
2022-12-11 13:26:03.910 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0102
2022-12-11 13:26:03.911 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0102
2022-12-11 13:26:03.913 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0201
2022-12-11 13:26:03.915 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0201
2022-12-11 13:26:03.916 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0202
2022-12-11 13:26:03.918 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0202
2022-12-11 13:26:03.920 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0300
2022-12-11 13:26:03.921 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0300
2022-12-11 13:26:03.923 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0400
2022-12-11 13:26:03.925 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0400
2022-12-11 13:26:03.926 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0402
2022-12-11 13:26:03.928 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0402
2022-12-11 13:26:03.930 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0403
2022-12-11 13:26:03.931 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0403
2022-12-11 13:26:03.933 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0405
2022-12-11 13:26:03.934 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0405
2022-12-11 13:26:03.936 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0406
2022-12-11 13:26:03.937 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0406
2022-12-11 13:26:03.939 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0500
2022-12-11 13:26:03.940 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0500
2022-12-11 13:26:03.941 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0502
2022-12-11 13:26:03.942 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0502
2022-12-11 13:26:03.944 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0702
2022-12-11 13:26:03.945 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0702
2022-12-11 13:26:03.946 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0B04
2022-12-11 13:26:03.947 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0B04
2022-12-11 13:26:03.951 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0005
2022-12-11 13:26:03.952 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0005
2022-12-11 13:26:03.953 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0006
2022-12-11 13:26:03.954 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0006
2022-12-11 13:26:03.956 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0008
2022-12-11 13:26:03.957 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0008
2022-12-11 13:26:03.958 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0402
2022-12-11 13:26:03.959 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0402
2022-12-11 13:26:03.960 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0000
2022-12-11 13:26:03.961 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0000
2022-12-11 13:26:03.962 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0019
2022-12-11 13:26:03.963 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0019
2022-12-11 13:26:03.964 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0000
2022-12-11 13:26:03.965 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0000
2022-12-11 13:26:03.966 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:03.967 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetTrustCentreLinkKeyCommand [linkKey=5A6967426565416C6C69616E63653039, password=password]
2022-12-11 13:26:03.999 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.012 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS09=5A6967426565416C6C69616E63653039:password
2022-12-11 13:26:04.013 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetTrustCentreLinkKeyCommand [linkKey=5A6967426565416C6C69616E63653039, password=password, status=SUCCESS]
2022-12-11 13:26:04.014 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.015 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetNetworkKeyCommand [networkKey=9A07CC2808F2BE3CB7A8C3005244D041, password=password]
2022-12-11 13:26:04.048 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.051 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS08=9A07CC2808F2BE3CB7A8C3005244D041:password
2022-12-11 13:26:04.052 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetNetworkKeyCommand [networkKey=9A07CC2808F2BE3CB7A8C3005244D041, password=password, status=SUCCESS]
2022-12-11 13:26:04.053 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.055 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetChannelMaskCommand [channelMask=0001]
2022-12-11 13:26:04.071 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.071 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS00=0001
2022-12-11 13:26:04.072 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetChannelMaskCommand [channelMask=0001, status=SUCCESS]
2022-12-11 13:26:04.073 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.075 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisDisplayNetworkInformationCommand [device=null, channel=null, power=null, panId=null, epanId=null]
2022-12-11 13:26:04.091 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:AT+N?
2022-12-11 13:26:04.092 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:+N=NoPAN
2022-12-11 13:26:04.093 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.093 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDisplayNetworkInformationCommand [device=NOPAN, channel=null, power=null, panId=null, epanId=null, status=SUCCESS]
2022-12-11 13:26:04.094 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.095 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetOutputClustersCommand [clusterList=[1280]]
2022-12-11 13:26:04.111 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS4C=0500
2022-12-11 13:26:04.114 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.115 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetOutputClustersCommand [clusterList=[1280], status=SUCCESS]
2022-12-11 13:26:04.115 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Setting Telegesis trust centre link mode: TC_JOIN_SECURE
2022-12-11 13:26:04.116 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.117 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisDisallowTcJoinCommand [disallowJoin=false, password=password]
2022-12-11 13:26:04.135 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.142 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0A5=0:password
2022-12-11 13:26:04.144 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDisallowTcJoinCommand [disallowJoin=false, password=password, status=SUCCESS]
2022-12-11 13:26:04.145 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.146 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisDisallowUnsecuredRejoinCommand [disallowRejoin=true, password=password]
2022-12-11 13:26:04.161 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0A3=1:password
2022-12-11 13:26:04.162 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.163 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDisallowUnsecuredRejoinCommand [disallowRejoin=true, password=password, status=SUCCESS]
2022-12-11 13:26:04.164 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager startup: reinitialize=true, networkState=INITIALISING
2022-12-11 13:26:04.165 [DEBUG] [atabase.ZigBeeNetworkDatabaseManager] - Data store:  Clearing all nodes.
2022-12-11 13:26:04.166 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Telegesis dongle startup.
2022-12-11 13:26:04.166 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Reinitialising Telegesis dongle and forming network.
2022-12-11 13:26:04.168 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.169 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisRestoreFactoryDefaultsCommand []
2022-12-11 13:26:04.202 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:AT&F
2022-12-11 13:26:04.701 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:
2022-12-11 13:26:04.703 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.704 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisRestoreFactoryDefaultsCommand [status=SUCCESS]
2022-12-11 13:26:04.706 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.708 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=18, bit=4, state=true, password=null]
2022-12-11 13:26:04.722 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:ATS124=1
2022-12-11 13:26:04.730 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS124=1
2022-12-11 13:26:04.733 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.734 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=18, bit=4, state=true, password=null, status=SUCCESS]
2022-12-11 13:26:04.736 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.738 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=1, state=false, password=null]
2022-12-11 13:26:04.750 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.761 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0E1=0
2022-12-11 13:26:04.763 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=1, state=false, password=null, status=SUCCESS]
2022-12-11 13:26:04.764 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.766 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=0, state=false, password=null]
2022-12-11 13:26:04.779 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.781 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0E0=0
2022-12-11 13:26:04.782 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=0, state=false, password=null, status=SUCCESS]
2022-12-11 13:26:04.784 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.786 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetPromptEnable1Command [configuration=8804]
2022-12-11 13:26:04.801 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.811 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0E=8804
2022-12-11 13:26:04.813 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetPromptEnable1Command [configuration=8804, status=SUCCESS]
2022-12-11 13:26:04.815 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.816 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetMainFunctionCommand [configuration=350, password=password]
2022-12-11 13:26:04.835 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.841 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0A=015E:password
2022-12-11 13:26:04.843 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetMainFunctionCommand [configuration=350, password=password, status=SUCCESS]
2022-12-11 13:26:04.845 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.847 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetExtendedFunctionCommand [configuration=56A9]
2022-12-11 13:26:04.861 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.872 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS10=56A9
2022-12-11 13:26:04.873 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetExtendedFunctionCommand [configuration=56A9, status=SUCCESS]
2022-12-11 13:26:04.875 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.876 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetPromptEnable2Command [configuration=6B3C]
2022-12-11 13:26:04.890 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.892 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0F=6B3C
2022-12-11 13:26:04.893 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetPromptEnable2Command [configuration=6B3C, status=SUCCESS]
2022-12-11 13:26:04.896 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.897 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetTrustCentreLinkKeyCommand [linkKey=5A6967426565416C6C69616E63653039, password=password]
2022-12-11 13:26:04.933 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.941 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS09=5A6967426565416C6C69616E63653039:password
2022-12-11 13:26:04.943 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetTrustCentreLinkKeyCommand [linkKey=5A6967426565416C6C69616E63653039, password=password, status=SUCCESS]
2022-12-11 13:26:04.944 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.946 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetNetworkKeyCommand [networkKey=9A07CC2808F2BE3CB7A8C3005244D041, password=password]
2022-12-11 13:26:04.982 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:04.992 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS08=9A07CC2808F2BE3CB7A8C3005244D041:password
2022-12-11 13:26:04.994 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetNetworkKeyCommand [networkKey=9A07CC2808F2BE3CB7A8C3005244D041, password=password, status=SUCCESS]
2022-12-11 13:26:04.996 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:04.997 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetPanIdCommand [panId=8617]
2022-12-11 13:26:05.012 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:05.020 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS02=21A9
2022-12-11 13:26:05.022 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetPanIdCommand [panId=8617, status=SUCCESS]
2022-12-11 13:26:05.024 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:05.025 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetEpanIdCommand [epanId=256D0C37C7216B84]
2022-12-11 13:26:05.042 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS03=256D0C37C7216B84
2022-12-11 13:26:05.047 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:05.049 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetEpanIdCommand [epanId=256D0C37C7216B84, status=SUCCESS]
2022-12-11 13:26:05.051 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:05.052 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterCommand [register=72, value=260, password=null]
2022-12-11 13:26:05.069 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:05.071 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS48=0104
2022-12-11 13:26:05.073 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterCommand [register=72, value=260, password=null, status=SUCCESS]
2022-12-11 13:26:05.074 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:05.076 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetChannelMaskCommand [channelMask=0001]
2022-12-11 13:26:05.091 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:05.101 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS00=0001
2022-12-11 13:26:05.103 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetChannelMaskCommand [channelMask=0001, status=SUCCESS]
2022-12-11 13:26:05.104 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:05.106 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisDisplayNetworkInformationCommand [device=null, channel=null, power=null, panId=null, epanId=null]
2022-12-11 13:26:05.123 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:+N=NoPAN
2022-12-11 13:26:05.131 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:AT+N?
2022-12-11 13:26:05.133 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 13:26:05.135 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDisplayNetworkInformationCommand [device=NOPAN, channel=null, power=null, panId=null, epanId=null, status=SUCCESS]
2022-12-11 13:26:05.136 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 13:26:05.138 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisCreatePanCommand []
2022-12-11 13:26:05.161 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:AT+EN
2022-12-11 13:26:05.345 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:ERROR:2D
2022-12-11 13:26:05.347 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisCreatePanCommand [status=ERROR_SCANNING_FOR_PAN]
2022-12-11 13:26:13.162 [DEBUG] [gesis.internal.TelegesisFrameHandler] - Telegesis interrupted in eventWait class com.zsmartsystems.zigbee.dongle.telegesis.internal.protocol.TelegesisNetworkJoinedEvent
2022-12-11 13:26:13.164 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Error creating Telegesis PAN
2022-12-11 13:26:13.165 [DEBUG] [gesis.internal.TelegesisFrameHandler] - Telegesis interrupted in waitEventAsync class com.zsmartsystems.zigbee.dongle.telegesis.internal.protocol.TelegesisNetworkJoinedEvent
2022-12-11 13:26:13.166 [ERROR] [ngle.telegesis.ZigBeeDongleTelegesis] - Error while initialising Telegesis dongle and forming network.
2022-12-11 13:26:13.168 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to OFFLINE
4

Error 2D means there was an error scanning for the PAN. I’m not 100% sure what that means under the hood, but in some cases it might mean that the channel is noisy and it can’t send (this is a known error with Silabs chips) or it could be that the device is trying to join the network and it can’t find the coordinator.

5

Thanks for your help!

Any idea what to do or to check?
I don’t want to go back to 2.5 :frowning: but I need a working Zigbee stick …

6

Try using a USB extension cable between your RaspberryPi and your Zigbee stick to reduce EMI.

7

I switched to a different USB-Port and now I see this:

022-12-11 18:50:03.801 [INFO ] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee dongle inactivity timer. Reinitializing ZigBee
2022-12-11 18:50:03.803 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager shutdown: networkState=OFFLINE
2022-12-11 18:50:03.805 [DEBUG] [atabase.ZigBeeNetworkDatabaseManager] - Data store: Deferred Write Time set to 0ms
2022-12-11 18:50:03.806 [DEBUG] [atabase.ZigBeeNetworkDatabaseManager] - Data store: Deferred Write Time set less than Max Deferred Write Time
2022-12-11 18:50:03.808 [DEBUG] [atabase.ZigBeeNetworkDatabaseManager] - Data store: Max Deferred Write Time set to 0ms
2022-12-11 18:50:03.811 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to SHUTDOWN
2022-12-11 18:50:03.814 [DEBUG] [p.discovery.ZigBeeDiscoveryExtension] - DISCOVERY Extension: Shutdown
2022-12-11 18:50:03.816 [DEBUG] [atabase.ZigBeeNetworkDatabaseManager] - Data store: Shutdown
2022-12-11 18:50:03.820 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TelegesisFrameHandler thread exited.
2022-12-11 18:50:03.822 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TelegesisFrameHandler closed.
2022-12-11 18:50:03.874 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Telegesis dongle shutdown.
2022-12-11 18:50:03.882 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Shutdown
2022-12-11 18:50:03.884 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Broadcast: Queue shutdown
2022-12-11 18:50:03.886 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Multicast: Queue shutdown
2022-12-11 18:50:04.891 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Default: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=1, interTransactionDelay=50, maxRetries=2]
2022-12-11 18:50:04.894 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Broadcast: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=2, interTransactionDelay=4000, maxRetries=0]
2022-12-11 18:50:04.896 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Multicast: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=3, interTransactionDelay=1200, maxRetries=0]
2022-12-11 18:50:04.898 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager initialize: networkState=UNINITIALISED
2022-12-11 18:50:04.899 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to INITIALISING
2022-12-11 18:50:04.902 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Telegesis dongle initialize.
2022-12-11 18:50:04.961 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TelegesisFrameHandler thread started
2022-12-11 18:50:04.961 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:04.962 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=18, bit=4, state=true, password=null]
2022-12-11 18:50:04.986 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS124=1
2022-12-11 18:50:04.988 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:04.990 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=18, bit=4, state=true, password=null, status=SUCCESS]
2022-12-11 18:50:04.991 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:04.993 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=1, state=false, password=null]
2022-12-11 18:50:05.006 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.016 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0E1=0
2022-12-11 18:50:05.018 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=1, state=false, password=null, status=SUCCESS]
2022-12-11 18:50:05.020 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.022 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=0, state=false, password=null]
2022-12-11 18:50:05.035 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.047 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0E0=0
2022-12-11 18:50:05.048 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=0, state=false, password=null, status=SUCCESS]
2022-12-11 18:50:05.050 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.051 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSoftwareResetCommand []
2022-12-11 18:50:05.076 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATZ
2022-12-11 18:50:05.333 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:
2022-12-11 18:50:05.335 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.337 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSoftwareResetCommand [status=SUCCESS]
2022-12-11 18:50:05.339 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.340 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=18, bit=4, state=true, password=null]
2022-12-11 18:50:05.355 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.357 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS124=1
2022-12-11 18:50:05.359 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=18, bit=4, state=true, password=null, status=SUCCESS]
2022-12-11 18:50:05.360 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.362 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=1, state=false, password=null]
2022-12-11 18:50:05.377 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.387 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0E1=0
2022-12-11 18:50:05.389 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=1, state=false, password=null, status=SUCCESS]
2022-12-11 18:50:05.396 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.398 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=0, state=false, password=null]
2022-12-11 18:50:05.411 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.425 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0E0=0
2022-12-11 18:50:05.426 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=14, bit=0, state=false, password=null, status=SUCCESS]
2022-12-11 18:50:05.428 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.429 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetPromptEnable1Command [configuration=8804]
2022-12-11 18:50:05.455 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0E=8804
2022-12-11 18:50:05.467 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.470 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetPromptEnable1Command [configuration=8804, status=SUCCESS]
2022-12-11 18:50:05.473 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.474 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetMainFunctionCommand [configuration=350, password=password]
2022-12-11 18:50:05.498 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.506 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0A=015E:password
2022-12-11 18:50:05.507 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetMainFunctionCommand [configuration=350, password=password, status=SUCCESS]
2022-12-11 18:50:05.508 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.510 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetExtendedFunctionCommand [configuration=56A9]
2022-12-11 18:50:05.525 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.536 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS10=56A9
2022-12-11 18:50:05.537 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetExtendedFunctionCommand [configuration=56A9, status=SUCCESS]
2022-12-11 18:50:05.538 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.539 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetPromptEnable2Command [configuration=6B3C]
2022-12-11 18:50:05.554 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.556 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0F=6B3C
2022-12-11 18:50:05.557 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetPromptEnable2Command [configuration=6B3C, status=SUCCESS]
2022-12-11 18:50:05.558 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.559 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisDisplayProductIdentificationCommand [deviceName=null, firmwareRevision=null, ieeeAddress=null]
2022-12-11 18:50:05.576 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATI
2022-12-11 18:50:05.599 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:Telegesis ETRX357
2022-12-11 18:50:05.601 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:R309C-DTAG build12S
2022-12-11 18:50:05.602 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:000D6F000AF8E2B3
2022-12-11 18:50:05.604 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.612 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDisplayProductIdentificationCommand [deviceName=ETRX357, firmwareRevision=309C-DTAG build12S, ieeeAddress=000D6F000AF8E2B3, status=SUCCESS]
2022-12-11 18:50:05.613 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0500
2022-12-11 18:50:05.614 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher starting for endpoint 1 with profile ID 0104 (ZIGBEE_HOME_AUTOMATION)
2022-12-11 18:50:05.615 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0500
2022-12-11 18:50:05.616 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0019
2022-12-11 18:50:05.617 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0019
2022-12-11 18:50:05.621 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0001
2022-12-11 18:50:05.622 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0001
2022-12-11 18:50:05.623 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0006
2022-12-11 18:50:05.624 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0006
2022-12-11 18:50:05.625 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0008
2022-12-11 18:50:05.627 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0008
2022-12-11 18:50:05.628 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 000F
2022-12-11 18:50:05.629 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 000F
2022-12-11 18:50:05.630 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0101
2022-12-11 18:50:05.631 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0101
2022-12-11 18:50:05.632 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0102
2022-12-11 18:50:05.634 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0102
2022-12-11 18:50:05.637 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0201
2022-12-11 18:50:05.638 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0201
2022-12-11 18:50:05.639 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0202
2022-12-11 18:50:05.640 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0202
2022-12-11 18:50:05.641 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0300
2022-12-11 18:50:05.642 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0300
2022-12-11 18:50:05.643 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0400
2022-12-11 18:50:05.644 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0400
2022-12-11 18:50:05.645 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0402
2022-12-11 18:50:05.647 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0402
2022-12-11 18:50:05.648 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0403
2022-12-11 18:50:05.649 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0403
2022-12-11 18:50:05.651 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0405
2022-12-11 18:50:05.652 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0405
2022-12-11 18:50:05.653 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0406
2022-12-11 18:50:05.654 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0406
2022-12-11 18:50:05.655 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0500
2022-12-11 18:50:05.656 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0500
2022-12-11 18:50:05.657 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0502
2022-12-11 18:50:05.658 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0502
2022-12-11 18:50:05.659 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0702
2022-12-11 18:50:05.661 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0702
2022-12-11 18:50:05.662 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0B04
2022-12-11 18:50:05.663 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0B04
2022-12-11 18:50:05.666 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0005
2022-12-11 18:50:05.667 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0005
2022-12-11 18:50:05.669 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0006
2022-12-11 18:50:05.670 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0006
2022-12-11 18:50:05.671 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0008
2022-12-11 18:50:05.672 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0008
2022-12-11 18:50:05.673 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0402
2022-12-11 18:50:05.674 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0402
2022-12-11 18:50:05.675 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0000
2022-12-11 18:50:05.677 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0000
2022-12-11 18:50:05.678 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0019
2022-12-11 18:50:05.679 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0019
2022-12-11 18:50:05.680 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0000
2022-12-11 18:50:05.681 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0000
2022-12-11 18:50:05.683 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.684 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetOutputClustersCommand [clusterList=[1280]]
2022-12-11 18:50:05.699 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.707 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS4C=0500
2022-12-11 18:50:05.708 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetOutputClustersCommand [clusterList=[1280], status=SUCCESS]
2022-12-11 18:50:05.709 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Setting Telegesis trust centre link mode: TC_JOIN_SECURE
2022-12-11 18:50:05.710 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.711 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisDisallowTcJoinCommand [disallowJoin=false, password=password]
2022-12-11 18:50:05.726 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0A5=0:password
2022-12-11 18:50:05.729 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.730 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDisallowTcJoinCommand [disallowJoin=false, password=password, status=SUCCESS]
2022-12-11 18:50:05.731 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.732 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisDisallowUnsecuredRejoinCommand [disallowRejoin=true, password=password]
2022-12-11 18:50:05.751 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.755 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS0A3=1:password
2022-12-11 18:50:05.756 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDisallowUnsecuredRejoinCommand [disallowRejoin=true, password=password, status=SUCCESS]
2022-12-11 18:50:05.758 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager startup: reinitialize=false, networkState=INITIALISING
2022-12-11 18:50:05.759 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Telegesis dongle startup.
2022-12-11 18:50:05.760 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.761 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetRegisterBitCommand [register=17, bit=14, state=true, password=null]
2022-12-11 18:50:05.773 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.775 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS11E=1
2022-12-11 18:50:05.776 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetRegisterBitCommand [register=17, bit=14, state=true, password=null, status=SUCCESS]
2022-12-11 18:50:05.778 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.779 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSetOutputPowerCommand [powerLevel=8]
2022-12-11 18:50:05.795 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.796 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:ATS01=8
2022-12-11 18:50:05.797 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSetOutputPowerCommand [powerLevel=8, status=SUCCESS]
2022-12-11 18:50:05.799 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 18:50:05.800 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisDisplayNetworkInformationCommand [device=null, channel=null, power=null, panId=null, epanId=null]
2022-12-11 18:50:05.815 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:AT+N?
2022-12-11 18:50:05.818 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:+N=NoPAN
2022-12-11 18:50:05.820 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 18:50:05.821 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDisplayNetworkInformationCommand [device=NOPAN, channel=null, power=null, panId=null, epanId=null, status=SUCCESS]
2022-12-11 18:50:05.822 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to OFFLINE

Looks different - now I don’t have the [ERROR] message.
But I have still the " COMMUNICATION_ERROR"

8

Update: Stick is working.
I used a USB-Hub as an extension cable and after resetting the stick with the binding → the status went to ONLINE :slight_smile:

I was able to connect my first devices:

  • multiple Bitron Power Switches
  • multiple Aqara Temperature & Humidity Sensors

Power Switches are working fine - but I don’t receive values from the Aqara sensors :frowning:

1 Like
9

Here is the corresponding debug output:

2022-12-11 20:16:36.026 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:SEQ:DB
2022-12-11 20:16:36.028 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 20:16:36.029 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSendUnicastCommand [address=20886, sourceEp=0, destEp=0, profileId=0, clusterId=33, messageData=FD B2 82 01 02 00 8D 15 00 01 02 04 03 B3 E2 F8 0A 00 6F 0D 00 01, messageId=219, status=SUCCESS]
2022-12-11 20:16:36.030 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=FD state=TX_ACK
2022-12-11 20:16:36.031 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=FD, state=TX_ACK, outstanding=5
2022-12-11 20:16:36.033 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=5196, TID=FD, event=TX_ACK, state=TRANSMITTED
2022-12-11 20:16:36.261 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:NACK:D7
2022-12-11 20:16:36.265 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisNackMessageEvent [messageId=215]
2022-12-11 20:16:36.266 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=FA state=RX_NAK
2022-12-11 20:16:36.267 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=FA, state=RX_NAK, outstanding=5
2022-12-11 20:16:36.269 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00158D00027307C6 queueTime=9878, state=FAILED, sendCnt=2, command=BindRequest [0000/0 -> 41BD/0, cluster=0021, TID=FA, bindingTableEntry=BindingTable [srcAddr=00158D00027307C6/1, addrMode=DEVICE, dstAddr=000D6F000AF8E2B3/1, clusterId=0403]]]
2022-12-11 20:16:36.270 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 4 outstanding
2022-12-11 20:16:36.272 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00158D00027307C6: transactionComplete, state=FAILED, outstanding=0
2022-12-11 20:16:36.273 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00158D00027307C6: transactionComplete exceeded max retries 2
2022-12-11 20:16:36.275 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction cancelled: ZigBeeTransaction [ieeeAddress=00158D00027307C6 queueTime=9883, state=CANCELLED, sendCnt=2, command=BindRequest [0000/0 -> 41BD/0, cluster=0021, TID=FA, bindingTableEntry=BindingTable [srcAddr=00158D00027307C6/1, addrMode=DEVICE, dstAddr=000D6F000AF8E2B3/1, clusterId=0403]]]
2022-12-11 20:16:36.277 [ERROR] [r.ZigBeeConverterAtmosphericPressure] - 00158D00027307C6: Error 0xffff setting server binding
2022-12-11 20:16:36.278 [INFO ] [bee.discovery.ZigBeeDiscoveryService] - 00158D00027307C6: Channel zigbee:device:77de8f9f8d:00158d00027307c6:00158D00027307C6_1_pressure failed to initialise device
2022-12-11 20:16:36.280 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00158D00027307C6 queueTime=9889, state=CANCELLED, sendCnt=2, command=BindRequest [0000/0 -> 41BD/0, cluster=0021, TID=FA, bindingTableEntry=BindingTable [srcAddr=00158D00027307C6/1, addrMode=DEVICE, dstAddr=000D6F000AF8E2B3/1, clusterId=0403]]]
2022-12-11 20:16:36.282 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 4 outstanding
2022-12-11 20:16:36.284 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00158D00027307C6: transactionComplete but not outstanding, state=CANCELLED, outstanding=0
2022-12-11 20:16:36.285 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=4, outstandingQueues=2, sleepy=0/3
2022-12-11 20:16:36.288 [DEBUG] [transaction.ZigBeeTransactionManager] - 82B3/0: Sending ZigBeeTransaction [ieeeAddress=00158D000278676D queueTime=16190, state=WAITING, sendCnt=1, command=BindRequest [0000/0 -> 82B3/0, cluster=0021, TID=FB, bindingTableEntry=BindingTable [srcAddr=00158D000278676D/1, addrMode=DEVICE, dstAddr=000D6F000AF8E2B3/1, clusterId=0402]]]
2022-12-11 20:16:36.289 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 5 outstanding
2022-12-11 20:16:36.294 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: BindRequest [0000/0 -> 82B3/0, cluster=0021, TID=FB, bindingTableEntry=BindingTable [srcAddr=00158D000278676D/1, addrMode=DEVICE, dstAddr=000D6F000AF8E2B3/1, clusterId=0402]]
2022-12-11 20:16:36.300 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/0, destinationAddress=82B3/0, profile=0000, cluster=0021, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=5C, rssi=--, lqi=--, payload=FB 6D 67 78 02 00 8D 15 00 01 02 04 03 B3 E2 F8 0A 00 6F 0D 00 01]
2022-12-11 20:16:36.302 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Telegesis send: TelegesisSendUnicastCommand [address=33459, sourceEp=0, destEp=0, profileId=0, clusterId=33, messageData=FB 6D 67 78 02 00 8D 15 00 01 02 04 03 B3 E2 F8 0A 00 6F 0D 00 01, messageId=null]
2022-12-11 20:16:36.304 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-11 20:16:36.304 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=5, outstandingQueues=1, sleepy=0/3
2022-12-11 20:16:36.306 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=41BD, TID=FA, event=RX_NAK, state=CANCELLED
2022-12-11 20:16:36.307 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00158D00027307C6: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00158D00027307C6 queueTime=0, state=WAITING, sendCnt=0, command=BindRequest [0000/0 -> 41BD/0, cluster=0021, TID=--, bindingTableEntry=BindingTable [srcAddr=00158D00027307C6/1, addrMode=DEVICE, dstAddr=000D6F000AF8E2B3/1, clusterId=0405]]]
2022-12-11 20:16:36.308 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=5, outstandingQueues=2, sleepy=0/3
2022-12-11 20:16:36.308 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSendUnicastCommand [address=33459, sourceEp=0, destEp=0, profileId=0, clusterId=33, messageData=FB 6D 67 78 02 00 8D 15 00 01 02 04 03 B3 E2 F8 0A 00 6F 0D 00 01, messageId=null]
2022-12-11 20:16:36.355 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:SEQ:DC
2022-12-11 20:16:36.357 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:AT+SENDUCASTB:16,82B3,00,00,0000,0021
ûmgx³âø
o

2022-12-11 20:16:36.359 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-11 20:16:36.360 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSendUnicastCommand [address=33459, sourceEp=0, destEp=0, profileId=0, clusterId=33, messageData=FB 6D 67 78 02 00 8D 15 00 01 02 04 03 B3 E2 F8 0A 00 6F 0D 00 01, messageId=220, status=SUCCESS]
10

I still have issues with the Aqara sensors and error messages (after restarting openhab):

2022-12-14 23:10:35.499 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:SEQ:C2
2022-12-14 23:10:35.501 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-14 23:10:35.502 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSendUnicastCommand [address=29160, sourceEp=0, destEp=0, profileId=0, clusterId=33, messageData=67 C5 F3 C9 02 00 8D 15 00 01 05 04 03 B3 E2 F8 0A 00 6F 0D 00 01, messageId=194, status=SUCCESS]
2022-12-14 23:10:35.504 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=67 state=TX_ACK
2022-12-14 23:10:35.505 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=67, state=TX_ACK, outstanding=3
2022-12-14 23:10:35.506 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=71E8, TID=67, event=TX_ACK, state=TRANSMITTED
2022-12-14 23:10:36.712 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-14 23:10:36.714 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisDisplayNetworkInformationCommand [device=null, channel=null, power=null, panId=null, epanId=null]
2022-12-14 23:10:36.731 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:AT+N?
2022-12-14 23:10:36.747 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:+N=COO,11,08,41FB,82E5D3B7A47EAFFA
2022-12-14 23:10:36.749 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-14 23:10:36.751 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisDisplayNetworkInformationCommand [device=COO, channel=11, power=8, panId=16891, epanId=82E5D3B7A47EAFFA, status=SUCCESS]
2022-12-14 23:10:36.947 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:NACK:C0
2022-12-14 23:10:36.948 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisNackMessageEvent [messageId=192]
2022-12-14 23:10:36.949 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=65 state=RX_NAK
2022-12-14 23:10:36.949 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=65, state=RX_NAK, outstanding=3
2022-12-14 23:10:36.951 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00158D0002B55ACA queueTime=9508, state=FAILED, sendCnt=2, command=BindRequest [0000/0 -> 5ECD/0, cluster=0021, TID=65, bindingTableEntry=BindingTable [srcAddr=00158D0002B55ACA/1, addrMode=DEVICE, dstAddr=000D6F000AF8E2B3/1, clusterId=0403]]]
2022-12-14 23:10:36.952 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 2 outstanding
2022-12-14 23:10:36.952 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00158D0002B55ACA: transactionComplete, state=FAILED, outstanding=0
2022-12-14 23:10:36.953 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00158D0002B55ACA: transactionComplete exceeded max retries 2
2022-12-14 23:10:36.954 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction cancelled: ZigBeeTransaction [ieeeAddress=00158D0002B55ACA queueTime=9511, state=CANCELLED, sendCnt=2, command=BindRequest [0000/0 -> 5ECD/0, cluster=0021, TID=65, bindingTableEntry=BindingTable [srcAddr=00158D0002B55ACA/1, addrMode=DEVICE, dstAddr=000D6F000AF8E2B3/1, clusterId=0403]]]
2022-12-14 23:10:36.955 [ERROR] [r.ZigBeeConverterAtmosphericPressure] - 00158D0002B55ACA: Error 0xffff setting server binding
2022-12-14 23:10:36.956 [INFO ] [bee.discovery.ZigBeeDiscoveryService] - 00158D0002B55ACA: Channel zigbee:device:77de8f9f8d:00158d0002b55aca:00158D0002B55ACA_1_pressure failed to initialise device
2022-12-14 23:10:36.957 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction complete: ZigBeeTransaction [ieeeAddress=00158D0002B55ACA queueTime=9513, state=CANCELLED, sendCnt=2, command=BindRequest [0000/0 -> 5ECD/0, cluster=0021, TID=65, bindingTableEntry=BindingTable [srcAddr=00158D0002B55ACA/1, addrMode=DEVICE, dstAddr=000D6F000AF8E2B3/1, clusterId=0403]]]
2022-12-14 23:10:36.958 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerRemoved: 2 outstanding
2022-12-14 23:10:36.958 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00158D0002B55ACA: transactionComplete but not outstanding, state=CANCELLED, outstanding=0
2022-12-14 23:10:36.959 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=2, outstandingQueues=0, sleepy=0/3
2022-12-14 23:10:36.960 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - 00158D0002B55ACA: Added transaction to queue, len=1, transaction=ZigBeeTransaction [ieeeAddress=00158D0002B55ACA queueTime=0, state=WAITING, sendCnt=0, command=BindRequest [0000/0 -> 5ECD/0, cluster=0021, TID=--, bindingTableEntry=BindingTable [srcAddr=00158D0002B55ACA/1, addrMode=DEVICE, dstAddr=000D6F000AF8E2B3/1, clusterId=0405]]]
2022-12-14 23:10:36.961 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=2, outstandingQueues=1, sleepy=0/3
2022-12-14 23:10:36.962 [DEBUG] [transaction.ZigBeeTransactionManager] - 5ECD/0: Sending ZigBeeTransaction [ieeeAddress=00158D0002B55ACA queueTime=2, state=WAITING, sendCnt=0, command=BindRequest [0000/0 -> 5ECD/0, cluster=0021, TID=68, bindingTableEntry=BindingTable [srcAddr=00158D0002B55ACA/1, addrMode=DEVICE, dstAddr=000D6F000AF8E2B3/1, clusterId=0405]]]
2022-12-14 23:10:36.963 [DEBUG] [transaction.ZigBeeTransactionManager] - transactionListenerAdded: 3 outstanding
2022-12-14 23:10:36.964 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX CMD: BindRequest [0000/0 -> 5ECD/0, cluster=0021, TID=68, bindingTableEntry=BindingTable [srcAddr=00158D0002B55ACA/1, addrMode=DEVICE, dstAddr=000D6F000AF8E2B3/1, clusterId=0405]]
2022-12-14 23:10:36.965 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - TX APS: ZigBeeApsFrame [sourceAddress=0000/0, destinationAddress=5ECD/0, profile=0000, cluster=0021, addressMode=DEVICE, radius=8, apsSecurity=false, ackRequest=true, apsCounter=4E, rssi=--, lqi=--, payload=68 CA 5A B5 02 00 8D 15 00 01 05 04 03 B3 E2 F8 0A 00 6F 0D 00 01]
2022-12-14 23:10:36.966 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Telegesis send: TelegesisSendUnicastCommand [address=24269, sourceEp=0, destEp=0, profileId=0, clusterId=33, messageData=68 CA 5A B5 02 00 8D 15 00 01 05 04 03 B3 E2 F8 0A 00 6F 0D 00 01, messageId=null]
2022-12-14 23:10:36.967 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1
2022-12-14 23:10:36.967 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Send Next transaction. outstandingTransactions=3, outstandingQueues=0, sleepy=1/3
2022-12-14 23:10:36.968 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=5ECD, TID=65, event=RX_NAK, state=CANCELLED
2022-12-14 23:10:36.968 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis: TelegesisSendUnicastCommand [address=24269, sourceEp=0, destEp=0, profileId=0, clusterId=33, messageData=68 CA 5A B5 02 00 8D 15 00 01 05 04 03 B3 E2 F8 0A 00 6F 0D 00 01, messageId=null]
2022-12-14 23:10:37.011 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis Data:AT+SENDUCASTB:16,5ECD,00,00,0000,0021
hÊZµ³âø
o

2022-12-14 23:10:37.012 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:SEQ:C3
2022-12-14 23:10:37.014 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:OK
2022-12-14 23:10:37.015 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisSendUnicastCommand [address=24269, sourceEp=0, destEp=0, profileId=0, clusterId=33, messageData=68 CA 5A B5 02 00 8D 15 00 01 05 04 03 B3 E2 F8 0A 00 6F 0D 00 01, messageId=195, status=SUCCESS]
2022-12-14 23:10:37.016 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX STA: msgTag=68 state=TX_ACK
2022-12-14 23:10:37.017 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionProgress: TID=68, state=TX_ACK, outstanding=3
2022-12-14 23:10:37.018 [DEBUG] [zigbee.transaction.ZigBeeTransaction] - Transaction state changed: nwk=5ECD, TID=68, event=TX_ACK, state=TRANSMITTED
2022-12-14 23:10:37.272 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:SR:00,00124B00072A6C2E,6511
2022-12-14 23:10:37.273 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisRouteRecordMessageEvent [hops=0, remoteAddress=00124B00072A6C2E, networkRoute=[25873]]
2022-12-14 23:10:37.274 [DEBUG] [ngle.telegesis.ZigBeeDongleTelegesis] - Unhandled Telegesis Frame: TelegesisRouteRecordMessageEvent [hops=0, remoteAddress=00124B00072A6C2E, networkRoute=[25873]]
2022-12-14 23:10:37.275 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis Data:RX:6511,0104,01,01,0702,12:}
*%ÙÛb,-60,FF
2022-12-14 23:10:37.275 [DEBUG] [gesis.internal.TelegesisFrameHandler] - RX Telegesis: TelegesisReceiveMessageEvent [ieeeAddress=null, networkAddress=25873, profileId=260, destinationEp=1, sourceEp=1, clusterId=1794, messageData=18 7D 0A 00 04 2A 0E 00 00 00 00 25 D9 DB 62 00 00 00, rssi=-96, lqi=255]
2022-12-14 23:10:37.276 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX APS: ZigBeeApsFrame [sourceAddress=6511/1, destinationAddress=0000/1, profile=0104, cluster=0702, addressMode=null, radius=0, apsSecurity=false, ackRequest=false, apsCounter=--, rssi=--, lqi=--, payload=18 7D 0A 00 04 2A 0E 00 00 00 00 25 D9 DB 62 00 00 00]
2022-12-14 23:10:37.277 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00072A6C2E: Node update. NWK Address=NULL
2022-12-14 23:10:37.278 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 00124B00072A6C2E: Node 6511 is not updated from ZigBeeNode [state=ONLINE, IEEE=00124B00072A6C2E, NWK=----, endpoints=[]]
2022-12-14 23:10:37.279 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX ZCL: ZclHeader [frameType=ENTIRE_PROFILE_COMMAND, manufacturerSpecific=false, direction=SERVER_TO_CLIENT, disableDefaultResponse=true, manufacturerCode=0, sequenceNumber=7D, commandId=10]
2022-12-14 23:10:37.280 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - RX CMD: ReportAttributesCommand [Metering: 6511/1 -> 0000/1, cluster=0702, TID=7D, reports=[AttributeReport [attributeDataType=SIGNED_24_BIT_INTEGER, attributeIdentifier=1024, attributeValue=14], AttributeReport [attributeDataType=UNSIGNED_48_BIT_INTEGER, attributeIdentifier=0, attributeValue=6478809]]]
2022-12-14 23:10:37.281 [DEBUG] [transaction.ZigBeeTransactionManager] - notifyTransactionCommand: ReportAttributesCommand [Metering: 6511/1 -> 0000/1, cluster=0702, TID=7D, reports=[AttributeReport [attributeDataType=SIGNED_24_BIT_INTEGER, attributeIdentifier=1024, attributeValue=14], AttributeReport [attributeDataType=UNSIGNED_48_BIT_INTEGER, attributeIdentifier=0, attributeValue=6478809]]] 
2022-12-14 23:10:38.733 [DEBUG] [gesis.internal.TelegesisFrameHandler] - TX Telegesis queue: 1

Especially this message:
Channel zigbee:device:77de8f9f8d:00158d0002b55aca:00158D0002B55ACA_1_pressure failed to initialise device

What could be the problem?