Hi all,
I dove in again to re-install my OH system fresh, then restored backups.
OH 2.5.2 release build, Raspberry Pi 3B+, running off of SSD (no microSD)
I did a fresh install, then restored my OH backup, then restored my influxdb backup.
Much looks to be working correctly, however I’m having issues with zwave.
I’ve tried a variety of approaches - using the stock 2.5.2 zwave binding, removing it and manually adding the 2.5.0 snapshot (Nov 16 2019) that I had been using when the backup was made, removing it and going back to the stock 2.5.2 binding. I deleted and re-added my z-wave controller (RaZberry hat)
Watching the logs after doing this the last time revealed the controller revealed that it was successfully getting updates when it suddenly was deactivated. It seems to my simplistic look that a scheduler shutdown the zwave service. I can’t figure out why, and would appreciate suggestions on where to look. The relevant log is below.
==> /var/log/openhab2/events.log <==
2020-03-02 23:23:37.302 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 39 to 40
==> /var/log/openhab2/openhab.log <==
2020-03-02 23:23:37.371 [DEBUG] [.internal.InfluxDBPersistenceService] - got DecimalType value 44
==> /var/log/openhab2/events.log <==
2020-03-02 23:23:37.372 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 43 to 44
==> /var/log/openhab2/openhab.log <==
2020-03-02 23:23:37.930 [INFO ] [org.quartz.core.QuartzScheduler ] - Scheduler openHAB-job-scheduler_$_NON_CLUSTERED started.
2020-03-02 23:23:40.470 [INFO ] [internal.service.FeaturesServiceImpl] - No deployment change.
2020-03-02 23:23:40.474 [INFO ] [internal.service.FeaturesServiceImpl] - Stopping bundles:
2020-03-02 23:23:40.477 [INFO ] [internal.service.FeaturesServiceImpl] - org.openhab.core.config.serial/2.5.0
2020-03-02 23:23:40.500 [INFO ] [internal.service.FeaturesServiceImpl] - org.openhab.binding.zwave/2.5.2
==> /var/log/openhab2/events.log <==
2020-03-02 23:23:40.609 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:6fa78702' changed from ONLINE to UNINITIALIZED
2020-03-02 23:23:40.784 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:6fa78702' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
My zwave client devices seem to come online when the controller is up and receiving updates per the log, then the statuses all go to UNINITIALIZED-HANDLER MISSING .
A bigger grab from the logs of all of my logs, filtered for the controller name, is:
[...]
2020-03-02 23:55:28.121 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 58 to 59
2020-03-02 23:55:28.149 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node16' changed from ONLINE: Node initialising: REQUEST_NIF to OFFLINE (COMMUNICATION_ERROR): Node is not communicating with controller
2020-03-02 23:55:28.177 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 47 to 48
2020-03-02 23:55:28.246 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 59 to 60
2020-03-02 23:55:32.934 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 60 to 61
2020-03-02 23:55:32.961 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 48 to 49
2020-03-02 23:55:33.031 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 61 to 62
2020-03-02 23:55:35.657 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node34' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-02 23:55:35.744 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node34' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:55:35.749 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node14' changed from OFFLINE (COMMUNICATION_ERROR): Node is not communicating with controller to UNINITIALIZED
2020-03-02 23:55:35.812 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node14' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:55:35.816 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node35' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-02 23:55:35.870 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node35' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:55:35.874 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node18' changed from ONLINE: Node initialising: REQUEST_NIF to UNINITIALIZED
2020-03-02 23:55:35.927 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node18' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:55:35.931 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node33' changed from ONLINE: Node initialising: REQUEST_NIF to UNINITIALIZED
2020-03-02 23:55:35.980 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node33' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:55:35.982 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node32' changed from ONLINE: Node initialising: REQUEST_NIF to UNINITIALIZED
2020-03-02 23:55:36.031 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node32' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:55:36.034 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node30' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-02 23:55:36.080 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node30' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:55:36.082 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node12' changed from OFFLINE (COMMUNICATION_ERROR): Node is not communicating with controller to UNINITIALIZED
2020-03-02 23:55:36.133 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node12' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:55:36.135 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node20' changed from ONLINE: Node initialising: REQUEST_NIF to UNINITIALIZED
2020-03-02 23:55:36.181 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node20' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:55:36.184 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node16' changed from OFFLINE (COMMUNICATION_ERROR): Node is not communicating with controller to UNINITIALIZED
[...]
2020-03-02 23:55:36.761 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node24' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-02 23:55:36.801 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node24' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:55:36.803 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:6fa78702' changed from ONLINE to UNINITIALIZED
2020-03-02 23:55:37.005 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:6fa78702' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:55:49.020 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:6fa78702' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.041 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:6fa78702' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.095 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node9' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.118 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node9' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.179 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node14' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.186 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node30' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.190 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node29' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.202 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node35' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.206 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node37' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.214 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node30' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.219 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node14' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.237 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node12' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.246 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node19' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.250 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node29' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.260 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node35' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.269 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node37' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.282 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node12' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.303 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node19' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.307 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node20' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.310 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node16' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.317 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node18' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.321 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node20' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.336 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node16' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.347 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node18' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.375 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node22' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.389 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node11' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.392 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node33' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.396 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node31' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.399 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node32' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.417 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node11' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.430 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node33' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.435 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node22' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.489 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node31' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.499 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node36' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.502 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node32' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.511 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node24' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.515 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node21' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.520 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node23' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.525 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node36' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.543 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node23' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.547 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node10' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.550 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node21' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.554 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node24' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.558 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node34' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.563 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node6' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-02 23:55:49.577 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node10' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.590 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node6' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:49.597 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node34' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-02 23:55:54.130 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 62 to 0
2020-03-02 23:55:54.139 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 49 to 0
2020-03-02 23:55:57.259 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 0 to 1
2020-03-02 23:55:57.267 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 0 to 1
2020-03-02 23:55:57.352 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 1 to 2
2020-03-02 23:55:57.354 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 1 to 2
2020-03-02 23:55:57.423 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 2 to 3
2020-03-02 23:55:57.425 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 2 to 3
2020-03-02 23:55:57.489 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 3 to 4
2020-03-02 23:55:57.491 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 3 to 4
2020-03-02 23:55:57.551 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 4 to 5
2020-03-02 23:55:57.553 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 4 to 5
2020-03-02 23:55:57.607 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 5 to 6
2020-03-02 23:55:57.667 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 5 to 6
2020-03-02 23:55:58.042 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 6 to 7
2020-03-02 23:55:58.047 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 6 to 7
2020-03-02 23:55:58.899 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 7 to 8
2020-03-02 23:55:58.903 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 7 to 8
2020-03-02 23:55:58.973 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 8 to 9
2020-03-02 23:55:58.984 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 8 to 9
2020-03-02 23:55:59.035 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 9 to 10
2020-03-02 23:55:59.280 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 9 to 10
2020-03-02 23:56:04.356 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 10 to 11
2020-03-02 23:56:04.392 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 10 to 11
2020-03-02 23:56:04.640 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 11 to 12
2020-03-02 23:56:08.133 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:6fa78702' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.140 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node30' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.155 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node29' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.163 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node14' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.170 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node35' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.178 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node9' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.186 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from NULL to 12
2020-03-02 23:56:08.200 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from NULL to 11
2020-03-02 23:56:08.221 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_nak changed from NULL to 0
2020-03-02 23:56:08.245 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_can changed from NULL to 0
2020-03-02 23:56:08.271 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node37' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.279 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node12' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.294 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node19' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.303 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node20' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.314 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node16' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.321 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node33' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.326 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node22' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.333 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node18' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.340 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node32' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.343 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_oof changed from NULL to 0
2020-03-02 23:56:08.346 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node21' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.352 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node23' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.358 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node36' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.363 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node24' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.372 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node10' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.377 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node11' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.380 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node31' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.383 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node6' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.389 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node34' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
2020-03-02 23:56:08.415 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_cse changed from NULL to 0
2020-03-02 23:56:08.418 [me.event.ThingUpdatedEvent] - Thing 'zwave:serial_zstick:6fa78702' has been updated.
2020-03-02 23:56:09.724 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 12 to 13
2020-03-02 23:56:09.753 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 11 to 12
2020-03-02 23:56:09.770 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 13 to 14
2020-03-02 23:56:09.844 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 12 to 13
2020-03-02 23:56:09.849 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 14 to 15
2020-03-02 23:56:09.856 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node31' changed from ONLINE to ONLINE: Node initialising: REQUEST_NIF
2020-03-02 23:56:09.904 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node19' changed from ONLINE to ONLINE: Node initialising: REQUEST_NIF
2020-03-02 23:56:09.943 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 13 to 14
2020-03-02 23:56:09.949 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 15 to 16
2020-03-02 23:56:09.975 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node32' changed from ONLINE to ONLINE: Node initialising: REQUEST_NIF
2020-03-02 23:56:09.996 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 14 to 15
2020-03-02 23:56:09.999 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 16 to 17
2020-03-02 23:56:10.053 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node36' changed from ONLINE to ONLINE: Node initialising: PING
2020-03-02 23:56:10.093 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 15 to 16
2020-03-02 23:56:10.095 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 17 to 18
2020-03-02 23:56:10.154 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 16 to 17
2020-03-02 23:56:10.156 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node22' changed from ONLINE to ONLINE: Node initialising: REQUEST_NIF
2020-03-02 23:56:10.183 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 18 to 19
2020-03-02 23:56:10.227 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node35' changed from ONLINE to ONLINE: Node initialising: PING
2020-03-02 23:56:10.247 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 17 to 18
2020-03-02 23:56:10.249 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 19 to 20
2020-03-02 23:56:10.304 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node23' changed from ONLINE to ONLINE: Node initialising: REQUEST_NIF
2020-03-02 23:56:10.317 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 18 to 19
2020-03-02 23:56:10.327 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 20 to 21
2020-03-02 23:56:10.377 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node14' changed from ONLINE to ONLINE: Node initialising: REQUEST_NIF
2020-03-02 23:56:10.426 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 19 to 20
2020-03-02 23:56:10.431 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 21 to 22
2020-03-02 23:56:10.487 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node18' changed from ONLINE to ONLINE: Node initialising: REQUEST_NIF
2020-03-02 23:56:10.511 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 20 to 21
2020-03-02 23:56:10.536 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 22 to 23
2020-03-02 23:56:10.562 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node24' changed from ONLINE to ONLINE: Node initialising: PING
2020-03-02 23:56:10.602 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 21 to 22
2020-03-02 23:56:10.609 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 23 to 24
2020-03-02 23:56:10.706 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 22 to 23
2020-03-02 23:56:10.710 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 24 to 25
2020-03-02 23:56:10.729 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 23 to 24
2020-03-02 23:56:10.731 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 25 to 26
2020-03-02 23:56:10.750 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node34' changed from ONLINE to ONLINE: Node initialising: PING
2020-03-02 23:56:10.787 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 24 to 25
2020-03-02 23:56:10.809 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 26 to 27
2020-03-02 23:56:11.012 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 25 to 26
2020-03-02 23:56:11.022 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node30' changed from ONLINE to ONLINE: Node initialising: PING
2020-03-02 23:56:11.043 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 27 to 28
2020-03-02 23:56:11.053 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node16' changed from ONLINE to ONLINE: Node initialising: REQUEST_NIF
2020-03-02 23:56:11.086 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 26 to 27
2020-03-02 23:56:11.088 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 28 to 29
2020-03-02 23:56:11.109 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node29' changed from ONLINE to ONLINE: Node initialising: PING
2020-03-02 23:56:11.119 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 27 to 28
2020-03-02 23:56:11.126 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 29 to 30
2020-03-02 23:56:11.174 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node6' changed from ONLINE to ONLINE: Node initialising: PING
2020-03-02 23:56:11.181 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 28 to 29
2020-03-02 23:56:11.183 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 30 to 31
2020-03-02 23:56:11.237 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node20' changed from ONLINE to ONLINE: Node initialising: REQUEST_NIF
2020-03-02 23:56:11.250 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 29 to 30
2020-03-02 23:56:11.260 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 31 to 32
2020-03-02 23:56:11.284 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node12' changed from ONLINE to ONLINE: Node initialising: REQUEST_NIF
2020-03-02 23:56:11.346 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 30 to 31
2020-03-02 23:56:11.387 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 32 to 33
2020-03-02 23:56:11.404 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node10' changed from ONLINE to ONLINE: Node initialising: PING
2020-03-02 23:56:11.413 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 31 to 32
2020-03-02 23:56:11.419 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 33 to 34
2020-03-02 23:56:11.450 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node21' changed from ONLINE to ONLINE: Node initialising: PING
2020-03-02 23:56:11.592 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 32 to 33
2020-03-02 23:56:11.649 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node9' changed from ONLINE to ONLINE: Node initialising: PING
2020-03-02 23:56:11.658 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 34 to 35
2020-03-02 23:56:11.670 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 33 to 34
2020-03-02 23:56:11.694 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 35 to 36
2020-03-02 23:56:11.704 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node11' changed from ONLINE to ONLINE: Node initialising: PING
2020-03-02 23:56:11.769 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node33' changed from ONLINE to ONLINE: Node initialising: REQUEST_NIF
2020-03-02 23:56:11.773 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 34 to 35
2020-03-02 23:56:11.780 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 36 to 37
2020-03-02 23:56:11.785 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 35 to 36
2020-03-02 23:56:11.821 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 37 to 38
2020-03-02 23:56:11.824 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 36 to 37
2020-03-02 23:56:11.832 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 38 to 39
2020-03-02 23:56:11.899 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 37 to 38
2020-03-02 23:56:11.901 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node37' changed from ONLINE to ONLINE: Node initialising: PING
2020-03-02 23:56:12.117 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 39 to 40
2020-03-02 23:56:17.199 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 40 to 41
2020-03-02 23:56:17.254 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 38 to 39
2020-03-02 23:56:17.322 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 41 to 42
2020-03-02 23:56:21.976 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 42 to 43
2020-03-02 23:56:22.011 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 39 to 40
2020-03-02 23:56:22.139 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 43 to 44
2020-03-02 23:56:26.812 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 44 to 45
2020-03-02 23:56:26.849 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 40 to 41
2020-03-02 23:56:26.918 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 45 to 46
2020-03-02 23:56:31.746 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 46 to 47
2020-03-02 23:56:31.766 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node19' changed from ONLINE: Node initialising: REQUEST_NIF to OFFLINE (COMMUNICATION_ERROR): Node is not communicating with controller
2020-03-02 23:56:31.792 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 41 to 42
2020-03-02 23:56:31.854 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 47 to 48
2020-03-02 23:56:36.119 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 48 to 49
2020-03-02 23:56:36.152 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 42 to 43
2020-03-02 23:56:36.221 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 49 to 50
2020-03-02 23:56:37.161 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node14' changed from ONLINE: Node initialising: REQUEST_NIF to UNINITIALIZED
2020-03-02 23:56:37.221 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node14' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.228 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node16' changed from ONLINE: Node initialising: REQUEST_NIF to UNINITIALIZED
2020-03-02 23:56:37.269 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node16' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.273 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node30' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-02 23:56:37.324 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node30' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.329 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node21' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-02 23:56:37.369 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node21' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.374 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node23' changed from ONLINE: Node initialising: REQUEST_NIF to UNINITIALIZED
2020-03-02 23:56:37.415 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node23' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.419 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node6' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-02 23:56:37.459 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node6' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.463 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node19' changed from OFFLINE (COMMUNICATION_ERROR): Node is not communicating with controller to UNINITIALIZED
2020-03-02 23:56:37.502 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node19' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.506 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node33' changed from ONLINE: Node initialising: REQUEST_NIF to UNINITIALIZED
2020-03-02 23:56:37.545 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node33' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.549 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node34' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-02 23:56:37.605 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node34' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.611 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node35' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-02 23:56:37.678 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node35' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.682 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node24' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-02 23:56:37.723 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node29' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-02 23:56:37.726 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node24' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.771 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node29' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.775 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node37' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-02 23:56:37.820 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node37' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.826 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node18' changed from ONLINE: Node initialising: REQUEST_NIF to UNINITIALIZED
2020-03-02 23:56:37.865 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node18' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.870 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node10' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-02 23:56:37.910 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node10' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-02 23:56:37.913 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node22' changed from ONLINE: Node initialising: REQUEST_NIF to UNINITIALIZED
2020-03-02 23:56:38.053 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node22' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
[snip]
Any suggestsion on where to go from here?
I’ve done a few reboots (nicely shutting down OH first), as well as some cache clears (with permission resetting)
Thanks!
Edit:
With a bit more looking, I think I was able to get a glimpse of some relevant details for this from the logs. I just don’t fully know how to interpret it. (the mail error is known - I couldn’t recall how I had the mail service set up before, so I’ve shelved getting it working for now)
2020-03-03 00:06:37.583 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node24' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-03 00:06:37.586 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node36' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-03 00:06:37.631 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node36' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-03 00:06:37.638 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node10' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-03 00:06:37.673 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node10' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-03 00:06:37.676 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node34' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-03 00:06:37.713 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node34' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-03 00:06:37.717 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node6' changed from ONLINE: Node initialising: PING to UNINITIALIZED
2020-03-03 00:06:37.759 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node6' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
2020-03-03 00:06:37.763 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:6fa78702' changed from ONLINE to UNINITIALIZED
2020-03-03 00:06:37.973 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:6fa78702' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
==> /var/log/openhab2/openhab.log <==
2020-03-03 00:06:40.371 [INFO ] [internal.service.FeaturesServiceImpl] - org.openhab.core.io.transport.serial.rxtx.rfc2217/2.5.0
2020-03-03 00:06:40.444 [INFO ] [internal.service.FeaturesServiceImpl] - org.openhab.core.io.transport.serial/2.5.0
2020-03-03 00:06:40.557 [INFO ] [internal.service.FeaturesServiceImpl] - org.openhab.core.io.transport.serial.rxtx/2.5.0
2020-03-03 00:06:40.685 [INFO ] [internal.service.FeaturesServiceImpl] - Refreshing bundles:
2020-03-03 00:06:40.688 [INFO ] [internal.service.FeaturesServiceImpl] - org.openhab.binding.zwave/2.5.2 (Should be wired to: org.openhab.core.io.transport.serial/2.5.0 (through [org.openhab.binding.zwave/2.5.2] osgi.wiring.package; filter:="(osgi.wiring.package=org.eclipse.smarthome.io.transport.serial)"))
2020-03-03 00:06:40.690 [INFO ] [internal.service.FeaturesServiceImpl] - org.openhab.core.config.serial/2.5.0 (Should be wired to: org.openhab.core.io.transport.serial/2.5.0 (through [org.openhab.core.config.serial/2.5.0] osgi.wiring.package; filter:="(&(osgi.wiring.package=org.eclipse.smarthome.io.transport.serial)(version>=2.5.0)(!(version>=3.0.0)))"))
2020-03-03 00:06:40.692 [INFO ] [internal.service.FeaturesServiceImpl] - org.openhab.core.io.transport.serial/2.5.0 (Should be wired to: org.openhab.core.io.transport.serial/2.5.0 (through [org.openhab.core.io.transport.serial/2.5.0] osgi.wiring.package; filter:="(osgi.wiring.package=org.eclipse.smarthome.io.transport.serial)"))
2020-03-03 00:06:40.695 [INFO ] [internal.service.FeaturesServiceImpl] - org.openhab.core.io.transport.serial.rxtx/2.5.0 (Wired to org.openhab.core.io.transport.serial/2.5.0 which is being refreshed)
2020-03-03 00:06:40.697 [INFO ] [internal.service.FeaturesServiceImpl] - org.openhab.core.io.transport.serial.rxtx.rfc2217/2.5.0 (Wired to org.openhab.core.io.transport.serial/2.5.0 which is being refreshed)
==> /var/log/openhab2/events.log <==
2020-03-03 00:06:41.027 [vent.ItemStateChangedEvent] - network_pingdevice_192_168_0_102_latency changed from 187.0 to 226.0
==> /var/log/openhab2/openhab.log <==
2020-03-03 00:06:41.030 [DEBUG] [.internal.InfluxDBPersistenceService] - got DecimalType value 226.0
==> /var/log/openhab2/events.log <==
2020-03-03 00:06:41.367 [vent.ItemStateChangedEvent] - network_pingdevice_192_168_0_102_lastseen changed from 2020-03-03T00:05:40.764-0800 to 2020-03-03T00:06:41.344-0800
==> /var/log/openhab2/openhab.log <==
2020-03-03 00:06:41.368 [DEBUG] [.internal.InfluxDBPersistenceService] - got DateTimeType value 1583222801344
2020-03-03 00:06:41.450 [INFO ] [internal.service.FeaturesServiceImpl] - Done.
2020-03-03 00:06:41.458 [ERROR] [core.karaf.internal.FeatureInstaller] - Failed installing 'openhab-action-mail'
==> /var/log/openhab2/events.log <==
2020-03-03 00:06:45.153 [vent.ItemStateChangedEvent] - network_pingdevice_192_168_0_112_latency changed from 20.0 to 21.0
==> /var/log/openhab2/openhab.log <==
2020-03-03 00:06:45.156 [DEBUG] [.internal.InfluxDBPersistenceService] - got DecimalType value 21.0
2020-03-03 00:06:45.620 [DEBUG] [.internal.InfluxDBPersistenceService] - got DateTimeType value 1583222805604
==> /var/log/openhab2/events.log <==
2020-03-03 00:06:45.626 [vent.ItemStateChangedEvent] - network_pingdevice_192_168_0_112_lastseen changed from 2020-03-03T00:05:45.104-0800 to 2020-03-03T00:06:45.604-0800
==> /var/log/openhab2/openhab.log <==
2020-03-03 00:06:50.199 [INFO ] [zwave.handler.ZWaveControllerHandler] - Attempting to add listener when controller is null
==> /var/log/openhab2/events.log <==
2020-03-03 00:06:50.397 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:6fa78702' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
2020-03-03 00:06:50.415 [hingStatusInfoChangedEvent] - 'zwave:serial_zstick:6fa78702' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-03 00:06:50.489 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node29' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
[snip for length]
2020-03-03 00:06:50.982 [hingStatusInfoChangedEvent] - 'zwave:device:6fa78702:node6' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
2020-03-03 00:06:54.603 [vent.ItemStateChangedEvent] - network_pingdevice_04df95fd_online changed from ON to OFF
2020-03-03 00:06:54.606 [vent.ItemStateChangedEvent] - network_pingdevice_04df95fd_latency changed from 1621.0 to UNDEF
==> /var/log/openhab2/openhab.log <==
2020-03-03 00:06:54.609 [DEBUG] [.internal.InfluxDBPersistenceService] - got OnOffType value 0
==> /var/log/openhab2/events.log <==
2020-03-03 00:06:55.469 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_sof changed from 70 to 0
==> /var/log/openhab2/openhab.log <==
2020-03-03 00:06:55.471 [DEBUG] [.internal.InfluxDBPersistenceService] - got DecimalType value 0
==> /var/log/openhab2/events.log <==
2020-03-03 00:06:55.479 [vent.ItemStateChangedEvent] - zwave_serial_zstick_6fa78702_serial_ack changed from 53 to 0
==> /var/log/openhab2/openhab.log <==
2020-03-03 00:06:55.484 [DEBUG] [.internal.InfluxDBPersistenceService] - got DecimalType value 0
2020-03-03 00:06:55.531 [INFO ] [ve.internal.protocol.ZWaveController] - Starting ZWave controller
2020-03-03 00:06:55.533 [INFO ] [ve.internal.protocol.ZWaveController] - ZWave timeout is set to 5000ms. Soft reset is false.
2020-03-03 00:06:58.625 [DEBUG] [.internal.InfluxDBPersistenceService] - got DecimalType value 1