I am running in to a problem while setting up the ZigBee controller (Popp ZB-stick 701554) which after initialization fails with the log entry “Failed to startup ZigBee transport layer”.
I am running OpenHAB 3.2.0 release build on OpenHabian on a rpi4 with a zwave stick from Aeotec and RFXcom.
The ZB-stick is set up with Ember Coordinator, Flow Control set to NONE and the Baud Rate at 115200. I have flashed the stick to the latest firmware version 6.10.3.0 and set up all the USB devices with symlinks including adding them to EXTRA_JAVA_OPTS.
I have also tried using the stable OH3 release, clean cache, rebooting multiple times, switching to a different USB port, reinstalling binding, re-adding thing, fixing permission through OpenHabian - alas, no improvement in the desired result.
I am not sure what to try next, so any advice on this issue is appreciated!
A complete debug log of the initialization is attached below.
2022-01-19 21:33:01.994 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee network starting
2022-01-19 21:33:01.995 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2022-01-19 21:33:02.030 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Default: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=1, interTransactionDelay=50, maxRetries=2]
2022-01-19 21:33:02.031 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Broadcast: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=2, interTransactionDelay=4000, maxRetries=0]
2022-01-19 21:33:02.032 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Multicast: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=3, interTransactionDelay=1200, maxRetries=0]
2022-01-19 21:33:02.035 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager initialize: networkState=UNINITIALISED
2022-01-19 21:33:02.036 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to INITIALISING
2022-01-19 21:33:02.038 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
2022-01-19 21:33:02.038 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Dongle: Initialize with protocol ASH2.
2022-01-19 21:33:02.039 [DEBUG] [nding.zigbee.serial.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyZigBee] at 115200 baud, flow control FLOWCONTROL_OUT_NONE.
2022-01-19 21:33:02.070 [DEBUG] [nding.zigbee.serial.ZigBeeSerialPort] - Serial port [/dev/ttyZigBee] is initialized.
2022-01-19 21:33:04.437 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember: Link State change to true, initialised=false, networkStateUp=false
2022-01-19 21:33:04.438 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember: Link State change to true ignored.
2022-01-19 21:33:04.455 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspVersionResponse [networkId=0, protocolVersion=8, stackType=2, stackVersion=6A30]
2022-01-19 21:33:04.455 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspVersionResponse [networkId=0, protocolVersion=8, stackType=2, stackVersion=6A30]
2022-01-19 21:33:04.466 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspVersionResponse [networkId=0, protocolVersion=8, stackType=2, stackVersion=6A30]
2022-01-19 21:33:04.466 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspVersionResponse [networkId=0, protocolVersion=8, stackType=2, stackVersion=6A30]
2022-01-19 21:33:04.467 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - EzspVersionResponse [networkId=0, protocolVersion=8, stackType=2, stackVersion=6A30]
2022-01-19 21:33:04.487 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetStandaloneBootloaderVersionPlatMicroPhyResponse [networkId=0, bootloaderVersion=1C3A, nodePlat=4, nodeMicro=24, nodePhy=15]
2022-01-19 21:33:04.512 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=200]
2022-01-19 21:33:04.512 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=200]
2022-01-19 21:33:04.527 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=5]
2022-01-19 21:33:04.527 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=5]
2022-01-19 21:33:04.547 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2022-01-19 21:33:04.547 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2022-01-19 21:33:04.568 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2022-01-19 21:33:04.568 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2022-01-19 21:33:04.588 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2022-01-19 21:33:04.588 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2022-01-19 21:33:04.609 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=3000]
2022-01-19 21:33:04.609 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=3000]
2022-01-19 21:33:04.630 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=30]
2022-01-19 21:33:04.630 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=30]
2022-01-19 21:33:04.650 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2022-01-19 21:33:04.650 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2022-01-19 21:33:04.670 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2022-01-19 21:33:04.670 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2022-01-19 21:33:04.690 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=12]
2022-01-19 21:33:04.690 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=12]
2022-01-19 21:33:04.711 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2022-01-19 21:33:04.711 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2022-01-19 21:33:04.731 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=32]
2022-01-19 21:33:04.731 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=32]
2022-01-19 21:33:04.751 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=10]
2022-01-19 21:33:04.751 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=10]
2022-01-19 21:33:04.771 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=15]
2022-01-19 21:33:04.771 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=15]
2022-01-19 21:33:04.792 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=32]
2022-01-19 21:33:04.792 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=32]
2022-01-19 21:33:04.813 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2022-01-19 21:33:04.813 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2022-01-19 21:33:04.832 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2022-01-19 21:33:04.832 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2022-01-19 21:33:04.852 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2022-01-19 21:33:04.852 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2022-01-19 21:33:04.873 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=250]
2022-01-19 21:33:04.873 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=250]
2022-01-19 21:33:04.893 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=8]
2022-01-19 21:33:04.893 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=8]
2022-01-19 21:33:04.914 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_ERROR_INVALID_ID, value=0]
2022-01-19 21:33:04.914 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_ERROR_INVALID_ID, value=0]
2022-01-19 21:33:04.915 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SUPPORTED_NETWORKS = 1
2022-01-19 21:33:04.916 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SOURCE_ROUTE_TABLE_SIZE = 200
2022-01-19 21:33:04.916 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_ADDRESS_TABLE_SIZE = 16
2022-01-19 21:33:04.917 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_FRAGMENT_WINDOW_SIZE = 1
2022-01-19 21:33:04.918 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT = 8
2022-01-19 21:33:04.921 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_MAX_HOPS = 30
2022-01-19 21:33:04.921 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE = 0
2022-01-19 21:33:04.922 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_INDIRECT_TRANSMISSION_TIMEOUT = 3000
2022-01-19 21:33:04.923 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_NEIGHBOR_TABLE_SIZE = 16
2022-01-19 21:33:04.923 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_KEY_TABLE_SIZE = 12
2022-01-19 21:33:04.924 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_BROADCAST_TABLE_SIZE = 15
2022-01-19 21:33:04.924 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_PACKET_BUFFER_COUNT = 250
2022-01-19 21:33:04.925 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_APS_UNICAST_MESSAGE_COUNT = 10
2022-01-19 21:33:04.926 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT_SHIFT = null
2022-01-19 21:33:04.926 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SECURITY_LEVEL = 5
2022-01-19 21:33:04.927 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_MAX_END_DEVICE_CHILDREN = 32
2022-01-19 21:33:04.927 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_STACK_PROFILE = 0
2022-01-19 21:33:04.928 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_FRAGMENT_DELAY_MS = 0
2022-01-19 21:33:04.929 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_TX_POWER_MODE = 0
2022-01-19 21:33:04.929 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_APPLICATION_ZDO_FLAGS = 0
2022-01-19 21:33:04.930 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_BINDING_TABLE_SIZE = 32
2022-01-19 21:33:04.938 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=03]
2022-01-19 21:33:04.938 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=03]
2022-01-19 21:33:04.958 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=10]
2022-01-19 21:33:04.958 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=10]
2022-01-19 21:33:04.978 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=40]
2022-01-19 21:33:04.978 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=40]
2022-01-19 21:33:04.999 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=50]
2022-01-19 21:33:04.999 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=50]
2022-01-19 21:33:05.019 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=60]
2022-01-19 21:33:05.019 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=60]
2022-01-19 21:33:05.039 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=00]
2022-01-19 21:33:05.039 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=00]
2022-01-19 21:33:05.040 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_TRUST_CENTER_POLICY = EZSP_DISALLOW_ALL_JOINS_AND_REJOINS [03]
2022-01-19 21:33:05.041 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_BINDING_MODIFICATION_POLICY = EZSP_DISALLOW_BINDING_MODIFICATION [10]
2022-01-19 21:33:05.042 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_APP_KEY_REQUEST_POLICY = EZSP_DENY_APP_KEY_REQUESTS [60]
2022-01-19 21:33:05.043 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_MESSAGE_CONTENTS_IN_CALLBACK_POLICY = EZSP_MESSAGE_TAG_ONLY_IN_CALLBACK [40]
2022-01-19 21:33:05.043 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_TC_REJOINS_USING_WELL_KNOWN_KEY_POLICY = EZSP_ALLOW_JOINS [00]
2022-01-19 21:33:05.044 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_TC_KEY_REQUEST_POLICY = EZSP_DENY_TC_KEY_REQUESTS [50]
2022-01-19 21:33:05.045 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SOURCE_ROUTE_TABLE_SIZE, value=16]
2022-01-19 21:33:05.060 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.060 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.061 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SECURITY_LEVEL, value=5]
2022-01-19 21:33:05.080 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.080 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.081 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_ADDRESS_TABLE_SIZE, value=25]
2022-01-19 21:33:05.100 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.100 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.101 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE, value=2]
2022-01-19 21:33:05.121 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.121 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.121 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_STACK_PROFILE, value=2]
2022-01-19 21:33:05.141 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.141 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.142 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_INDIRECT_TRANSMISSION_TIMEOUT, value=7680]
2022-01-19 21:33:05.161 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.161 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.162 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_MAX_HOPS, value=8]
2022-01-19 21:33:05.182 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.182 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.182 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_TX_POWER_MODE, value=1]
2022-01-19 21:33:05.202 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.202 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.203 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SUPPORTED_NETWORKS, value=1]
2022-01-19 21:33:05.222 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.222 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.223 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_KEY_TABLE_SIZE, value=4]
2022-01-19 21:33:05.243 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.243 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.243 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_APPLICATION_ZDO_FLAGS, value=1]
2022-01-19 21:33:05.268 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.269 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.269 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_MAX_END_DEVICE_CHILDREN, value=16]
2022-01-19 21:33:05.289 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.289 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.289 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_APS_UNICAST_MESSAGE_COUNT, value=10]
2022-01-19 21:33:05.311 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.311 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.312 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_BROADCAST_TABLE_SIZE, value=15]
2022-01-19 21:33:05.331 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.331 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.332 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_BINDING_TABLE_SIZE, value=2]
2022-01-19 21:33:05.352 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.352 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.353 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_NEIGHBOR_TABLE_SIZE, value=16]
2022-01-19 21:33:05.374 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.374 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.374 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_FRAGMENT_WINDOW_SIZE, value=1]
2022-01-19 21:33:05.393 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.393 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.393 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_FRAGMENT_DELAY_MS, value=50]
2022-01-19 21:33:05.413 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.413 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.414 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_PACKET_BUFFER_COUNT, value=255]
2022-01-19 21:33:05.433 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.433 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.434 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT, value=169]
2022-01-19 21:33:05.454 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.454 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.454 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT_SHIFT, value=9]
2022-01-19 21:33:05.474 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_ERROR_INVALID_ID]
2022-01-19 21:33:05.474 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_ERROR_INVALID_ID]
2022-01-19 21:33:05.494 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2022-01-19 21:33:05.494 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2022-01-19 21:33:05.515 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=5]
2022-01-19 21:33:05.515 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=5]
2022-01-19 21:33:05.535 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=25]
2022-01-19 21:33:05.535 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=25]
2022-01-19 21:33:05.555 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
2022-01-19 21:33:05.555 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
2022-01-19 21:33:05.576 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
2022-01-19 21:33:05.576 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
2022-01-19 21:33:05.596 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=7680]
2022-01-19 21:33:05.596 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=7680]
2022-01-19 21:33:05.616 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=8]
2022-01-19 21:33:05.616 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=8]
2022-01-19 21:33:05.637 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2022-01-19 21:33:05.637 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2022-01-19 21:33:05.657 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2022-01-19 21:33:05.657 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2022-01-19 21:33:05.677 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=4]
2022-01-19 21:33:05.677 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=4]
2022-01-19 21:33:05.698 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2022-01-19 21:33:05.698 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2022-01-19 21:33:05.718 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2022-01-19 21:33:05.718 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2022-01-19 21:33:05.739 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=10]
2022-01-19 21:33:05.739 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=10]
2022-01-19 21:33:05.759 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=15]
2022-01-19 21:33:05.759 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=15]
2022-01-19 21:33:05.779 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
2022-01-19 21:33:05.780 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
2022-01-19 21:33:05.800 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2022-01-19 21:33:05.800 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2022-01-19 21:33:05.820 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2022-01-19 21:33:05.820 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2022-01-19 21:33:05.840 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=50]
2022-01-19 21:33:05.841 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=50]
2022-01-19 21:33:05.861 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=253]
2022-01-19 21:33:05.861 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=253]
2022-01-19 21:33:05.881 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=169]
2022-01-19 21:33:05.881 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=169]
2022-01-19 21:33:05.902 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_ERROR_INVALID_ID, value=0]
2022-01-19 21:33:05.902 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_ERROR_INVALID_ID, value=0]
2022-01-19 21:33:05.902 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SUPPORTED_NETWORKS = 1
2022-01-19 21:33:05.903 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SOURCE_ROUTE_TABLE_SIZE = 16
2022-01-19 21:33:05.904 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_ADDRESS_TABLE_SIZE = 25
2022-01-19 21:33:05.904 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_FRAGMENT_WINDOW_SIZE = 1
2022-01-19 21:33:05.905 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT = 169
2022-01-19 21:33:05.905 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_MAX_HOPS = 8
2022-01-19 21:33:05.905 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE = 2
2022-01-19 21:33:05.906 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_INDIRECT_TRANSMISSION_TIMEOUT = 7680
2022-01-19 21:33:05.906 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_NEIGHBOR_TABLE_SIZE = 16
2022-01-19 21:33:05.907 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_KEY_TABLE_SIZE = 4
2022-01-19 21:33:05.907 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_BROADCAST_TABLE_SIZE = 15
2022-01-19 21:33:05.908 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_PACKET_BUFFER_COUNT = 253
2022-01-19 21:33:05.908 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_APS_UNICAST_MESSAGE_COUNT = 10
2022-01-19 21:33:05.909 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT_SHIFT = null
2022-01-19 21:33:05.909 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SECURITY_LEVEL = 5
2022-01-19 21:33:05.910 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_MAX_END_DEVICE_CHILDREN = 16
2022-01-19 21:33:05.910 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_STACK_PROFILE = 2
2022-01-19 21:33:05.911 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_FRAGMENT_DELAY_MS = 50
2022-01-19 21:33:05.911 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_TX_POWER_MODE = 1
2022-01-19 21:33:05.912 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_APPLICATION_ZDO_FLAGS = 1
2022-01-19 21:33:05.912 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_BINDING_TABLE_SIZE = 2
2022-01-19 21:33:05.922 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.922 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.942 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.942 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.963 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.963 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.983 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:05.983 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:06.003 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:06.003 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:06.024 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:06.024 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:06.044 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=01]
2022-01-19 21:33:06.044 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=01]
2022-01-19 21:33:06.065 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=12]
2022-01-19 21:33:06.065 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=12]
2022-01-19 21:33:06.085 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=40]
2022-01-19 21:33:06.085 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=40]
2022-01-19 21:33:06.105 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=51]
2022-01-19 21:33:06.105 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=51]
2022-01-19 21:33:06.126 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=60]
2022-01-19 21:33:06.126 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=60]
2022-01-19 21:33:06.146 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=00]
2022-01-19 21:33:06.146 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=00]
2022-01-19 21:33:06.147 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_TRUST_CENTER_POLICY = EZSP_ALLOW_PRECONFIGURED_KEY_JOINS [01]
2022-01-19 21:33:06.148 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_BINDING_MODIFICATION_POLICY = EZSP_CHECK_BINDING_MODIFICATIONS_ARE_VALID_ENDPOINT_CLUSTERS [12]
2022-01-19 21:33:06.149 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_APP_KEY_REQUEST_POLICY = EZSP_DENY_APP_KEY_REQUESTS [60]
2022-01-19 21:33:06.150 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_MESSAGE_CONTENTS_IN_CALLBACK_POLICY = EZSP_MESSAGE_TAG_ONLY_IN_CALLBACK [40]
2022-01-19 21:33:06.151 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_TC_REJOINS_USING_WELL_KNOWN_KEY_POLICY = EZSP_ALLOW_JOINS [00]
2022-01-19 21:33:06.152 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_TC_KEY_REQUEST_POLICY = EZSP_ALLOW_TC_KEY_REQUESTS_AND_SEND_CURRENT_KEY [51]
2022-01-19 21:33:06.171 [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]
2022-01-19 21:33:06.171 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetNetworkParametersResponse [networkId=0, status=EMBER_NOT_JOINED, nodeType=EMBER_UNKNOWN_DEVICE, parameters=EmberNetworkParameters [extendedPanId=0000000000000000, panId=FFFF, radioTxPower=-1, radioChannel=0, joinMethod=EMBER_USE_MAC_ASSOCIATION, nwkManagerId=FFFF, nwkUpdateId=0, channels=00000000]]
2022-01-19 21:33:06.188 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetEui64Response [networkId=0, eui64=84FD27FFFE822F27]
2022-01-19 21:33:06.188 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember local IEEE Address is 84FD27FFFE822F27
2022-01-19 21:33:06.208 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Dongle: initialize done
2022-01-19 21:33:06.208 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetNetworkParametersResponse [networkId=0, status=EMBER_NOT_JOINED, nodeType=EMBER_UNKNOWN_DEVICE, parameters=EmberNetworkParameters [extendedPanId=0000000000000000, panId=FFFF, radioTxPower=-1, radioChannel=0, joinMethod=EMBER_USE_MAC_ASSOCIATION, nwkManagerId=FFFF, nwkUpdateId=0, channels=00000000]]
2022-01-19 21:33:06.211 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Mesh Update Period 86400
2022-01-19 21:33:06.219 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported client cluster 0500
2022-01-19 21:33:06.224 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher starting for endpoint 1 with profile ID 0104 (ZIGBEE_HOME_AUTOMATION)
2022-01-19 21:33:06.225 [DEBUG] [stems.zigbee.internal.ClusterMatcher] - ClusterMatcher adding client cluster 0500
2022-01-19 21:33:06.227 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Adding supported server cluster 0019
...
2022-01-19 21:33:06.359 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee Initialise: Previous device configuration was: channel=CHANNEL_00, PanID=65535, EPanId=0000000000000000
2022-01-19 21:33:06.359 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Config: zigbee_trustcentremode=TC_JOIN_SECURE
2022-01-19 21:33:06.368 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConcentratorResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:06.368 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - EzspSetConcentratorResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:06.388 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:06.388 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetPolicyResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:06.389 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager startup: reinitialize=false, networkState=INITIALISING
2022-01-19 21:33:06.390 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Dongle: Startup - reinitialize=false
2022-01-19 21:33:06.390 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Adding Endpoint: ProfileID=0104, DeviceID=0050
2022-01-19 21:33:06.391 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Adding Endpoint: Input Clusters 0000
2022-01-19 21:33:06.392 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Adding Endpoint: Output Clusters 0000
2022-01-19 21:33:06.409 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspAddEndpointResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:06.409 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspAddEndpointResponse [networkId=0, status=EZSP_SUCCESS]
2022-01-19 21:33:06.429 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspNetworkInitResponse [networkId=0, status=EMBER_NOT_JOINED]
2022-01-19 21:33:06.429 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspNetworkInitResponse [networkId=0, status=EMBER_NOT_JOINED]
2022-01-19 21:33:06.430 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP dongle initialize failed to join network
2022-01-19 21:33:06.431 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to OFFLINE
2022-01-19 21:33:06.431 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2022-01-19 21:33:06.433 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_ember:35dffc32ba' changed from UNKNOWN to OFFLINE: Failed to startup ZigBee transport layer
2022-01-19 21:33:06.435 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_ember:35dffc32ba' changed from OFFLINE: Failed to startup ZigBee transport layer to OFFLINE (COMMUNICATION_ERROR)
2022-01-19 21:33:07.435 [INFO ] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee dongle inactivity timer. Reinitializing ZigBee
2022-01-19 21:33:07.436 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager shutdown: networkState=OFFLINE
2022-01-19 21:33:07.437 [DEBUG] [atabase.ZigBeeNetworkDatabaseManager] - Data store: Deferred Write Time set to 0ms
2022-01-19 21:33:07.438 [DEBUG] [atabase.ZigBeeNetworkDatabaseManager] - Data store: Deferred Write Time set less than Max Deferred Write Time
2022-01-19 21:33:07.439 [DEBUG] [atabase.ZigBeeNetworkDatabaseManager] - Data store: Max Deferred Write Time set to 0ms
2022-01-19 21:33:07.442 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to SHUTDOWN
2022-01-19 21:33:07.445 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2022-01-19 21:33:07.445 [DEBUG] [p.discovery.ZigBeeDiscoveryExtension] - DISCOVERY Extension: Shutdown
2022-01-19 21:33:07.446 [DEBUG] [atabase.ZigBeeNetworkDatabaseManager] - Data store: Shutdown
2022-01-19 21:33:07.447 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Dongle: Shutdown
2022-01-19 21:33:07.448 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember: Link State change to false, initialised=false, networkStateUp=false
2022-01-19 21:33:07.449 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember: Link State change to false ignored.
2022-01-19 21:33:07.575 [DEBUG] [nding.zigbee.serial.ZigBeeSerialPort] - Serial port '/dev/ttyZigBee' closed.
2022-01-19 21:33:07.576 [DEBUG] [transaction.ZigBeeTransactionManager] - Transaction Manager: Shutdown
2022-01-19 21:33:07.577 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Broadcast: Queue shutdown
2022-01-19 21:33:07.577 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Multicast: Queue shutdown
2022-01-19 21:33:07.578 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - Initializing ZigBee Ember serial bridge handler.
2022-01-19 21:33:07.579 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - ZigBee Ember Coordinator opening Port:'/dev/ttyZigBee' PAN:cbe5, EPAN:E33EBB68E5783F4F, Channel:11
2022-01-19 21:33:07.580 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - Ember end device poll timeout set to (169 * 2^9) = 86528 seconds
2022-01-19 21:33:07.581 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Scheduling ZigBee start
2022-01-19 21:33:07.581 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_ember:35dffc32ba' changed from OFFLINE (COMMUNICATION_ERROR) to UNKNOWN