Closed Madelaide closed 4 years ago
removing "instance: 1" and restarting let ozw start up once, but following a reboot it failed again; the full log listed follows
[20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "isnodefailed" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/isnodefailed/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "open" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/open/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "ping" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/ping/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "refreshnodeinfo" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/refreshnodeinfo/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "refreshvalue" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/refreshvalue/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "removeassociation" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/removeassociation/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "removefailednode" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/removefailednode/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "removenode" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/removenode/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "replacefailednode" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/replacefailednode/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestallconfigparam" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestallconfigparam/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestconfigparam" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestconfigparam/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestnetworkupdate" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestnetworkupdate/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestnodedynamic" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestnodedynamic/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestnodeneighborupdate" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestnodeneighborupdate/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestnodestate" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestnodestate/") [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "sendnodeinformation" [20200709 8:49:02.184 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/sendnodeinformation/") [20200709 8:49:02.185 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "setpollinterval" [20200709 8:49:02.185 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/setpollinterval/") [20200709 8:49:02.185 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "setvalue" [20200709 8:49:02.185 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/setvalue/") [20200709 8:49:02.185 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "softresetcontroller" [20200709 8:49:02.185 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/softresetcontroller/") [20200709 8:49:02.185 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "syncronisenodeneighbors" [20200709 8:49:02.185 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/syncronisenodeneighbors/") [20200709 8:49:02.185 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "testnetwork" [20200709 8:49:02.185 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/testnetwork/") [20200709 8:49:02.185 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "testnetworknode" [20200709 8:49:02.185 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/testnetworknode/") [20200709 8:49:02.187 ACST] [ozw.library] [debug]: Detail - Node: 255 Queuing (Command) FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
[20200709 8:49:02.187 ACST] [ozw.mqtt.publisher] [warning]: Another ozwdaemon is running for Instance 1 [20200709 8:49:02.187 ACST] [ozw.mqtt.publisher] [warning]: If not, please clean up the MQTT Topic: "OpenZWave/1/status/" [20200709 8:49:02.187 ACST] [ozw.mqtt.publisher] [warning]: "{\n \"OpenZWave_Version\": \"1.6.1201\",\n \"OZWDaemon_Version\": \"0.1.0\",\n \"QTOpenZWave_Version\": \"1.2.0\",\n \"QT_Version\": \"5.14.2\",\n \"Status\": \"driverRemoved\",\n \"TimeStamp\": 1594250292,\n \"homeID\": 0\n}" [20200709 8:49:02.187 ACST] [ozw.library] [debug]: Detail - Node: 0 Notification: DriverRemoved [20200709 8:49:02.187 ACST] [ozw.notifications] [debug]: Notification pvt_driverRemoved 0 Thread: 0x7f7e1fbe8d48 [20200709 8:49:02.188 ACST] [ozw.mqtt.publisher] [debug]: Publishing Event stopped [20200709 8:49:02.188 ACST] [ozw.mqtt.publisher] [debug]: Publishing Event driverRemoved: 0 [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 *** [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 * Cumulative Network Statistics *** [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 * General [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 Driver run time: . . . 0 days, 0 hours, 0 minutes [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 Frames processed: . . . . . . . . . . . . . . . . . . . . 0 [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 Total messages successfully received: . . . . . . . . . . 0 [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 Total Messages successfully sent: . . . . . . . . . . . . 0 [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 ACKs received from controller: . . . . . . . . . . . . . 0 [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 * Errors [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 Unsolicited messages received while waiting for ACK: . . 0 [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 Reads aborted due to timeouts: . . . . . . . . . . . . . 0 [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 Bad checksum errors: . . . . . . . . . . . . . . . . . . 0 [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 CANs received from controller: . . . . . . . . . . . . . 0 [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 NAKs received from controller: . . . . . . . . . . . . . 0 [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 Out of frame data flow errors: . . . . . . . . . . . . . 0 [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 Messages retransmitted: . . . . . . . . . . . . . . . . . 0 [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 Messages dropped and not delivered: . . . . . . . . . . . 0 [20200709 8:49:02.191 ACST] [ozw.library] [debug]: Always - Node: 0 ***** [20200709 8:49:02.191 ACST] [ozw.library] [warning]: Warning - Node: 0 WARNING: Tried to write driver config with no home ID set [20200709 8:49:02.272 ACST] [ozw.library] [info]: Info - Node: 0 Lookup for mfs.db.openzwave.com returned 107 [20200709 8:49:02.273 ACST] [ozw.library] [info]: Info - Node: 0 Stopping DNSThread [20200709 8:49:02.314 ACST] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/images/honeywell/39348-ZW4005.jpg (Node 0) [20200709 8:49:02.316 ACST] [ozw.library] [info]: Info - Node: 0 Missing Picture /data/ozw/config/images/honeywell/39348-ZW4005.jpg - Starting Download [20200709 8:49:02.318 ACST] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/images/honeywell/39449-ZW4016.png (Node 0) [20200709 8:49:02.318 ACST] [ozw.library] [info]: Info - Node: 0 Missing Picture /data/ozw/config/images/honeywell/39449-ZW4016.png - Starting Download [20200709 8:49:02.320 ACST] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/images/honeywell/39348-ZW4005.jpg (/data/ozw/config/images/honeywell/39348-ZW4005.jpg) [20200709 8:49:02.322 ACST] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/images/honeywell/39449-ZW4016.png (/data/ozw/config/images/honeywell/39449-ZW4016.png) [20200709 8:49:03.286 ACST] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 2 [20200709 8:49:05.291 ACST] [ozw.library] [info]: Info - Node: 0 HttpThread Exiting. [20200709 8:49:05.291 ACST] [ozw.library] [info]: Info - Node: 0 HttpThread Exiting. [20200709 8:49:05.291 ACST] [ozw.library] [info]: Info - Node: 0 mgr, Driver for controller /dev/serial/by-id/usb-0658_0200-if00 removed [20200709 8:49:05.292 ACST] [ozw.manager] [debug]: Driver Removed for "/dev/serial/by-id/usb-0658_0200-if00" [20200709 8:49:05.292 ACST] [ozw.manager] [debug]: OZW Serial Port Closed [20200709 8:49:05.292 ACST] [ozw.daemon] [info]: Shutting Down "ozwdaemon" Version: "0.1.0" [20200709 8:49:05.292 ACST] [ozw.daemon] [info]: OpenZWave Version: "1.6.1201" [20200709 8:49:05.292 ACST] [ozw.daemon] [info]: QT-OpenZWave Version: "1.2.0" [20200709 8:49:05.292 ACST] [ozw.daemon] [info]: QT Version: 5.14.2 1594250345: Client qt-openzwave-1 disconnected. In exit [cont-finish.d] executing container finish scripts... [cont-finish.d] done. [s6-finish] waiting for services. 1594250345: mosquitto version 1.6.9 terminating 1594250345: Saving in-memory database to /data/mosquitto.db. s6-svwait: fatal: supervisor died [s6-finish] sending all processes the TERM signal. [s6-finish] sending all processes the KILL signal and exiting.
[ozw.mqtt.publisher] [warning]: Another ozwdaemon is running for Instance 1 [20200709 8:49:02.187 ACST] [ozw.mqtt.publisher] [warning]: If not, please clean up the MQTT Topic: "OpenZWave/1/status/"
Please cleanup that topic - it’s left over from a unclean shutdown.
Thankyou Justin, I will try this.
I installde mqtt explorer and deleted all the nodes. I restarted the VM I removed mosquitto addon and readded and still I receive the following error that an instance of ozwdaemon is running, as follows
[20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/healnetworknode/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "isnodefailed" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/isnodefailed/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "open" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/open/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "ping" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/ping/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "refreshnodeinfo" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/refreshnodeinfo/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "refreshvalue" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/refreshvalue/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "removeassociation" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/removeassociation/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "removefailednode" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/removefailednode/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "removenode" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/removenode/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "replacefailednode" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/replacefailednode/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestallconfigparam" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestallconfigparam/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestconfigparam" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestconfigparam/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestnetworkupdate" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestnetworkupdate/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestnodedynamic" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestnodedynamic/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestnodeneighborupdate" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestnodeneighborupdate/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestnodestate" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestnodestate/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "sendnodeinformation" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/sendnodeinformation/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "setpollinterval" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/setpollinterval/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "setvalue" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/setvalue/") [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "softresetcontroller" [20200713 13:49:24.334 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/softresetcontroller/") [20200713 13:49:24.342 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "syncronisenodeneighbors" [20200713 13:49:24.342 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/syncronisenodeneighbors/") [20200713 13:49:24.342 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "testnetwork" [20200713 13:49:24.342 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/testnetwork/") [20200713 13:49:24.342 ACST] [ozw.mqtt.commands] [debug]: Creating Subscription for "testnetworknode" [20200713 13:49:24.342 ACST] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/testnetworknode/")
[20200713 13:49:24.344 ACST] [ozw.mqtt.publisher] [warning]: Another ozwdaemon is running for Instance 1 [20200713 13:49:24.344 ACST] [ozw.mqtt.publisher] [warning]: If not, please clean up the MQTT Topic: "OpenZWave/1/status/" [20200713 13:49:24.344 ACST] [ozw.mqtt.publisher] [warning]: "{\n \"OpenZWave_Version\": \"1.6.1201\",\n \"OZWDaemon_Version\": \"0.1.0\",\n \"QTOpenZWave_Version\": \"1.2.0\",\n \"QT_Version\": \"5.14.2\",\n \"Status\": \"driverRemoved\",\n \"TimeStamp\": 1594602380,\n \"homeID\": 0\n}" [20200713 13:49:24.344 ACST] [ozw.library] [debug]: Detail - Node: 0 Notification: DriverRemoved [20200713 13:49:24.345 ACST] [ozw.library] [debug]: Always - Node: 0 *** [20200713 13:49:24.345 ACST] [ozw.library] [debug]: Always - Node: 0 * Cumulative Network Statistics *** [20200713 13:49:24.345 ACST] [ozw.library] [debug]: Always - Node: 0 * General [20200713 13:49:24.345 ACST] [ozw.library] [debug]: Always - Node: 0 Driver run time: . . . 0 days, 0 hours, 0 minutes [20200713 13:49:24.345 ACST] [ozw.library] [debug]: Always - Node: 0 Frames processed: . . . . . . . . . . . . . . . . . . . . 0 [20200713 13:49:24.345 ACST] [ozw.library] [debug]: Always - Node: 0 Total messages successfully received: . . . . . . . . . . 0 [20200713 13:49:24.345 ACST] [ozw.library] [debug]: Always - Node: 0 Total Messages successfully sent: . . . . . . . . . . . . 0 [20200713 13:49:24.345 ACST] [ozw.library] [debug]: Always - Node: 0 ACKs received from controller: . . . . . . . . . . . . . 0 [20200713 13:49:24.345 ACST] [ozw.library] [debug]: Always - Node: 0 * Errors [20200713 13:49:24.345 ACST] [ozw.library] [debug]: Always - Node: 0 Unsolicited messages received while waiting for ACK: . . 0 [20200713 13:49:24.346 ACST] [ozw.library] [debug]: Always - Node: 0 Reads aborted due to timeouts: . . . . . . . . . . . . . 0 [20200713 13:49:24.346 ACST] [ozw.library] [debug]: Always - Node: 0 Bad checksum errors: . . . . . . . . . . . . . . . . . . 0 [20200713 13:49:24.346 ACST] [ozw.library] [debug]: Always - Node: 0 CANs received from controller: . . . . . . . . . . . . . 0 [20200713 13:49:24.346 ACST] [ozw.library] [debug]: Always - Node: 0 NAKs received from controller: . . . . . . . . . . . . . 0 [20200713 13:49:24.346 ACST] [ozw.library] [debug]: Always - Node: 0 Out of frame data flow errors: . . . . . . . . . . . . . 0 [20200713 13:49:24.346 ACST] [ozw.library] [debug]: Always - Node: 0 Messages retransmitted: . . . . . . . . . . . . . . . . . 0 [20200713 13:49:24.346 ACST] [ozw.library] [debug]: Always - Node: 0 Messages dropped and not delivered: . . . . . . . . . . . 0 [20200713 13:49:24.346 ACST] [ozw.library] [debug]: Always - Node: 0 ***** [20200713 13:49:24.346 ACST] [ozw.library] [warning]: Warning - Node: 0 WARNING: Tried to write driver config with no home ID set [20200713 13:49:24.723 ACST] [ozw.library] [info]: Info - Node: 0 Lookup for mfs.db.openzwave.com returned 108 [20200713 13:49:24.723 ACST] [ozw.library] [info]: Info - Node: 0 Stopping DNSThread [20200713 13:49:24.801 ACST] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/images/honeywell/39348-ZW4005.jpg (Node 0) [20200713 13:49:24.802 ACST] [ozw.library] [info]: Info - Node: 0 Missing Picture /data/ozw/config/images/honeywell/39348-ZW4005.jpg - Starting Download [20200713 13:49:24.803 ACST] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/images/honeywell/39449-ZW4016.png (Node 0) [20200713 13:49:24.804 ACST] [ozw.library] [info]: Info - Node: 0 Missing Picture /data/ozw/config/images/honeywell/39449-ZW4016.png - Starting Download [20200713 13:49:24.806 ACST] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/images/honeywell/39348-ZW4005.jpg (/data/ozw/config/images/honeywell/39348-ZW4005.jpg) [20200713 13:49:24.811 ACST] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/images/honeywell/39449-ZW4016.png (/data/ozw/config/images/honeywell/39449-ZW4016.png) [20200713 13:49:26.547 ACST] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 2 [20200713 13:49:28.555 ACST] [ozw.library] [info]: Info - Node: 0 HttpThread Exiting. [20200713 13:49:28.555 ACST] [ozw.library] [info]: Info - Node: 0 HttpThread Exiting. [20200713 13:49:28.556 ACST] [ozw.library] [info]: Info - Node: 0 mgr, Driver for controller /dev/serial/by-id/usb-0658_0200-if00 removed [20200713 13:49:28.556 ACST] [ozw.manager] [debug]: Driver Removed for "/dev/serial/by-id/usb-0658_0200-if00" [20200713 13:49:28.556 ACST] [ozw.manager] [debug]: OZW Serial Port Closed [20200713 13:49:28.556 ACST] [ozw.daemon] [info]: Shutting Down "ozwdaemon" Version: "0.1.0" [20200713 13:49:28.556 ACST] [ozw.daemon] [info]: OpenZWave Version: "1.6.1201" [20200713 13:49:28.558 ACST] [ozw.daemon] [info]: QT-OpenZWave Version: "1.2.0" [20200713 13:49:28.558 ACST] [ozw.daemon] [info]: QT Version: 5.14.2 [20200713 13:49:28.558 ACST] [ozw.notifications] [debug]: Notification pvt_driverRemoved 0 Thread: 0x7fe19d8a3d48 [20200713 13:49:28.559 ACST] [ozw.mqtt.publisher] [debug]: Publishing Event stopped [20200713 13:49:28.559 ACST] [ozw.mqtt.publisher] [debug]: Publishing Event driverRemoved: 0 1594613968: Client qt-openzwave-1 disconnected. In exit [cont-finish.d] executing container finish scripts... [cont-finish.d] done. [s6-finish] waiting for services. s6-svwait: fatal: supervisor died 1594613968: mosquitto version 1.6.9 terminating 1594613968: Saving in-memory database to /data/mosquitto.db. [s6-finish] sending all processes the TERM signal. [s6-finish] sending all processes the KILL signal and exiting.
Please try the 0.5.1 addon version which solves crashing issues. It might still be needed to delete the status topic manually with MQTT Explorer
I have similiar problems (I think, I am not sure and have just used home assistant for about 2 weeks). Since 0.5.0 it crashes consistently after about 5 minutes. Same problem in 0.5.1.
What I understand of the log is that the mqtt-broker-connection is disconnected, but I am not sure if that is the cause or if there is something else before that disconnects the mqtt-connection on tear-down.
[20200715 23:20:06.581 CEST] [ozw.library] [info]: Info - Node: 78 Sending (NoOp) message (Callback ID=0x2f, Expected Reply=0x13) - NoOperation_Set (Node=78): 0x01, 0x09, 0x00, 0x13, 0x4e, 0x02, 0x00, 0x00, 0x25, 0x2f, 0xa3 , [20200715 23:20:06.581 CEST] [ozw.library] [info]: Info - Node: 78 Encrypted Flag is 0 , [20200715 23:20:07.582 CEST] [ozw.library] [critical]: Error - Node: 78 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=78): 0x01, 0x09, 0x00, 0x13, 0x4e, 0x02, 0x00, 0x00, 0x25, 0x2f, 0xa3" , [20200715 23:20:07.582 CEST] [ozw.library] [debug]: Detail - Node: 78 Removing current message , [20200715 23:20:07.582 CEST] [ozw.library] [debug]: Detail - Node: 78 Notification: Notification - TimeOut , [20200715 23:20:07.582 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:07.582 CEST] [ozw.library] [info]: Info - Node: 79 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=79): 0x01, 0x04, 0x00, 0x41, 0x4f, 0xf5 , [20200715 23:20:07.582 CEST] [ozw.library] [info]: Info - Node: 79 Encrypted Flag is 0 , [20200715 23:20:07.582 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:07.604 CEST] [ozw.mqtt.publisher] [debug]: "Wed Jul 15 23:20:07 2020 PingResponse\n" , [20200715 23:20:08.582 CEST] [ozw.library] [critical]: Error - Node: 79 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=79): 0x01, 0x04, 0x00, 0x41, 0x4f, 0xf5" , [20200715 23:20:08.582 CEST] [ozw.library] [debug]: Detail - Node: 79 Removing current message , [20200715 23:20:08.582 CEST] [ozw.library] [debug]: Detail - Node: 79 Notification: Notification - TimeOut , [20200715 23:20:08.583 CEST] [ozw.library] [debug]: Detail - Node: 79 Query Stage Complete (ProtocolInfo) , [20200715 23:20:08.583 CEST] [ozw.library] [debug]: Detail - Node: 79 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:20:08.583 CEST] [ozw.library] [debug]: Detail - Node: 79 QueryStage_Probe , [20200715 23:20:08.583 CEST] [ozw.library] [info]: Info - Node: 79 NoOperation::Set - Routing=true , [20200715 23:20:08.583 CEST] [ozw.library] [debug]: Detail - Node: 79 Queuing (NoOp) NoOperation_Set (Node=79): 0x01, 0x09, 0x00, 0x13, 0x4f, 0x02, 0x00, 0x00, 0x25, 0x30, 0xbd , [20200715 23:20:08.583 CEST] [ozw.library] [debug]: Detail - Node: 79 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:20:08.583 CEST] [ozw.library] [info]: Info - Node: 79 Sending (NoOp) message (Callback ID=0x30, Expected Reply=0x13) - NoOperation_Set (Node=79): 0x01, 0x09, 0x00, 0x13, 0x4f, 0x02, 0x00, 0x00, 0x25, 0x30, 0xbd , [20200715 23:20:08.583 CEST] [ozw.library] [info]: Info - Node: 79 Encrypted Flag is 0 , [20200715 23:20:08.583 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:08.583 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:09.583 CEST] [ozw.library] [critical]: Error - Node: 79 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=79): 0x01, 0x09, 0x00, 0x13, 0x4f, 0x02, 0x00, 0x00, 0x25, 0x30, 0xbd" , [20200715 23:20:09.583 CEST] [ozw.library] [debug]: Detail - Node: 79 Removing current message , [20200715 23:20:09.583 CEST] [ozw.library] [debug]: Detail - Node: 79 Notification: Notification - TimeOut , [20200715 23:20:09.583 CEST] [ozw.library] [info]: Info - Node: 80 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=80): 0x01, 0x04, 0x00, 0x41, 0x50, 0xea , [20200715 23:20:09.583 CEST] [ozw.library] [info]: Info - Node: 80 Encrypted Flag is 0 , [20200715 23:20:09.583 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:09.583 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:09.604 CEST] [default] [debug]: QVariant(int, 1) , [20200715 23:20:09.604 CEST] [default] [debug]: QVariant(int, 4) , [20200715 23:20:09.604 CEST] [default] [debug]: QVariant(int, 11) , [20200715 23:20:09.604 CEST] [default] [debug]: QVariant(int, 14) , [20200715 23:20:09.604 CEST] [default] [debug]: QVariant(int, 15) , [20200715 23:20:09.604 CEST] [default] [debug]: QVariant(int, 16) , [20200715 23:20:09.605 CEST] [default] [debug]: QVariant(int, 17) , [20200715 23:20:09.605 CEST] [default] [debug]: QVariant(int, 19) , [20200715 23:20:09.605 CEST] [default] [debug]: QVariant(int, 20) , [20200715 23:20:09.605 CEST] [default] [debug]: QVariant(int, 21) , [20200715 23:20:09.605 CEST] [default] [debug]: QVariant(int, 24) , [20200715 23:20:09.605 CEST] [default] [debug]: QVariant(int, 25) , [20200715 23:20:09.605 CEST] [default] [debug]: QVariant(int, 26) , [20200715 23:20:09.605 CEST] [default] [debug]: QVariant(int, 28) , [20200715 23:20:09.605 CEST] [default] [debug]: QVariant(int, 29) , [20200715 23:20:09.605 CEST] [default] [debug]: QVariant(int, 30) , [20200715 23:20:09.605 CEST] [default] [debug]: QVariant(int, 31) , [20200715 23:20:09.605 CEST] [default] [debug]: QVariant(int, 37) , [20200715 23:20:09.606 CEST] [default] [debug]: QVariant(int, 38) , [20200715 23:20:09.606 CEST] [default] [debug]: QVariant(int, 39) , [20200715 23:20:09.606 CEST] [default] [debug]: QVariant(int, 40) , [20200715 23:20:09.606 CEST] [default] [debug]: QVariant(int, 42) , [20200715 23:20:09.606 CEST] [default] [debug]: QVariant(int, 43) , [20200715 23:20:09.606 CEST] [default] [debug]: QVariant(int, 44) , [20200715 23:20:09.606 CEST] [default] [debug]: QVariant(int, 45) , [20200715 23:20:09.606 CEST] [default] [debug]: QVariant(int, 47) , [20200715 23:20:09.606 CEST] [default] [debug]: QVariant(int, 48) , [20200715 23:20:09.606 CEST] [default] [debug]: QVariant(int, 50) , [20200715 23:20:09.606 CEST] [default] [debug]: QVariant(int, 52) , [20200715 23:20:09.607 CEST] [default] [debug]: QVariant(int, 54) , [20200715 23:20:09.607 CEST] [default] [debug]: QVariant(int, 56) , [20200715 23:20:09.607 CEST] [default] [debug]: QVariant(int, 59) , [20200715 23:20:09.607 CEST] [default] [debug]: QVariant(int, 64) , [20200715 23:20:09.607 CEST] [default] [debug]: QVariant(int, 65) , [20200715 23:20:09.607 CEST] [default] [debug]: QVariant(int, 72) , [20200715 23:20:09.607 CEST] [default] [debug]: QVariant(int, 73) , [20200715 23:20:09.607 CEST] [default] [debug]: QVariant(int, 75) , [20200715 23:20:09.607 CEST] [default] [debug]: QVariant(int, 77) , [20200715 23:20:09.608 CEST] [default] [debug]: QVariant(int, 78) , [20200715 23:20:09.608 CEST] [default] [debug]: QVariant(int, 79) , [20200715 23:20:09.608 CEST] [default] [debug]: QVariant(int, 80) , [20200715 23:20:09.608 CEST] [default] [debug]: QVariant(int, 86) , [20200715 23:20:09.608 CEST] [default] [debug]: QVariant(int, 88) , [20200715 23:20:09.608 CEST] [default] [debug]: QVariant(int, 90) , [20200715 23:20:09.609 CEST] [default] [debug]: QVariant(int, 91) , [20200715 23:20:09.609 CEST] [default] [debug]: QVariant(int, 93) , [20200715 23:20:09.609 CEST] [default] [debug]: QVariant(int, 94) , [20200715 23:20:09.609 CEST] [default] [debug]: QVariant(int, 96) , [20200715 23:20:09.609 CEST] [default] [debug]: QVariant(int, 97) , [20200715 23:20:09.609 CEST] [default] [debug]: QVariant(int, 99) , [20200715 23:20:09.609 CEST] [default] [debug]: QVariant(int, 101) , [20200715 23:20:09.610 CEST] [default] [debug]: QVariant(int, 103) , [20200715 23:20:09.610 CEST] [default] [debug]: QVariant(int, 104) , [20200715 23:20:09.610 CEST] [default] [debug]: QVariant(int, 105) , [20200715 23:20:09.610 CEST] [default] [debug]: QVariant(int, 106) , [20200715 23:20:09.610 CEST] [default] [debug]: QVariant(int, 107) , [20200715 23:20:09.610 CEST] [default] [debug]: QVariant(int, 108) , [20200715 23:20:10.583 CEST] [ozw.library] [critical]: Error - Node: 80 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=80): 0x01, 0x04, 0x00, 0x41, 0x50, 0xea" , [20200715 23:20:10.583 CEST] [ozw.library] [debug]: Detail - Node: 80 Removing current message , [20200715 23:20:10.583 CEST] [ozw.library] [debug]: Detail - Node: 80 Notification: Notification - TimeOut , [20200715 23:20:10.583 CEST] [ozw.library] [debug]: Detail - Node: 80 Query Stage Complete (ProtocolInfo) , [20200715 23:20:10.583 CEST] [ozw.library] [debug]: Detail - Node: 80 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:20:10.583 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:10.584 CEST] [ozw.library] [debug]: Detail - Node: 80 QueryStage_Probe , [20200715 23:20:10.584 CEST] [ozw.library] [info]: Info - Node: 80 NoOperation::Set - Routing=true , [20200715 23:20:10.584 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:10.584 CEST] [ozw.library] [debug]: Detail - Node: 80 Queuing (NoOp) NoOperation_Set (Node=80): 0x01, 0x09, 0x00, 0x13, 0x50, 0x02, 0x00, 0x00, 0x25, 0x31, 0xa3 , [20200715 23:20:10.584 CEST] [ozw.library] [debug]: Detail - Node: 80 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:20:10.584 CEST] [ozw.library] [info]: Info - Node: 80 Sending (NoOp) message (Callback ID=0x31, Expected Reply=0x13) - NoOperation_Set (Node=80): 0x01, 0x09, 0x00, 0x13, 0x50, 0x02, 0x00, 0x00, 0x25, 0x31, 0xa3 , [20200715 23:20:10.584 CEST] [ozw.library] [info]: Info - Node: 80 Encrypted Flag is 0 , [20200715 23:20:11.584 CEST] [ozw.library] [critical]: Error - Node: 80 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=80): 0x01, 0x09, 0x00, 0x13, 0x50, 0x02, 0x00, 0x00, 0x25, 0x31, 0xa3" , [20200715 23:20:11.584 CEST] [ozw.library] [debug]: Detail - Node: 80 Removing current message , [20200715 23:20:11.584 CEST] [ozw.library] [debug]: Detail - Node: 80 Notification: Notification - TimeOut , [20200715 23:20:11.584 CEST] [ozw.library] [info]: Info - Node: 86 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=86): 0x01, 0x04, 0x00, 0x41, 0x56, 0xec , [20200715 23:20:11.584 CEST] [ozw.library] [info]: Info - Node: 86 Encrypted Flag is 0 , [20200715 23:20:11.584 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:11.584 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:12.584 CEST] [ozw.library] [critical]: Error - Node: 86 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=86): 0x01, 0x04, 0x00, 0x41, 0x56, 0xec" , [20200715 23:20:12.584 CEST] [ozw.library] [debug]: Detail - Node: 86 Removing current message , [20200715 23:20:12.584 CEST] [ozw.library] [debug]: Detail - Node: 86 Notification: Notification - TimeOut , [20200715 23:20:12.584 CEST] [ozw.library] [debug]: Detail - Node: 86 Query Stage Complete (ProtocolInfo) , [20200715 23:20:12.584 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:12.584 CEST] [ozw.library] [debug]: Detail - Node: 86 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:20:12.585 CEST] [ozw.library] [debug]: Detail - Node: 86 QueryStage_Probe , [20200715 23:20:12.585 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:12.585 CEST] [ozw.library] [info]: Info - Node: 86 NoOperation::Set - Routing=true , [20200715 23:20:12.585 CEST] [ozw.library] [debug]: Detail - Node: 86 Queuing (NoOp) NoOperation_Set (Node=86): 0x01, 0x09, 0x00, 0x13, 0x56, 0x02, 0x00, 0x00, 0x25, 0x32, 0xa6 , [20200715 23:20:12.585 CEST] [ozw.library] [debug]: Detail - Node: 86 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:20:12.585 CEST] [ozw.library] [info]: Info - Node: 86 Sending (NoOp) message (Callback ID=0x32, Expected Reply=0x13) - NoOperation_Set (Node=86): 0x01, 0x09, 0x00, 0x13, 0x56, 0x02, 0x00, 0x00, 0x25, 0x32, 0xa6 , [20200715 23:20:12.585 CEST] [ozw.library] [info]: Info - Node: 86 Encrypted Flag is 0 , [20200715 23:20:13.585 CEST] [ozw.library] [critical]: Error - Node: 86 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=86): 0x01, 0x09, 0x00, 0x13, 0x56, 0x02, 0x00, 0x00, 0x25, 0x32, 0xa6" , [20200715 23:20:13.585 CEST] [ozw.library] [debug]: Detail - Node: 86 Removing current message , [20200715 23:20:13.585 CEST] [ozw.library] [debug]: Detail - Node: 86 Notification: Notification - TimeOut , [20200715 23:20:13.585 CEST] [ozw.library] [info]: Info - Node: 88 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=88): 0x01, 0x04, 0x00, 0x41, 0x58, 0xe2 , [20200715 23:20:13.585 CEST] [ozw.library] [info]: Info - Node: 88 Encrypted Flag is 0 , [20200715 23:20:13.585 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:13.586 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:14.586 CEST] [ozw.library] [critical]: Error - Node: 88 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=88): 0x01, 0x04, 0x00, 0x41, 0x58, 0xe2" , [20200715 23:20:14.586 CEST] [ozw.library] [debug]: Detail - Node: 88 Removing current message , [20200715 23:20:14.586 CEST] [ozw.library] [debug]: Detail - Node: 88 Notification: Notification - TimeOut , [20200715 23:20:14.586 CEST] [ozw.library] [debug]: Detail - Node: 88 Query Stage Complete (ProtocolInfo) , [20200715 23:20:14.586 CEST] [ozw.library] [debug]: Detail - Node: 88 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:20:14.586 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:14.586 CEST] [ozw.library] [debug]: Detail - Node: 88 QueryStage_Probe , [20200715 23:20:14.586 CEST] [ozw.library] [info]: Info - Node: 88 NoOperation::Set - Routing=true , [20200715 23:20:14.586 CEST] [ozw.library] [debug]: Detail - Node: 88 Queuing (NoOp) NoOperation_Set (Node=88): 0x01, 0x09, 0x00, 0x13, 0x58, 0x02, 0x00, 0x00, 0x25, 0x33, 0xa9 , [20200715 23:20:14.586 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:14.586 CEST] [ozw.library] [debug]: Detail - Node: 88 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:20:14.586 CEST] [ozw.library] [info]: Info - Node: 88 Sending (NoOp) message (Callback ID=0x33, Expected Reply=0x13) - NoOperation_Set (Node=88): 0x01, 0x09, 0x00, 0x13, 0x58, 0x02, 0x00, 0x00, 0x25, 0x33, 0xa9 , [20200715 23:20:14.586 CEST] [ozw.library] [info]: Info - Node: 88 Encrypted Flag is 0 , [20200715 23:20:15.587 CEST] [ozw.library] [critical]: Error - Node: 88 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=88): 0x01, 0x09, 0x00, 0x13, 0x58, 0x02, 0x00, 0x00, 0x25, 0x33, 0xa9" , [20200715 23:20:15.587 CEST] [ozw.library] [debug]: Detail - Node: 88 Removing current message , [20200715 23:20:15.587 CEST] [ozw.library] [debug]: Detail - Node: 88 Notification: Notification - TimeOut , [20200715 23:20:15.587 CEST] [ozw.library] [info]: Info - Node: 90 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=90): 0x01, 0x04, 0x00, 0x41, 0x5a, 0xe0 , [20200715 23:20:15.587 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:15.587 CEST] [ozw.library] [info]: Info - Node: 90 Encrypted Flag is 0 , [20200715 23:20:15.587 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:16.587 CEST] [ozw.library] [critical]: Error - Node: 90 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=90): 0x01, 0x04, 0x00, 0x41, 0x5a, 0xe0" , [20200715 23:20:16.587 CEST] [ozw.library] [debug]: Detail - Node: 90 Removing current message , [20200715 23:20:16.587 CEST] [ozw.library] [debug]: Detail - Node: 90 Notification: Notification - TimeOut , [20200715 23:20:16.587 CEST] [ozw.library] [debug]: Detail - Node: 90 Query Stage Complete (ProtocolInfo) , [20200715 23:20:16.588 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:16.588 CEST] [ozw.library] [debug]: Detail - Node: 90 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:20:16.588 CEST] [ozw.library] [debug]: Detail - Node: 90 QueryStage_Probe , [20200715 23:20:16.588 CEST] [ozw.library] [info]: Info - Node: 90 NoOperation::Set - Routing=true , [20200715 23:20:16.588 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:16.588 CEST] [ozw.library] [debug]: Detail - Node: 90 Queuing (NoOp) NoOperation_Set (Node=90): 0x01, 0x09, 0x00, 0x13, 0x5a, 0x02, 0x00, 0x00, 0x25, 0x34, 0xac , [20200715 23:20:16.588 CEST] [ozw.library] [debug]: Detail - Node: 90 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:20:16.588 CEST] [ozw.library] [info]: Info - Node: 90 Sending (NoOp) message (Callback ID=0x34, Expected Reply=0x13) - NoOperation_Set (Node=90): 0x01, 0x09, 0x00, 0x13, 0x5a, 0x02, 0x00, 0x00, 0x25, 0x34, 0xac , [20200715 23:20:16.588 CEST] [ozw.library] [info]: Info - Node: 90 Encrypted Flag is 0 , [20200715 23:20:17.588 CEST] [ozw.library] [critical]: Error - Node: 90 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=90): 0x01, 0x09, 0x00, 0x13, 0x5a, 0x02, 0x00, 0x00, 0x25, 0x34, 0xac" , [20200715 23:20:17.588 CEST] [ozw.library] [debug]: Detail - Node: 90 Removing current message , [20200715 23:20:17.588 CEST] [ozw.library] [debug]: Detail - Node: 90 Notification: Notification - TimeOut , [20200715 23:20:17.588 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:17.588 CEST] [ozw.library] [info]: Info - Node: 91 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=91): 0x01, 0x04, 0x00, 0x41, 0x5b, 0xe1 , [20200715 23:20:17.588 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:17.588 CEST] [ozw.library] [info]: Info - Node: 91 Encrypted Flag is 0 , [20200715 23:20:18.589 CEST] [ozw.library] [critical]: Error - Node: 91 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=91): 0x01, 0x04, 0x00, 0x41, 0x5b, 0xe1" , [20200715 23:20:18.589 CEST] [ozw.library] [debug]: Detail - Node: 91 Removing current message , [20200715 23:20:18.589 CEST] [ozw.library] [debug]: Detail - Node: 91 Notification: Notification - TimeOut , [20200715 23:20:18.589 CEST] [ozw.library] [debug]: Detail - Node: 91 Query Stage Complete (ProtocolInfo) , [20200715 23:20:18.589 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:18.589 CEST] [ozw.library] [debug]: Detail - Node: 91 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:20:18.589 CEST] [ozw.library] [debug]: Detail - Node: 91 QueryStage_Probe , [20200715 23:20:18.589 CEST] [ozw.library] [info]: Info - Node: 91 NoOperation::Set - Routing=true , [20200715 23:20:18.589 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:18.589 CEST] [ozw.library] [debug]: Detail - Node: 91 Queuing (NoOp) NoOperation_Set (Node=91): 0x01, 0x09, 0x00, 0x13, 0x5b, 0x02, 0x00, 0x00, 0x25, 0x35, 0xac , [20200715 23:20:18.589 CEST] [ozw.library] [debug]: Detail - Node: 91 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:20:18.589 CEST] [ozw.library] [info]: Info - Node: 91 Sending (NoOp) message (Callback ID=0x35, Expected Reply=0x13) - NoOperation_Set (Node=91): 0x01, 0x09, 0x00, 0x13, 0x5b, 0x02, 0x00, 0x00, 0x25, 0x35, 0xac , [20200715 23:20:18.589 CEST] [ozw.library] [info]: Info - Node: 91 Encrypted Flag is 0 , [20200715 23:20:19.589 CEST] [ozw.library] [critical]: Error - Node: 91 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=91): 0x01, 0x09, 0x00, 0x13, 0x5b, 0x02, 0x00, 0x00, 0x25, 0x35, 0xac" , [20200715 23:20:19.589 CEST] [ozw.library] [debug]: Detail - Node: 91 Removing current message , [20200715 23:20:19.590 CEST] [ozw.library] [debug]: Detail - Node: 91 Notification: Notification - TimeOut , [20200715 23:20:19.590 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:19.590 CEST] [ozw.library] [info]: Info - Node: 93 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=93): 0x01, 0x04, 0x00, 0x41, 0x5d, 0xe7 , [20200715 23:20:19.590 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:19.590 CEST] [ozw.library] [info]: Info - Node: 93 Encrypted Flag is 0 , [20200715 23:20:20.590 CEST] [ozw.library] [critical]: Error - Node: 93 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=93): 0x01, 0x04, 0x00, 0x41, 0x5d, 0xe7" , [20200715 23:20:20.590 CEST] [ozw.library] [debug]: Detail - Node: 93 Removing current message , [20200715 23:20:20.590 CEST] [ozw.library] [debug]: Detail - Node: 93 Notification: Notification - TimeOut , [20200715 23:20:20.590 CEST] [ozw.library] [debug]: Detail - Node: 93 Query Stage Complete (ProtocolInfo) , [20200715 23:20:20.590 CEST] [ozw.library] [debug]: Detail - Node: 93 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:20:20.591 CEST] [ozw.library] [debug]: Detail - Node: 93 QueryStage_Probe , [20200715 23:20:20.591 CEST] [ozw.library] [info]: Info - Node: 93 NoOperation::Set - Routing=true , [20200715 23:20:20.591 CEST] [ozw.library] [debug]: Detail - Node: 93 Queuing (NoOp) NoOperation_Set (Node=93): 0x01, 0x09, 0x00, 0x13, 0x5d, 0x02, 0x00, 0x00, 0x25, 0x36, 0xa9 , [20200715 23:20:20.591 CEST] [ozw.library] [debug]: Detail - Node: 93 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:20:20.591 CEST] [ozw.library] [info]: Info - Node: 93 Sending (NoOp) message (Callback ID=0x36, Expected Reply=0x13) - NoOperation_Set (Node=93): 0x01, 0x09, 0x00, 0x13, 0x5d, 0x02, 0x00, 0x00, 0x25, 0x36, 0xa9 , [20200715 23:20:20.591 CEST] [ozw.library] [info]: Info - Node: 93 Encrypted Flag is 0 , [20200715 23:20:20.591 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:20.591 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:21.591 CEST] [ozw.library] [critical]: Error - Node: 93 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=93): 0x01, 0x09, 0x00, 0x13, 0x5d, 0x02, 0x00, 0x00, 0x25, 0x36, 0xa9" , [20200715 23:20:21.591 CEST] [ozw.library] [debug]: Detail - Node: 93 Removing current message , [20200715 23:20:21.591 CEST] [ozw.library] [debug]: Detail - Node: 93 Notification: Notification - TimeOut , [20200715 23:20:21.591 CEST] [ozw.library] [info]: Info - Node: 94 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=94): 0x01, 0x04, 0x00, 0x41, 0x5e, 0xe4 , [20200715 23:20:21.591 CEST] [ozw.library] [info]: Info - Node: 94 Encrypted Flag is 0 , [20200715 23:20:21.591 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:21.591 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:22.592 CEST] [ozw.library] [critical]: Error - Node: 94 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=94): 0x01, 0x04, 0x00, 0x41, 0x5e, 0xe4" , [20200715 23:20:22.592 CEST] [ozw.library] [debug]: Detail - Node: 94 Removing current message , [20200715 23:20:22.592 CEST] [ozw.library] [debug]: Detail - Node: 94 Notification: Notification - TimeOut , [20200715 23:20:22.592 CEST] [ozw.library] [debug]: Detail - Node: 94 Query Stage Complete (ProtocolInfo) , [20200715 23:20:22.592 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:22.592 CEST] [ozw.library] [debug]: Detail - Node: 94 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:20:22.592 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:22.592 CEST] [ozw.library] [debug]: Detail - Node: 94 QueryStage_Probe , [20200715 23:20:22.592 CEST] [ozw.library] [info]: Info - Node: 94 NoOperation::Set - Routing=true , [20200715 23:20:22.593 CEST] [ozw.library] [debug]: Detail - Node: 94 Queuing (NoOp) NoOperation_Set (Node=94): 0x01, 0x09, 0x00, 0x13, 0x5e, 0x02, 0x00, 0x00, 0x25, 0x37, 0xab , [20200715 23:20:22.593 CEST] [ozw.library] [debug]: Detail - Node: 94 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:20:22.593 CEST] [ozw.library] [info]: Info - Node: 94 Sending (NoOp) message (Callback ID=0x37, Expected Reply=0x13) - NoOperation_Set (Node=94): 0x01, 0x09, 0x00, 0x13, 0x5e, 0x02, 0x00, 0x00, 0x25, 0x37, 0xab , [20200715 23:20:22.593 CEST] [ozw.library] [info]: Info - Node: 94 Encrypted Flag is 0 , [20200715 23:20:23.593 CEST] [ozw.library] [critical]: Error - Node: 94 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=94): 0x01, 0x09, 0x00, 0x13, 0x5e, 0x02, 0x00, 0x00, 0x25, 0x37, 0xab" , [20200715 23:20:23.594 CEST] [ozw.library] [debug]: Detail - Node: 94 Removing current message , [20200715 23:20:23.594 CEST] [ozw.library] [debug]: Detail - Node: 94 Notification: Notification - TimeOut , [20200715 23:20:23.594 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:23.594 CEST] [ozw.library] [info]: Info - Node: 96 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=96): 0x01, 0x04, 0x00, 0x41, 0x60, 0xda , [20200715 23:20:23.594 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:23.594 CEST] [ozw.library] [info]: Info - Node: 96 Encrypted Flag is 0 , [20200715 23:20:24.594 CEST] [ozw.library] [critical]: Error - Node: 96 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=96): 0x01, 0x04, 0x00, 0x41, 0x60, 0xda" , [20200715 23:20:24.594 CEST] [ozw.library] [debug]: Detail - Node: 96 Removing current message , [20200715 23:20:24.594 CEST] [ozw.library] [debug]: Detail - Node: 96 Notification: Notification - TimeOut , [20200715 23:20:24.594 CEST] [ozw.library] [debug]: Detail - Node: 96 Query Stage Complete (ProtocolInfo) , [20200715 23:20:24.594 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:24.594 CEST] [ozw.library] [debug]: Detail - Node: 96 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:20:24.595 CEST] [ozw.library] [debug]: Detail - Node: 96 QueryStage_Probe , [20200715 23:20:24.595 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:24.595 CEST] [ozw.library] [info]: Info - Node: 96 NoOperation::Set - Routing=true , [20200715 23:20:24.595 CEST] [ozw.library] [debug]: Detail - Node: 96 Queuing (NoOp) NoOperation_Set (Node=96): 0x01, 0x09, 0x00, 0x13, 0x60, 0x02, 0x00, 0x00, 0x25, 0x38, 0x9a , [20200715 23:20:24.595 CEST] [ozw.library] [debug]: Detail - Node: 96 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:20:24.595 CEST] [ozw.library] [info]: Info - Node: 96 Sending (NoOp) message (Callback ID=0x38, Expected Reply=0x13) - NoOperation_Set (Node=96): 0x01, 0x09, 0x00, 0x13, 0x60, 0x02, 0x00, 0x00, 0x25, 0x38, 0x9a , [20200715 23:20:24.595 CEST] [ozw.library] [info]: Info - Node: 96 Encrypted Flag is 0 , [20200715 23:20:25.595 CEST] [ozw.library] [critical]: Error - Node: 96 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=96): 0x01, 0x09, 0x00, 0x13, 0x60, 0x02, 0x00, 0x00, 0x25, 0x38, 0x9a" , [20200715 23:20:25.595 CEST] [ozw.library] [debug]: Detail - Node: 96 Removing current message , [20200715 23:20:25.595 CEST] [ozw.library] [debug]: Detail - Node: 96 Notification: Notification - TimeOut , [20200715 23:20:25.595 CEST] [ozw.library] [info]: Info - Node: 97 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=97): 0x01, 0x04, 0x00, 0x41, 0x61, 0xdb , [20200715 23:20:25.595 CEST] [ozw.library] [info]: Info - Node: 97 Encrypted Flag is 0 , [20200715 23:20:25.595 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:25.596 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:26.596 CEST] [ozw.library] [critical]: Error - Node: 97 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=97): 0x01, 0x04, 0x00, 0x41, 0x61, 0xdb" , [20200715 23:20:26.596 CEST] [ozw.library] [debug]: Detail - Node: 97 Removing current message , [20200715 23:20:26.596 CEST] [ozw.library] [debug]: Detail - Node: 97 Notification: Notification - TimeOut , [20200715 23:20:26.596 CEST] [ozw.library] [debug]: Detail - Node: 97 Query Stage Complete (ProtocolInfo) , [20200715 23:20:26.596 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:20:26.596 CEST] [ozw.library] [debug]: Detail - Node: 97 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:20:26.596 CEST] [ozw.library] [debug]: Detail - Node: 97 QueryStage_Probe , [20200715 23:20:26.596 CEST] [ozw.library] [info]: Info - Node: 97 NoOperation::Set - Routing=true , [20200715 23:20:26.596 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:20:26.596 CEST] [ozw.library] [debug]: Detail - Node: 97 Queuing (NoOp) NoOperation_Set (Node=97): 0x01, 0x09, 0x00, 0x13, 0x61, 0x02, 0x00, 0x00, 0x25, 0x39, 0x9a , [20200715 23:20:26.596 CEST] [ozw.library] [debug]: Detail - Node: 97 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:20:26.596 CEST] [ozw.library] [info]: Info - Node: 97 Sending (NoOp) message (Callback ID=0x39, Expected Reply=0x13) - NoOperation_Set (Node=97): 0x01, 0x09, 0x00, 0x13, 0x61, 0x02, 0x00, 0x00, 0x25, 0x39, 0x9a , [20200715 23:20:26.596 CEST] [ozw.library] [info]: Info - Node: 97 Encrypted Flag is 0 , [20200715 23:20:39.616 CEST] [default] [debug]: QVariant(int, 1) , [20200715 23:21:12.943 CEST] [ozw.library] [debug]: Detail - Node: 0 Unsolicited message received while waiting for ACK. , [20200715 23:21:12.943 CEST] [ozw.library] [debug]: Detail - Node: 97 Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 , [20200715 23:21:12.943 CEST] [default] [debug]: QVariant(int, 4) , [20200715 23:21:12.943 CEST] [default] [debug]: QVariant(int, 11) , [20200715 23:21:12.944 CEST] [ozw.library] [debug]: Detail - Node: 97 ZW_SEND_DATA delivered to Z-Wave stack , [20200715 23:21:12.944 CEST] [default] [debug]: QVariant(int, 14) , [20200715 23:21:12.944 CEST] [default] [debug]: QVariant(int, 15) , [20200715 23:21:12.944 CEST] [default] [debug]: QVariant(int, 16) , [20200715 23:21:12.944 CEST] [default] [debug]: QVariant(int, 17) , [20200715 23:21:12.944 CEST] [default] [debug]: QVariant(int, 19) , [20200715 23:21:12.944 CEST] [default] [debug]: QVariant(int, 20) , [20200715 23:21:12.944 CEST] [default] [debug]: QVariant(int, 21) , [20200715 23:21:12.945 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.945 CEST] [default] [debug]: QVariant(int, 24) , [20200715 23:21:12.945 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.945 CEST] [default] [debug]: QVariant(int, 25) , [20200715 23:21:12.945 CEST] [default] [debug]: QVariant(int, 26) , [20200715 23:21:12.945 CEST] [default] [debug]: QVariant(int, 28) , [20200715 23:21:12.945 CEST] [default] [debug]: QVariant(int, 29) , [20200715 23:21:12.945 CEST] [default] [debug]: QVariant(int, 30) , [20200715 23:21:12.945 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.946 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.946 CEST] [default] [debug]: QVariant(int, 31) , [20200715 23:21:12.946 CEST] [default] [debug]: QVariant(int, 37) , [20200715 23:21:12.946 CEST] [default] [debug]: QVariant(int, 38) , [20200715 23:21:12.946 CEST] [default] [debug]: QVariant(int, 39) , [20200715 23:21:12.946 CEST] [default] [debug]: QVariant(int, 40) , [20200715 23:21:12.946 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.946 CEST] [default] [debug]: QVariant(int, 42) , [20200715 23:21:12.946 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.947 CEST] [default] [debug]: QVariant(int, 43) , [20200715 23:21:12.947 CEST] [default] [debug]: QVariant(int, 44) , [20200715 23:21:12.947 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.947 CEST] [default] [debug]: QVariant(int, 45) , [20200715 23:21:12.947 CEST] [default] [debug]: QVariant(int, 47) , [20200715 23:21:12.947 CEST] [default] [debug]: QVariant(int, 48) , [20200715 23:21:12.947 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.947 CEST] [default] [debug]: QVariant(int, 50) , [20200715 23:21:12.948 CEST] [default] [debug]: QVariant(int, 52) , [20200715 23:21:12.948 CEST] [default] [debug]: QVariant(int, 54) , [20200715 23:21:12.948 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.948 CEST] [default] [debug]: QVariant(int, 56) , [20200715 23:21:12.948 CEST] [default] [debug]: QVariant(int, 59) , [20200715 23:21:12.948 CEST] [default] [debug]: QVariant(int, 64) , [20200715 23:21:12.949 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.949 CEST] [default] [debug]: QVariant(int, 65) , [20200715 23:21:12.949 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.949 CEST] [default] [debug]: QVariant(int, 72) , [20200715 23:21:12.949 CEST] [default] [debug]: QVariant(int, 73) , [20200715 23:21:12.949 CEST] [default] [debug]: QVariant(int, 75) , [20200715 23:21:12.949 CEST] [default] [debug]: QVariant(int, 77) , [20200715 23:21:12.949 CEST] [default] [debug]: QVariant(int, 78) , [20200715 23:21:12.949 CEST] [default] [debug]: QVariant(int, 79) , [20200715 23:21:12.949 CEST] [default] [debug]: QVariant(int, 80) , [20200715 23:21:12.950 CEST] [default] [debug]: QVariant(int, 86) , [20200715 23:21:12.950 CEST] [default] [debug]: QVariant(int, 88) , [20200715 23:21:12.950 CEST] [default] [debug]: QVariant(int, 90) , [20200715 23:21:12.950 CEST] [default] [debug]: QVariant(int, 91) , [20200715 23:21:12.950 CEST] [default] [debug]: QVariant(int, 93) , [20200715 23:21:12.950 CEST] [default] [debug]: QVariant(int, 94) , [20200715 23:21:12.950 CEST] [default] [debug]: QVariant(int, 96) , [20200715 23:21:12.950 CEST] [default] [debug]: QVariant(int, 97) , [20200715 23:21:12.950 CEST] [default] [debug]: QVariant(int, 99) , [20200715 23:21:12.950 CEST] [default] [debug]: QVariant(int, 101) , [20200715 23:21:12.951 CEST] [default] [debug]: QVariant(int, 103) , [20200715 23:21:12.951 CEST] [default] [debug]: QVariant(int, 104) , [20200715 23:21:12.951 CEST] [default] [debug]: QVariant(int, 105) , [20200715 23:21:12.951 CEST] [default] [debug]: QVariant(int, 106) , [20200715 23:21:12.951 CEST] [default] [debug]: QVariant(int, 107) , [20200715 23:21:12.951 CEST] [default] [debug]: QVariant(int, 108) , [20200715 23:21:12.951 CEST] [default] [debug]: QVariant(int, 1) , [20200715 23:21:12.951 CEST] [default] [debug]: QVariant(int, 4) , [20200715 23:21:12.951 CEST] [default] [debug]: QVariant(int, 11) , [20200715 23:21:12.952 CEST] [default] [debug]: QVariant(int, 14) , [20200715 23:21:12.952 CEST] [default] [debug]: QVariant(int, 15) , [20200715 23:21:12.952 CEST] [default] [debug]: QVariant(int, 16) , [20200715 23:21:12.952 CEST] [default] [debug]: QVariant(int, 17) , [20200715 23:21:12.952 CEST] [default] [debug]: QVariant(int, 19) , [20200715 23:21:12.952 CEST] [default] [debug]: QVariant(int, 20) , [20200715 23:21:12.952 CEST] [default] [debug]: QVariant(int, 21) , [20200715 23:21:12.952 CEST] [default] [debug]: QVariant(int, 24) , [20200715 23:21:12.952 CEST] [default] [debug]: QVariant(int, 25) , [20200715 23:21:12.953 CEST] [default] [debug]: QVariant(int, 26) , [20200715 23:21:12.953 CEST] [default] [debug]: QVariant(int, 28) , [20200715 23:21:12.953 CEST] [default] [debug]: QVariant(int, 29) , [20200715 23:21:12.953 CEST] [default] [debug]: QVariant(int, 30) , [20200715 23:21:12.953 CEST] [default] [debug]: QVariant(int, 31) , [20200715 23:21:12.953 CEST] [default] [debug]: QVariant(int, 37) , [20200715 23:21:12.953 CEST] [default] [debug]: QVariant(int, 38) , [20200715 23:21:12.953 CEST] [default] [debug]: QVariant(int, 39) , [20200715 23:21:12.954 CEST] [default] [debug]: QVariant(int, 40) , [20200715 23:21:12.954 CEST] [default] [debug]: QVariant(int, 42) , [20200715 23:21:12.954 CEST] [default] [debug]: QVariant(int, 43) , [20200715 23:21:12.954 CEST] [default] [debug]: QVariant(int, 44) , [20200715 23:21:12.954 CEST] [default] [debug]: QVariant(int, 45) , [20200715 23:21:12.954 CEST] [default] [debug]: QVariant(int, 47) , [20200715 23:21:12.954 CEST] [default] [debug]: QVariant(int, 48) , [20200715 23:21:12.954 CEST] [default] [debug]: QVariant(int, 50) , [20200715 23:21:12.954 CEST] [default] [debug]: QVariant(int, 52) , [20200715 23:21:12.955 CEST] [default] [debug]: QVariant(int, 54) , [20200715 23:21:12.955 CEST] [default] [debug]: QVariant(int, 56) , [20200715 23:21:12.955 CEST] [default] [debug]: QVariant(int, 59) , [20200715 23:21:12.955 CEST] [default] [debug]: QVariant(int, 64) , [20200715 23:21:12.955 CEST] [default] [debug]: QVariant(int, 65) , [20200715 23:21:12.955 CEST] [default] [debug]: QVariant(int, 72) , [20200715 23:21:12.955 CEST] [default] [debug]: QVariant(int, 73) , [20200715 23:21:12.955 CEST] [default] [debug]: QVariant(int, 75) , [20200715 23:21:12.956 CEST] [default] [debug]: QVariant(int, 77) , [20200715 23:21:12.956 CEST] [default] [debug]: QVariant(int, 78) , [20200715 23:21:12.957 CEST] [default] [debug]: QVariant(int, 79) , [20200715 23:21:12.957 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.958 CEST] [default] [debug]: QVariant(int, 80) , [20200715 23:21:12.958 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.958 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.958 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.958 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.958 CEST] [default] [debug]: QVariant(int, 86) , [20200715 23:21:12.958 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.958 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.958 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.958 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.958 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.959 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.959 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.959 CEST] [default] [debug]: QVariant(int, 88) , [20200715 23:21:12.959 CEST] [default] [debug]: QVariant(int, 90) , [20200715 23:21:12.959 CEST] [default] [debug]: QVariant(int, 91) , [20200715 23:21:12.959 CEST] [default] [debug]: QVariant(int, 93) , [20200715 23:21:12.959 CEST] [ozw.library] [debug]: Detail - Node: 97 CAN received...triggering resend , [20200715 23:21:12.959 CEST] [default] [debug]: QVariant(int, 94) , [20200715 23:21:12.959 CEST] [default] [debug]: QVariant(int, 96) , [20200715 23:21:12.959 CEST] [default] [debug]: QVariant(int, 97) , [20200715 23:21:12.959 CEST] [default] [debug]: QVariant(int, 99) , [20200715 23:21:12.960 CEST] [default] [debug]: QVariant(int, 101) , [20200715 23:21:12.960 CEST] [default] [debug]: QVariant(int, 103) , [20200715 23:21:12.960 CEST] [default] [debug]: QVariant(int, 104) , [20200715 23:21:12.960 CEST] [default] [debug]: QVariant(int, 105) , [20200715 23:21:12.960 CEST] [default] [debug]: QVariant(int, 106) , [20200715 23:21:12.960 CEST] [default] [debug]: QVariant(int, 107) , [20200715 23:21:12.961 CEST] [default] [debug]: QVariant(int, 108) , [20200715 23:21:12.963 CEST] [ozw.mqtt.publisher] [debug]: "Wed Jul 15 23:21:12 2020 PingResponse\n" , [20200715 23:21:13.959 CEST] [ozw.library] [info]: Info - Node: 97 Sending (NoOp) message (Attempt 2, Callback ID=0x3a, Expected Reply=0x13) - NoOperation_Set (Node=97): 0x01, 0x09, 0x00, 0x13, 0x61, 0x02, 0x00, 0x00, 0x25, 0x3a, 0x99 , [20200715 23:21:13.959 CEST] [ozw.library] [info]: Info - Node: 97 Encrypted Flag is 0 , [20200715 23:21:14.960 CEST] [ozw.library] [info]: Info - Node: 97 Sending (NoOp) message (Attempt 3, Callback ID=0x3b, Expected Reply=0x13) - NoOperation_Set (Node=97): 0x01, 0x09, 0x00, 0x13, 0x61, 0x02, 0x00, 0x00, 0x25, 0x3b, 0x98 , [20200715 23:21:14.960 CEST] [ozw.library] [info]: Info - Node: 97 Encrypted Flag is 0 , [20200715 23:21:15.960 CEST] [ozw.library] [info]: Info - Node: 97 Sending (NoOp) message (Attempt 4, Callback ID=0x3c, Expected Reply=0x13) - NoOperation_Set (Node=97): 0x01, 0x09, 0x00, 0x13, 0x61, 0x02, 0x00, 0x00, 0x25, 0x3c, 0x9f , [20200715 23:21:15.960 CEST] [ozw.library] [info]: Info - Node: 97 Encrypted Flag is 0 , [20200715 23:21:16.960 CEST] [ozw.library] [info]: Info - Node: 97 Sending (NoOp) message (Attempt 5, Callback ID=0x3d, Expected Reply=0x13) - NoOperation_Set (Node=97): 0x01, 0x09, 0x00, 0x13, 0x61, 0x02, 0x00, 0x00, 0x25, 0x3d, 0x9e , [20200715 23:21:16.960 CEST] [ozw.library] [info]: Info - Node: 97 Encrypted Flag is 0 , [20200715 23:21:17.961 CEST] [ozw.library] [info]: Info - Node: 97 Sending (NoOp) message (Attempt 6, Callback ID=0x3e, Expected Reply=0x13) - NoOperation_Set (Node=97): 0x01, 0x09, 0x00, 0x13, 0x61, 0x02, 0x00, 0x00, 0x25, 0x3e, 0x9d , [20200715 23:21:17.961 CEST] [ozw.library] [info]: Info - Node: 97 Encrypted Flag is 0 , [20200715 23:21:18.961 CEST] [ozw.library] [critical]: Error - Node: 97 ERROR: Dropping command, expected response not received after 6 attempt(s). Command: "NoOperation_Set (Node=97): 0x01, 0x09, 0x00, 0x13, 0x61, 0x02, 0x00, 0x00, 0x25, 0x3e, 0x9d" , [20200715 23:21:18.961 CEST] [ozw.library] [debug]: Detail - Node: 97 Removing current message , [20200715 23:21:18.961 CEST] [ozw.library] [info]: Info - Node: 99 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=99): 0x01, 0x04, 0x00, 0x41, 0x63, 0xd9 , [20200715 23:21:18.961 CEST] [ozw.library] [info]: Info - Node: 99 Encrypted Flag is 0 , [20200715 23:21:19.962 CEST] [ozw.library] [critical]: Error - Node: 99 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=99): 0x01, 0x04, 0x00, 0x41, 0x63, 0xd9" , [20200715 23:21:19.962 CEST] [ozw.library] [debug]: Detail - Node: 99 Removing current message , [20200715 23:21:19.962 CEST] [ozw.library] [debug]: Detail - Node: 99 Notification: Notification - TimeOut , [20200715 23:21:19.962 CEST] [ozw.library] [debug]: Detail - Node: 99 Query Stage Complete (ProtocolInfo) , [20200715 23:21:19.962 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:19.962 CEST] [ozw.library] [debug]: Detail - Node: 99 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:21:19.962 CEST] [ozw.library] [debug]: Detail - Node: 99 QueryStage_Probe , [20200715 23:21:19.962 CEST] [ozw.library] [info]: Info - Node: 99 NoOperation::Set - Routing=true , [20200715 23:21:19.962 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:19.962 CEST] [ozw.library] [debug]: Detail - Node: 99 Queuing (NoOp) NoOperation_Set (Node=99): 0x01, 0x09, 0x00, 0x13, 0x63, 0x02, 0x00, 0x00, 0x25, 0x3f, 0x9e , [20200715 23:21:19.962 CEST] [ozw.library] [debug]: Detail - Node: 99 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:21:19.962 CEST] [ozw.library] [info]: Info - Node: 99 Sending (NoOp) message (Callback ID=0x3f, Expected Reply=0x13) - NoOperation_Set (Node=99): 0x01, 0x09, 0x00, 0x13, 0x63, 0x02, 0x00, 0x00, 0x25, 0x3f, 0x9e , [20200715 23:21:19.962 CEST] [ozw.library] [info]: Info - Node: 99 Encrypted Flag is 0 , [20200715 23:21:20.962 CEST] [ozw.library] [critical]: Error - Node: 99 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=99): 0x01, 0x09, 0x00, 0x13, 0x63, 0x02, 0x00, 0x00, 0x25, 0x3f, 0x9e" , [20200715 23:21:20.962 CEST] [ozw.library] [debug]: Detail - Node: 99 Removing current message , [20200715 23:21:20.962 CEST] [ozw.library] [debug]: Detail - Node: 99 Notification: Notification - TimeOut , [20200715 23:21:20.962 CEST] [ozw.library] [info]: Info - Node: 101 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=101): 0x01, 0x04, 0x00, 0x41, 0x65, 0xdf , [20200715 23:21:20.962 CEST] [ozw.library] [info]: Info - Node: 101 Encrypted Flag is 0 , [20200715 23:21:20.962 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:20.963 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:21.963 CEST] [ozw.library] [critical]: Error - Node: 101 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=101): 0x01, 0x04, 0x00, 0x41, 0x65, 0xdf" , [20200715 23:21:21.963 CEST] [ozw.library] [debug]: Detail - Node: 101 Removing current message , [20200715 23:21:21.963 CEST] [ozw.library] [debug]: Detail - Node: 101 Notification: Notification - TimeOut , [20200715 23:21:21.963 CEST] [ozw.library] [debug]: Detail - Node: 101 Query Stage Complete (ProtocolInfo) , [20200715 23:21:21.963 CEST] [ozw.library] [debug]: Detail - Node: 101 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:21:21.963 CEST] [ozw.library] [debug]: Detail - Node: 101 QueryStage_Probe , [20200715 23:21:21.963 CEST] [ozw.library] [info]: Info - Node: 101 NoOperation::Set - Routing=true , [20200715 23:21:21.963 CEST] [ozw.library] [debug]: Detail - Node: 101 Queuing (NoOp) NoOperation_Set (Node=101): 0x01, 0x09, 0x00, 0x13, 0x65, 0x02, 0x00, 0x00, 0x25, 0x40, 0xe7 , [20200715 23:21:21.963 CEST] [ozw.library] [debug]: Detail - Node: 101 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:21:21.963 CEST] [ozw.library] [info]: Info - Node: 101 Sending (NoOp) message (Callback ID=0x40, Expected Reply=0x13) - NoOperation_Set (Node=101): 0x01, 0x09, 0x00, 0x13, 0x65, 0x02, 0x00, 0x00, 0x25, 0x40, 0xe7 , [20200715 23:21:21.963 CEST] [ozw.library] [info]: Info - Node: 101 Encrypted Flag is 0 , [20200715 23:21:21.964 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:21.964 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:22.964 CEST] [ozw.library] [critical]: Error - Node: 101 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=101): 0x01, 0x09, 0x00, 0x13, 0x65, 0x02, 0x00, 0x00, 0x25, 0x40, 0xe7" , [20200715 23:21:22.964 CEST] [ozw.library] [debug]: Detail - Node: 101 Removing current message , [20200715 23:21:22.964 CEST] [ozw.library] [debug]: Detail - Node: 101 Notification: Notification - TimeOut , [20200715 23:21:22.964 CEST] [ozw.library] [info]: Info - Node: 103 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=103): 0x01, 0x04, 0x00, 0x41, 0x67, 0xdd , [20200715 23:21:22.964 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:22.964 CEST] [ozw.library] [info]: Info - Node: 103 Encrypted Flag is 0 , [20200715 23:21:22.964 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:23.964 CEST] [ozw.library] [critical]: Error - Node: 103 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=103): 0x01, 0x04, 0x00, 0x41, 0x67, 0xdd" , [20200715 23:21:23.964 CEST] [ozw.library] [debug]: Detail - Node: 103 Removing current message , [20200715 23:21:23.964 CEST] [ozw.library] [debug]: Detail - Node: 103 Notification: Notification - TimeOut , [20200715 23:21:23.964 CEST] [ozw.library] [debug]: Detail - Node: 103 Query Stage Complete (ProtocolInfo) , [20200715 23:21:23.965 CEST] [ozw.library] [debug]: Detail - Node: 103 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:21:23.965 CEST] [ozw.library] [debug]: Detail - Node: 103 QueryStage_Probe , [20200715 23:21:23.965 CEST] [ozw.library] [info]: Info - Node: 103 NoOperation::Set - Routing=true , [20200715 23:21:23.965 CEST] [ozw.library] [debug]: Detail - Node: 103 Queuing (NoOp) NoOperation_Set (Node=103): 0x01, 0x09, 0x00, 0x13, 0x67, 0x02, 0x00, 0x00, 0x25, 0x41, 0xe4 , [20200715 23:21:23.965 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:23.965 CEST] [ozw.library] [debug]: Detail - Node: 103 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:21:23.965 CEST] [ozw.library] [info]: Info - Node: 103 Sending (NoOp) message (Callback ID=0x41, Expected Reply=0x13) - NoOperation_Set (Node=103): 0x01, 0x09, 0x00, 0x13, 0x67, 0x02, 0x00, 0x00, 0x25, 0x41, 0xe4 , [20200715 23:21:23.965 CEST] [ozw.library] [info]: Info - Node: 103 Encrypted Flag is 0 , [20200715 23:21:23.966 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:24.966 CEST] [ozw.library] [critical]: Error - Node: 103 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=103): 0x01, 0x09, 0x00, 0x13, 0x67, 0x02, 0x00, 0x00, 0x25, 0x41, 0xe4" , [20200715 23:21:24.966 CEST] [ozw.library] [debug]: Detail - Node: 103 Removing current message , [20200715 23:21:24.966 CEST] [ozw.library] [debug]: Detail - Node: 103 Notification: Notification - TimeOut , [20200715 23:21:24.966 CEST] [ozw.library] [info]: Info - Node: 104 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=104): 0x01, 0x04, 0x00, 0x41, 0x68, 0xd2 , [20200715 23:21:24.966 CEST] [ozw.library] [info]: Info - Node: 104 Encrypted Flag is 0 , [20200715 23:21:24.966 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:24.966 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:25.966 CEST] [ozw.library] [critical]: Error - Node: 104 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=104): 0x01, 0x04, 0x00, 0x41, 0x68, 0xd2" , [20200715 23:21:25.966 CEST] [ozw.library] [debug]: Detail - Node: 104 Removing current message , [20200715 23:21:25.966 CEST] [ozw.library] [debug]: Detail - Node: 104 Notification: Notification - TimeOut , [20200715 23:21:25.966 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:25.966 CEST] [ozw.library] [debug]: Detail - Node: 104 Query Stage Complete (ProtocolInfo) , [20200715 23:21:25.967 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:25.967 CEST] [ozw.library] [debug]: Detail - Node: 104 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:21:25.967 CEST] [ozw.library] [debug]: Detail - Node: 104 QueryStage_Probe , [20200715 23:21:25.967 CEST] [ozw.library] [info]: Info - Node: 104 NoOperation::Set - Routing=true , [20200715 23:21:25.967 CEST] [ozw.library] [debug]: Detail - Node: 104 Queuing (NoOp) NoOperation_Set (Node=104): 0x01, 0x09, 0x00, 0x13, 0x68, 0x02, 0x00, 0x00, 0x25, 0x42, 0xe8 , [20200715 23:21:25.967 CEST] [ozw.library] [debug]: Detail - Node: 104 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:21:25.967 CEST] [ozw.library] [info]: Info - Node: 104 Sending (NoOp) message (Callback ID=0x42, Expected Reply=0x13) - NoOperation_Set (Node=104): 0x01, 0x09, 0x00, 0x13, 0x68, 0x02, 0x00, 0x00, 0x25, 0x42, 0xe8 , [20200715 23:21:25.967 CEST] [ozw.library] [info]: Info - Node: 104 Encrypted Flag is 0 , [20200715 23:21:26.967 CEST] [ozw.library] [critical]: Error - Node: 104 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=104): 0x01, 0x09, 0x00, 0x13, 0x68, 0x02, 0x00, 0x00, 0x25, 0x42, 0xe8" , [20200715 23:21:26.967 CEST] [ozw.library] [debug]: Detail - Node: 104 Removing current message , [20200715 23:21:26.967 CEST] [ozw.library] [debug]: Detail - Node: 104 Notification: Notification - TimeOut , [20200715 23:21:26.967 CEST] [ozw.library] [info]: Info - Node: 105 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=105): 0x01, 0x04, 0x00, 0x41, 0x69, 0xd3 , [20200715 23:21:26.968 CEST] [ozw.library] [info]: Info - Node: 105 Encrypted Flag is 0 , [20200715 23:21:26.968 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:26.968 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:27.968 CEST] [ozw.library] [critical]: Error - Node: 105 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=105): 0x01, 0x04, 0x00, 0x41, 0x69, 0xd3" , [20200715 23:21:27.968 CEST] [ozw.library] [debug]: Detail - Node: 105 Removing current message , [20200715 23:21:27.968 CEST] [ozw.library] [debug]: Detail - Node: 105 Notification: Notification - TimeOut , [20200715 23:21:27.968 CEST] [ozw.library] [debug]: Detail - Node: 105 Query Stage Complete (ProtocolInfo) , [20200715 23:21:27.968 CEST] [ozw.library] [debug]: Detail - Node: 105 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:21:27.968 CEST] [ozw.library] [debug]: Detail - Node: 105 QueryStage_Probe , [20200715 23:21:27.968 CEST] [ozw.library] [info]: Info - Node: 105 NoOperation::Set - Routing=true , [20200715 23:21:27.968 CEST] [ozw.library] [debug]: Detail - Node: 105 Queuing (NoOp) NoOperation_Set (Node=105): 0x01, 0x09, 0x00, 0x13, 0x69, 0x02, 0x00, 0x00, 0x25, 0x43, 0xe8 , [20200715 23:21:27.968 CEST] [ozw.library] [debug]: Detail - Node: 105 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:21:27.968 CEST] [ozw.library] [info]: Info - Node: 105 Sending (NoOp) message (Callback ID=0x43, Expected Reply=0x13) - NoOperation_Set (Node=105): 0x01, 0x09, 0x00, 0x13, 0x69, 0x02, 0x00, 0x00, 0x25, 0x43, 0xe8 , [20200715 23:21:27.968 CEST] [ozw.library] [info]: Info - Node: 105 Encrypted Flag is 0 , [20200715 23:21:27.968 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:27.968 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:28.968 CEST] [ozw.library] [critical]: Error - Node: 105 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=105): 0x01, 0x09, 0x00, 0x13, 0x69, 0x02, 0x00, 0x00, 0x25, 0x43, 0xe8" , [20200715 23:21:28.968 CEST] [ozw.library] [debug]: Detail - Node: 105 Removing current message , [20200715 23:21:28.968 CEST] [ozw.library] [debug]: Detail - Node: 105 Notification: Notification - TimeOut , [20200715 23:21:28.968 CEST] [ozw.library] [info]: Info - Node: 106 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=106): 0x01, 0x04, 0x00, 0x41, 0x6a, 0xd0 , [20200715 23:21:28.969 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:28.969 CEST] [ozw.library] [info]: Info - Node: 106 Encrypted Flag is 0 , [20200715 23:21:28.969 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:29.969 CEST] [ozw.library] [critical]: Error - Node: 106 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=106): 0x01, 0x04, 0x00, 0x41, 0x6a, 0xd0" , [20200715 23:21:29.969 CEST] [ozw.library] [debug]: Detail - Node: 106 Removing current message , [20200715 23:21:29.969 CEST] [ozw.library] [debug]: Detail - Node: 106 Notification: Notification - TimeOut , [20200715 23:21:29.969 CEST] [ozw.library] [debug]: Detail - Node: 106 Query Stage Complete (ProtocolInfo) , [20200715 23:21:29.969 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:29.969 CEST] [ozw.library] [debug]: Detail - Node: 106 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:21:29.969 CEST] [ozw.library] [debug]: Detail - Node: 106 QueryStage_Probe , [20200715 23:21:29.969 CEST] [ozw.library] [info]: Info - Node: 106 NoOperation::Set - Routing=true , [20200715 23:21:29.969 CEST] [ozw.library] [debug]: Detail - Node: 106 Queuing (NoOp) NoOperation_Set (Node=106): 0x01, 0x09, 0x00, 0x13, 0x6a, 0x02, 0x00, 0x00, 0x25, 0x44, 0xec , [20200715 23:21:29.969 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:29.969 CEST] [ozw.library] [debug]: Detail - Node: 106 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:21:29.969 CEST] [ozw.library] [info]: Info - Node: 106 Sending (NoOp) message (Callback ID=0x44, Expected Reply=0x13) - NoOperation_Set (Node=106): 0x01, 0x09, 0x00, 0x13, 0x6a, 0x02, 0x00, 0x00, 0x25, 0x44, 0xec , [20200715 23:21:29.969 CEST] [ozw.library] [info]: Info - Node: 106 Encrypted Flag is 0 , [20200715 23:21:30.970 CEST] [ozw.library] [critical]: Error - Node: 106 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=106): 0x01, 0x09, 0x00, 0x13, 0x6a, 0x02, 0x00, 0x00, 0x25, 0x44, 0xec" , [20200715 23:21:30.970 CEST] [ozw.library] [debug]: Detail - Node: 106 Removing current message , [20200715 23:21:30.970 CEST] [ozw.library] [debug]: Detail - Node: 106 Notification: Notification - TimeOut , [20200715 23:21:30.970 CEST] [ozw.library] [info]: Info - Node: 107 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=107): 0x01, 0x04, 0x00, 0x41, 0x6b, 0xd1 , [20200715 23:21:30.970 CEST] [ozw.library] [info]: Info - Node: 107 Encrypted Flag is 0 , [20200715 23:21:30.970 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:30.970 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:31.970 CEST] [ozw.library] [critical]: Error - Node: 107 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=107): 0x01, 0x04, 0x00, 0x41, 0x6b, 0xd1" , [20200715 23:21:31.970 CEST] [ozw.library] [debug]: Detail - Node: 107 Removing current message , [20200715 23:21:31.970 CEST] [ozw.library] [debug]: Detail - Node: 107 Notification: Notification - TimeOut , [20200715 23:21:31.970 CEST] [ozw.library] [debug]: Detail - Node: 107 Query Stage Complete (ProtocolInfo) , [20200715 23:21:31.970 CEST] [ozw.library] [debug]: Detail - Node: 107 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:21:31.970 CEST] [ozw.library] [debug]: Detail - Node: 107 QueryStage_Probe , [20200715 23:21:31.970 CEST] [ozw.library] [info]: Info - Node: 107 NoOperation::Set - Routing=true , [20200715 23:21:31.970 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:31.970 CEST] [ozw.library] [debug]: Detail - Node: 107 Queuing (NoOp) NoOperation_Set (Node=107): 0x01, 0x09, 0x00, 0x13, 0x6b, 0x02, 0x00, 0x00, 0x25, 0x45, 0xec , [20200715 23:21:31.970 CEST] [ozw.library] [debug]: Detail - Node: 107 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:21:31.971 CEST] [ozw.library] [info]: Info - Node: 107 Sending (NoOp) message (Callback ID=0x45, Expected Reply=0x13) - NoOperation_Set (Node=107): 0x01, 0x09, 0x00, 0x13, 0x6b, 0x02, 0x00, 0x00, 0x25, 0x45, 0xec , [20200715 23:21:31.971 CEST] [ozw.library] [info]: Info - Node: 107 Encrypted Flag is 0 , [20200715 23:21:31.971 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:32.971 CEST] [ozw.library] [critical]: Error - Node: 107 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=107): 0x01, 0x09, 0x00, 0x13, 0x6b, 0x02, 0x00, 0x00, 0x25, 0x45, 0xec" , [20200715 23:21:32.971 CEST] [ozw.library] [debug]: Detail - Node: 107 Removing current message , [20200715 23:21:32.971 CEST] [ozw.library] [debug]: Detail - Node: 107 Notification: Notification - TimeOut , [20200715 23:21:32.971 CEST] [ozw.library] [info]: Info - Node: 108 Sending (Query) message (Callback ID=0x00, Expected Reply=0x41) - Get Node Protocol Info (Node=108): 0x01, 0x04, 0x00, 0x41, 0x6c, 0xd6 , [20200715 23:21:32.971 CEST] [ozw.library] [info]: Info - Node: 108 Encrypted Flag is 0 , [20200715 23:21:32.971 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:32.971 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:33.971 CEST] [ozw.library] [critical]: Error - Node: 108 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "Get Node Protocol Info (Node=108): 0x01, 0x04, 0x00, 0x41, 0x6c, 0xd6" , [20200715 23:21:33.971 CEST] [ozw.library] [debug]: Detail - Node: 108 Removing current message , [20200715 23:21:33.971 CEST] [ozw.library] [debug]: Detail - Node: 108 Notification: Notification - TimeOut , [20200715 23:21:33.971 CEST] [ozw.library] [debug]: Detail - Node: 108 Query Stage Complete (ProtocolInfo) , [20200715 23:21:33.971 CEST] [ozw.library] [debug]: Detail - Node: 108 AdvanceQueries queryPending=0 queryRetries=0 queryStage=Probe live=1 , [20200715 23:21:33.971 CEST] [ozw.library] [debug]: Detail - Node: 108 QueryStage_Probe , [20200715 23:21:33.971 CEST] [ozw.library] [info]: Info - Node: 108 NoOperation::Set - Routing=true , [20200715 23:21:33.972 CEST] [ozw.library] [debug]: Detail - Node: 108 Queuing (NoOp) NoOperation_Set (Node=108): 0x01, 0x09, 0x00, 0x13, 0x6c, 0x02, 0x00, 0x00, 0x25, 0x46, 0xe8 , [20200715 23:21:33.972 CEST] [ozw.library] [debug]: Detail - Node: 108 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:21:33.972 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:33.972 CEST] [ozw.library] [info]: Info - Node: 108 Sending (NoOp) message (Callback ID=0x46, Expected Reply=0x13) - NoOperation_Set (Node=108): 0x01, 0x09, 0x00, 0x13, 0x6c, 0x02, 0x00, 0x00, 0x25, 0x46, 0xe8 , [20200715 23:21:33.972 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:33.972 CEST] [ozw.library] [info]: Info - Node: 108 Encrypted Flag is 0 , [20200715 23:21:34.973 CEST] [ozw.library] [critical]: Error - Node: 108 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=108): 0x01, 0x09, 0x00, 0x13, 0x6c, 0x02, 0x00, 0x00, 0x25, 0x46, 0xe8" , [20200715 23:21:34.973 CEST] [ozw.library] [debug]: Detail - Node: 108 Removing current message , [20200715 23:21:34.973 CEST] [ozw.library] [debug]: Detail - Node: 108 Notification: Notification - TimeOut , [20200715 23:21:34.973 CEST] [ozw.library] [debug]: Detail - Node: 11 Query Stage Complete (Probe) , [20200715 23:21:34.973 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:34.973 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:34.973 CEST] [ozw.library] [debug]: Detail - Node: 11 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:34.973 CEST] [ozw.library] [debug]: Detail - Node: 11 QueryStage_WakeUp , [20200715 23:21:34.974 CEST] [ozw.library] [info]: Info - Node: 11 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:34.974 CEST] [ozw.library] [debug]: Detail - Node: 11 QueryStage_NodeInfo , [20200715 23:21:34.974 CEST] [ozw.library] [debug]: Detail - Node: 11 Queuing (Query) Request Node Info (Node=11): 0x01, 0x04, 0x00, 0x60, 0x0b, 0x90 , [20200715 23:21:34.974 CEST] [ozw.library] [debug]: Detail - Node: 11 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:34.974 CEST] [ozw.library] [debug]: Detail - Node: 15 Query Stage Complete (Probe) , [20200715 23:21:34.974 CEST] [ozw.library] [debug]: Detail - Node: 15 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:34.974 CEST] [ozw.library] [debug]: Detail - Node: 15 QueryStage_WakeUp , [20200715 23:21:34.974 CEST] [ozw.library] [info]: Info - Node: 15 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:34.974 CEST] [ozw.library] [debug]: Detail - Node: 15 QueryStage_NodeInfo , [20200715 23:21:34.974 CEST] [ozw.library] [debug]: Detail - Node: 15 Queuing (Query) Request Node Info (Node=15): 0x01, 0x04, 0x00, 0x60, 0x0f, 0x94 , [20200715 23:21:34.974 CEST] [ozw.library] [debug]: Detail - Node: 15 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:34.974 CEST] [ozw.library] [debug]: Detail - Node: 16 Query Stage Complete (Probe) , [20200715 23:21:34.974 CEST] [ozw.library] [debug]: Detail - Node: 16 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:34.974 CEST] [ozw.library] [debug]: Detail - Node: 16 QueryStage_WakeUp , [20200715 23:21:34.974 CEST] [ozw.library] [info]: Info - Node: 16 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:34.974 CEST] [ozw.library] [debug]: Detail - Node: 16 QueryStage_NodeInfo , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 16 Queuing (Query) Request Node Info (Node=16): 0x01, 0x04, 0x00, 0x60, 0x10, 0x8b , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 16 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 17 Query Stage Complete (Probe) , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 17 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 17 QueryStage_WakeUp , [20200715 23:21:34.975 CEST] [ozw.library] [info]: Info - Node: 17 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 17 QueryStage_NodeInfo , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 17 Queuing (Query) Request Node Info (Node=17): 0x01, 0x04, 0x00, 0x60, 0x11, 0x8a , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 17 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 19 Query Stage Complete (Probe) , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 19 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 19 QueryStage_WakeUp , [20200715 23:21:34.975 CEST] [ozw.library] [info]: Info - Node: 19 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 19 QueryStage_NodeInfo , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 19 Queuing (Query) Request Node Info (Node=19): 0x01, 0x04, 0x00, 0x60, 0x13, 0x88 , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 19 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 20 Query Stage Complete (Probe) , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 20 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 20 QueryStage_WakeUp , [20200715 23:21:34.975 CEST] [ozw.library] [info]: Info - Node: 20 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 20 QueryStage_NodeInfo , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 20 Queuing (Query) Request Node Info (Node=20): 0x01, 0x04, 0x00, 0x60, 0x14, 0x8f , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 20 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 21 Query Stage Complete (Probe) , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 21 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 21 QueryStage_WakeUp , [20200715 23:21:34.975 CEST] [ozw.library] [info]: Info - Node: 21 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 21 QueryStage_NodeInfo , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 21 Queuing (Query) Request Node Info (Node=21): 0x01, 0x04, 0x00, 0x60, 0x15, 0x8e , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 21 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 24 Query Stage Complete (Probe) , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 24 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 24 QueryStage_WakeUp , [20200715 23:21:34.975 CEST] [ozw.library] [info]: Info - Node: 24 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 24 QueryStage_NodeInfo , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 24 Queuing (Query) Request Node Info (Node=24): 0x01, 0x04, 0x00, 0x60, 0x18, 0x83 , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 24 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 25 Query Stage Complete (Probe) , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 25 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 25 QueryStage_WakeUp , [20200715 23:21:34.975 CEST] [ozw.library] [info]: Info - Node: 25 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 25 QueryStage_NodeInfo , [20200715 23:21:34.975 CEST] [ozw.library] [debug]: Detail - Node: 25 Queuing (Query) Request Node Info (Node=25): 0x01, 0x04, 0x00, 0x60, 0x19, 0x82 , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 25 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 26 Query Stage Complete (Probe) , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 26 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 26 QueryStage_WakeUp , [20200715 23:21:34.976 CEST] [ozw.library] [info]: Info - Node: 26 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 26 QueryStage_NodeInfo , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 26 Queuing (Query) Request Node Info (Node=26): 0x01, 0x04, 0x00, 0x60, 0x1a, 0x81 , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 26 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 28 Query Stage Complete (Probe) , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 28 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 28 QueryStage_WakeUp , [20200715 23:21:34.976 CEST] [ozw.library] [info]: Info - Node: 28 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 28 QueryStage_NodeInfo , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 28 Queuing (Query) Request Node Info (Node=28): 0x01, 0x04, 0x00, 0x60, 0x1c, 0x87 , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 28 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 47 Query Stage Complete (Probe) , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 47 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 47 QueryStage_WakeUp , [20200715 23:21:34.976 CEST] [ozw.library] [info]: Info - Node: 47 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 47 QueryStage_NodeInfo , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 47 Queuing (Query) Request Node Info (Node=47): 0x01, 0x04, 0x00, 0x60, 0x2f, 0xb4 , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 47 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 48 Query Stage Complete (Probe) , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 48 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 48 QueryStage_WakeUp , [20200715 23:21:34.976 CEST] [ozw.library] [info]: Info - Node: 48 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 48 QueryStage_NodeInfo , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 48 Queuing (Query) Request Node Info (Node=48): 0x01, 0x04, 0x00, 0x60, 0x30, 0xab , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 48 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:34.976 CEST] [ozw.library] [debug]: Detail - Node: 50 Query Stage Complete (Probe) , [20200715 23:21:34.977 CEST] [ozw.library] [debug]: Detail - Node: 50 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:34.977 CEST] [ozw.library] [debug]: Detail - Node: 50 QueryStage_WakeUp , [20200715 23:21:34.977 CEST] [ozw.library] [info]: Info - Node: 50 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:34.977 CEST] [ozw.library] [debug]: Detail - Node: 50 QueryStage_NodeInfo , [20200715 23:21:34.977 CEST] [ozw.library] [debug]: Detail - Node: 50 Queuing (Query) Request Node Info (Node=50): 0x01, 0x04, 0x00, 0x60, 0x32, 0xa9 , [20200715 23:21:34.977 CEST] [ozw.library] [debug]: Detail - Node: 50 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:34.977 CEST] [ozw.library] [debug]: Detail - Node: 54 Query Stage Complete (Probe) , [20200715 23:21:34.977 CEST] [ozw.library] [debug]: Detail - Node: 54 AdvanceQueries queryPending=0 queryRetries=1 queryStage=Probe live=1 , [20200715 23:21:34.977 CEST] [ozw.library] [debug]: Detail - Node: 54 QueryStage_Probe , [20200715 23:21:34.977 CEST] [ozw.library] [info]: Info - Node: 54 NoOperation::Set - Routing=true , [20200715 23:21:34.977 CEST] [ozw.library] [debug]: Detail - Node: 54 Queuing (NoOp) NoOperation_Set (Node=54): 0x01, 0x09, 0x00, 0x13, 0x36, 0x02, 0x00, 0x00, 0x25, 0x47, 0xb3 , [20200715 23:21:34.977 CEST] [ozw.library] [debug]: Detail - Node: 54 Queuing (Query) Query Stage Complete (Probe) , [20200715 23:21:34.978 CEST] [ozw.library] [info]: Info - Node: 54 Sending (NoOp) message (Callback ID=0x47, Expected Reply=0x13) - NoOperation_Set (Node=54): 0x01, 0x09, 0x00, 0x13, 0x36, 0x02, 0x00, 0x00, 0x25, 0x47, 0xb3 , [20200715 23:21:34.978 CEST] [ozw.library] [info]: Info - Node: 54 Encrypted Flag is 0 , [20200715 23:21:35.978 CEST] [ozw.library] [critical]: Error - Node: 54 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "NoOperation_Set (Node=54): 0x01, 0x09, 0x00, 0x13, 0x36, 0x02, 0x00, 0x00, 0x25, 0x47, 0xb3" , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 54 Removing current message , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 54 Notification: Notification - TimeOut , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 56 Query Stage Complete (Probe) , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 56 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 56 QueryStage_WakeUp , [20200715 23:21:35.978 CEST] [ozw.library] [info]: Info - Node: 56 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 56 QueryStage_NodeInfo , [20200715 23:21:35.978 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_MsgTimeout Thread: 0x7f2480a08d48 , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 56 Queuing (Query) Request Node Info (Node=56): 0x01, 0x04, 0x00, 0x60, 0x38, 0xa3 , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 56 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 64 Query Stage Complete (Probe) , [20200715 23:21:35.978 CEST] [ozw.mqtt.publisher] [debug]: Publishing Event ozwNotification , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 64 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 64 QueryStage_WakeUp , [20200715 23:21:35.978 CEST] [ozw.library] [info]: Info - Node: 64 NodeInfo Stage - NodeInfoRecieved 0 - NotInfoSupported 1 , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 64 QueryStage_NodeInfo , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 64 Queuing (Query) Request Node Info (Node=64): 0x01, 0x04, 0x00, 0x60, 0x40, 0xdb , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 64 Queuing (Query) Query Stage Complete (NodeInfo) , [20200715 23:21:35.978 CEST] [ozw.library] [debug]: Detail - Node: 65 Query Stage Complete (Probe) , [20200715 23:21:35.979 CEST] [ozw.library] [debug]: Detail - Node: 65 AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1 , [20200715 23:21:35.979 CEST] [ozw.library] [debug]: Detail - Node: 65 QueryStage_WakeUp , [20200715 23:21:35.979 CEST] [ozw.library] [debug]: Detail - Node: 65 Queuing (WakeUp) WakeUpCmd_IntervalGet (Node=65): 0x01, 0x09, 0x00, 0x13, 0x41, 0x02, 0x84, 0x05, 0x25, 0x48, 0x4a , [20200715 23:21:35.979 CEST] [ozw.library] [debug]: Detail - Node: 65 Queuing (Query) Query Stage Complete (WakeUp) , [20200715 23:21:35.979 CEST] [ozw.library] [info]: Info - Node: 65 Sending (WakeUp) message (Callback ID=0x48, Expected Reply=0x04) - WakeUpCmd_IntervalGet (Node=65): 0x01, 0x09, 0x00, 0x13, 0x41, 0x02, 0x84, 0x05, 0x25, 0x48, 0x4a , [20200715 23:21:35.979 CEST] [ozw.library] [info]: Info - Node: 65 Encrypted Flag is 0 , [20200715 23:21:39.603 CEST] [default] [debug]: QVariant(int, 1) , 1594848186: Client qt-openzwave-1 has exceeded timeout, disconnecting., [20200715 23:23:23.779 CEST] [default] [debug]: QVariant(int, 4) , [20200715 23:23:23.780 CEST] [default] [debug]: QVariant(int, 11) , [20200715 23:23:23.780 CEST] [default] [debug]: QVariant(int, 14) , [20200715 23:23:23.780 CEST] [default] [debug]: QVariant(int, 15) , [20200715 23:23:23.780 CEST] [default] [debug]: QVariant(int, 16) , [20200715 23:23:23.780 CEST] [default] [debug]: QVariant(int, 17) , [20200715 23:23:23.781 CEST] [default] [debug]: QVariant(int, 19) , [20200715 23:23:23.781 CEST] [default] [debug]: QVariant(int, 20) , [20200715 23:23:23.781 CEST] [default] [debug]: QVariant(int, 21) , [20200715 23:23:23.781 CEST] [default] [debug]: QVariant(int, 24) , [20200715 23:23:23.781 CEST] [default] [debug]: QVariant(int, 25) , [20200715 23:23:23.781 CEST] [default] [debug]: QVariant(int, 26) , [20200715 23:23:23.781 CEST] [default] [debug]: QVariant(int, 28) , [20200715 23:23:23.782 CEST] [default] [debug]: QVariant(int, 29) , [20200715 23:23:23.782 CEST] [default] [debug]: QVariant(int, 30) , [20200715 23:23:23.782 CEST] [default] [debug]: QVariant(int, 31) , [20200715 23:23:23.782 CEST] [default] [debug]: QVariant(int, 37) , [20200715 23:23:23.782 CEST] [default] [debug]: QVariant(int, 38) , [20200715 23:23:23.782 CEST] [default] [debug]: QVariant(int, 39) , [20200715 23:23:23.782 CEST] [default] [debug]: QVariant(int, 40) , [20200715 23:23:23.783 CEST] [default] [debug]: QVariant(int, 42) , [20200715 23:23:23.783 CEST] [default] [debug]: QVariant(int, 43) , [20200715 23:23:23.783 CEST] [default] [debug]: QVariant(int, 44) , [20200715 23:23:23.783 CEST] [default] [debug]: QVariant(int, 45) , [20200715 23:23:23.783 CEST] [default] [debug]: QVariant(int, 47) , [20200715 23:23:23.783 CEST] [default] [debug]: QVariant(int, 48) , [20200715 23:23:23.783 CEST] [default] [debug]: QVariant(int, 50) , [20200715 23:23:23.783 CEST] [default] [debug]: QVariant(int, 52) , [20200715 23:23:23.783 CEST] [default] [debug]: QVariant(int, 54) , [20200715 23:23:23.784 CEST] [default] [debug]: QVariant(int, 56) , [20200715 23:23:23.784 CEST] [default] [debug]: QVariant(int, 59) , [20200715 23:23:23.784 CEST] [default] [debug]: QVariant(int, 64) , [20200715 23:23:23.784 CEST] [default] [debug]: QVariant(int, 65) , [20200715 23:23:23.784 CEST] [default] [debug]: QVariant(int, 72) , [20200715 23:23:23.784 CEST] [default] [debug]: QVariant(int, 73) , [20200715 23:23:23.784 CEST] [default] [debug]: QVariant(int, 75) , [20200715 23:23:23.784 CEST] [default] [debug]: QVariant(int, 77) , [20200715 23:23:23.784 CEST] [default] [debug]: QVariant(int, 78) , [20200715 23:23:23.784 CEST] [default] [debug]: QVariant(int, 79) , [20200715 23:23:23.784 CEST] [default] [debug]: QVariant(int, 80) , [20200715 23:23:23.785 CEST] [default] [debug]: QVariant(int, 86) , [20200715 23:23:23.785 CEST] [default] [debug]: QVariant(int, 88) , [20200715 23:23:23.785 CEST] [default] [debug]: QVariant(int, 90) , [20200715 23:23:23.785 CEST] [default] [debug]: QVariant(int, 91) , [20200715 23:23:23.785 CEST] [default] [debug]: QVariant(int, 93) , [20200715 23:23:23.785 CEST] [default] [debug]: QVariant(int, 94) , [20200715 23:23:23.785 CEST] [default] [debug]: QVariant(int, 96) , [20200715 23:23:23.785 CEST] [default] [debug]: QVariant(int, 97) , [20200715 23:23:23.785 CEST] [default] [debug]: QVariant(int, 99) , [20200715 23:23:23.785 CEST] [default] [debug]: QVariant(int, 101) , [20200715 23:23:23.786 CEST] [default] [debug]: QVariant(int, 103) , [20200715 23:23:23.786 CEST] [default] [debug]: QVariant(int, 104) , [20200715 23:23:23.786 CEST] [default] [debug]: QVariant(int, 105) , [20200715 23:23:23.786 CEST] [default] [debug]: QVariant(int, 106) , [20200715 23:23:23.786 CEST] [default] [debug]: QVariant(int, 107) , [20200715 23:23:23.786 CEST] [default] [debug]: QVariant(int, 108) , [20200715 23:23:23.786 CEST] [ozw.mqtt.publisher] [debug]: MQTT State Change "Disconnected" , [20200715 23:23:23.786 CEST] [ozw.mqtt.publisher] [warning]: Exiting on Failure , [20200715 23:23:23.786 CEST] [ozw.mqtt.publisher] [warning]: MQTT Client Disconnnected , [20200715 23:23:23.786 CEST] [ozw.mqtt.publisher] [warning]: MQTT Client Error "Transport Invalid" , [20200715 23:23:23.786 CEST] [ozw.library] [info]: Info - Node: 0 mgr, Driver for controller /dev/serial/by-id/usb-0658_0200_12345678-9012-3456-7890-123456789012-if00 pending removal , [20200715 23:23:23.786 CEST] [ozw.library] [debug]: Detail - Node: 0 Notification: DriverRemoved , [20200715 23:23:23.786 CEST] [ozw.notifications] [debug]: Notification pvt_driverRemoved 4229128124 Thread: 0x7f2480a08d48 , [20200715 23:23:23.786 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 1 Thread: 0x7f2480a08d48 , [20200715 23:23:23.786 CEST] [ozw.notifications] [debug]: Notification pvt_valueRemoved: 17301521 Thread: 0x7f2480a08d48 , [20200715 23:23:23.786 CEST] [ozw.values] [debug]: delValue: Removing Value QVariant(QString, "Basic") QVariant(qulonglong, 17301521) 0 , [20200715 23:23:23.786 CEST] [ozw.notifications] [debug]: Notification pvt_valueRemoved: 281474994012177 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.values] [debug]: delValue: Removing Value QVariant(QString, "Basic Target") QVariant(qulonglong, 281474994012177) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_valueRemoved: 562949970722835 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.mqtt.publisher] [debug]: Removing CommandClass Topic for 1 1 32 , [20200715 23:23:23.787 CEST] [ozw.values] [debug]: delValue: Removing Value QVariant(QString, "Basic Duration") QVariant(qulonglong, 562949970722835) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_valueRemoved: 31227923 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.values] [debug]: delValue: Removing Value QVariant(QString, "Loaded Config Revision") QVariant(qulonglong, 31227923) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_valueRemoved: 281475007938579 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.values] [debug]: delValue: Removing Value QVariant(QString, "Config File Revision") QVariant(qulonglong, 281475007938579) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_valueRemoved: 562949984649235 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.mqtt.publisher] [debug]: Removing CommandClass Topic for 1 1 114 , [20200715 23:23:23.787 CEST] [ozw.mqtt.publisher] [debug]: Removing Instance Topic for 1 1 , [20200715 23:23:23.787 CEST] [ozw.values] [debug]: delValue: Removing Value QVariant(QString, "Latest Available Config File Revision") QVariant(qulonglong, 562949984649235) 0 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 1) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 4 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 4) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 11 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 11) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 14 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 14) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 15 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 15) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 16 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 16) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 17 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 17) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 19 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 19) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 20 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 20) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 21 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 21) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 24 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 24) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 25 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 25) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 26 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 26) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 28 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 28) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 29 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 29) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 30 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 30) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 31 Thread: 0x7f2480a08d48 , [20200715 23:23:23.787 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 31) 0 , [20200715 23:23:23.787 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 37 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 37) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 38 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 38) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 39 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 39) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 40 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 40) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 42 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 42) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 43 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 43) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 44 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 44) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 45 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 45) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 47 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 47) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 48 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 48) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 50 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 50) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 52 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 52) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 54 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 54) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 56 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 56) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 59 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 59) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 64 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 64) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 65 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 65) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 72 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 72) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 73 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 73) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 75 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 75) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 77 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 77) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 78 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 78) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 79 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 79) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 80 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 80) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 86 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 86) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 88 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 88) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 90 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 90) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 91 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 91) 0 , [20200715 23:23:23.788 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 93 Thread: 0x7f2480a08d48 , [20200715 23:23:23.788 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 93) 0 , [20200715 23:23:23.789 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 94 Thread: 0x7f2480a08d48 , [20200715 23:23:23.789 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 94) 0 , [20200715 23:23:23.789 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 96 Thread: 0x7f2480a08d48 , [20200715 23:23:23.789 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 96) 0 , [20200715 23:23:23.789 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 97 Thread: 0x7f2480a08d48 , [20200715 23:23:23.789 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 97) 0 , [20200715 23:23:23.789 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 99 Thread: 0x7f2480a08d48 , [20200715 23:23:23.789 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 99) 0 , [20200715 23:23:23.789 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 101 Thread: 0x7f2480a08d48 , [20200715 23:23:23.789 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 101) 0 , [20200715 23:23:23.789 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 103 Thread: 0x7f2480a08d48 , [20200715 23:23:23.789 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 103) 0 , [20200715 23:23:23.789 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 104 Thread: 0x7f2480a08d48 , [20200715 23:23:23.789 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 104) 0 , [20200715 23:23:23.789 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 105 Thread: 0x7f2480a08d48 , [20200715 23:23:23.789 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 105) 0 , [20200715 23:23:23.789 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 106 Thread: 0x7f2480a08d48 , [20200715 23:23:23.789 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 106) 0 , [20200715 23:23:23.789 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 107 Thread: 0x7f2480a08d48 , [20200715 23:23:23.789 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 107) 0 , [20200715 23:23:23.789 CEST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 108 Thread: 0x7f2480a08d48 , [20200715 23:23:23.789 CEST] [ozw.nodes] [debug]: Removing Node QVariant(int, 108) 0 , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 *** , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 * Cumulative Network Statistics *** , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 * General , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 Driver run time: . . . 0 days, 0 hours, 5 minutes , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 Frames processed: . . . . . . . . . . . . . . . . . . . . 160 , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 Total messages successfully received: . . . . . . . . . . 160 , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 Total Messages successfully sent: . . . . . . . . . . . . 130 , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 ACKs received from controller: . . . . . . . . . . . . . 83 , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 * Errors , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 Unsolicited messages received while waiting for ACK: . . 5 , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 Reads aborted due to timeouts: . . . . . . . . . . . . . 0 , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 Bad checksum errors: . . . . . . . . . . . . . . . . . . 0 , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 CANs received from controller: . . . . . . . . . . . . . 25 , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 NAKs received from controller: . . . . . . . . . . . . . 0 , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 Out of frame data flow errors: . . . . . . . . . . . . . 0 , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 Messages retransmitted: . . . . . . . . . . . . . . . . . 6 , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 Messages dropped and not delivered: . . . . . . . . . . . 43 , [20200715 23:23:23.789 CEST] [ozw.library] [debug]: Always - Node: 0 ***** , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 0 Saving Cache , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 1 Cache Save for Node 1 as its QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 4 Skipping Cache Save for Node 4 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 11 Skipping Cache Save for Node 11 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 14 Skipping Cache Save for Node 14 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 15 Skipping Cache Save for Node 15 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 16 Skipping Cache Save for Node 16 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 17 Skipping Cache Save for Node 17 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 19 Skipping Cache Save for Node 19 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 20 Skipping Cache Save for Node 20 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 21 Skipping Cache Save for Node 21 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 24 Skipping Cache Save for Node 24 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 25 Skipping Cache Save for Node 25 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 26 Skipping Cache Save for Node 26 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 28 Skipping Cache Save for Node 28 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 29 Skipping Cache Save for Node 29 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 30 Skipping Cache Save for Node 30 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 31 Skipping Cache Save for Node 31 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 37 Skipping Cache Save for Node 37 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 38 Skipping Cache Save for Node 38 as its not past QueryStage_CacheLoad , [20200715 23:23:23.789 CEST] [ozw.library] [info]: Info - Node: 39 Skipping Cache Save for Node 39 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 40 Skipping Cache Save for Node 40 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 42 Skipping Cache Save for Node 42 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 43 Skipping Cache Save for Node 43 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 44 Skipping Cache Save for Node 44 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 45 Skipping Cache Save for Node 45 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 47 Skipping Cache Save for Node 47 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 48 Skipping Cache Save for Node 48 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 50 Skipping Cache Save for Node 50 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 52 Skipping Cache Save for Node 52 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 54 Skipping Cache Save for Node 54 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 56 Skipping Cache Save for Node 56 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 59 Skipping Cache Save for Node 59 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 64 Skipping Cache Save for Node 64 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 65 Skipping Cache Save for Node 65 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 72 Skipping Cache Save for Node 72 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 73 Skipping Cache Save for Node 73 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 75 Skipping Cache Save for Node 75 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 77 Skipping Cache Save for Node 77 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 78 Skipping Cache Save for Node 78 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 79 Skipping Cache Save for Node 79 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 80 Skipping Cache Save for Node 80 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 86 Skipping Cache Save for Node 86 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 88 Skipping Cache Save for Node 88 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 90 Skipping Cache Save for Node 90 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 91 Skipping Cache Save for Node 91 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 93 Skipping Cache Save for Node 93 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 94 Skipping Cache Save for Node 94 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 96 Skipping Cache Save for Node 96 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 97 Skipping Cache Save for Node 97 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 99 Skipping Cache Save for Node 99 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 101 Skipping Cache Save for Node 101 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 103 Skipping Cache Save for Node 103 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 104 Skipping Cache Save for Node 104 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 105 Skipping Cache Save for Node 105 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 106 Skipping Cache Save for Node 106 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 107 Skipping Cache Save for Node 107 as its not past QueryStage_CacheLoad , [20200715 23:23:23.790 CEST] [ozw.library] [info]: Info - Node: 108 Skipping Cache Save for Node 108 as its not past QueryStage_CacheLoad , [20200715 23:23:23.791 CEST] [ozw.library] [info]: Info - Node: 0 Stopping DNSThread , [20200715 23:23:24.798 CEST] [ozw.library] [debug]: Detail - Node: 65 Removing current message , [20200715 23:23:24.798 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted , [20200715 23:23:24.798 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted , [20200715 23:23:24.798 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted , [20200715 23:23:24.798 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted , [20200715 23:23:24.798 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted , [20200715 23:23:24.799 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted , [20200715 23:23:24.799 CEST] [ozw.library] [info]: Info - Node: 0 mgr, Driver for controller /dev/serial/by-id/usb-0658_0200_12345678-9012-3456-7890-123456789012-if00 removed , [20200715 23:23:24.799 CEST] [ozw.manager] [debug]: Driver Removed for "/dev/serial/by-id/usb-0658_0200_12345678-9012-3456-7890-123456789012-if00" , [20200715 23:23:24.799 CEST] [ozw.manager] [debug]: OZW Serial Port Closed , [20200715 23:23:24.799 CEST] [ozw.daemon] [info]: Shutting Down "ozwdaemon" Version: "0.1.0" , [20200715 23:23:24.799 CEST] [ozw.daemon] [info]: OpenZWave Version: "1.6.1198" , [20200715 23:23:24.799 CEST] [ozw.daemon] [info]: QT-OpenZWave Version: "1.2.0" , [20200715 23:23:24.799 CEST] [ozw.daemon] [info]: QT Version: 5.12.5 , In exit, [cont-finish.d] executing container finish scripts..., [cont-finish.d] done., [s6-finish] waiting for services., 1594848204: mosquitto version 1.6.8 terminating, 1594848204: Saving in-memory database to /data/mosquitto.db., s6-svwait: fatal: supervisor died, [s6-finish] sending all processes the TERM signal., [s6-finish] sending all processes the KILL signal and exiting.,
1594848186: Client qt-openzwave-1 has exceeded timeout, disconnecting.,
The broker stopped responding to ozwdaemon for some reason. Anyway, please either wait for the addon to be updated, or try the official ozwdaemon docker image and see if hte problem persists.
Thanks!
I am pretty sure it was some weird hardware problem with my zwave.me usb stick. I couldn't get it to work and even if I tried the Z-way software (from zwave.me) on a Windows box and even doing a hard reset and starting over. Even that application has problems with the z-wave stack becoming unresponsive on heavy load (e g startup).
I brought a new Aeotec Z-Stick Gen5 and my problem went away! I also switches to Home assistant Z-wave MQTT addon without problems!
[20200709 8:29:15.943 ACST] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/8/instance/1/commandclass/134/value/281475125706775/"
[20200709 8:29:15.944 ACST] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/8/instance/1/commandclass/134/value/562950102417431/"
[20200709 8:29:15.946 ACST] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/8/association/1/"
[20200709 8:29:15.947 ACST] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/8/association/2/"
[20200709 8:29:15.948 ACST] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/5/"
[20200709 8:29:15.949 ACST] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/7/" [20200709 8:29:16.098 ACST] [ozw.library] [info]: Info - Node: 0 Lookup for mfs.db.openzwave.com returned 107 [20200709 8:29:16.164 ACST] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/images/honeywell/39348-ZW4005.jpg (Node 0) [20200709 8:29:16.165 ACST] [ozw.library] [info]: Info - Node: 0 Missing Picture /data/ozw/config/images/honeywell/39348-ZW4005.jpg - Starting Download [20200709 8:29:16.168 ACST] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/images/honeywell/39449-ZW4016.png (Node 0) [20200709 8:29:16.169 ACST] [ozw.library] [info]: Info - Node: 0 Missing Picture /data/ozw/config/images/honeywell/39449-ZW4016.png - Starting Download [20200709 8:29:16.170 ACST] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/images/honeywell/39348-ZW4005.jpg (/data/ozw/config/images/honeywell/39348-ZW4005.jpg) [20200709 8:29:16.174 ACST] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/images/honeywell/39449-ZW4016.png (/data/ozw/config/images/honeywell/39449-ZW4016.png) [20200709 8:29:17.635 ACST] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/images/aeotec/zwa009.png (Node 0) [20200709 8:29:17.636 ACST] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/images/aeotec/zwa009.png (/data/ozw/config/images/aeotec/zwa009.png)
[20200709 8:29:17.637 ACST] [ozw.daemon] [warning]: CRASH!!! - Dumping Backtrace:
[20200709 8:29:17.638 ACST] [ozw.daemon] [warning]: #1 0x00007f5bdde8c304 sp=0x00007f5bdac85400 sigwaitinfo + 0x8
1594249157: Socket error on client qt-openzwave-1, disconnecting. In exit [cont-finish.d] executing container finish scripts... [cont-finish.d] done. [s6-finish] waiting for services. s6-svwait: fatal: supervisor died 1594249157: mosquitto version 1.6.9 terminating 1594249157: Saving in-memory database to /data/mosquitto.db. [s6-finish] sending all processes the TERM signal.