Dear all,
I use OH milestone (i.e. currently OH 2.4 release) with a UZB Z-Wave stick and I own this thermostat since today:
https://www.openhab.org/addons/bindings/zwave/thing.html?manufacturer=danfoss&file=mt02650_0_0.html
It is included and I receive both current temperature as well as battery status.
However, if I choose a set point temperature via PaperUI (in the example below 13°C), the Item tells the value is set, but some seconds later, it switches back to the last value (in the example 14°C).
I guess the value that is assigned after some seconds is the set value still stored in the valve, and this one seems to overwrite the value from PaperUI. Is it possible that my selection is not correctly transferred to the valve, and so the next update from the valve overwrites my selection, and thus the item is showing the last value again?
2019-01-19 22:48:29.815 [ome.event.ItemCommandEvent] - Item 'Set_Point_Heating_Office' received command 13 °C
2019-01-19 22:48:29.823 [nt.ItemStatePredictedEvent] - Set_Point_Heating_Office predicted to become 13 °C
2019-01-19 22:48:29.836 [vent.ItemStateChangedEvent] - Set_Point_Heating_Office changed from 14 °C to 13 °C
2019-01-19 22:49:41.409 [vent.ItemStateChangedEvent] - Set_Point_Heating_Office changed from 13 °C to 14 °C
Here are my current settings:
Here some logs in Z-Wave TRACE mode. I now set the setpoint value to 15°C:
2019-01-20 00:04:15.725 [DEBUG] [ter.ZWaveThermostatSetpointConverter] - NODE 3: Thermostat command received for 15 °C
2019-01-20 00:04:15.728 [DEBUG] [.ZWaveThermostatSetpointCommandClass] - NODE 3: Creating new message for command THERMOSTAT_SETPOINT_SET
2019-01-20 00:04:15.732 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Encapsulating message, endpoint 0
2019-01-20 00:04:15.737 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported
2019-01-20 00:04:15.740 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Command Class COMMAND_CLASS_THERMOSTAT_SETPOINT is NOT required to be secured
2019-01-20 00:04:15.743 [DEBUG] [ter.ZWaveThermostatSetpointConverter] - NODE 3: Sending Message: org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@b30cc5
2019-01-20 00:04:15.747 [DEBUG] [.ZWaveThermostatSetpointCommandClass] - NODE 3: Creating new message for application command THERMOSTAT_SETPOINT_GET (Heating)
2019-01-20 00:04:15.750 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Encapsulating message, endpoint 0
2019-01-20 00:04:15.754 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported
2019-01-20 00:04:15.756 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Command Class COMMAND_CLASS_THERMOSTAT_SETPOINT is NOT required to be secured
2019-01-20 00:04:15.759 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Bump transaction 54 priority from Set to Immediate
2019-01-20 00:04:15.761 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Adding to device queue
2019-01-20 00:04:15.763 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Added 54 to queue - size 7
2019-01-20 00:04:15.765 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-01-20 00:04:15.767 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:15.769 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:15.770 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:15.772 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:15.774 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:15.776 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:15.777 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:15.779 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:15.781 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:15.783 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:15.786 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:15.787 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:15.789 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:15.791 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:15.793 [TRACE] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage nothing
2019-01-20 00:04:15.794 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Bump transaction 55 priority from Get to Immediate
2019-01-20 00:04:15.796 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Adding to device queue
2019-01-20 00:04:15.798 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Transaction already in queue - removed original
2019-01-20 00:04:15.799 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Added 55 to queue - size 7
2019-01-20 00:04:15.801 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-01-20 00:04:15.803 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:15.806 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:15.808 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:15.810 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:15.811 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:15.813 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:15.815 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:15.816 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:15.818 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:15.821 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:15.822 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:15.824 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:15.826 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:15.828 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:15.829 [TRACE] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage nothing
2019-01-20 00:04:15.831 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling intialised at 7200 seconds - start in 1500 milliseconds.
2019-01-20 00:04:17.331 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling...
2019-01-20 00:04:17.335 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:512:node3:sensor_temperature
2019-01-20 00:04:17.338 [DEBUG] [erter.ZWaveMultiLevelSensorConverter] - NODE 3: Generating poll message for COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2019-01-20 00:04:17.341 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 3: Creating new message for command SENSOR_MULTILEVEL_GET
2019-01-20 00:04:17.344 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Encapsulating message, endpoint 0
2019-01-20 00:04:17.347 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported
2019-01-20 00:04:17.350 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Command Class COMMAND_CLASS_SENSOR_MULTILEVEL is NOT required to be secured
2019-01-20 00:04:17.354 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:512:node3:thermostat_setpoint_heating
2019-01-20 00:04:17.357 [DEBUG] [ter.ZWaveThermostatSetpointConverter] - NODE 3: Generating poll message for COMMAND_CLASS_THERMOSTAT_SETPOINT, endpoint 0
2019-01-20 00:04:17.359 [DEBUG] [.ZWaveThermostatSetpointCommandClass] - NODE 3: Creating new message for application command THERMOSTAT_SETPOINT_GET (Heating)
2019-01-20 00:04:17.362 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Encapsulating message, endpoint 0
2019-01-20 00:04:17.365 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported
2019-01-20 00:04:17.368 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Command Class COMMAND_CLASS_THERMOSTAT_SETPOINT is NOT required to be secured
2019-01-20 00:04:17.370 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:512:node3:battery-level
2019-01-20 00:04:17.373 [DEBUG] [rnal.converter.ZWaveBatteryConverter] - NODE 3: Generating poll message for COMMAND_CLASS_BATTERY endpoint 0
2019-01-20 00:04:17.376 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Encapsulating message, endpoint 0
2019-01-20 00:04:17.378 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported
2019-01-20 00:04:17.381 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Command Class COMMAND_CLASS_BATTERY is NOT required to be secured
2019-01-20 00:04:17.384 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Bump transaction 56 priority from Get to Immediate
2019-01-20 00:04:17.387 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Adding to device queue
2019-01-20 00:04:17.389 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Transaction already in queue - removed original
2019-01-20 00:04:17.392 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Added 56 to queue - size 7
2019-01-20 00:04:17.394 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-01-20 00:04:17.397 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.400 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.403 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.405 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.408 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.409 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.411 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.413 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.414 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.416 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.417 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.419 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.420 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.422 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.424 [TRACE] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage nothing
2019-01-20 00:04:17.425 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Bump transaction 57 priority from Get to Immediate
2019-01-20 00:04:17.427 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Adding to device queue
2019-01-20 00:04:17.428 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Transaction already in queue - removed original
2019-01-20 00:04:17.430 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Added 57 to queue - size 7
2019-01-20 00:04:17.431 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-01-20 00:04:17.433 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.435 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.436 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.438 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.439 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.441 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.442 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.444 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.446 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.447 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.449 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.451 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.453 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.454 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.456 [TRACE] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage nothing
2019-01-20 00:04:17.458 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Bump transaction 58 priority from Get to Immediate
2019-01-20 00:04:17.459 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Adding to device queue
2019-01-20 00:04:17.461 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Transaction already in queue - removed original
2019-01-20 00:04:17.462 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Added 58 to queue - size 7
2019-01-20 00:04:17.464 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-01-20 00:04:17.465 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.467 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.469 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.470 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.472 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.473 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.475 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.476 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.478 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.479 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.481 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.483 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.484 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:04:17.486 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:04:17.487 [TRACE] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage nothing
…and here, after some minutes (I did nothing meanwhile) it sets back to 12°C.
Note, there was no Z-Wave log activity in the meantime:
2019-01-20 00:07:41.539 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Received SOF
2019-01-20 00:07:41.548 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 03 03 80 03 61 10
2019-01-20 00:07:41.563 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Message is valid, sending ACK
2019-01-20 00:07:41.567 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Response SENT 6
2019-01-20 00:07:41.570 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 03 80 03 61
2019-01-20 00:07:41.574 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Received SOF
2019-01-20 00:07:41.574 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 03 80 03 61
2019-01-20 00:07:41.577 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-01-20 00:07:41.579 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 03 06 43 03 01 42 04 B0 45
2019-01-20 00:07:41.580 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE)
2019-01-20 00:07:41.582 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false
2019-01-20 00:07:41.585 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_BATTERY, endpoint 0
2019-01-20 00:07:41.588 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported
2019-01-20 00:07:41.591 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_BATTERY V1 BATTERY_REPORT
2019-01-20 00:07:41.594 [DEBUG] [ommandclass.ZWaveBatteryCommandClass] - NODE 3: Battery report value = 97
2019-01-20 00:07:41.596 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Message is valid, sending ACK
2019-01-20 00:07:41.596 [TRACE] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
2019-01-20 00:07:41.600 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Response SENT 6
2019-01-20 00:07:41.599 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-01-20 00:07:41.602 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_BATTERY, value = 97
2019-01-20 00:07:41.604 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 06 43 03 01 42 04 B0
2019-01-20 00:07:41.606 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:512:node3:battery-level to 97 [DecimalType]
2019-01-20 00:07:41.608 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Received SOF
2019-01-20 00:07:41.610 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1.
2019-01-20 00:07:41.614 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@94d48c.
2019-01-20 00:07:41.617 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-01-20 00:07:41.620 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-01-20 00:07:41.623 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 03 04 46 08 00 7F C7
2019-01-20 00:07:41.623 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 06 43 03 01 42 04 B0
2019-01-20 00:07:41.625 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-01-20 00:07:41.628 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE)
2019-01-20 00:07:41.631 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false
2019-01-20 00:07:41.633 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_THERMOSTAT_SETPOINT, endpoint 0
2019-01-20 00:07:41.636 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported
2019-01-20 00:07:41.639 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_THERMOSTAT_SETPOINT V1 THERMOSTAT_SETPOINT_REPORT
2019-01-20 00:07:41.640 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Message is valid, sending ACK
2019-01-20 00:07:41.642 [DEBUG] [.ZWaveThermostatSetpointCommandClass] - NODE 3: Thermostat Setpoint report Scale = 0
2019-01-20 00:07:41.644 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Response SENT 6
2019-01-20 00:07:41.645 [DEBUG] [.ZWaveThermostatSetpointCommandClass] - NODE 3: Thermostat Setpoint Value = 12
2019-01-20 00:07:41.647 [DEBUG] [.ZWaveThermostatSetpointCommandClass] - NODE 3: Thermostat Setpoint Report, Type Heating (1), value = 12
2019-01-20 00:07:41.649 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 04 46 08 00 7F
2019-01-20 00:07:41.650 [TRACE] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveThermostatSetpointValueEvent
2019-01-20 00:07:41.652 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Received SOF
2019-01-20 00:07:41.654 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveThermostatSetpointValueEvent
2019-01-20 00:07:41.656 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_THERMOSTAT_SETPOINT, value = 12
2019-01-20 00:07:41.658 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 03 06 31 05 01 42 07 45 C7
2019-01-20 00:07:41.660 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:512:node3:thermostat_setpoint_heating to 12 °C [QuantityType]
2019-01-20 00:07:41.678 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1.
2019-01-20 00:07:41.677 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Message is valid, sending ACK
2019-01-20 00:07:41.684 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Response SENT 6
2019-01-20 00:07:41.685 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1595758.
2019-01-20 00:07:41.692 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-01-20 00:07:41.692 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 1<>127 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 06 31 05 01 42 07 45
2019-01-20 00:07:41.694 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Received SOF
2019-01-20 00:07:41.694 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-01-20 00:07:41.698 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (1): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 04 46 08 00 7F
2019-01-20 00:07:41.698 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 03 02 81 05 76
2019-01-20 00:07:41.700 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-01-20 00:07:41.703 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE)
2019-01-20 00:07:41.705 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false
2019-01-20 00:07:41.707 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_CLIMATE_CONTROL_SCHEDULE, endpoint 0
2019-01-20 00:07:41.708 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported
2019-01-20 00:07:41.710 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_CLIMATE_CONTROL_SCHEDULE V1 SCHEDULE_OVERRIDE_REPORT
2019-01-20 00:07:41.711 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Message is valid, sending ACK
2019-01-20 00:07:41.713 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Response SENT 6
2019-01-20 00:07:41.714 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1.
2019-01-20 00:07:41.714 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 1<>127 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 02 81 05
2019-01-20 00:07:41.717 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@126ee94.
2019-01-20 00:07:41.719 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-01-20 00:07:41.720 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-01-20 00:07:41.722 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (1): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 06 31 05 01 42 07 45
2019-01-20 00:07:41.724 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-01-20 00:07:41.726 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE)
2019-01-20 00:07:41.727 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false
2019-01-20 00:07:41.730 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2019-01-20 00:07:41.731 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported
2019-01-20 00:07:41.733 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_SENSOR_MULTILEVEL V6 SENSOR_MULTILEVEL_REPORT
2019-01-20 00:07:41.735 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 3: Sensor Type = Temperature(1), Scale = 0
2019-01-20 00:07:41.737 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 3: Sensor Value = 18.61
2019-01-20 00:07:41.738 [TRACE] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveMultiLevelSensorValueEvent
2019-01-20 00:07:41.741 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent
2019-01-20 00:07:41.742 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SENSOR_MULTILEVEL, value = 18.61
2019-01-20 00:07:41.745 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:512:node3:sensor_temperature to 18.61 °C [QuantityType]
2019-01-20 00:07:41.751 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1.
2019-01-20 00:07:41.754 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@e1468f.
2019-01-20 00:07:41.756 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-01-20 00:07:41.759 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-01-20 00:07:41.761 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 02 81 05
2019-01-20 00:07:41.763 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-01-20 00:07:41.766 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE)
2019-01-20 00:07:41.768 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false
2019-01-20 00:07:41.770 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_CLOCK, endpoint 0
2019-01-20 00:07:41.772 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported
2019-01-20 00:07:41.773 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_CLOCK V1 CLOCK_GET
2019-01-20 00:07:41.776 [DEBUG] [.commandclass.ZWaveClockCommandClass] - NODE 3: Answering with java.util.GregorianCalendar[time=1547939261776,areFieldsSet=true,areAllFieldsSet=true,lenient=true,zone=sun.util.calendar.ZoneInfo[id="Europe/Berlin",offset=3600000,dstSavings=3600000,useDaylight=true,transitions=143,lastRule=java.util.SimpleTimeZone[id=Europe/Berlin,offset=3600000,dstSavings=3600000,useDaylight=true,startYear=0,startMode=2,startMonth=2,startDay=-1,startDayOfWeek=1,startTime=3600000,startTimeMode=2,endMode=2,endMonth=9,endDay=-1,endDayOfWeek=1,endTime=3600000,endTimeMode=2]],firstDayOfWeek=1,minimalDaysInFirstWeek=1,ERA=1,YEAR=2019,MONTH=0,WEEK_OF_YEAR=4,WEEK_OF_MONTH=4,DAY_OF_MONTH=20,DAY_OF_YEAR=20,DAY_OF_WEEK=1,DAY_OF_WEEK_IN_MONTH=3,AM_PM=0,HOUR=0,HOUR_OF_DAY=0,MINUTE=7,SECOND=41,MILLISECOND=776,ZONE_OFFSET=3600000,DST_OFFSET=0]
2019-01-20 00:07:41.778 [DEBUG] [.commandclass.ZWaveClockCommandClass] - NODE 3: Creating new message for command CLOCK_REPORT
2019-01-20 00:07:41.780 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Bump transaction 59 priority from RealTime to Immediate
2019-01-20 00:07:41.782 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Adding to device queue
2019-01-20 00:07:41.784 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Added 59 to queue - size 8
2019-01-20 00:07:41.786 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-01-20 00:07:41.788 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.790 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.792 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.793 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.795 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.797 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.799 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.801 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.803 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.805 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.807 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.809 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.810 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.812 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.813 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.814 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.816 [TRACE] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage nothing
2019-01-20 00:07:41.817 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1.
2019-01-20 00:07:41.818 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@a3d76b.
2019-01-20 00:07:41.819 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-01-20 00:07:41.821 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-01-20 00:07:41.823 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-01-20 00:07:41.825 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-01-20 00:07:41.827 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.829 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.831 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.832 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.835 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.836 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.839 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.840 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.843 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.844 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.847 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.848 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.851 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.852 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.855 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: listening == false, frequentlyListening == false, awake == false
2019-01-20 00:07:41.856 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 3: Node not awake!
2019-01-20 00:07:41.858 [TRACE] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage nothing
Are these NODE 3: Node not awake!
messages the problem? Maybe my Z-Wave controller cannot deliver my desired values?