SMaBiT AV2010/10 Status: OFFLINE - COMMUNICATION_ERROR

rlkoshak · November 29, 2022, 9:18pm

Screen shots are almost useless on the forum. Please click on the “Code” tab and paste the textual Thing config. Use code fences.

```
code goes here
```

This appears to have an Ember chipset. Did you configure it as such?

Logs?

Cybercat · November 29, 2022, 9:25pm

yes Ember Chip and Config

UID: zigbee:coordinator_ember:74e606c57d
label: Ember Coordinator
thingTypeUID: zigbee:coordinator_ember
configuration:
  zigbee_port: /dev/ttyUSB0
  zigbee_channel: 11
  zigbee_initialise: false
  zigbee_concentrator: 1
  zigbee_trustcentremode: TC_JOIN_SECURE
  zigbee_extendedpanid: F5E11F608A2E141B
  zigbee_baud: 57600
  zigbee_flowcontrol: 2
  zigbee_panid: 62000
  zigbee_powermode: 1
  zigbee_txpower: 0
  zigbee_networksize: 100
  zigbee_linkkey: 5A6967426565416C6C69616E63653039
  zigbee_childtimeout: 86400
  zigbee_networkkey: 47303B4A9C9E058135F4AC612EBC497B
  zigbee_meshupdateperiod: 86400

21:28:39.486 [INFO ] [hab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_ember:74e606c57d' changed from UNINITIALIZED to UNINITIALIZED (DISABLED)
21:28:44.165 [INFO ] [hab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_ember:74e606c57d' changed from UNINITIALIZED (DISABLED) to INITIALIZING
21:28:44.167 [INFO ] [openhab.event.FirmwareStatusInfoEvent] - Firmware status of thing zigbee:coordinator_ember:74e606c57d changed to UNKNOWN.
21:28:48.169 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'RouterOSInterface_TransmissionRate' changed from 3.3945127 Mbit/s to 3.444456 Mbit/s
21:28:48.170 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'RouterOSInterface_ReceivingRate' changed from 0.0678832 Mbit/s to 0.1371048 Mbit/s
21:28:49.645 [INFO ] [hab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_ember:74e606c57d' changed from INITIALIZING to OFFLINE: Failed to startup ZigBee transport layer
21:28:49.646 [INFO ] [hab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_ember:74e606c57d' changed from OFFLINE: Failed to startup ZigBee transport layer to OFFLINE (COMMUNICATION_ERROR)
21:28:50.646 [INFO ] [gbee.handler.ZigBeeCoordinatorHandler] - ZigBee dongle inactivity timer. Reinitializing ZigBee
21:28:56.294 [INFO ] [hab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_ember:74e606c57d' changed from OFFLINE (COMMUNICATION_ERROR) to OFFLINE: Failed to startup ZigBee transport layer
21:28:56.295 [INFO ] [hab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_ember:74e606c57d' changed from OFFLINE: Failed to startup ZigBee transport layer to OFFLINE (COMMUNICATION_ERROR)
21:28:58.395 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'RouterOSInterface_TransmissionRate' changed from 3.444456 Mbit/s to 3.4678087 Mbit/s
21:28:58.396 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'RouterOSInterface_ReceivingRate' changed from 0.1371048 Mbit/s to 0.0996152 Mbit/s
21:29:01.294 [INFO ] [gbee.handler.ZigBeeCoordinatorHandler] - ZigBee dongle inactivity timer. Reinitializing ZigBee
21:29:06.934 [INFO ] [hab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_ember:74e606c57d' changed from OFFLINE (COMMUNICATION_ERROR) to OFFLINE: Failed to startup ZigBee transport layer
21:29:06.935 [INFO ] [hab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_ember:74e606c57d' changed from OFFLINE: Failed to startup ZigBee transport layer to OFFLINE (COMMUNICATION_ERROR)
21:29:08.568 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'MikrotikRouterOS_CPULoad' changed from 0 % to 16 %
21:29:08.568 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'RouterOSInterface_TransmissionRate' changed from 3.4678087 Mbit/s to 0.0866032 Mbit/s
21:29:08.569 [INFO ] [openhab.event.ItemStateChangedEvent  ] - Item 'RouterOSInterface_ReceivingRate' changed from 0.0996152 Mbit/s to 0.0338032 Mbit/s
21:29:11.935 [INFO ] [gbee.handler.ZigBeeCoordinatorHandler] - ZigBee dongle inactivity timer. Reinitializing ZigBee

anon71759204 · November 29, 2022, 11:29pm

We would need to see debug logs:

IIRC coordinator firmware (Thing → Information → Thing Properties → firmwareVersion) >= 6.7.8 is required for Zigbee 3.0 devices.

Cybercat · November 30, 2022, 12:14am

i hope this is right

00:12:49.420 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager shutdown: networkState=OFFLINE
00:12:49.420 [DEBUG] [database.ZigBeeNetworkDatabaseManager] - Data store: Deferred Write Time set to 0ms
00:12:49.420 [DEBUG] [database.ZigBeeNetworkDatabaseManager] - Data store: Deferred Write Time set less than Max Deferred Write Time
00:12:49.421 [DEBUG] [database.ZigBeeNetworkDatabaseManager] - Data store: Max Deferred Write Time set to 0ms
00:12:49.422 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to SHUTDOWN
00:12:49.422 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
00:12:49.423 [DEBUG] [pp.discovery.ZigBeeDiscoveryExtension] - DISCOVERY Extension: Shutdown
00:12:49.423 [DEBUG] [database.ZigBeeNetworkDatabaseManager] - Data store: Shutdown
00:12:49.423 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Dongle: Shutdown
00:12:49.423 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember: Link State change to false, initialised=false, networkStateUp=false
00:12:49.424 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember: Link State change to false ignored.
00:12:49.569 [DEBUG] [inding.zigbee.serial.ZigBeeSerialPort] - Serial port '/dev/ttyUSB0' closed.
00:12:49.569 [DEBUG] [.transaction.ZigBeeTransactionManager] - Transaction Manager: Shutdown
00:12:49.569 [DEBUG] [ee.transaction.ZigBeeTransactionQueue] - Broadcast: Queue shutdown
00:12:49.569 [DEBUG] [ee.transaction.ZigBeeTransactionQueue] - Multicast: Queue shutdown
00:12:49.570 [DEBUG] [ing.zigbee.ember.handler.EmberHandler] - Initializing ZigBee Ember serial bridge handler.
00:12:49.570 [DEBUG] [ing.zigbee.ember.handler.EmberHandler] - ZigBee Ember Coordinator opening Port:'/dev/ttyUSB0' PAN:f230, EPAN:F5E11F608A2E141B, Channel:11
00:12:49.570 [DEBUG] [ing.zigbee.ember.handler.EmberHandler] - Ember end device poll timeout set to (169 * 2^9) = 86528 seconds
00:12:49.570 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Scheduling ZigBee start
00:12:50.571 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - ZigBee network starting
00:12:50.571 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
00:12:50.571 [DEBUG] [ee.transaction.ZigBeeTransactionQueue] - Default: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=1, interTransactionDelay=50, maxRetries=2]
00:12:50.571 [DEBUG] [ee.transaction.ZigBeeTransactionQueue] - Broadcast: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=2, interTransactionDelay=4000, maxRetries=0]
00:12:50.572 [DEBUG] [ee.transaction.ZigBeeTransactionQueue] - Multicast: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=3, interTransactionDelay=1200, maxRetries=0]
00:12:50.572 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager initialize: networkState=UNINITIALISED
00:12:50.572 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to INITIALISING
00:12:50.572 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Dongle: Initialize with protocol ASH2.
00:12:50.572 [DEBUG] [inding.zigbee.serial.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB0] at 57600 baud, flow control FLOWCONTROL_OUT_XONOFF.
00:12:50.572 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
00:12:50.787 [DEBUG] [inding.zigbee.serial.ZigBeeSerialPort] - Serial port [/dev/ttyUSB0] is initialized.
00:12:53.084 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember: Link State change to true, initialised=false, networkStateUp=false
00:12:53.084 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember: Link State change to true ignored.
00:12:53.096 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspVersionResponse [networkId=0, protocolVersion=4, stackType=2, stackVersion=5800]
00:12:53.097 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspVersionResponse [networkId=0, protocolVersion=4, stackType=2, stackVersion=5800]
00:12:53.114 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetStandaloneBootloaderVersionPlatMicroPhyResponse [networkId=0, bootloaderVersion=5800, nodePlat=4, nodeMicro=14, nodePhy=3]
00:12:53.136 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
00:12:53.136 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
00:12:53.158 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=5]
00:12:53.158 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=5]
00:12:53.180 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=8]
00:12:53.180 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=8]
00:12:53.202 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
00:12:53.203 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
00:12:53.224 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
00:12:53.225 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
00:12:53.246 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=3000]
00:12:53.246 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=3000]
00:12:53.268 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=30]
00:12:53.269 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=30]
00:12:53.290 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
00:12:53.290 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
00:12:53.312 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
00:12:53.312 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
00:12:53.334 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=6]
00:12:53.334 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=6]
00:12:53.356 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
00:12:53.357 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
00:12:53.378 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=32]
00:12:53.378 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=32]
00:12:53.400 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=10]
00:12:53.401 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=10]
00:12:53.424 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=15]
00:12:53.424 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=15]
00:12:53.448 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=32]
00:12:53.451 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=32]
00:12:53.469 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
00:12:53.470 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
00:12:53.491 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
00:12:53.492 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
00:12:53.514 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
00:12:53.515 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
00:12:53.536 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=75]
00:12:53.536 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=75]
00:12:53.558 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=5]
00:12:53.558 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=5]
00:12:53.580 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=6]
00:12:53.580 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=6]
00:12:53.581 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT = 5
00:12:53.581 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_INDIRECT_TRANSMISSION_TIMEOUT = 3000
00:12:53.581 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SECURITY_LEVEL = 5
00:12:53.582 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_MAX_HOPS = 30
00:12:53.582 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_NEIGHBOR_TABLE_SIZE = 16
00:12:53.582 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_FRAGMENT_WINDOW_SIZE = 1
00:12:53.582 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT_SHIFT = 6
00:12:53.583 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_BROADCAST_TABLE_SIZE = 15
00:12:53.583 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_TX_POWER_MODE = 0
00:12:53.583 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SUPPORTED_NETWORKS = 1
00:12:53.583 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_FRAGMENT_DELAY_MS = 0
00:12:53.584 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SOURCE_ROUTE_TABLE_SIZE = 0
00:12:53.584 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_KEY_TABLE_SIZE = 6
00:12:53.584 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_BINDING_TABLE_SIZE = 32
00:12:53.584 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_PACKET_BUFFER_COUNT = 75
00:12:53.585 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_ADDRESS_TABLE_SIZE = 8
00:12:53.585 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_STACK_PROFILE = 0
00:12:53.585 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_APS_UNICAST_MESSAGE_COUNT = 10
00:12:53.586 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE = 0
00:12:53.586 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_MAX_END_DEVICE_CHILDREN = 32
00:12:53.586 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_APPLICATION_ZDO_FLAGS = 0
00:12:53.602 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=01]
00:12:53.602 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=01]
00:12:53.624 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=10]
00:12:53.624 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=10]
00:12:53.646 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=40]
00:12:53.646 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=40]
00:12:53.668 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=50]
00:12:53.668 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=50]
00:12:53.690 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=61]
00:12:53.690 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=61]
00:12:53.712 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=71]
00:12:53.712 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=71]
00:12:53.713 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_TRUST_CENTER_POLICY = EZSP_ALLOW_PRECONFIGURED_KEY_JOINS [01]
00:12:53.713 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_APP_KEY_REQUEST_POLICY = EZSP_ALLOW_APP_KEY_REQUESTS [61]
00:12:53.713 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_TC_REJOINS_USING_WELL_KNOWN_KEY_POLICY = UNKNOWN [71]
00:12:53.713 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_MESSAGE_CONTENTS_IN_CALLBACK_POLICY = EZSP_MESSAGE_TAG_ONLY_IN_CALLBACK [40]
00:12:53.714 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_TC_KEY_REQUEST_POLICY = EZSP_DENY_TC_KEY_REQUESTS [50]
00:12:53.714 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_BINDING_MODIFICATION_POLICY = EZSP_DISALLOW_BINDING_MODIFICATION [10]
00:12:53.714 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SOURCE_ROUTE_TABLE_SIZE, value=16]
00:12:53.734 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.734 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.735 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SECURITY_LEVEL, value=5]
00:12:53.756 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.756 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.757 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_ADDRESS_TABLE_SIZE, value=100]
00:12:53.778 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.778 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.779 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE, value=2]
00:12:53.800 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.800 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.801 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_STACK_PROFILE, value=2]
00:12:53.822 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.822 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.823 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_INDIRECT_TRANSMISSION_TIMEOUT, value=7680]
00:12:53.844 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.844 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.845 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_MAX_HOPS, value=8]
00:12:53.866 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.867 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.867 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_TX_POWER_MODE, value=1]
00:12:53.888 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.888 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.889 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SUPPORTED_NETWORKS, value=1]
00:12:53.910 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.911 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.911 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_KEY_TABLE_SIZE, value=4]
00:12:53.932 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.932 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.933 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_APPLICATION_ZDO_FLAGS, value=1]
00:12:53.954 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.955 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.955 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_MAX_END_DEVICE_CHILDREN, value=16]
00:12:53.976 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.977 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.977 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_APS_UNICAST_MESSAGE_COUNT, value=10]
00:12:53.998 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.998 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:53.999 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_BROADCAST_TABLE_SIZE, value=15]
00:12:54.020 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_ERROR_INVALID_VALUE]
00:12:54.021 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_ERROR_INVALID_VALUE]
00:12:54.021 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_BINDING_TABLE_SIZE, value=2]
00:12:54.042 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.043 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.043 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_NEIGHBOR_TABLE_SIZE, value=16]
00:12:54.065 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.065 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.065 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_FRAGMENT_WINDOW_SIZE, value=1]
00:12:54.089 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.089 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.090 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_FRAGMENT_DELAY_MS, value=50]
00:12:54.112 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.112 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.112 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_PACKET_BUFFER_COUNT, value=255]
00:12:54.136 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.139 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.139 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT, value=169]
00:12:54.155 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.155 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.156 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT_SHIFT, value=9]
00:12:54.177 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.178 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.200 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
00:12:54.200 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
00:12:54.222 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=5]
00:12:54.223 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=5]
00:12:54.244 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=100]
00:12:54.245 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=100]
00:12:54.266 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
00:12:54.267 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
00:12:54.288 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
00:12:54.289 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
00:12:54.310 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=7680]
00:12:54.311 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=7680]
00:12:54.332 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=8]
00:12:54.333 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=8]
00:12:54.354 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
00:12:54.355 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
00:12:54.377 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
00:12:54.377 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
00:12:54.401 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=4]
00:12:54.402 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=4]
00:12:54.423 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
00:12:54.424 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
00:12:54.445 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
00:12:54.446 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
00:12:54.467 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=10]
00:12:54.468 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=10]
00:12:54.489 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=15]
00:12:54.490 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=15]
00:12:54.511 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
00:12:54.512 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
00:12:54.533 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
00:12:54.534 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
00:12:54.555 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
00:12:54.556 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
00:12:54.577 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=50]
00:12:54.578 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=50]
00:12:54.599 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=255]
00:12:54.600 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=255]
00:12:54.621 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=169]
00:12:54.622 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=169]
00:12:54.643 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=9]
00:12:54.644 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=9]
00:12:54.644 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT = 169
00:12:54.644 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_INDIRECT_TRANSMISSION_TIMEOUT = 7680
00:12:54.644 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SECURITY_LEVEL = 5
00:12:54.645 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_MAX_HOPS = 8
00:12:54.645 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_NEIGHBOR_TABLE_SIZE = 16
00:12:54.645 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_FRAGMENT_WINDOW_SIZE = 1
00:12:54.645 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT_SHIFT = 9
00:12:54.645 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_BROADCAST_TABLE_SIZE = 15
00:12:54.646 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_TX_POWER_MODE = 1
00:12:54.646 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SUPPORTED_NETWORKS = 1
00:12:54.646 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_FRAGMENT_DELAY_MS = 50
00:12:54.646 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SOURCE_ROUTE_TABLE_SIZE = 16
00:12:54.647 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_KEY_TABLE_SIZE = 4
00:12:54.647 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_BINDING_TABLE_SIZE = 2
00:12:54.647 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_PACKET_BUFFER_COUNT = 255
00:12:54.647 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_ADDRESS_TABLE_SIZE = 100
00:12:54.647 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_STACK_PROFILE = 2
00:12:54.648 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_APS_UNICAST_MESSAGE_COUNT = 10
00:12:54.648 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE = 2
00:12:54.648 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_MAX_END_DEVICE_CHILDREN = 16
00:12:54.648 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_APPLICATION_ZDO_FLAGS = 1
00:12:54.665 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.666 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.687 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.688 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.709 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.710 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.731 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.732 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.753 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.754 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.775 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.776 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
00:12:54.797 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=01]
00:12:54.798 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=01]
00:12:54.819 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=12]
00:12:54.820 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=12]
00:12:54.841 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=40]
00:12:54.842 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=40]
00:12:54.863 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=51]
00:12:54.864 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=51]
00:12:54.885 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=60]
00:12:54.886 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=60]
00:12:54.907 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=00]
00:12:54.908 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=00]
00:12:54.908 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_TRUST_CENTER_POLICY = EZSP_ALLOW_PRECONFIGURED_KEY_JOINS [01]
00:12:54.908 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_APP_KEY_REQUEST_POLICY = EZSP_DENY_APP_KEY_REQUESTS [60]
00:12:54.908 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_TC_REJOINS_USING_WELL_KNOWN_KEY_POLICY = EZSP_ALLOW_JOINS [00]
00:12:54.909 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_MESSAGE_CONTENTS_IN_CALLBACK_POLICY = EZSP_MESSAGE_TAG_ONLY_IN_CALLBACK [40]
00:12:54.909 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_TC_KEY_REQUEST_POLICY = EZSP_ALLOW_TC_KEY_REQUESTS_AND_SEND_CURRENT_KEY [51]
00:12:54.909 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_BINDING_MODIFICATION_POLICY = EZSP_CHECK_BINDING_MODIFICATIONS_ARE_VALID_ENDPOINT_CLUSTERS [12]
00:12:54.929 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetNetworkParametersResponse [networkId=0, status=EMBER_NOT_JOINED, nodeType=UNKNOWN, parameters=EmberNetworkParameters [extendedPanId=0000000000000000, panId=FFFF, radioTxPower=-1, radioChannel=0, joinMethod=EMBER_USE_MAC_ASSOCIATION, nwkManagerId=FFFF, nwkUpdateId=0, channels=00000000]]
00:12:54.930 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember initial network parameters are EmberNetworkParameters [extendedPanId=0000000000000000, panId=FFFF, radioTxPower=-1, radioChannel=0, joinMethod=EMBER_USE_MAC_ASSOCIATION, nwkManagerId=FFFF, nwkUpdateId=0, channels=00000000]
00:12:54.951 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetEui64Response [networkId=0, eui64=000D6F000DC56006]
00:12:54.952 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember local IEEE Address is 000D6F000DC56006
00:12:54.973 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetNetworkParametersResponse [networkId=0, status=EMBER_NOT_JOINED, nodeType=UNKNOWN, parameters=EmberNetworkParameters [extendedPanId=0000000000000000, panId=FFFF, radioTxPower=-1, radioChannel=0, joinMethod=EMBER_USE_MAC_ASSOCIATION, nwkManagerId=FFFF, nwkUpdateId=0, channels=00000000]]
00:12:54.974 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Dongle: initialize done
00:12:54.975 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Mesh Update Period 86400.0
00:12:54.975 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0500
00:12:54.975 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher starting for endpoint 1 with profile ID 0104 (ZIGBEE_HOME_AUTOMATION)
00:12:54.976 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0500
00:12:54.976 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0019
00:12:54.976 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0019
00:12:54.977 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0001
00:12:54.977 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0001
00:12:54.977 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0006
00:12:54.978 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0006
00:12:54.978 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0008
00:12:54.978 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0008
00:12:54.978 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 000F
00:12:54.979 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 000F
00:12:54.979 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0101
00:12:54.979 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0101
00:12:54.979 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0102
00:12:54.979 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0102
00:12:54.980 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0201
00:12:54.980 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0201
00:12:54.980 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0202
00:12:54.980 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0202
00:12:54.981 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0300
00:12:54.981 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0300
00:12:54.981 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0400
00:12:54.981 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0400
00:12:54.982 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0402
00:12:54.982 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0402
00:12:54.982 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0403
00:12:54.982 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0403
00:12:54.983 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0405
00:12:54.983 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0405
00:12:54.983 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0406
00:12:54.983 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0406
00:12:54.984 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0500
00:12:54.984 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0500
00:12:54.984 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0502
00:12:54.984 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0502
00:12:54.985 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0702
00:12:54.985 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0702
00:12:54.985 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0B04
00:12:54.985 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0B04
00:12:54.986 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0005
00:12:54.986 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0005
00:12:54.987 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0006
00:12:54.987 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0006
00:12:54.987 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0008
00:12:54.987 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0008
00:12:54.987 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0402
00:12:54.988 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0402
00:12:54.988 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0000
00:12:54.988 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0000
00:12:54.989 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0019
00:12:54.989 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0019
00:12:54.989 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0000
00:12:54.989 [DEBUG] [ystems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding server cluster 0000
00:12:54.990 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - ZigBee Initialise: Previous device configuration was: channel=CHANNEL_00, PanID=65535, EPanId=0000000000000000
00:12:54.990 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Config: zigbee_trustcentremode=TC_JOIN_SECURE
00:12:54.997 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConcentratorResponse [networkId=0, status=EZSP_SUCCESS]
00:12:55.000 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EzspSetConcentratorResponse [networkId=0, status=EZSP_SUCCESS]
00:12:55.019 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
00:12:55.020 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
00:12:55.020 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager startup: reinitialize=false, networkState=INITIALISING
00:12:55.020 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Dongle: Startup - reinitialize=false
00:12:55.020 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Adding Endpoint: ProfileID=0104, DeviceID=0050
00:12:55.020 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Adding Endpoint: Input Clusters   0000
00:12:55.021 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Adding Endpoint: Output Clusters  0000
00:12:55.041 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspAddEndpointResponse [networkId=0, status=EZSP_SUCCESS]
00:12:55.042 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspAddEndpointResponse [networkId=0, status=EZSP_SUCCESS]
00:12:55.063 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspNetworkInitResponse [networkId=0, status=EMBER_NOT_JOINED]
00:12:55.064 [DEBUG] [tsystems.zigbee.dongle.ember.EmberNcp] - EzspNetworkInitResponse [networkId=0, status=EMBER_NOT_JOINED]
00:12:55.064 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP dongle initialize failed to join network
00:12:55.064 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to OFFLINE
00:12:55.064 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
00:12:55.065 [INFO ] [hab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_ember:74e606c57d' changed from OFFLINE (COMMUNICATION_ERROR) to OFFLINE: Failed to startup ZigBee transport layer
00:12:55.065 [INFO ] [hab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_ember:74e606c57d' changed from OFFLINE: Failed to startup ZigBee transport layer to OFFLINE (COMMUNICATION_ERROR)

Cybercat · November 30, 2022, 12:16am

firmwareVersion

5.8.0.0

zigbee_macaddress

000D6F000DC56006

anon71759204 · November 30, 2022, 12:31am

seems to be related (Popp Stick @ firmware 6.10.3)

@chris: Any idea?

anon71759204 · November 30, 2022, 12:36am

[SOLVED] Fail to start Zigbee transport layer - summary: noisy environment, use an extension cable …

Cybercat · November 30, 2022, 3:17pm

use an extension cable - no change

anon71759204 · November 30, 2022, 5:24pm

I suggest waiting for @chris first, but he may be under NDA on this stick.

Otherwise, there seems to be a possibility to update the firmware of the stick (scroll down to the bottom …):

github.com/zigpy/bellows

[DOCUMENTATION] Links to how-to upgrade firmware on Bitron Video AV2010/10 and SMaBiT AV2010/10 USB-sticks?

opened 07:00AM - 15 Sep 20 UTC

closed 12:59PM - 10 Jan 22 UTC

Hedda

Does anyone have links to info on how-to upgrade firmware on SMaBiT AV2010/10 an…d Bitron Video (BV) AV2010/10 USB stick? Would be good to add links to step-by-step in bellows README.md file https://github.com/zigpy/bellows/blob/master/README.md Plus links to publicly available firmware images with newer EmberZNet NCP application FW image files for them? From the info that I could find these are based on Ember EM3587 (EM358x series) chip + has a CP2104 USB-to-Serial/UART chip? This AV2010/10 USB-stick is effectively an RS232 to USB bridge connected to a SiLabs ETRX3 Series ZigBee module. https://silabs-prod.adobecqms.net/support/resources.p-wireless_zigbee-and-thread_em358x-wireless-zigbee-socs https://www.silabs.com/documents/public/reference-manuals/TG-PM-0509-ETRX358x.pdf https://www.texim-europe.com/getfile.aspx?id=101076 That probably means users preferably want later version of EmberZNet 6.6 / 6.6.x / 6.6.x.x if possible for EZSP v5/v6/v7 support? https://bv.smabit.eu/index.php/smart-home-produkte/zb-funkstick/ _**"The ZigBee USB radio device can be used to use ZigBee devices that run QIVICON Home Base 1 and Telekom Speedport Smart. The product is not compatible with QIVICON Home Base 2. You can still use the wireless Stick with another OpenHAB-based system."**_ ![](https://img.smabit.eu/Smart%20Home/AV2010-10/transparent/AV2010-10%20(1).png) @martin3000 added the Bitron Video Zigbee Stick to Home Assistant ZHA list https://www.home-assistant.io/integrations/zha/ - **_Bitron Video/Smabit BV AV2010/10 USB-Stick with Silicon Labs Ember 3587_** @walthowd has for example posted great instructions on upgrading HUSBZB-1 https://github.com/walthowd/husbzb-firmware PS: Submitted a PR to update bellows README.md with a general recommendation to upgrade EmberZNet firmware in https://github.com/zigpy/bellows/pull/346 PPS: I am only asking this on behalf of the community as I do not actually own any Bitron Video/Smabit USB dongles myself.

I’m not sure what your hourly rate is, but it may be more economical (but not as enlightening) to buy another stick.

Sorry, I’m out.

chris · November 30, 2022, 5:52pm

From the log it just looks like the device is not initialised as it’s not joined to a network. You should just have to set the configuration (network PANID, channel, etc) and initialise the device.

Cybercat · November 30, 2022, 8:10pm

ok configuration.
but what else can I set?
or else, where can I get the network PANID, channel, etc? I only have this Zigbee USB stick, without which I can’t learn any devices, or am I wrong about it?

chris · November 30, 2022, 8:19pm

Have you initialised the stick? There is a config option called something like “Reset controller” or “Initialise controller” - have you set this to enabled? If not, the device will not be initialised, and it will not create a network, and this is what I see in the log - no network.

Cybercat · November 30, 2022, 8:45pm

That’s my problem, I can’t get it involved.
and i don’t know why
can “Reinitialize Controller”
(Resets the coordinator, reinitialises the network, and sets the configuration to the configured values)
but that changes just as little.
if I disable it and then turn it back on, INITIALIZING
and then Offline “COMMUNICATION_ERROR”
on the USB stick

Cybercat · November 30, 2022, 8:49pm

chris · November 30, 2022, 8:57pm

Please provide a debug log showing the initialisation - ie selecting to initialise the controller, then clicking save. The above log doesn’t seem to show that this has been selected.

Cybercat · November 30, 2022, 9:07pm

openHAB Debug

openhab/things/zigbee:coordinator_ember:74e606c57d/statuschanged
ThingStatusInfoChangedEvent
[{"status":"UNINITIALIZED","statusDetail":"DISABLED"},{"status":"UNINITIALIZED","statusDetail":"NONE"}]
openhab/things/zigbee:coordinator_ember:74e606c57d/status
ThingStatusInfoEvent
{"status":"UNINITIALIZED","statusDetail":"DISABLED"}
openhab/things/zigbee:coordinator_ember:74e606c57d/statuschanged
ThingStatusInfoChangedEvent
[{"status":"UNINITIALIZED","statusDetail":"NONE"},{"status":"OFFLINE","statusDetail":"COMMUNICATION_ERROR"}]
openhab/things/zigbee:coordinator_ember:74e606c57d/status
ThingStatusInfoEvent
{"status":"UNINITIALIZED","statusDetail":"NONE"}
openhab/things/zigbee:coordinator_ember:74e606c57d/statuschanged
ThingStatusInfoChangedEvent
[{"status":"OFFLINE","statusDetail":"COMMUNICATION_ERROR"},{"status":"OFFLINE","statusDetail":"NONE","description":"Failed to open communications port"}]
openhab/things/zigbee:coordinator_ember:74e606c57d/status
ThingStatusInfoEvent
{"status":"OFFLINE","statusDetail":"COMMUNICATION_ERROR"}
openhab/things/zigbee:coordinator_ember:74e606c57d/statuschanged
ThingStatusInfoChangedEvent
[{"status":"OFFLINE","statusDetail":"NONE","description":"Failed to open communications port"},{"status":"OFFLINE","statusDetail":"COMMUNICATION_ERROR"}]
openhab/things/zigbee:coordinator_ember:74e606c57d/status
ThingStatusInfoEvent
{"status":"OFFLINE","statusDetail":"NONE","description":"Failed to open communications port"}
openhab/things/zigbee:coordinator_ember:74e606c57d/statuschanged
ThingStatusInfoChangedEvent
[{"status":"OFFLINE","statusDetail":"COMMUNICATION_ERROR"},{"status":"OFFLINE","statusDetail":"NONE","description":"Failed to open communications port"}]
openhab/things/zigbee:coordinator_ember:74e606c57d/status
ThingStatusInfoEvent
{"status":"OFFLINE","statusDetail":"COMMUNICATION_ERROR"}
openhab/things/zigbee:coordinator_ember:74e606c57d/statuschanged
ThingStatusInfoChangedEvent
[{"status":"OFFLINE","statusDetail":"NONE","description":"Failed to open communications port"},{"status":"INITIALIZING","statusDetail":"NONE"}]
openhab/things/zigbee:coordinator_ember:74e606c57d/status
ThingStatusInfoEvent
{"status":"OFFLINE","statusDetail":"NONE","description":"Failed to open communications port"}
openhab/things/zigbee:coordinator_ember:74e606c57d/firmware/status
FirmwareStatusInfoEvent
{"thingUID":{"segments":["zigbee","coordinator_ember","74e606c57d"],"uid":"zigbee:coordinator_ember:74e606c57d"},"firmwareStatus":"UNKNOWN"}
openhab/things/zigbee:coordinator_ember:74e606c57d/statuschanged
ThingStatusInfoChangedEvent
[{"status":"INITIALIZING","statusDetail":"NONE"},{"status":"UNINITIALIZED","statusDetail":"DISABLED"}]

Cybercat · November 30, 2022, 9:14pm

log:display org.openhab.binding.zigbee

21:13:25.735 [DEBUG] [gbee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.3.0 (259)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(298)] : dm ZigBeeCoordinatorHandler tracking 29 MultipleDynamic added {org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler}={service.id=572, service.bundleid=264, service.scope=singleton} (enter)
21:13:25.735 [DEBUG] [gbee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.3.0 (259)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(298)] : dm ZigBeeCoordinatorHandler tracking 29 MultipleDynamic already active, binding {org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler}={service.id=572, service.bundleid=264, service.scope=singleton}
21:13:25.735 [DEBUG] [gbee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.3.0 (259)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(298)] : invoking bind: addZigBeeCoordinatorHandler: parameters [org.openhab.binding.zigbee.ember.handler.EmberHandler]
21:13:25.735 [DEBUG] [gbee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.3.0 (259)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(298)] : invoked bind: addZigBeeCoordinatorHandler
21:13:25.735 [DEBUG] [gbee.discovery.ZigBeeDiscoveryService] - bundle org.openhab.binding.zigbee:3.3.0 (259)[org.openhab.binding.zigbee.discovery.ZigBeeDiscoveryService(298)] : dm ZigBeeCoordinatorHandler tracking 29 MultipleDynamic added {org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler}={service.id=572, service.bundleid=264, service.scope=singleton} (exit)
21:13:25.740 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Initializing ZigBee network [zigbee:coordinator_ember:74e606c57d].
21:13:25.746 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Channel 11
21:13:25.746 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - PANID 6900
21:13:25.746 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - EPANID F5E11F608A2E141B
21:13:25.746 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Network Key 47303B4A9C9E058135F4AC612EBC497B
21:13:25.746 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Link Key 5A6967426565416C6C69616E63653039
21:13:25.746 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Config: zigbee_initialise found, initializeNetwork=false
21:13:25.746 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Network Key String 47303B4A9C9E058135F4AC612EBC497B
21:13:25.746 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Network key final array 47303B4A9C9E058135F4AC612EBC497B
21:13:25.746 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Link Key String 5A6967426565416C6C69616E63653039
21:13:25.746 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Link key final array 5A6967426565416C6C69616E63653039
21:13:25.746 [DEBUG] [ing.zigbee.ember.handler.EmberHandler] - Initializing ZigBee Ember serial bridge handler.
21:13:25.746 [DEBUG] [ing.zigbee.ember.handler.EmberHandler] - ZigBee Ember Coordinator opening Port:'/dev/ttyUSB0' PAN:1af4, EPAN:F5E11F608A2E141B, Channel:11
21:13:25.746 [DEBUG] [ing.zigbee.ember.handler.EmberHandler] - Ember end device poll timeout set to (169 * 2^9) = 86528 seconds
21:13:25.746 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Scheduling ZigBee start
21:13:26.747 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - ZigBee network starting
21:13:26.747 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
21:13:26.748 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
21:13:26.748 [DEBUG] [inding.zigbee.serial.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB0] at 57600 baud, flow control FLOWCONTROL_OUT_XONOFF.
21:13:26.748 [DEBUG] [inding.zigbee.serial.ZigBeeSerialPort] - No communication ports found, cannot connect to [/dev/ttyUSB0]
21:13:26.748 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
21:13:27.749 [INFO ] [gbee.handler.ZigBeeCoordinatorHandler] - ZigBee dongle inactivity timer. Reinitializing ZigBee
21:13:27.753 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
21:13:27.754 [DEBUG] [ing.zigbee.ember.handler.EmberHandler] - Initializing ZigBee Ember serial bridge handler.
21:13:27.754 [DEBUG] [ing.zigbee.ember.handler.EmberHandler] - ZigBee Ember Coordinator opening Port:'/dev/ttyUSB0' PAN:1af4, EPAN:F5E11F608A2E141B, Channel:11
21:13:27.754 [DEBUG] [ing.zigbee.ember.handler.EmberHandler] - Ember end device poll timeout set to (169 * 2^9) = 86528 seconds
21:13:27.754 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Scheduling ZigBee start
21:13:28.758 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - ZigBee network starting
21:13:28.758 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
21:13:28.758 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
21:13:28.758 [DEBUG] [inding.zigbee.serial.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB0] at 57600 baud, flow control FLOWCONTROL_OUT_XONOFF.
21:13:28.759 [DEBUG] [inding.zigbee.serial.ZigBeeSerialPort] - No communication ports found, cannot connect to [/dev/ttyUSB0]
21:13:28.759 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
21:13:33.768 [INFO ] [gbee.handler.ZigBeeCoordinatorHandler] - ZigBee dongle inactivity timer. Reinitializing ZigBee
21:13:33.774 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
21:13:33.780 [DEBUG] [ing.zigbee.ember.handler.EmberHandler] - Initializing ZigBee Ember serial bridge handler.
21:13:33.780 [DEBUG] [ing.zigbee.ember.handler.EmberHandler] - ZigBee Ember Coordinator opening Port:'/dev/ttyUSB0' PAN:1af4, EPAN:F5E11F608A2E141B, Channel:11
21:13:33.780 [DEBUG] [ing.zigbee.ember.handler.EmberHandler] - Ember end device poll timeout set to (169 * 2^9) = 86528 seconds
21:13:33.780 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Scheduling ZigBee start
21:13:34.780 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - ZigBee network starting
21:13:34.785 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
21:13:34.786 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
21:13:34.786 [DEBUG] [inding.zigbee.serial.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB0] at 57600 baud, flow control FLOWCONTROL_OUT_XONOFF.
21:13:34.786 [DEBUG] [inding.zigbee.serial.ZigBeeSerialPort] - No communication ports found, cannot connect to [/dev/ttyUSB0]
21:13:34.787 [DEBUG] [gbee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE

Cybercat · November 30, 2022, 9:17pm

log:display com.zsmartsystems.zigbee

21:13:34.785 [DEBUG] [ee.transaction.ZigBeeTransactionQueue] - Default: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=1, interTransactionDelay=50, maxRetries=2]
21:13:34.785 [DEBUG] [ee.transaction.ZigBeeTransactionQueue] - Broadcast: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=2, interTransactionDelay=4000, maxRetries=0]
21:13:34.786 [DEBUG] [ee.transaction.ZigBeeTransactionQueue] - Multicast: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=3, interTransactionDelay=1200, maxRetries=0]
21:13:34.786 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager initialize: networkState=UNINITIALISED
21:13:34.786 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to INITIALISING
21:13:34.786 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Dongle: Initialize with protocol ASH2.
21:13:34.786 [ERROR] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Dongle: Unable to open serial port
21:13:34.786 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to OFFLINE
21:13:39.605 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager shutdown: networkState=OFFLINE
21:13:39.606 [DEBUG] [database.ZigBeeNetworkDatabaseManager] - Data store: Deferred Write Time set to 0ms
21:13:39.606 [DEBUG] [database.ZigBeeNetworkDatabaseManager] - Data store: Deferred Write Time set less than Max Deferred Write Time
21:13:39.606 [DEBUG] [database.ZigBeeNetworkDatabaseManager] - Data store: Max Deferred Write Time set to 0ms
21:13:39.610 [DEBUG] [rtsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to SHUTDOWN
21:13:39.610 [DEBUG] [database.ZigBeeNetworkDatabaseManager] - Data store: Shutdown
21:13:39.610 [DEBUG] [.zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Dongle: Shutdown
21:13:39.615 [DEBUG] [.transaction.ZigBeeTransactionManager] - Transaction Manager: Shutdown
21:13:39.615 [DEBUG] [ee.transaction.ZigBeeTransactionQueue] - Broadcast: Queue shutdown
21:13:39.615 [DEBUG] [ee.transaction.ZigBeeTransactionQueue] - Multicast: Queue shutdown

chris · November 30, 2022, 10:56pm

While I don’t think this is the problem you had earlier, at least in this log the serial port is not defined or unavailable, or has a permission issue (or something - it’s unable to be opened in any case).

Cybercat · November 30, 2022, 11:18pm

okay.

I actually passed through the USB port.
ttyUSB0
okay, apparently I still have to look there, unfortunately I just don’t know where.
Proxmox I looped through the 2 usb’s to the LXC container OpenHAB.
my z-wave usb is in there without any problems.