2021-11-04 00:30:52.684 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - Initializing ZigBee Ember serial bridge handler.
2021-11-04 00:30:52.684 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - ZigBee Ember Coordinator opening Port:'rfc2217://192.168.1.168:8888' PAN:cfa4, EPAN:862427909C78DC1B, Channel:11
2021-11-04 00:30:52.684 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - Ember end device poll timeout set to (169 * 2^9) = 86528 seconds
2021-11-04 00:30:52.684 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Scheduling ZigBee start
2021-11-04 00:30:53.706 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee network starting
2021-11-04 00:30:53.706 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2021-11-04 00:30:53.706 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Default: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=1, interTransactionDelay=50, maxRetries=2]
2021-11-04 00:30:53.706 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Broadcast: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=2, interTransactionDelay=4000, maxRetries=0]
2021-11-04 00:30:53.706 [DEBUG] [e.transaction.ZigBeeTransactionQueue] - Multicast: Set profile to ZigBeeTransactionProfile [maxOutstandingTransactions=3, interTransactionDelay=1200, maxRetries=0]
2021-11-04 00:30:53.706 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - ZigBeeNetworkManager initialize: networkState=UNINITIALISED
2021-11-04 00:30:53.706 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - Network state is updated to INITIALISING
2021-11-04 00:30:53.721 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - 04CD15FFFEE457FC: networkStateUpdated called with state=INITIALISING
2021-11-04 00:30:53.759 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 04CD15FFFEE457FC: ZigBee reading network state complete.
2021-11-04 00:30:53.759 [DEBUG] [atabase.ZigBeeNetworkDatabaseManager] - 04CD15FFFEE457FC: Data store: Node was restored.
2021-11-04 00:30:53.759 [DEBUG] [tsystems.zigbee.ZigBeeNetworkManager] - 04CD15FFFEE457FC: Updating node NWK=0000
2021-11-04 00:30:53.759 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - EZSP Dongle: Initialize with protocol ASH2.
2021-11-04 00:30:53.759 [DEBUG] [nding.zigbee.serial.ZigBeeSerialPort] - Connecting to serial port [rfc2217://192.168.1.168:8888] at 115200 baud, flow control FLOWCONTROL_OUT_RTSCTS.
2021-11-04 00:30:53.775 [DEBUG] [nding.zigbee.serial.ZigBeeSerialPort] - Enabling receive timeout is unsupported on [rfc2217://192.168.1.168:8888]
2021-11-04 00:30:53.775 [DEBUG] [nding.zigbee.serial.ZigBeeSerialPort] - Serial port [rfc2217://192.168.1.168:8888] is initialized.
2021-11-04 00:30:53.775 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Connect
2021-11-04 00:30:53.775 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - AshReceiveParserThread thread started
2021-11-04 00:30:53.775 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Reconnect
2021-11-04 00:30:53.775 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameRst []
2021-11-04 00:30:53.775 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspVersionRequest [networkId=0, desiredProtocolVersion=8]
2021-11-04 00:30:53.775 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:30:55.263 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameRstAck [version=2, resetCode=11, Reset: Software]
2021-11-04 00:30:56.527 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Connected
2021-11-04 00:30:56.527 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember: Link State change to true, initialised=false, networkStateUp=false
2021-11-04 00:30:56.527 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember: Link State change to true ignored.
2021-11-04 00:30:56.527 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=0, ackNum=0, reTx=false, data=7B 00 01 00 00 08]
2021-11-04 00:30:56.564 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=0, ackNum=1, reTx=false, data=7B 80 01 00 00 08 02 90 67]
2021-11-04 00:30:56.564 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=0, ackNum=0, reTx=false, data=7B 00 01 00 00 08]
2021-11-04 00:30:56.564 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:30:56.564 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:30:56.564 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=1, notRdy=false]
2021-11-04 00:30:56.564 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspVersionResponse [networkId=0, protocolVersion=8, stackType=2, stackVersion=6790]
2021-11-04 00:30:56.564 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspVersionResponse [networkId=0, protocolVersion=8, stackType=2, stackVersion=6790]
2021-11-04 00:30:56.564 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetStandaloneBootloaderVersionPlatMicroPhyRequest [networkId=0]
2021-11-04 00:30:56.580 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:30:56.580 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=1, ackNum=1, reTx=false, data=7C 00 01 91 00]
2021-11-04 00:30:56.711 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=1, ackNum=2, reTx=false, data=7C 80 01 91 00 01 19 04 18 0F]
2021-11-04 00:30:56.711 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=1, ackNum=1, reTx=false, data=7C 00 01 91 00]
2021-11-04 00:30:56.711 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:30:56.711 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:30:56.711 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=2, notRdy=false]
2021-11-04 00:30:56.711 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetStandaloneBootloaderVersionPlatMicroPhyResponse [networkId=0, bootloaderVersion=1901, nodePlat=4, nodeMicro=24, nodePhy=15]
2021-11-04 00:30:56.711 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SOURCE_ROUTE_TABLE_SIZE]
2021-11-04 00:30:56.711 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:30:56.727 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=false, data=7D 00 01 52 00 1A]
2021-11-04 00:30:57.065 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=2, ackNum=3, reTx=false, data=7D 80 01 52 00 00 07 00]
2021-11-04 00:30:57.065 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=2, ackNum=2, reTx=false, data=7D 00 01 52 00 1A]
2021-11-04 00:30:57.065 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:30:57.065 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=3, notRdy=false]
2021-11-04 00:30:57.081 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:30:57.081 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=7]
2021-11-04 00:30:57.081 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=7]
2021-11-04 00:30:57.081 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SECURITY_LEVEL]
2021-11-04 00:30:57.081 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:30:57.081 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=3, ackNum=3, reTx=false, data=7E 00 01 52 00 0D]
2021-11-04 00:30:57.565 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=4, ackNum=5, reTx=false, data=7F 80 01 52 00 00 08 00]
2021-11-04 00:30:57.565 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=4, ackNum=4, reTx=false, data=7F 00 01 52 00 05]
2021-11-04 00:30:57.565 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:30:57.565 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=5, notRdy=false]
2021-11-04 00:30:57.565 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:30:57.565 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=8]
2021-11-04 00:30:57.565 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=8]
2021-11-04 00:30:57.573 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE]
2021-11-04 00:30:57.573 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:30:57.575 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=5, ackNum=5, reTx=false, data=80 00 01 52 00 19]
2021-11-04 00:30:57.768 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=5, ackNum=6, reTx=false, data=80 80 01 52 00 00 00 00]
2021-11-04 00:30:57.768 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=5, ackNum=5, reTx=false, data=80 00 01 52 00 19]
2021-11-04 00:30:57.768 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:30:57.768 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=6, notRdy=false]
2021-11-04 00:30:57.768 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:30:57.768 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2021-11-04 00:30:57.768 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2021-11-04 00:30:57.768 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_STACK_PROFILE]
2021-11-04 00:30:57.768 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:30:57.768 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=6, ackNum=6, reTx=false, data=81 00 01 52 00 0C]
2021-11-04 00:30:58.120 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=6, ackNum=7, reTx=false, data=81 80 01 52 00 00 00 00]
2021-11-04 00:30:58.120 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=6, ackNum=6, reTx=false, data=81 00 01 52 00 0C]
2021-11-04 00:30:58.122 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:30:58.122 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=7, notRdy=false]
2021-11-04 00:30:58.122 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:30:58.122 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2021-11-04 00:30:58.122 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2021-11-04 00:30:58.122 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_INDIRECT_TRANSMISSION_TIMEOUT]
2021-11-04 00:30:58.122 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:30:58.122 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=7, ackNum=7, reTx=false, data=82 00 01 52 00 12]
2021-11-04 00:30:58.373 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=7, ackNum=0, reTx=false, data=82 80 01 52 00 00 B8 0B]
2021-11-04 00:30:58.373 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=7, ackNum=7, reTx=false, data=82 00 01 52 00 12]
2021-11-04 00:30:58.373 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:30:58.375 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=0, notRdy=false]
2021-11-04 00:30:58.375 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:30:58.375 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=3000]
2021-11-04 00:30:58.375 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=3000]
2021-11-04 00:30:58.375 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_MAX_HOPS]
2021-11-04 00:30:58.375 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:30:58.375 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=0, ackNum=0, reTx=false, data=83 00 01 52 00 10]
2021-11-04 00:30:58.770 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=0, ackNum=1, reTx=false, data=83 80 01 52 00 00 1E 00]
2021-11-04 00:30:58.770 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=0, ackNum=0, reTx=false, data=83 00 01 52 00 10]
2021-11-04 00:30:58.770 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:30:58.770 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=1, notRdy=false]
2021-11-04 00:30:58.780 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:30:58.780 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=30]
2021-11-04 00:30:58.780 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=30]
2021-11-04 00:30:58.780 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_TX_POWER_MODE]
2021-11-04 00:30:58.780 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:30:58.780 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=1, ackNum=1, reTx=false, data=84 00 01 52 00 17]
2021-11-04 00:30:58.831 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=1, ackNum=2, reTx=false, data=84 80 01 52 00 00 00 00]
2021-11-04 00:30:58.831 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=1, ackNum=1, reTx=false, data=84 00 01 52 00 17]
2021-11-04 00:30:58.839 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:30:58.839 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=2, notRdy=false]
2021-11-04 00:30:58.841 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:30:58.841 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2021-11-04 00:30:58.841 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2021-11-04 00:30:58.841 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SUPPORTED_NETWORKS]
2021-11-04 00:30:58.841 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:30:58.841 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=false, data=85 00 01 52 00 2D]
2021-11-04 00:30:59.185 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=2, ackNum=3, reTx=false, data=85 80 01 52 00 00 01 00]
2021-11-04 00:30:59.185 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=2, ackNum=2, reTx=false, data=85 00 01 52 00 2D]
2021-11-04 00:30:59.185 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:30:59.185 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=3, notRdy=false]
2021-11-04 00:30:59.185 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:30:59.185 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2021-11-04 00:30:59.185 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2021-11-04 00:30:59.185 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_KEY_TABLE_SIZE]
2021-11-04 00:30:59.185 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:30:59.193 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=3, ackNum=3, reTx=false, data=86 00 01 52 00 1E]
2021-11-04 00:30:59.529 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=3, ackNum=4, reTx=false, data=86 80 01 52 00 00 0C 00]
2021-11-04 00:30:59.531 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=3, ackNum=3, reTx=false, data=86 00 01 52 00 1E]
2021-11-04 00:30:59.531 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:30:59.531 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=4, notRdy=false]
2021-11-04 00:30:59.531 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:30:59.531 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=12]
2021-11-04 00:30:59.531 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=12]
2021-11-04 00:30:59.531 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_APPLICATION_ZDO_FLAGS]
2021-11-04 00:30:59.531 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:30:59.531 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=4, ackNum=4, reTx=false, data=87 00 01 52 00 2A]
2021-11-04 00:30:59.623 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=4, ackNum=5, reTx=false, data=87 80 01 52 00 00 00 00]
2021-11-04 00:30:59.623 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=4, ackNum=4, reTx=false, data=87 00 01 52 00 2A]
2021-11-04 00:30:59.623 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:30:59.623 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=5, notRdy=false]
2021-11-04 00:30:59.623 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:30:59.623 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2021-11-04 00:30:59.623 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2021-11-04 00:30:59.631 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_MAX_END_DEVICE_CHILDREN]
2021-11-04 00:30:59.631 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:30:59.631 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=5, ackNum=5, reTx=false, data=88 00 01 52 00 11]
2021-11-04 00:31:00.040 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=5, ackNum=6, reTx=false, data=88 80 01 52 00 00 20 00]
2021-11-04 00:31:00.040 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=5, ackNum=5, reTx=false, data=88 00 01 52 00 11]
2021-11-04 00:31:00.040 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:00.040 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=6, notRdy=false]
2021-11-04 00:31:00.040 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:00.040 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=32]
2021-11-04 00:31:00.040 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=32]
2021-11-04 00:31:00.040 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_APS_UNICAST_MESSAGE_COUNT]
2021-11-04 00:31:00.040 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:00.040 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=6, ackNum=6, reTx=false, data=89 00 01 52 00 03]
2021-11-04 00:31:00.171 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=6, ackNum=7, reTx=false, data=89 80 01 52 00 00 0A 00]
2021-11-04 00:31:00.171 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=6, ackNum=6, reTx=false, data=89 00 01 52 00 03]
2021-11-04 00:31:00.171 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:00.171 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:00.171 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=7, notRdy=false]
2021-11-04 00:31:00.171 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=10]
2021-11-04 00:31:00.171 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=10]
2021-11-04 00:31:00.187 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_BROADCAST_TABLE_SIZE]
2021-11-04 00:31:00.187 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:00.187 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=7, ackNum=7, reTx=false, data=8A 00 01 52 00 2B]
2021-11-04 00:31:00.625 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=7, ackNum=0, reTx=false, data=8A 80 01 52 00 00 80 00]
2021-11-04 00:31:00.625 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=7, ackNum=7, reTx=false, data=8A 00 01 52 00 2B]
2021-11-04 00:31:00.625 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:00.625 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=0, notRdy=false]
2021-11-04 00:31:00.641 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:00.641 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=128]
2021-11-04 00:31:00.641 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=128]
2021-11-04 00:31:00.641 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_BINDING_TABLE_SIZE]
2021-11-04 00:31:00.641 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:00.641 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=0, ackNum=0, reTx=false, data=8B 00 01 52 00 04]
2021-11-04 00:31:00.735 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=0, ackNum=1, reTx=false, data=8B 80 01 52 00 00 20 00]
2021-11-04 00:31:00.735 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=0, ackNum=0, reTx=false, data=8B 00 01 52 00 04]
2021-11-04 00:31:00.735 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:00.735 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=1, notRdy=false]
2021-11-04 00:31:00.735 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:00.735 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=32]
2021-11-04 00:31:00.750 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=32]
2021-11-04 00:31:00.750 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_NEIGHBOR_TABLE_SIZE]
2021-11-04 00:31:00.750 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:00.750 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=1, ackNum=1, reTx=false, data=8C 00 01 52 00 02]
2021-11-04 00:31:01.051 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=1, ackNum=2, reTx=false, data=8C 80 01 52 00 00 10 00]
2021-11-04 00:31:01.051 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=1, ackNum=1, reTx=false, data=8C 00 01 52 00 02]
2021-11-04 00:31:01.051 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:01.051 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=2, notRdy=false]
2021-11-04 00:31:01.051 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:01.051 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2021-11-04 00:31:01.051 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2021-11-04 00:31:01.051 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_FRAGMENT_WINDOW_SIZE]
2021-11-04 00:31:01.051 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:01.051 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=false, data=8D 00 01 52 00 1C]
2021-11-04 00:31:01.452 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=2, ackNum=3, reTx=false, data=8D 80 01 52 00 00 01 00]
2021-11-04 00:31:01.452 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=2, ackNum=2, reTx=false, data=8D 00 01 52 00 1C]
2021-11-04 00:31:01.452 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:01.452 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=3, notRdy=false]
2021-11-04 00:31:01.452 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:01.452 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2021-11-04 00:31:01.452 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2021-11-04 00:31:01.452 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_FRAGMENT_DELAY_MS]
2021-11-04 00:31:01.452 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:01.452 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=3, ackNum=3, reTx=false, data=8E 00 01 52 00 1D]
2021-11-04 00:31:01.552 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=3, ackNum=4, reTx=false, data=8E 80 01 52 00 00 00 00]
2021-11-04 00:31:01.552 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=3, ackNum=3, reTx=false, data=8E 00 01 52 00 1D]
2021-11-04 00:31:01.552 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:01.552 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=4, notRdy=false]
2021-11-04 00:31:01.552 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:01.552 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2021-11-04 00:31:01.552 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=0]
2021-11-04 00:31:01.552 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_PACKET_BUFFER_COUNT]
2021-11-04 00:31:01.552 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:01.552 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=4, ackNum=4, reTx=false, data=8F 00 01 52 00 01]
2021-11-04 00:31:01.800 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=4, ackNum=5, reTx=false, data=8F 80 01 52 00 00 40 00]
2021-11-04 00:31:01.800 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=4, ackNum=4, reTx=false, data=8F 00 01 52 00 01]
2021-11-04 00:31:01.800 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:01.800 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=5, notRdy=false]
2021-11-04 00:31:01.800 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:01.800 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=64]
2021-11-04 00:31:01.800 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=64]
2021-11-04 00:31:01.800 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT]
2021-11-04 00:31:01.800 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:01.800 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=5, ackNum=5, reTx=false, data=90 00 01 52 00 13]
2021-11-04 00:31:02.286 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=5, ackNum=6, reTx=false, data=90 80 01 52 00 00 08 00]
2021-11-04 00:31:02.286 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=5, ackNum=5, reTx=false, data=90 00 01 52 00 13]
2021-11-04 00:31:02.286 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:02.286 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=6, notRdy=false]
2021-11-04 00:31:02.301 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:02.301 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=8]
2021-11-04 00:31:02.301 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=8]
2021-11-04 00:31:02.301 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT_SHIFT]
2021-11-04 00:31:02.301 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:02.301 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=6, ackNum=6, reTx=false, data=91 00 01 52 00 1B]
2021-11-04 00:31:02.339 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=6, ackNum=7, reTx=false, data=91 80 01 52 00 37 00 00]
2021-11-04 00:31:02.339 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=6, ackNum=6, reTx=false, data=91 00 01 52 00 1B]
2021-11-04 00:31:02.339 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:02.339 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=7, notRdy=false]
2021-11-04 00:31:02.339 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_ERROR_INVALID_ID, value=0]
2021-11-04 00:31:02.355 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_ERROR_INVALID_ID, value=0]
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_APS_UNICAST_MESSAGE_COUNT = 10
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_NEIGHBOR_TABLE_SIZE = 16
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_BROADCAST_TABLE_SIZE = 128
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_MAX_END_DEVICE_CHILDREN = 32
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SOURCE_ROUTE_TABLE_SIZE = 7
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_ADDRESS_TABLE_SIZE = 8
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_MAX_HOPS = 30
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_FRAGMENT_DELAY_MS = 0
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE = 0
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SUPPORTED_NETWORKS = 1
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_KEY_TABLE_SIZE = 12
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_SECURITY_LEVEL = 5
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT_SHIFT = null
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_TX_POWER_MODE = 0
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_INDIRECT_TRANSMISSION_TIMEOUT = 3000
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_STACK_PROFILE = 0
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_PACKET_BUFFER_COUNT = 64
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT = 8
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_APPLICATION_ZDO_FLAGS = 0
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_FRAGMENT_WINDOW_SIZE = 1
2021-11-04 00:31:02.355 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Configuration state EZSP_CONFIG_BINDING_TABLE_SIZE = 32
2021-11-04 00:31:02.355 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetPolicyRequest [networkId=0, policyId=EZSP_TRUST_CENTER_POLICY]
2021-11-04 00:31:02.355 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:02.355 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=7, ackNum=7, reTx=false, data=92 00 01 56 00 00]
2021-11-04 00:31:02.703 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=7, ackNum=0, reTx=false, data=92 80 01 56 00 00 03]
2021-11-04 00:31:02.718 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=7, ackNum=7, reTx=false, data=92 00 01 56 00 00]
2021-11-04 00:31:02.718 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:02.718 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=0, notRdy=false]
2021-11-04 00:31:02.718 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:02.718 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=03]
2021-11-04 00:31:02.718 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=03]
2021-11-04 00:31:02.718 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetPolicyRequest [networkId=0, policyId=EZSP_BINDING_MODIFICATION_POLICY]
2021-11-04 00:31:02.718 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:02.718 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=0, ackNum=0, reTx=false, data=93 00 01 56 00 01]
2021-11-04 00:31:03.119 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=0, ackNum=1, reTx=false, data=93 80 01 56 00 00 10]
2021-11-04 00:31:03.119 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=0, ackNum=0, reTx=false, data=93 00 01 56 00 01]
2021-11-04 00:31:03.119 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:03.119 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=1, notRdy=false]
2021-11-04 00:31:03.119 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:03.119 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=10]
2021-11-04 00:31:03.135 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=10]
2021-11-04 00:31:03.142 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetPolicyRequest [networkId=0, policyId=EZSP_MESSAGE_CONTENTS_IN_CALLBACK_POLICY]
2021-11-04 00:31:03.142 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:03.142 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=1, ackNum=1, reTx=false, data=94 00 01 56 00 04]
2021-11-04 00:31:03.520 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=1, ackNum=2, reTx=false, data=94 80 01 56 00 00 40]
2021-11-04 00:31:03.520 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=1, ackNum=1, reTx=false, data=94 00 01 56 00 04]
2021-11-04 00:31:03.520 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:03.520 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=2, notRdy=false]
2021-11-04 00:31:03.520 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:03.520 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=40]
2021-11-04 00:31:03.520 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=40]
2021-11-04 00:31:03.520 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetPolicyRequest [networkId=0, policyId=EZSP_TC_KEY_REQUEST_POLICY]
2021-11-04 00:31:03.520 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:03.520 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=false, data=95 00 01 56 00 05]
2021-11-04 00:31:03.721 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=2, ackNum=3, reTx=false, data=95 80 01 56 00 00 50]
2021-11-04 00:31:03.721 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=2, ackNum=2, reTx=false, data=95 00 01 56 00 05]
2021-11-04 00:31:03.721 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:03.721 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=3, notRdy=false]
2021-11-04 00:31:03.721 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:03.721 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=50]
2021-11-04 00:31:03.721 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=50]
2021-11-04 00:31:03.721 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetPolicyRequest [networkId=0, policyId=EZSP_APP_KEY_REQUEST_POLICY]
2021-11-04 00:31:03.721 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:03.721 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=3, ackNum=3, reTx=false, data=96 00 01 56 00 06]
2021-11-04 00:31:04.122 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=3, ackNum=4, reTx=false, data=96 80 01 56 00 00 61]
2021-11-04 00:31:04.122 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=3, ackNum=3, reTx=false, data=96 00 01 56 00 06]
2021-11-04 00:31:04.122 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:04.122 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:04.122 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=4, notRdy=false]
2021-11-04 00:31:04.122 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=61]
2021-11-04 00:31:04.122 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetPolicyResponse [networkId=0, status=EZSP_SUCCESS, decisionId=61]
2021-11-04 00:31:04.122 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_TC_KEY_REQUEST_POLICY = EZSP_DENY_TC_KEY_REQUESTS [50]
2021-11-04 00:31:04.122 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_APP_KEY_REQUEST_POLICY = EZSP_ALLOW_APP_KEY_REQUESTS [61]
2021-11-04 00:31:04.122 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_BINDING_MODIFICATION_POLICY = EZSP_DISALLOW_BINDING_MODIFICATION [10]
2021-11-04 00:31:04.122 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_TRUST_CENTER_POLICY = EZSP_DISALLOW_ALL_JOINS_AND_REJOINS [03]
2021-11-04 00:31:04.122 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Policy state EZSP_MESSAGE_CONTENTS_IN_CALLBACK_POLICY = EZSP_MESSAGE_TAG_ONLY_IN_CALLBACK [40]
2021-11-04 00:31:04.122 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SOURCE_ROUTE_TABLE_SIZE, value=16]
2021-11-04 00:31:04.122 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SOURCE_ROUTE_TABLE_SIZE, value=16]
2021-11-04 00:31:04.122 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:04.138 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=4, ackNum=4, reTx=false, data=97 00 01 53 00 1A 10 00]
2021-11-04 00:31:04.260 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=4, ackNum=5, reTx=false, data=97 80 01 53 00 00]
2021-11-04 00:31:04.260 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=4, ackNum=4, reTx=false, data=97 00 01 53 00 1A 10 00]
2021-11-04 00:31:04.260 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:04.260 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=5, notRdy=false]
2021-11-04 00:31:04.260 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:04.260 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:04.260 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:04.260 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SECURITY_LEVEL, value=5]
2021-11-04 00:31:04.260 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SECURITY_LEVEL, value=5]
2021-11-04 00:31:04.260 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:04.260 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=5, ackNum=5, reTx=false, data=98 00 01 53 00 0D 05 00]
2021-11-04 00:31:04.476 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=5, ackNum=6, reTx=false, data=98 80 01 53 00 00]
2021-11-04 00:31:04.476 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=5, ackNum=5, reTx=false, data=98 00 01 53 00 0D 05 00]
2021-11-04 00:31:04.476 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:04.476 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=6, notRdy=false]
2021-11-04 00:31:04.476 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:04.476 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:04.476 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:04.476 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_ADDRESS_TABLE_SIZE, value=25]
2021-11-04 00:31:04.476 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_ADDRESS_TABLE_SIZE, value=25]
2021-11-04 00:31:04.476 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:04.476 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=6, ackNum=6, reTx=false, data=99 00 01 53 00 05 19 00]
2021-11-04 00:31:04.946 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=6, ackNum=7, reTx=false, data=99 80 01 53 00 00]
2021-11-04 00:31:04.946 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=6, ackNum=6, reTx=false, data=99 00 01 53 00 05 19 00]
2021-11-04 00:31:04.946 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:04.946 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:04.946 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=7, notRdy=false]
2021-11-04 00:31:04.946 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:04.946 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:04.946 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE, value=2]
2021-11-04 00:31:04.946 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE, value=2]
2021-11-04 00:31:04.946 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:04.946 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=7, ackNum=7, reTx=false, data=9A 00 01 53 00 19 02 00]
2021-11-04 00:31:05.062 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=7, ackNum=0, reTx=false, data=9A 80 01 53 00 00]
2021-11-04 00:31:05.062 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=7, ackNum=7, reTx=false, data=9A 00 01 53 00 19 02 00]
2021-11-04 00:31:05.062 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:05.062 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:05.062 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=0, notRdy=false]
2021-11-04 00:31:05.062 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:05.062 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:05.062 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_STACK_PROFILE, value=2]
2021-11-04 00:31:05.062 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_STACK_PROFILE, value=2]
2021-11-04 00:31:05.062 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:05.078 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=0, ackNum=0, reTx=false, data=9B 00 01 53 00 0C 02 00]
2021-11-04 00:31:05.309 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=0, ackNum=1, reTx=false, data=9B 80 01 53 00 00]
2021-11-04 00:31:05.309 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=0, ackNum=0, reTx=false, data=9B 00 01 53 00 0C 02 00]
2021-11-04 00:31:05.324 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:05.324 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:05.324 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=1, notRdy=false]
2021-11-04 00:31:05.324 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:05.324 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:05.324 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_INDIRECT_TRANSMISSION_TIMEOUT, value=7680]
2021-11-04 00:31:05.324 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_INDIRECT_TRANSMISSION_TIMEOUT, value=7680]
2021-11-04 00:31:05.324 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:05.324 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=1, ackNum=1, reTx=false, data=9C 00 01 53 00 12 00 1E]
2021-11-04 00:31:05.762 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=1, ackNum=2, reTx=false, data=9C 80 01 53 00 00]
2021-11-04 00:31:05.762 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=1, ackNum=1, reTx=false, data=9C 00 01 53 00 12 00 1E]
2021-11-04 00:31:05.777 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:05.777 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:05.777 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=2, notRdy=false]
2021-11-04 00:31:05.777 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:05.777 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:05.777 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_MAX_HOPS, value=8]
2021-11-04 00:31:05.777 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_MAX_HOPS, value=8]
2021-11-04 00:31:05.777 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:05.777 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=false, data=9D 00 01 53 00 10 08 00]
2021-11-04 00:31:05.877 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=2, ackNum=3, reTx=false, data=9D 80 01 53 00 00]
2021-11-04 00:31:05.877 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=2, ackNum=2, reTx=false, data=9D 00 01 53 00 10 08 00]
2021-11-04 00:31:05.877 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:05.877 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:05.877 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=3, notRdy=false]
2021-11-04 00:31:05.877 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:05.877 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:05.877 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_TX_POWER_MODE, value=1]
2021-11-04 00:31:05.877 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_TX_POWER_MODE, value=1]
2021-11-04 00:31:05.877 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:05.877 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=3, ackNum=3, reTx=false, data=9E 00 01 53 00 17 01 00]
2021-11-04 00:31:06.178 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=3, ackNum=4, reTx=false, data=9E 80 01 53 00 00]
2021-11-04 00:31:06.178 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=3, ackNum=3, reTx=false, data=9E 00 01 53 00 17 01 00]
2021-11-04 00:31:06.178 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:06.178 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:06.178 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=4, notRdy=false]
2021-11-04 00:31:06.178 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:06.178 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:06.178 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SUPPORTED_NETWORKS, value=1]
2021-11-04 00:31:06.178 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SUPPORTED_NETWORKS, value=1]
2021-11-04 00:31:06.178 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:06.178 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=4, ackNum=4, reTx=false, data=9F 00 01 53 00 2D 01 00]
2021-11-04 00:31:06.591 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=4, ackNum=5, reTx=false, data=9F 80 01 53 00 00]
2021-11-04 00:31:06.606 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=4, ackNum=4, reTx=false, data=9F 00 01 53 00 2D 01 00]
2021-11-04 00:31:06.606 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:06.606 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:06.606 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=5, notRdy=false]
2021-11-04 00:31:06.606 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:06.606 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:06.606 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_KEY_TABLE_SIZE, value=4]
2021-11-04 00:31:06.606 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_KEY_TABLE_SIZE, value=4]
2021-11-04 00:31:06.606 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:06.606 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=5, ackNum=5, reTx=false, data=A0 00 01 53 00 1E 04 00]
2021-11-04 00:31:06.940 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=5, ackNum=6, reTx=false, data=A0 80 01 53 00 00]
2021-11-04 00:31:06.940 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=5, ackNum=5, reTx=false, data=A0 00 01 53 00 1E 04 00]
2021-11-04 00:31:06.940 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:06.940 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:06.940 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=6, notRdy=false]
2021-11-04 00:31:06.947 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:06.947 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:06.947 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_APPLICATION_ZDO_FLAGS, value=1]
2021-11-04 00:31:06.947 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_APPLICATION_ZDO_FLAGS, value=1]
2021-11-04 00:31:06.947 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:06.947 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=6, ackNum=6, reTx=false, data=A1 00 01 53 00 2A 01 00]
2021-11-04 00:31:07.394 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=6, ackNum=7, reTx=false, data=A1 80 01 53 00 00]
2021-11-04 00:31:07.394 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=6, ackNum=6, reTx=false, data=A1 00 01 53 00 2A 01 00]
2021-11-04 00:31:07.394 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:07.394 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:07.394 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=7, notRdy=false]
2021-11-04 00:31:07.394 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:07.394 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:07.394 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_MAX_END_DEVICE_CHILDREN, value=16]
2021-11-04 00:31:07.394 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_MAX_END_DEVICE_CHILDREN, value=16]
2021-11-04 00:31:07.394 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:07.394 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=7, ackNum=7, reTx=false, data=A2 00 01 53 00 11 10 00]
2021-11-04 00:31:07.810 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=7, ackNum=0, reTx=false, data=A2 80 01 53 00 00]
2021-11-04 00:31:07.810 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=7, ackNum=7, reTx=false, data=A2 00 01 53 00 11 10 00]
2021-11-04 00:31:07.810 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:07.810 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:07.810 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=0, notRdy=false]
2021-11-04 00:31:07.810 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:07.810 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:07.810 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_APS_UNICAST_MESSAGE_COUNT, value=10]
2021-11-04 00:31:07.826 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_APS_UNICAST_MESSAGE_COUNT, value=10]
2021-11-04 00:31:07.826 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:07.826 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=0, ackNum=0, reTx=false, data=A3 00 01 53 00 03 0A 00]
2021-11-04 00:31:07.926 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=0, ackNum=1, reTx=false, data=A3 80 01 53 00 00]
2021-11-04 00:31:07.926 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=0, ackNum=0, reTx=false, data=A3 00 01 53 00 03 0A 00]
2021-11-04 00:31:07.926 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:07.926 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=1, notRdy=false]
2021-11-04 00:31:07.926 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:07.942 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:07.942 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:07.942 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_BROADCAST_TABLE_SIZE, value=15]
2021-11-04 00:31:07.942 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_BROADCAST_TABLE_SIZE, value=15]
2021-11-04 00:31:07.942 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:07.942 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=1, ackNum=1, reTx=false, data=A4 00 01 53 00 2B 0F 00]
2021-11-04 00:31:08.396 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=1, ackNum=2, reTx=false, data=A4 80 01 53 00 00]
2021-11-04 00:31:08.396 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=1, ackNum=1, reTx=false, data=A4 00 01 53 00 2B 0F 00]
2021-11-04 00:31:08.396 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:08.396 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:08.396 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=2, notRdy=false]
2021-11-04 00:31:08.396 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:08.412 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:08.412 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_BINDING_TABLE_SIZE, value=2]
2021-11-04 00:31:08.412 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_BINDING_TABLE_SIZE, value=2]
2021-11-04 00:31:08.412 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:08.412 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=false, data=A5 00 01 53 00 04 02 00]
2021-11-04 00:31:08.512 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=2, ackNum=3, reTx=false, data=A5 80 01 53 00 00]
2021-11-04 00:31:08.512 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=2, ackNum=2, reTx=false, data=A5 00 01 53 00 04 02 00]
2021-11-04 00:31:08.512 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:08.512 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:08.512 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=3, notRdy=false]
2021-11-04 00:31:08.512 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:08.528 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:08.528 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_NEIGHBOR_TABLE_SIZE, value=16]
2021-11-04 00:31:08.528 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_NEIGHBOR_TABLE_SIZE, value=16]
2021-11-04 00:31:08.528 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:08.528 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=3, ackNum=3, reTx=false, data=A6 00 01 53 00 02 10 00]
2021-11-04 00:31:08.828 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=3, ackNum=4, reTx=false, data=A6 80 01 53 00 00]
2021-11-04 00:31:08.828 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=3, ackNum=3, reTx=false, data=A6 00 01 53 00 02 10 00]
2021-11-04 00:31:08.828 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:08.828 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:08.828 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=4, notRdy=false]
2021-11-04 00:31:08.828 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:08.828 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:08.828 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_FRAGMENT_WINDOW_SIZE, value=1]
2021-11-04 00:31:08.828 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_FRAGMENT_WINDOW_SIZE, value=1]
2021-11-04 00:31:08.844 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:08.844 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=4, ackNum=4, reTx=false, data=A7 00 01 53 00 1C 01 00]
2021-11-04 00:31:09.230 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=4, ackNum=5, reTx=false, data=A7 80 01 53 00 00]
2021-11-04 00:31:09.245 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=4, ackNum=4, reTx=false, data=A7 00 01 53 00 1C 01 00]
2021-11-04 00:31:09.245 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:09.245 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:09.245 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=5, notRdy=false]
2021-11-04 00:31:09.245 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:09.245 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:09.245 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_FRAGMENT_DELAY_MS, value=50]
2021-11-04 00:31:09.245 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_FRAGMENT_DELAY_MS, value=50]
2021-11-04 00:31:09.245 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:09.245 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=5, ackNum=5, reTx=false, data=A8 00 01 53 00 1D 32 00]
2021-11-04 00:31:09.283 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=5, ackNum=6, reTx=false, data=A8 80 01 53 00 00]
2021-11-04 00:31:09.283 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=5, ackNum=5, reTx=false, data=A8 00 01 53 00 1D 32 00]
2021-11-04 00:31:09.299 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:09.299 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=6, notRdy=false]
2021-11-04 00:31:09.299 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:09.299 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:09.299 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:09.299 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_PACKET_BUFFER_COUNT, value=255]
2021-11-04 00:31:09.299 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_PACKET_BUFFER_COUNT, value=255]
2021-11-04 00:31:09.299 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:09.299 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=6, ackNum=6, reTx=false, data=A9 00 01 53 00 01 FF 00]
2021-11-04 00:31:09.568 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=6, ackNum=7, reTx=false, data=A9 80 01 00 00 00]
2021-11-04 00:31:09.568 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=6, ackNum=6, reTx=false, data=A9 00 01 53 00 01 FF 00]
2021-11-04 00:31:09.568 [DEBUG] [s.zigbee.dongle.ember.ezsp.EzspFrame] - Error creating instance of EzspFrame
java.lang.reflect.InvocationTargetException: null
	at jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:?]
	at jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) ~[?:?]
	at jdk.internal.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:?]
	at java.lang.reflect.Constructor.newInstance(Constructor.java:490) ~[?:?]
	at com.zsmartsystems.zigbee.dongle.ember.ezsp.EzspFrame.createHandler(EzspFrame.java:487) [bundleFile:?]
	at com.zsmartsystems.zigbee.dongle.ember.internal.ash.AshFrameHandler$AshReceiveParserThread.run(AshFrameHandler.java:309) [bundleFile:?]
Caused by: java.lang.ArrayIndexOutOfBoundsException: Index 6 out of bounds for length 6
	at com.zsmartsystems.zigbee.dongle.ember.internal.serializer.EzspDeserializer.deserializeUInt8(EzspDeserializer.java:85) ~[?:?]
	at com.zsmartsystems.zigbee.dongle.ember.ezsp.command.EzspVersionResponse.<init>(EzspVersionResponse.java:58) ~[?:?]
	... 6 more
2021-11-04 00:31:09.584 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: No frame handler created for AshFrameData [frmNum=6, ackNum=7, reTx=false, data=A9 80 01 00 00 00]
2021-11-04 00:31:09.584 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=7, notRdy=false]
2021-11-04 00:31:19.312 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - Sending EZSP transaction timed out after 10 seconds
2021-11-04 00:31:19.312 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT, value=169]
2021-11-04 00:31:19.312 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT, value=169]
2021-11-04 00:31:19.312 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:19.312 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=7, ackNum=7, reTx=false, data=AA 00 01 53 00 13 A9 00]
2021-11-04 00:31:19.359 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=7, ackNum=0, reTx=false, data=AA 80 01 53 00 00]
2021-11-04 00:31:19.359 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=7, ackNum=7, reTx=false, data=AA 00 01 53 00 13 A9 00]
2021-11-04 00:31:19.359 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:19.359 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:19.359 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=0, notRdy=false]
2021-11-04 00:31:19.359 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:19.359 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS]
2021-11-04 00:31:19.359 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT_SHIFT, value=9]
2021-11-04 00:31:19.359 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspSetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_END_DEVICE_POLL_TIMEOUT_SHIFT, value=9]
2021-11-04 00:31:19.359 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:19.359 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=0, ackNum=0, reTx=false, data=AB 00 01 53 00 1B 09 00]
2021-11-04 00:31:19.659 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=0, ackNum=1, reTx=false, data=AB 80 01 53 00 37]
2021-11-04 00:31:19.659 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=0, ackNum=0, reTx=false, data=AB 00 01 53 00 1B 09 00]
2021-11-04 00:31:19.659 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:19.659 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:19.665 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=1, notRdy=false]
2021-11-04 00:31:19.665 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspSetConfigurationValueResponse [networkId=0, status=EZSP_ERROR_INVALID_ID]
2021-11-04 00:31:19.665 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspSetConfigurationValueResponse [networkId=0, status=EZSP_ERROR_INVALID_ID]
2021-11-04 00:31:19.665 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SOURCE_ROUTE_TABLE_SIZE]
2021-11-04 00:31:19.665 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:19.665 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=1, ackNum=1, reTx=false, data=AC 00 01 52 00 1A]
2021-11-04 00:31:20.065 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=1, ackNum=2, reTx=false, data=AC 80 01 52 00 00 10 00]
2021-11-04 00:31:20.065 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=1, ackNum=1, reTx=false, data=AC 00 01 52 00 1A]
2021-11-04 00:31:20.065 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:20.065 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:20.065 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=2, notRdy=false]
2021-11-04 00:31:20.065 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2021-11-04 00:31:20.065 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2021-11-04 00:31:20.065 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SECURITY_LEVEL]
2021-11-04 00:31:20.065 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:20.065 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=false, data=AD 00 01 52 00 0D]
2021-11-04 00:31:20.165 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=2, ackNum=3, reTx=false, data=AD 80 01 52 00 00 05 00]
2021-11-04 00:31:20.165 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=2, ackNum=2, reTx=false, data=AD 00 01 52 00 0D]
2021-11-04 00:31:20.165 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:20.165 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:20.165 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=3, notRdy=false]
2021-11-04 00:31:20.165 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=5]
2021-11-04 00:31:20.165 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=5]
2021-11-04 00:31:20.165 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_ADDRESS_TABLE_SIZE]
2021-11-04 00:31:20.165 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:20.165 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=3, ackNum=3, reTx=false, data=AE 00 01 52 00 05]
2021-11-04 00:31:20.466 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=3, ackNum=4, reTx=false, data=AE 80 01 52 00 00 19 00]
2021-11-04 00:31:20.466 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=3, ackNum=3, reTx=false, data=AE 00 01 52 00 05]
2021-11-04 00:31:20.466 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:20.466 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:20.466 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=4, notRdy=false]
2021-11-04 00:31:20.466 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=25]
2021-11-04 00:31:20.466 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=25]
2021-11-04 00:31:20.481 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE]
2021-11-04 00:31:20.481 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:20.481 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=4, ackNum=4, reTx=false, data=AF 00 01 52 00 19]
2021-11-04 00:31:20.928 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=4, ackNum=5, reTx=false, data=AF 80 01 52 00 00 02 00]
2021-11-04 00:31:20.928 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=4, ackNum=4, reTx=false, data=AF 00 01 52 00 19]
2021-11-04 00:31:20.928 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:20.928 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:20.928 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=5, notRdy=false]
2021-11-04 00:31:20.928 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
2021-11-04 00:31:20.928 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
2021-11-04 00:31:20.928 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_STACK_PROFILE]
2021-11-04 00:31:20.928 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:20.928 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=5, ackNum=5, reTx=false, data=B0 00 01 52 00 0C]
2021-11-04 00:31:21.044 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=5, ackNum=6, reTx=false, data=B0 80 01 52 00 00 02 00]
2021-11-04 00:31:21.044 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=5, ackNum=5, reTx=false, data=B0 00 01 52 00 0C]
2021-11-04 00:31:21.044 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:21.044 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:21.044 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=6, notRdy=false]
2021-11-04 00:31:21.044 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
2021-11-04 00:31:21.044 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
2021-11-04 00:31:21.044 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_INDIRECT_TRANSMISSION_TIMEOUT]
2021-11-04 00:31:21.044 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:21.044 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=6, ackNum=6, reTx=false, data=B1 00 01 52 00 12]
2021-11-04 00:31:21.298 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=6, ackNum=7, reTx=false, data=B1 80 01 52 00 00 00 1E]
2021-11-04 00:31:21.298 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=6, ackNum=6, reTx=false, data=B1 00 01 52 00 12]
2021-11-04 00:31:21.298 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:21.298 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=7, notRdy=false]
2021-11-04 00:31:21.298 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:21.298 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=7680]
2021-11-04 00:31:21.298 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=7680]
2021-11-04 00:31:21.298 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_MAX_HOPS]
2021-11-04 00:31:21.298 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:21.298 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=7, ackNum=7, reTx=false, data=B2 00 01 52 00 10]
2021-11-04 00:31:21.829 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=7, ackNum=0, reTx=false, data=B2 80 01 52 00 00 08 00]
2021-11-04 00:31:21.829 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=7, ackNum=7, reTx=false, data=B2 00 01 52 00 10]
2021-11-04 00:31:21.829 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:21.829 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:21.829 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=0, notRdy=false]
2021-11-04 00:31:21.829 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=8]
2021-11-04 00:31:21.829 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=8]
2021-11-04 00:31:21.829 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_TX_POWER_MODE]
2021-11-04 00:31:21.829 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:21.829 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=0, ackNum=0, reTx=false, data=B3 00 01 52 00 17]
2021-11-04 00:31:22.130 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=0, ackNum=1, reTx=false, data=B3 80 01 52 00 00 01 00]
2021-11-04 00:31:22.130 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=0, ackNum=0, reTx=false, data=B3 00 01 52 00 17]
2021-11-04 00:31:22.130 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:22.130 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=1, notRdy=false]
2021-11-04 00:31:22.130 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:22.130 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2021-11-04 00:31:22.130 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2021-11-04 00:31:22.130 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_SUPPORTED_NETWORKS]
2021-11-04 00:31:22.130 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:22.145 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=1, ackNum=1, reTx=false, data=B4 00 01 52 00 2D]
2021-11-04 00:31:22.530 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=1, ackNum=2, reTx=false, data=B4 80 01 52 00 00 01 00]
2021-11-04 00:31:22.530 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=1, ackNum=1, reTx=false, data=B4 00 01 52 00 2D]
2021-11-04 00:31:22.530 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:22.530 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:22.530 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=2, notRdy=false]
2021-11-04 00:31:22.546 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2021-11-04 00:31:22.546 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2021-11-04 00:31:22.546 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_KEY_TABLE_SIZE]
2021-11-04 00:31:22.546 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:22.546 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=false, data=B5 00 01 52 00 1E]
2021-11-04 00:31:22.584 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=2, ackNum=3, reTx=false, data=B5 80 01 52 00 00 04 00]
2021-11-04 00:31:22.584 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=2, ackNum=2, reTx=false, data=B5 00 01 52 00 1E]
2021-11-04 00:31:22.584 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:22.584 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:22.584 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=3, notRdy=false]
2021-11-04 00:31:22.599 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=4]
2021-11-04 00:31:22.599 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=4]
2021-11-04 00:31:22.599 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_APPLICATION_ZDO_FLAGS]
2021-11-04 00:31:22.599 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:22.599 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=3, ackNum=3, reTx=false, data=B6 00 01 52 00 2A]
2021-11-04 00:31:22.947 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=3, ackNum=4, reTx=false, data=B6 80 01 52 00 00 01 00]
2021-11-04 00:31:22.947 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=3, ackNum=3, reTx=false, data=B6 00 01 52 00 2A]
2021-11-04 00:31:22.947 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:22.947 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:22.947 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=4, notRdy=false]
2021-11-04 00:31:22.947 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2021-11-04 00:31:22.947 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2021-11-04 00:31:22.947 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_MAX_END_DEVICE_CHILDREN]
2021-11-04 00:31:22.947 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:22.947 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=4, ackNum=4, reTx=false, data=B7 00 01 52 00 11]
2021-11-04 00:31:23.147 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=4, ackNum=5, reTx=false, data=B7 80 01 52 00 00 10 00]
2021-11-04 00:31:23.147 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=4, ackNum=4, reTx=false, data=B7 00 01 52 00 11]
2021-11-04 00:31:23.147 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:23.147 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:23.147 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=5, notRdy=false]
2021-11-04 00:31:23.147 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2021-11-04 00:31:23.147 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2021-11-04 00:31:23.147 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_APS_UNICAST_MESSAGE_COUNT]
2021-11-04 00:31:23.147 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:23.147 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=5, ackNum=5, reTx=false, data=B8 00 01 52 00 03]
2021-11-04 00:31:23.517 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=5, ackNum=6, reTx=false, data=B8 80 01 52 00 00 0A 00]
2021-11-04 00:31:23.517 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=5, ackNum=5, reTx=false, data=B8 00 01 52 00 03]
2021-11-04 00:31:23.517 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:23.517 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=6, notRdy=false]
2021-11-04 00:31:23.517 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:23.517 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=10]
2021-11-04 00:31:23.517 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=10]
2021-11-04 00:31:23.517 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_BROADCAST_TABLE_SIZE]
2021-11-04 00:31:23.517 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:23.517 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=6, ackNum=6, reTx=false, data=B9 00 01 52 00 2B]
2021-11-04 00:31:23.617 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=6, ackNum=7, reTx=false, data=B9 80 01 52 00 00 0F 00]
2021-11-04 00:31:23.617 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=6, ackNum=6, reTx=false, data=B9 00 01 52 00 2B]
2021-11-04 00:31:23.617 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:23.617 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=7, notRdy=false]
2021-11-04 00:31:23.617 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:23.633 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=15]
2021-11-04 00:31:23.633 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=15]
2021-11-04 00:31:23.633 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_BINDING_TABLE_SIZE]
2021-11-04 00:31:23.633 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:23.633 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=7, ackNum=7, reTx=false, data=BA 00 01 52 00 04]
2021-11-04 00:31:23.971 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=7, ackNum=0, reTx=false, data=BA 80 01 52 00 00 02 00]
2021-11-04 00:31:23.971 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=7, ackNum=7, reTx=false, data=BA 00 01 52 00 04]
2021-11-04 00:31:23.971 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:23.971 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:23.971 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=0, notRdy=false]
2021-11-04 00:31:23.971 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
2021-11-04 00:31:23.971 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=2]
2021-11-04 00:31:23.971 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_NEIGHBOR_TABLE_SIZE]
2021-11-04 00:31:23.971 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:23.971 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=0, ackNum=0, reTx=false, data=BB 00 01 52 00 02]
2021-11-04 00:31:24.302 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=0, ackNum=1, reTx=false, data=BB 80 01 52 00 00 10 00]
2021-11-04 00:31:24.302 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=0, ackNum=0, reTx=false, data=BB 00 01 52 00 02]
2021-11-04 00:31:24.302 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:24.302 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:24.302 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=1, notRdy=false]
2021-11-04 00:31:24.302 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2021-11-04 00:31:24.302 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=16]
2021-11-04 00:31:24.302 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_FRAGMENT_WINDOW_SIZE]
2021-11-04 00:31:24.302 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:24.302 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=1, ackNum=1, reTx=false, data=BC 00 01 52 00 1C]
2021-11-04 00:31:24.402 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameData [frmNum=1, ackNum=2, reTx=false, data=BC 80 01 52 00 00 01 00]
2021-11-04 00:31:24.402 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Frame acked and removed AshFrameData [frmNum=1, ackNum=1, reTx=false, data=BC 00 01 52 00 1C]
2021-11-04 00:31:24.402 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH added EZSP frame to receive queue. Queue length 1
2021-11-04 00:31:24.402 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameAck [ackNum=2, notRdy=false]
2021-11-04 00:31:24.402 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH took EZSP frame from receive queue. Queue length 0
2021-11-04 00:31:24.402 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - RX EZSP: EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2021-11-04 00:31:24.402 [DEBUG] [systems.zigbee.dongle.ember.EmberNcp] - EzspGetConfigurationValueResponse [networkId=0, status=EZSP_SUCCESS, value=1]
2021-11-04 00:31:24.402 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH TX EZSP: EzspGetConfigurationValueRequest [networkId=0, configId=EZSP_CONFIG_FRAGMENT_DELAY_MS]
2021-11-04 00:31:24.402 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: TX EZSP queue size: 1
2021-11-04 00:31:24.402 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=false, data=BD 00 01 52 00 1D]
2021-11-04 00:31:24.819 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - <-- RX ASH frame: AshFrameNak [ackNum=2, notRdy=false]
2021-11-04 00:31:24.819 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Retry Sent Queue Length 1
2021-11-04 00:31:24.819 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=true, data=BD 00 01 52 00 1D]
2021-11-04 00:31:25.836 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Retry Sent Queue Length 1
2021-11-04 00:31:25.836 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=true, data=BD 00 01 52 00 1D]
2021-11-04 00:31:27.855 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Retry Sent Queue Length 1
2021-11-04 00:31:27.855 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=true, data=BD 00 01 52 00 1D]
2021-11-04 00:31:31.075 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Retry Sent Queue Length 1
2021-11-04 00:31:31.075 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=true, data=BD 00 01 52 00 1D]
2021-11-04 00:31:34.290 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Retry Sent Queue Length 1
2021-11-04 00:31:34.290 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=true, data=BD 00 01 52 00 1D]
2021-11-04 00:31:34.431 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - Sending EZSP transaction timed out after 10 seconds
2021-11-04 00:31:34.431 [WARN ] [mmon.WrappedScheduledExecutorService] - Scheduled runnable ended with an exception: 
java.lang.NullPointerException: null
	at com.zsmartsystems.zigbee.dongle.ember.EmberNcp.getConfiguration(EmberNcp.java:446) ~[?:?]
	at com.zsmartsystems.zigbee.dongle.ember.internal.EmberStackConfiguration.getConfiguration(EmberStackConfiguration.java:72) ~[?:?]
	at com.zsmartsystems.zigbee.dongle.ember.ZigBeeDongleEzsp.initialize(ZigBeeDongleEzsp.java:443) ~[?:?]
	at com.zsmartsystems.zigbee.ZigBeeNetworkManager.initialize(ZigBeeNetworkManager.java:420) ~[?:?]
	at org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler.initialiseZigBee(ZigBeeCoordinatorHandler.java:433) ~[?:?]
	at org.openhab.binding.zigbee.handler.ZigBeeCoordinatorHandler.lambda$2(ZigBeeCoordinatorHandler.java:559) ~[?:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) ~[?:?]
	at java.util.concurrent.FutureTask.run(FutureTask.java:264) ~[?:?]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:304) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [?:?]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [?:?]
	at java.lang.Thread.run(Thread.java:829) [?:?]
2021-11-04 00:31:37.501 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Retry Sent Queue Length 1
2021-11-04 00:31:37.501 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - --> TX ASH frame: AshFrameData [frmNum=2, ackNum=2, reTx=true, data=BD 00 01 52 00 1D]
2021-11-04 00:31:40.717 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Error number of retries exceeded [6].
2021-11-04 00:31:40.717 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - ASH: Disconnected!
2021-11-04 00:31:40.717 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - AshFrameHandler close.
2021-11-04 00:31:40.717 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember: Link State change to false, initialised=false, networkStateUp=false
2021-11-04 00:31:40.717 [DEBUG] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Ember: Link State change to false ignored.
2021-11-04 00:31:40.717 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - AshFrameHandler interrupted in packet parser thread shutdown join.
2021-11-04 00:31:40.717 [DEBUG] [e.ember.internal.ash.AshFrameHandler] - AshReceiveParserThread exited.