[SOLVED] Devolo MT 2650 ignores setpoint value sent via Z-Wave

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?

Maybe these issues are related?


Especially this is quite close to my issue - is it related to some new code that changed from OH 2.3 to 2.4?

Anyone successfully using the valve?

I have exactly the same problem… it started only with the latest release… weird thing is it happens only to one of my two devolo devices! I have also one danfoss which works flawlessly!!

I don’t see anything wrong here. The device has not woken up, so there will be no data transferred.

These devices sleep nearly all the time. They only wake up for short periods, and it’s only during these short periods that setpoint changes can be transferred.

Please wake up the device and provide another log. Please also do not use TRACE level logging unless asked for it as it just adds a lot of extra logging that is nearly always unnecessary.

I will not be able to look at this further for a couple of weeks, but if you provide the logs, I will look into it when I return.

imho a zwave thermostat without FLIRS is just a wrong buy :slight_smile:

1 Like

I would agree - unfortunately, there aren’t very many with FLIRS yet (only the Spirit I think?).

So this is normal behaviour? I selected a set point value of 4°C. There is definitely communication as the thermostat tells OH that the set point value is 17°C, and the current room temperature is updates as well. However, the set value reported from the thermostat overwrites my choice, see the log below.

How can I ever successfully transmit a set point value?

@Chris The updateInterval works perfectly: I get the temperature measurement indeed every 300s in the log below. Thanks for the explanations!

2019-01-22 21:17:15.862 [INFO ] [ommandclass.ZWaveVersionCommandClass] - NODE 3: Command Class COMMAND_CLASS_BASIC has version 0!

==> /var/log/openhab2/events.log <==

2019-01-22 21:17:28.837 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 184 to 185

2019-01-22 21:17:29.249 [me.event.ThingUpdatedEvent] - Thing 'zwave:device:5fe6dd01:node3' has been updated.

2019-01-22 21:17:31.750 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_ack changed from 62 to 63

2019-01-22 21:17:31.759 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 185 to 186

2019-01-22 21:17:31.778 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 186 to 187

2019-01-22 21:17:31.797 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 187 to 188

2019-01-22 21:17:31.812 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_ack changed from 63 to 64

2019-01-22 21:17:31.819 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 188 to 189

2019-01-22 21:17:31.832 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 189 to 190

2019-01-22 21:17:31.839 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_ack changed from 64 to 65

2019-01-22 21:17:31.847 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 190 to 191

2019-01-22 21:17:31.863 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 191 to 192

2019-01-22 21:17:31.875 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 192 to 193

2019-01-22 21:17:53.790 [ome.event.ItemCommandEvent] - Item 'Set_Point_Heating_Office' received command 4 °C

2019-01-22 21:17:53.808 [nt.ItemStatePredictedEvent] - Set_Point_Heating_Office predicted to become 4 °C

2019-01-22 21:17:53.826 [vent.ItemStateChangedEvent] - Set_Point_Heating_Office changed from 17 °C to 4 °C

2019-01-22 21:18:20.414 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 193 to 194

2019-01-22 21:18:20.431 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 194 to 195

2019-01-22 21:18:20.440 [vent.ItemStateChangedEvent] - Set_Point_Heating_Office changed from 4 °C to 17 °C

==> /var/log/openhab2/openhab.log <==

2019-01-22 21:18:20.448 [INFO ] [veClimateControlScheduleCommandClass] - NODE 3 reported: Override type: NO_OVERRIDE, ScheduleState: [UNUSED]

==> /var/log/openhab2/events.log <==

2019-01-22 21:18:20.454 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 195 to 196

2019-01-22 21:18:20.481 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 196 to 197

2019-01-22 21:18:20.496 [vent.ItemStateChangedEvent] - Temperature_Office changed from 16.72 °C to 17.31 °C

2019-01-22 21:18:20.526 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 197 to 198

2019-01-22 21:20:07.893 [vent.ItemStateChangedEvent] - Heating_Kitchen changed from 17.2 to 17.3

2019-01-22 21:20:48.728 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 198 to 199

2019-01-22 21:20:48.760 [me.event.ThingUpdatedEvent] - Thing 'zwave:device:5fe6dd01:node2' has been updated.

2019-01-22 21:20:48.780 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 199 to 200

2019-01-22 21:20:48.808 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 200 to 201

2019-01-22 21:20:49.738 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_ack changed from 65 to 66

2019-01-22 21:20:49.754 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 201 to 202

2019-01-22 21:20:49.765 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 202 to 203

2019-01-22 21:20:58.756 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 203 to 204

2019-01-22 21:20:58.801 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 204 to 205

2019-01-22 21:20:58.840 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 205 to 206

2019-01-22 21:22:51.283 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 206 to 207

2019-01-22 21:22:51.327 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 207 to 208

2019-01-22 21:22:51.366 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 208 to 209

2019-01-22 21:23:12.478 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 209 to 210

==> /var/log/openhab2/openhab.log <==

2019-01-22 21:23:12.517 [INFO ] [veClimateControlScheduleCommandClass] - NODE 3 reported: Override type: NO_OVERRIDE, ScheduleState: [UNUSED]

==> /var/log/openhab2/events.log <==

2019-01-22 21:23:12.524 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 210 to 211

2019-01-22 21:23:12.535 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 211 to 212

2019-01-22 21:23:12.547 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 212 to 213

2019-01-22 21:23:12.571 [vent.ItemStateChangedEvent] - zwave_serial_zstick_5fe6dd01_serial_sof changed from 213 to 214

2019-01-22 21:23:12.579 [vent.ItemStateChangedEvent] - Temperature_Office changed from 17.31 °C to 17.11 °C

I think I’ve been through this, but let me repeat how battery devices work…

ZWave battery devices sleep most of the time. They only wake up periodically - normally around every hour, but it depends on how the wakeup period is set. The binding can only communicate with the device when the device wakes up. In the log you sent, the device did not wake up.

The fact that the device sent its current temperature is completely irrelevant - that is the device communicating with the binding - the opposite way around is not possible unless the device wakes up!

From the log above, there is no wakeup -:

You need to wake up the device - I hope tat makes sense.

Your 4 °C are likely still in the queue waiting for a wakeup of the device.
You could reduce the wakeup time… to set the temp faster … BUT this SIGNIFICANTLY reduces battery.

Okay, got it. So that’s no real wakeup. Now the trouble is that the overwriting happens quite quick. In the log above, only 27s. This means that the wakeupInterval would need to be quicker to catch the set point value I sent before the overwriting happens? That again would mean I need a wakeupInterval of around 20s. Is this reasonable?

No - I don’t think you understand how this works.

You send a command - this will set the value in the UI, but if the device sends a value, it will update what you see in the UI. When the device wakes up, this command that you sent is still sitting in the queue and should be sent. Once it is sent, the UI should later be updated with the new value.

no and no
despite the value is read back to 17 your 4 should anyways be still in queue and set once the device wakes up

I once had a device set to 4min wakeup time… reducing battery from about 2 years to 2 weeks…
so anything below one hour should be nonsense…

if you need to set setpoints quick … like window opens … setpoint 4 °C … you MUST use a different device with flirs

1 Like

Okay, so I will try to change the device. I will open a new thread to get a recommendation, okay?

as chris mentioned above.
there is only a single thermostat device which supports flirs currently
the eurotronic spirit. so no choices … sorry.

additonally if you want to stick with your current device at least cron job use cases are feasible.

  1. set wake up to something reasonable (60-90 min)
  2. e.g. 2 cron jobs 8am - 20pm = 21 °C … 20pm - 8am = 18 °C

something like this would work with the devolo. in worst case e.g. your 18 °C would be 60-90 mins later …

for anything else …> spirit

Thanks a lot!

@shorty707: I opened a new thread there: Which Z-Wave thermostat works well?, maybe you can comment there on the Spirit?

Yes, three of them. I’m on 2.4 (stable)
Jan