ZigBee binding resets configuration of serial port after reboot

Hi,

my setup:

openhab2 ver. 2.5.0-1 on openhabian

I have two USB-Sticks: 1 455-USB-CUL and 1 USB-Ember-ZigBee-Stick

To get not in trouble with the ttyusb[#]-counting, I created tow symlinks:
/dev/ttyUSBZeeBee
and
/dev/ttyUSBCUL

In “Paper UI” I configured the ZigBee-coordinator-thing to the Port “/dev/tty/USBZigBee”. So far so good - it works fine.

But after a reboot the ZigBee-coordinator-thing is automaticly reconfigured to Port /dev/ttyusb1 (and this is not the right one).

Is this an issue of OpenHAB or of the ZigBee-binding? Or did I something wrong?

Thanks for support!


Skyhawk

What type of dongle are you using???

I use the dongle from Bitron Video.

I’m not aware of any problems with the Ember being reconfigured. The binding shouldn’t change the port - what do the debug logs show is happening?

Extract from the “openhab.log”:

[...]
2019-12-21 21:46:44.033 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - Scheduling timeout task for thingUID=zigbee:device:01382CB3:7cb03eaa0a00a37f in 1830 seconds
2019-12-21 21:57:40.684 [INFO ] [panel.internal.HABPanelDashboardTile] - Stopped HABPanel
2019-12-21 21:57:40.747 [INFO ] [openhab.ui.paper.internal.PaperUIApp] - Stopped Paper UI
2019-12-21 21:57:40.953 [INFO ] [basic.internal.servlet.WebAppServlet] - Stopped Basic UI
2019-12-21 21:57:41.124 [INFO ] [io.openhabcloud.internal.CloudClient] - Shutting down openHAB Cloud service connection
2019-12-21 21:57:41.170 [INFO ] [io.openhabcloud.internal.CloudClient] - Disconnected from the openHAB Cloud service (UUID = xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxxx, base URL = http://localhost:8080)
2019-12-21 21:57:43.668 [WARN ] [ternal.AbstractCULHandler$SendThread] - Failed to wait for queue: java.lang.InterruptedException
2019-12-21 21:57:43.850 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Handler dispose.
2019-12-21 21:57:43.852 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Polling stopped
2019-12-21 21:57:43.854 [DEBUG] [rter.ZigBeeConverterMeasurementPower] - 7CB03EAA0A00A37F: Closing electrical measurement cluster
2019-12-21 21:57:43.856 [DEBUG] [converter.ZigBeeConverterSwitchOnoff] - 7CB03EAA0A00A37F: Closing device on/off cluster
2019-12-21 21:57:43.858 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - Remove IsAlive Tracker for thingUID=zigbee:device:01382CB3:7cb03eaa0a00a37f
2019-12-21 21:57:43.859 [DEBUG] [.zigbee.handler.ZigBeeIsAliveTracker] - Canceling timeout task for thingUID=zigbee:device:01382CB3:7cb03eaa0a00a37f
2019-12-21 21:57:43.886 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2019-12-21 21:57:43.922 [DEBUG] [ding.zigbee.handler.ZigBeeSerialPort] - Serial port '/dev/ttyUSBZeeBee' closed.
2019-12-21 21:57:43.927 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee network [zigbee:coordinator_ember:01382CB3] closed.
2019-12-21 21:57:44.303 [INFO ] [control.internal.WebSocketConnection] - Web Socket close 1006. Reason: Disconnected
2019-12-21 21:57:44.858 [INFO ] [.dashboard.internal.DashboardService] - Stopped Dashboard
2019-12-21 21:57:48.608 [ERROR] [e.internal.engine.RuleTriggerManager] - Error while starting the scheduler service: The Scheduler cannot be restarted after shutdown() has been called.
--- REBOOT ---
2019-12-21 21:58:49.851 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'standard.items'
2019-12-21 21:58:50.306 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'astro.items'
2019-12-21 21:58:52.160 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'standard.sitemap'
2019-12-21 21:58:57.646 [INFO ] [thome.model.lsp.internal.ModelServer] - Started Language Server Protocol (LSP) service on port 5007
2019-12-21 21:59:05.400 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'weihnachten.rules'
2019-12-21 21:59:08.400 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at http://192.168.178.32:8080
2019-12-21 21:59:08.402 [INFO ] [.dashboard.internal.DashboardService] - Started Dashboard at https://192.168.178.32:8443
2019-12-21 21:59:10.116 [DEBUG] [bee.discovery.ZigBeeDiscoveryService] - Starting ZigBeeDiscoveryService
2019-12-21 21:59:10.372 [INFO ] [.handler.FlashBriefingProfileHandler] - FlashBriefingProfileHandler initialized
2019-12-21 21:59:11.393 [INFO ] [enhab.binding.astro.internal.job.Job] - Scheduled Astro event-jobs for thing astro:sun:local
2019-12-21 21:59:11.631 [INFO ] [o.internal.handler.AstroThingHandler] - Scheduled Positional job astro:sun:local every 300 seconds
2019-12-21 21:59:11.906 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - Initializing ZigBee Ember serial bridge handler.
2019-12-21 21:59:11.909 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initializing ZigBee network [zigbee:coordinator_ember:01382CB3].
2019-12-21 21:59:11.938 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Channel 11
2019-12-21 21:59:11.940 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - PANID xxxx
2019-12-21 21:59:11.942 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - EPANID xxxxxxxxxxxxxxxx
2019-12-21 21:59:11.951 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Network Key yyyyyyyyyyyyyyyyyyyyyyyyyyyyyyyy
2019-12-21 21:59:11.953 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Link Key zzzzzzzzzzzzzzzzzzzzzzzzzzzzzzzz
2019-12-21 21:59:11.962 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Config: zigbee_initialise found, initializeNetwork=false
2019-12-21 21:59:11.964 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Network Key String yyyyyyyyyyyyyyyyyyyyyyyyyyyyyyyy
2019-12-21 21:59:11.970 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Network key final array yyyyyyyyyyyyyyyyyyyyyyyyyyyyyyyy
2019-12-21 21:59:11.977 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Link Key String zzzzzzzzzzzzzzzzzzzzzzzzzzzzzzzz
2019-12-21 21:59:11.981 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Link key final array zzzzzzzzzzzzzzzzzzzzzzzzzzzzzzzz
2019-12-21 21:59:12.127 [INFO ] [enhab.binding.astro.internal.job.Job] - Scheduled Astro event-jobs for thing astro:sun:local
2019-12-21 21:59:12.241 [INFO ] [o.internal.handler.AstroThingHandler] - Scheduled Positional job astro:sun:local every 300 seconds
2019-12-21 21:59:12.316 [INFO ] [enhab.binding.astro.internal.job.Job] - Scheduled Astro event-jobs for thing astro:moon:local
2019-12-21 21:59:12.341 [INFO ] [o.internal.handler.AstroThingHandler] - Scheduled Positional job astro:moon:local every 300 seconds
2019-12-21 21:59:12.357 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - ZigBee Ember Coordinator opening Port:'/dev/ttyUSBZeeBee' PAN:aaaa, EPAN:xxxxxxxxxxxxxxxx, Channel:11
2019-12-21 21:59:12.369 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - Ember end device poll timout set to (225 * 2^5) = 7200 seconds
2019-12-21 21:59:12.407 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Scheduling ZigBee start
2019-12-21 21:59:12.564 [WARN ] [io.transport.cul.CULLifecycleManager] - CUL config is NULL, doing nothing
2019-12-21 21:59:12.616 [INFO ] [ternal.serial.CULSerialConfigFactory] - Update config, baudrate = 38400
2019-12-21 21:59:12.618 [INFO ] [ternal.serial.CULSerialConfigFactory] - Update config, parity = NONE (0)
2019-12-21 21:59:12.752 [INFO ] [enhab.binding.astro.internal.job.Job] - Scheduled Astro event-jobs for thing astro:moon:local
2019-12-21 21:59:12.756 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Initializing ZigBee thing handler zigbee:device:01382CB3:7cb03eaa0a00a37f
2019-12-21 21:59:12.762 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to UNKNOWN.
2019-12-21 21:59:12.764 [INFO ] [o.internal.handler.AstroThingHandler] - Scheduled Positional job astro:moon:local every 300 seconds
2019-12-21 21:59:12.764 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Channel zigbee:device:01382CB3:7cb03eaa0a00a37f:7CB03EAA0A00A37F_3_switch linked - polling started.
2019-12-21 21:59:12.781 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:13.168 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee network [zigbee:coordinator_ember:01382CB3] closed.
2019-12-21 21:59:13.170 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - Initializing ZigBee Ember serial bridge handler.
2019-12-21 21:59:13.172 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initializing ZigBee network [zigbee:coordinator_ember:01382CB3].
2019-12-21 21:59:13.174 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Channel 11
2019-12-21 21:59:13.176 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - PANID xxxx
2019-12-21 21:59:13.178 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - EPANID xxxxxxxxxxxxxxxx
2019-12-21 21:59:13.191 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Network Key yyyyyyyyyyyyyyyyyyyyyyyyyyyyyyyy
2019-12-21 21:59:13.193 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Link Key zzzzzzzzzzzzzzzzzzzzzzzzzzzzzzzz
2019-12-21 21:59:13.195 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Config: zigbee_initialise found, initializeNetwork=false
2019-12-21 21:59:13.197 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Network Key String yyyyyyyyyyyyyyyyyyyyyyyyyyyyyyyy
2019-12-21 21:59:13.200 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Network key final array yyyyyyyyyyyyyyyyyyyyyyyyyyyyyyyy
2019-12-21 21:59:13.213 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Link Key String zzzzzzzzzzzzzzzzzzzzzzzzzzzzzzzz
2019-12-21 21:59:13.216 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Link key final array zzzzzzzzzzzzzzzzzzzzzzzzzzzzzzzz
2019-12-21 21:59:13.220 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - ZigBee Ember Coordinator opening Port:'/dev/ttyUSB1' PAN:15d4, EPAN:xxxxxxxxxxxxxxxx, Channel:11
2019-12-21 21:59:13.224 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - Ember end device poll timout set to (225 * 2^5) = 7200 seconds
2019-12-21 21:59:13.227 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Scheduling ZigBee start
2019-12-21 21:59:13.229 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Updating coordinator [zigbee:coordinator_ember:01382CB3]
2019-12-21 21:59:14.230 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee network starting
2019-12-21 21:59:14.231 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2019-12-21 21:59:14.306 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Mesh Update Period 86400
2019-12-21 21:59:14.330 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
2019-12-21 21:59:14.447 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 000D6F000DC5596F: ZigBee reading network state complete.
2019-12-21 21:59:14.817 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 7CB03EAA0A00A37F: ZigBee reading network state complete.
2019-12-21 21:59:15.557 [DEBUG] [ding.zigbee.handler.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB1] at 57600 baud, flow control FLOWCONTROL_OUT_XONOFF.
2019-12-21 21:59:15.570 [ERROR] [ding.zigbee.handler.ZigBeeSerialPort] - Serial Error: Port /dev/ttyUSB1 does not exist.
2019-12-21 21:59:15.572 [ERROR] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Unable to open Ember serial port
2019-12-21 21:59:15.574 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2019-12-21 21:59:15.594 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:15.597 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:15.600 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:15.607 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:16.442 [INFO ] [io.openhabcloud.internal.CloudClient] - Connected to the openHAB Cloud service (UUID = xxxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxxx, base URL = http://localhost:8080)
2019-12-21 21:59:16.598 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2019-12-21 21:59:16.603 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2019-12-21 21:59:16.606 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Mesh Update Period 86400
2019-12-21 21:59:16.665 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
2019-12-21 21:59:16.677 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 000D6F000DC5596F: ZigBee reading network state complete.
2019-12-21 21:59:16.748 [INFO ] [openhab.ui.paper.internal.PaperUIApp] - Started Paper UI at /paperui
2019-12-21 21:59:16.914 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 7CB03EAA0A00A37F: ZigBee reading network state complete.
2019-12-21 21:59:16.924 [DEBUG] [ding.zigbee.handler.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB1] at 57600 baud, flow control FLOWCONTROL_OUT_XONOFF.
2019-12-21 21:59:16.937 [ERROR] [ding.zigbee.handler.ZigBeeSerialPort] - Serial Error: Port /dev/ttyUSB1 does not exist.
2019-12-21 21:59:16.939 [ERROR] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Unable to open Ember serial port
2019-12-21 21:59:16.941 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2019-12-21 21:59:16.962 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:16.964 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:16.964 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:16.967 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:17.161 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel
2019-12-21 21:59:21.970 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2019-12-21 21:59:21.972 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2019-12-21 21:59:21.974 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Mesh Update Period 86400
2019-12-21 21:59:21.998 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
2019-12-21 21:59:22.020 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 000D6F000DC5596F: ZigBee reading network state complete.
2019-12-21 21:59:22.185 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 7CB03EAA0A00A37F: ZigBee reading network state complete.
2019-12-21 21:59:22.192 [DEBUG] [ding.zigbee.handler.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB1] at 57600 baud, flow control FLOWCONTROL_OUT_XONOFF.
2019-12-21 21:59:22.205 [ERROR] [ding.zigbee.handler.ZigBeeSerialPort] - Serial Error: Port /dev/ttyUSB1 does not exist.
2019-12-21 21:59:22.207 [ERROR] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Unable to open Ember serial port
2019-12-21 21:59:22.208 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2019-12-21 21:59:22.211 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:22.212 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:22.213 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:22.214 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:27.220 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2019-12-21 21:59:27.225 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2019-12-21 21:59:27.228 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Mesh Update Period 86400
2019-12-21 21:59:27.231 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
2019-12-21 21:59:27.248 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 000D6F000DC5596F: ZigBee reading network state complete.
2019-12-21 21:59:27.408 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 7CB03EAA0A00A37F: ZigBee reading network state complete.
2019-12-21 21:59:27.415 [DEBUG] [ding.zigbee.handler.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB1] at 57600 baud, flow control FLOWCONTROL_OUT_XONOFF.
2019-12-21 21:59:27.429 [ERROR] [ding.zigbee.handler.ZigBeeSerialPort] - Serial Error: Port /dev/ttyUSB1 does not exist.
2019-12-21 21:59:27.431 [ERROR] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Unable to open Ember serial port
2019-12-21 21:59:27.433 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2019-12-21 21:59:27.442 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:27.444 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:27.444 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:27.446 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:32.447 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2019-12-21 21:59:32.452 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2019-12-21 21:59:32.454 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Mesh Update Period 86400
2019-12-21 21:59:32.457 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
2019-12-21 21:59:32.468 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 000D6F000DC5596F: ZigBee reading network state complete.
2019-12-21 21:59:32.622 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 7CB03EAA0A00A37F: ZigBee reading network state complete.
2019-12-21 21:59:32.629 [DEBUG] [ding.zigbee.handler.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB1] at 57600 baud, flow control FLOWCONTROL_OUT_XONOFF.
2019-12-21 21:59:32.643 [ERROR] [ding.zigbee.handler.ZigBeeSerialPort] - Serial Error: Port /dev/ttyUSB1 does not exist.
2019-12-21 21:59:32.645 [ERROR] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Unable to open Ember serial port
2019-12-21 21:59:32.647 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2019-12-21 21:59:32.651 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:32.653 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:32.657 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:32.659 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:37.666 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2019-12-21 21:59:37.671 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2019-12-21 21:59:37.675 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Mesh Update Period 86400
2019-12-21 21:59:37.678 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
2019-12-21 21:59:37.716 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 000D6F000DC5596F: ZigBee reading network state complete.
2019-12-21 21:59:37.875 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 7CB03EAA0A00A37F: ZigBee reading network state complete.
2019-12-21 21:59:37.883 [DEBUG] [ding.zigbee.handler.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB1] at 57600 baud, flow control FLOWCONTROL_OUT_XONOFF.
2019-12-21 21:59:37.897 [ERROR] [ding.zigbee.handler.ZigBeeSerialPort] - Serial Error: Port /dev/ttyUSB1 does not exist.
2019-12-21 21:59:37.898 [ERROR] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Unable to open Ember serial port
2019-12-21 21:59:37.901 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2019-12-21 21:59:37.905 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:37.907 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:37.913 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:37.915 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:42.912 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2019-12-21 21:59:42.917 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2019-12-21 21:59:42.922 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Mesh Update Period 86400
2019-12-21 21:59:42.925 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
2019-12-21 21:59:42.940 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 000D6F000DC5596F: ZigBee reading network state complete.
2019-12-21 21:59:43.098 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 7CB03EAA0A00A37F: ZigBee reading network state complete.
2019-12-21 21:59:43.106 [DEBUG] [ding.zigbee.handler.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB1] at 57600 baud, flow control FLOWCONTROL_OUT_XONOFF.
2019-12-21 21:59:43.119 [ERROR] [ding.zigbee.handler.ZigBeeSerialPort] - Serial Error: Port /dev/ttyUSB1 does not exist.
2019-12-21 21:59:43.121 [ERROR] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Unable to open Ember serial port
2019-12-21 21:59:43.123 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2019-12-21 21:59:43.129 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:43.130 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:43.131 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:43.133 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:48.147 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2019-12-21 21:59:48.152 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2019-12-21 21:59:48.154 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Mesh Update Period 86400
2019-12-21 21:59:48.156 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
2019-12-21 21:59:48.168 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 000D6F000DC5596F: ZigBee reading network state complete.
2019-12-21 21:59:48.303 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 7CB03EAA0A00A37F: ZigBee reading network state complete.
2019-12-21 21:59:48.309 [DEBUG] [ding.zigbee.handler.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB1] at 57600 baud, flow control FLOWCONTROL_OUT_XONOFF.
2019-12-21 21:59:48.319 [ERROR] [ding.zigbee.handler.ZigBeeSerialPort] - Serial Error: Port /dev/ttyUSB1 does not exist.
2019-12-21 21:59:48.320 [ERROR] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Unable to open Ember serial port
2019-12-21 21:59:48.325 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:48.327 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:48.322 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2019-12-21 21:59:48.332 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:48.334 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:53.331 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2019-12-21 21:59:53.337 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2019-12-21 21:59:53.345 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Mesh Update Period 86400
2019-12-21 21:59:53.348 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
2019-12-21 21:59:53.362 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 000D6F000DC5596F: ZigBee reading network state complete.
2019-12-21 21:59:53.510 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 7CB03EAA0A00A37F: ZigBee reading network state complete.
2019-12-21 21:59:53.518 [DEBUG] [ding.zigbee.handler.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB1] at 57600 baud, flow control FLOWCONTROL_OUT_XONOFF.
2019-12-21 21:59:53.530 [ERROR] [ding.zigbee.handler.ZigBeeSerialPort] - Serial Error: Port /dev/ttyUSB1 does not exist.
2019-12-21 21:59:53.533 [ERROR] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Unable to open Ember serial port
2019-12-21 21:59:53.535 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2019-12-21 21:59:53.542 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:53.541 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:53.543 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:53.543 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:58.542 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2019-12-21 21:59:58.545 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2019-12-21 21:59:58.555 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Mesh Update Period 86400
2019-12-21 21:59:58.557 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
2019-12-21 21:59:58.570 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 000D6F000DC5596F: ZigBee reading network state complete.
2019-12-21 21:59:58.737 [DEBUG] [ding.zigbee.internal.ZigBeeDataStore] - 7CB03EAA0A00A37F: ZigBee reading network state complete.
2019-12-21 21:59:58.743 [DEBUG] [ding.zigbee.handler.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB1] at 57600 baud, flow control FLOWCONTROL_OUT_XONOFF.
2019-12-21 21:59:58.755 [ERROR] [ding.zigbee.handler.ZigBeeSerialPort] - Serial Error: Port /dev/ttyUSB1 does not exist.
2019-12-21 21:59:58.757 [ERROR] [zigbee.dongle.ember.ZigBeeDongleEzsp] - Unable to open Ember serial port
2019-12-21 21:59:58.758 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2019-12-21 21:59:58.764 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:58.766 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 21:59:58.771 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator status changed to OFFLINE.
2019-12-21 21:59:58.774 [DEBUG] [ng.zigbee.handler.ZigBeeThingHandler] - 7CB03EAA0A00A37F: Coordinator is unknown or not online.
2019-12-21 22:00:03.774 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
[...]

Thanks. Please raise an issue on Github. I’m tempted to remove the USB searching from the binding - this was something added in ESH, but I removed it from ZWave as it caused problems and I think we should do the same here.