Hi,
I’m experiencing some problems with the Max! Cube Binding. After some days of running OpenHab suddenly I cannot set the temperature of the thermostats through setpoints. All items still receive values like valve position or current temperature. So the binding in general still works.
I activated the logs and one can see the problem
11:03:22.099 [INFO ] [openhab.event.ItemStatePredictedEvent] - Item 'WallmountedThermostatLivingRoom_SetpointTemperature' predicted to become 22
11:03:22.102 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'WallmountedThermostatLivingRoom_SetpointTemperature' changed from 21.5 °C to 22 °C
11:03:22.101 [DEBUG] [internal.handler.MaxCubeBridgeHandler] - Removed Command id 234 (KEQ0065608-set_temp) from queue. Superceeded by 235
11:03:22.113 [DEBUG] [internal.handler.MaxCubeBridgeHandler] - Command queued id 235 (KEQ0065608-set_temp:22 °C).
11:03:49.588 [DEBUG] [internal.handler.MaxCubeBridgeHandler] - Sending request #739 to MAX! Cube
11:03:49.590 [TRACE] [internal.handler.MaxCubeBridgeHandler] - Write string to Max! Cube 10.42.21.235: l:
11:03:49.664 [TRACE] [internal.handler.MaxCubeBridgeHandler] - message block: 'L:DAeHtwkSGQQrAAAA1gsMe08JEhk2KwAAAAwMzUsJEhkELQAAAOALBxTkCRIZTS0AAAA='
11:03:49.665 [TRACE] [internal.handler.MaxCubeBridgeHandler] - === L Message ===
11:03:49.666 [TRACE] [internal.handler.MaxCubeBridgeHandler] - RAW: DAeHtwkSGQQrAAAA1gsMe08JEhk2KwAAAAwMzUsJEhkELQAAAOALBxTkCRIZTS0AAAA=
11:03:49.668 [TRACE] [ab.binding.max.internal.device.Device] - Device 0787b7 (Wallmounted Thermostat): L Message length: 12 content: 07 87 B7 09 12 19 04 2B 00 00 00 D6
11:03:49.669 [DEBUG] [ab.binding.max.internal.device.Device] - Device 0787b7 (Wallmounted Thermostat): Actual Temperature : 21.4
11:03:49.669 [TRACE] [ab.binding.max.internal.device.Device] - Device 0c7b4f (Thermostat): L Message length: 11 content: 0C 7B 4F 09 12 19 36 2B 00 00 00
11:03:49.669 [DEBUG] [ab.binding.max.internal.device.Device] - Device 0c7b4f (Thermostat): Actual Temperature : 0.0
11:03:49.670 [TRACE] [ab.binding.max.internal.device.Device] - Device 0ccd4b (Wallmounted Thermostat): L Message length: 12 content: 0C CD 4B 09 12 19 04 2D 00 00 00 E0
11:03:49.670 [DEBUG] [ab.binding.max.internal.device.Device] - Device 0ccd4b (Wallmounted Thermostat): Actual Temperature : 22.4
11:03:49.670 [TRACE] [ab.binding.max.internal.device.Device] - Device 0714e4 (Thermostat): L Message length: 11 content: 07 14 E4 09 12 19 4D 2D 00 00 00
11:03:49.673 [DEBUG] [ab.binding.max.internal.device.Device] - Device 0714e4 (Thermostat): Actual Temperature : 0.0
11:03:49.674 [TRACE] [internal.handler.MaxCubeBridgeHandler] - 4 devices found.
11:03:49.675 [DEBUG] [ax.internal.handler.MaxDevicesHandler] - Updating states of Wallmounted Thermostat Wall Thermostat 1 (KEQ0065608) id: max:wallthermostat:JEQ0340594:KEQ0065608
11:03:49.676 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'WallmountedThermostatLivingRoom_SetpointTemperature' changed from 22 °C to 21.5 °C
11:03:49.678 [DEBUG] [ax.internal.handler.MaxDevicesHandler] - Updating states of Thermostat Radiator Thermostat 1 (KEQ0717689) id: max:thermostat:JEQ0340594:KEQ0717689
11:03:49.679 [DEBUG] [ax.internal.handler.MaxDevicesHandler] - Updating states of Wallmounted Thermostat Wall Thermostat 1 (KEQ0808851) id: max:wallthermostat:JEQ0340594:KEQ0808851
11:03:49.680 [DEBUG] [ax.internal.handler.MaxDevicesHandler] - Updating states of Thermostat Radiator Thermostat 1 (KHA0003692) id: max:thermostat:JEQ0340594:KHA0003692
11:04:19.681 [DEBUG] [internal.handler.MaxCubeBridgeHandler] - Sending request #740 to MAX! Cube
It looks to me like the command is queued but the binding just does nothing with it. Not even an error message.
If I just restart the binding itself with bundle:restart org.openhab.binding.max it starts to work again as expected:
11:40:08.242 [INFO ] [openhab.event.ItemStatePredictedEvent] - Item 'WallmountedThermostatLivingRoom_SetpointTemperature' predicted to become 22
11:40:08.247 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'WallmountedThermostatLivingRoom_SetpointTemperature' changed from 21.5 °C to 22 °C
11:40:08.243 [DEBUG] [internal.handler.MaxCubeBridgeHandler] - Command queued id 237 (KEQ0065608-set_temp:22 °C).
11:40:08.244 [DEBUG] [internal.handler.MaxCubeBridgeHandler] - Command id: 237, channelUID: max:wallthermostat:JEQ0340594:KEQ0065608:set_temp, command: 22 °C, cubeCommand: null, serialNumber: KEQ0065608, key: KEQ0065608-set_temp, commandText: 22 °C sent to MAX! Cube at IP: 10.42.21.235
11:40:08.251 [DEBUG] [internal.handler.MaxCubeBridgeHandler] - Sending request #3 to MAX! Cube
11:40:08.252 [TRACE] [internal.handler.MaxCubeBridgeHandler] - Write string to Max! Cube 10.42.21.235: s:AARAAAAAB4e3AWw=
11:40:08.393 [TRACE] [internal.handler.MaxCubeBridgeHandler] - message block: 'S:00,0,31'
11:40:08.394 [TRACE] [internal.handler.MaxCubeBridgeHandler] - === S Message ===
11:40:08.397 [TRACE] [internal.handler.MaxCubeBridgeHandler] - RAW : 00,0,31
11:40:08.398 [TRACE] [internal.handler.MaxCubeBridgeHandler] - DutyCycle : 0
11:40:08.401 [TRACE] [internal.handler.MaxCubeBridgeHandler] - Command Discarded : false
11:40:08.402 [TRACE] [internal.handler.MaxCubeBridgeHandler] - FreeMemorySlots : 49
11:40:08.406 [DEBUG] [internal.handler.MaxCubeBridgeHandler] - S message. Duty Cycle: 0, Free Memory Slots: 49
11:40:08.407 [TRACE] [internal.handler.MaxCubeBridgeHandler] - Command id: 237, channelUID: max:wallthermostat:JEQ0340594:KEQ0065608:set_temp, command: 22 °C, cubeCommand: null, serialNumber: KEQ0065608, key: KEQ0065608-set_temp, commandText: 22 °C completed for MAX! Cube at IP: 10.42.21.235
11:40:16.129 [DEBUG] [internal.handler.MaxCubeBridgeHandler] - Sending request #4 to MAX! Cube
Anybody some idea what could cause this? Is there some worker thread crashing in the binding and I did not see this in the logs?
Using openHAB 3.1.1
Only the Max! Binding is effected by this. I can switch still the lights through Enocean while this problem is active.
Would appreciate any hints.