Z-Wave things suddenly stopped updating channels

[kris_dg (Kris)]

Hi,

Last week most of my Z-Wave nodes suddenly stopped “working”. As in, they still communicate with my Z-Wave controller, but the values of the channels remain “NULL”.

I used the Z-Wave PC Controller from Sililabs to check my network health, and all nodes report being healthy. After some investigation I found out, that commands sent by the nodes are received by the Z-Wave binding. However, these commands can not be processed for some reason.

The following logs were captured after changing the binary state using the OpenHab UI:

2023-08-12 14:47:13.746 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Command received zwave:tkb_tz74_00_000:b6a601be8e:woonkamerZwaveSwitch1:switch_binary1 --> ON [OnOffType]
2023-08-12 14:47:13.747 [DEBUG] [converter.ZWaveBinarySwitchConverter] - NODE 13: Command class class COMMAND_CLASS_SWITCH_BINARY for endpoint 1 not found
2023-08-12 14:47:13.747 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: No messages returned from converter

And these logs were captured after receiving a command from the device itself:

2023-08-12 14:46:33.942 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:33.942 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:33.942 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-08-12 14:46:33.942 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: SECURITY not supported
2023-08-12 14:46:33.942 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 13: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2023-08-12 14:46:33.942 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 13: Basic report, value = 255
2023-08-12 14:46:33.943 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:33.943 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:33.943 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Updating channel state zwave:tkb_tz74_00_000:b6a601be8e:woonkamerZwaveSwitch1:switch_binary to ON [OnOffType]
2023-08-12 14:46:33.943 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:33.943 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:33.943 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Commands processed 1.
2023-08-12 14:46:33.943 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1ade2717.
2023-08-12 14:46:35.897 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:35.897 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:35.897 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-08-12 14:46:35.897 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: SECURITY not supported
2023-08-12 14:46:35.897 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 13: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2023-08-12 14:46:35.897 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 13: Basic report, value = 255
2023-08-12 14:46:35.898 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:35.898 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:35.898 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Updating channel state zwave:tkb_tz74_00_000:b6a601be8e:woonkamerZwaveSwitch1:switch_binary to ON [OnOffType]
2023-08-12 14:46:35.898 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:35.898 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:35.898 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Commands processed 1.
2023-08-12 14:46:35.898 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@2d1bfb9c.
2023-08-12 14:46:35.924 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:35.925 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:35.925 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-08-12 14:46:35.925 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: SECURITY not supported
2023-08-12 14:46:35.925 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 13: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2023-08-12 14:46:35.925 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 13: Basic report, value = 255
2023-08-12 14:46:35.925 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:35.925 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:35.925 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Updating channel state zwave:tkb_tz74_00_000:b6a601be8e:woonkamerZwaveSwitch1:switch_binary to ON [OnOffType]
2023-08-12 14:46:35.925 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:35.925 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:35.925 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Commands processed 1.
2023-08-12 14:46:35.926 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@599c023a.
2023-08-12 14:46:36.005 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:36.005 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:36.005 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-08-12 14:46:36.005 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: SECURITY not supported
2023-08-12 14:46:36.005 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 13: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2023-08-12 14:46:36.005 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 13: Basic report, value = 255
2023-08-12 14:46:36.007 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:36.007 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:36.007 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Updating channel state zwave:tkb_tz74_00_000:b6a601be8e:woonkamerZwaveSwitch1:switch_binary to ON [OnOffType]
2023-08-12 14:46:36.007 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:36.007 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:36.007 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Commands processed 1.
2023-08-12 14:46:36.007 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@2fbf8fe5.
2023-08-12 14:46:36.313 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:36.313 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:36.313 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-08-12 14:46:36.314 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: SECURITY not supported
2023-08-12 14:46:36.314 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 13: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2023-08-12 14:46:36.314 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 13: Basic report, value = 255
2023-08-12 14:46:36.314 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:36.314 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:36.314 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Updating channel state zwave:tkb_tz74_00_000:b6a601be8e:woonkamerZwaveSwitch1:switch_binary to ON [OnOffType]
2023-08-12 14:46:36.314 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:36.314 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:36.314 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Commands processed 1.
2023-08-12 14:46:36.314 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@4432e39a.
2023-08-12 14:46:36.358 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:36.358 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:36.358 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-08-12 14:46:36.358 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: SECURITY not supported
2023-08-12 14:46:36.358 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 13: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2023-08-12 14:46:36.358 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 13: Basic report, value = 255
2023-08-12 14:46:36.358 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:36.358 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:36.359 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Updating channel state zwave:tkb_tz74_00_000:b6a601be8e:woonkamerZwaveSwitch1:switch_binary to ON [OnOffType]
2023-08-12 14:46:36.359 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:36.359 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:36.359 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Commands processed 1.
2023-08-12 14:46:36.359 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@3607279b.
2023-08-12 14:46:36.402 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:36.403 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:36.403 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-08-12 14:46:36.403 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: SECURITY not supported
2023-08-12 14:46:36.403 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 13: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2023-08-12 14:46:36.403 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 13: Basic report, value = 255
2023-08-12 14:46:36.403 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:36.403 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:36.403 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Updating channel state zwave:tkb_tz74_00_000:b6a601be8e:woonkamerZwaveSwitch1:switch_binary to ON [OnOffType]
2023-08-12 14:46:36.403 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:36.403 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:36.403 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Commands processed 1.
2023-08-12 14:46:36.403 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@f337eb3.
2023-08-12 14:46:36.801 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:36.802 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:36.802 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-08-12 14:46:36.802 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: SECURITY not supported
2023-08-12 14:46:36.802 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 13: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2023-08-12 14:46:36.802 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 13: Basic report, value = 255
2023-08-12 14:46:36.802 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:36.802 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:36.802 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Updating channel state zwave:tkb_tz74_00_000:b6a601be8e:woonkamerZwaveSwitch1:switch_binary to ON [OnOffType]
2023-08-12 14:46:36.802 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:36.802 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:36.802 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Commands processed 1.
2023-08-12 14:46:36.802 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5ca00817.
2023-08-12 14:46:36.866 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:36.866 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:36.866 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-08-12 14:46:36.866 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: SECURITY not supported
2023-08-12 14:46:36.866 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 13: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2023-08-12 14:46:36.866 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 13: Basic report, value = 255
2023-08-12 14:46:36.867 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:36.867 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:36.867 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Updating channel state zwave:tkb_tz74_00_000:b6a601be8e:woonkamerZwaveSwitch1:switch_binary to ON [OnOffType]
2023-08-12 14:46:36.867 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:36.867 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:36.867 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Commands processed 1.
2023-08-12 14:46:36.867 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@fdd0e2a.
2023-08-12 14:46:37.092 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:37.092 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:37.092 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-08-12 14:46:37.093 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: SECURITY not supported
2023-08-12 14:46:37.093 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 13: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2023-08-12 14:46:37.093 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 13: Basic report, value = 255
2023-08-12 14:46:37.093 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:37.093 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:37.093 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Updating channel state zwave:tkb_tz74_00_000:b6a601be8e:woonkamerZwaveSwitch1:switch_binary to ON [OnOffType]
2023-08-12 14:46:37.093 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-08-12 14:46:37.093 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=255
2023-08-12 14:46:37.093 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Commands processed 1.
2023-08-12 14:46:37.093 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@e9dbb5.
2023-08-12 14:46:40.765 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:40.765 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:40.765 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2023-08-12 14:46:40.765 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: No endpoint 1!
2023-08-12 14:46:42.482 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:42.482 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:42.482 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2023-08-12 14:46:42.482 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: No endpoint 1!
2023-08-12 14:46:42.545 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:42.545 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:42.545 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2023-08-12 14:46:42.545 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: No endpoint 1!
2023-08-12 14:46:42.608 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:42.608 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:42.608 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2023-08-12 14:46:42.608 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: No endpoint 1!
2023-08-12 14:46:42.990 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:42.990 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:42.990 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2023-08-12 14:46:42.990 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: No endpoint 1!
2023-08-12 14:46:43.035 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:43.035 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:43.035 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2023-08-12 14:46:43.035 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: No endpoint 1!
2023-08-12 14:46:43.116 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:43.116 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:43.116 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2023-08-12 14:46:43.116 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: No endpoint 1!
2023-08-12 14:46:43.623 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:43.624 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:43.624 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2023-08-12 14:46:43.624 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: No endpoint 1!
2023-08-12 14:46:43.767 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:43.767 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:43.767 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2023-08-12 14:46:43.768 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: No endpoint 1!
2023-08-12 14:46:43.839 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-08-12 14:46:43.839 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-08-12 14:46:43.840 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2023-08-12 14:46:43.840 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: No endpoint 1!

I see the same thing happening with most of my devices from TBK and Fibaro.

When this problem occured for the first time, I used OH version 3.1. However, I encounter the exact same problem when using OH 4.0.1.

[apella12 (Bob Eckhoff)]

From the logs endpoint 0 Basic channel is working fine. What seems amiss is that it is sending endpoint 1 via Multichannel and that is not supported. I looked at the DB and it hasn’t changed since Sept 2019. What is your physical set-up? (two switches or one?) Do both work manually? Did you change anything recently? What channel(s) do you have linked to the item?

Edit: I can tell the log is filtered and that cuts out important messages. Also try out the debug viewer here https://www.opensmarthouse.org/utilities/logviewer/zwave/

[kris_dg (Kris)]

I have the following setup:

// zwave.things
Bridge zwave:serial_zstick:b6a601be8e "ZWave Controller" [ port="/dev/ttyACM0", controller_softreset="false", controller_master="true", heal_enable="true", security_networkkey="***" ]
{
  shenzhen_eu2_00_000 gangZwaveSwitch1 "GANG.ZWAVE.SWITCH1"  [ node_id=8, switchall_mode=255, config_1_1=1, config_2_1=1, config_3_1=1, config_4_1=1 ]
}

// zwave.items
Switch GANGZWAVESWITCH1_Switch1                             {channel="zwave:shenzhen_eu2_00_000:b6a601be8e:gangZwaveSwitch1:switch_binary1"}
Switch GANGZWAVESWITCH1_Switch2                             {channel="zwave:shenzhen_eu2_00_000:b6a601be8e:gangZwaveSwitch1:switch_binary2"}

The following snippet is not filtered. Using the UI I switched the channel OFF → ON → OFF. But the physical device won’t switch.

2023-08-15 13:30:04.165 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 8: Command received zwave:shenzhen_eu2_00_000:b6a601be8e:gangZwaveSwitch1:switch_binary1 --> ON [OnOffType]
2023-08-15 13:30:04.165 [DEBUG] [converter.ZWaveBinarySwitchConverter] - NODE 8: Command class class COMMAND_CLASS_SWITCH_BINARY for endpoint 1 not found
2023-08-15 13:30:04.165 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 8: No messages returned from converter
2023-08-15 13:30:09.376 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 8: Command received zwave:shenzhen_eu2_00_000:b6a601be8e:gangZwaveSwitch1:switch_binary1 --> OFF [OnOffType]
2023-08-15 13:30:09.376 [DEBUG] [converter.ZWaveBinarySwitchConverter] - NODE 8: Command class class COMMAND_CLASS_SWITCH_BINARY for endpoint 1 not found
2023-08-15 13:30:09.376 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 8: No messages returned from converter

This is just an overview of Node 8. But 17 of my 18 nodes behave like this. Except node 3, which is of type aeon_zw100_01_010. All its sensor values are mapped correctly to the channels.

[kris_dg (Kris)]

Here is the generated node XML

<node>
  <homeId>0xec1d7a02</homeId>
  <nodeId>8</nodeId>
  <version>4</version>
  <manufacturer>0x7fffffff</manufacturer>
  <deviceId>0x7fffffff</deviceId>
  <deviceType>0x7fffffff</deviceType>
  <listening>true</listening>
  <frequentlyListening>false</frequentlyListening>
  <routing>true</routing>
  <security>false</security>
  <beaming>true</beaming>
  <maxBaudRate>40000</maxBaudRate>
  <sleepDelay>500</sleepDelay>
  <associationGroups class="concurrent-hash-map"/>
  <endpoints class="concurrent-hash-map">
    <entry>
      <int>0</int>
      <endPoint>
        <deviceClass>
          <basicDeviceClass>BASIC_TYPE_ROUTING_SLAVE</basicDeviceClass>
          <genericDeviceClass>GENERIC_TYPE_SWITCH_BINARY</genericDeviceClass>
          <specificDeviceClass>SPECIFIC_TYPE_POWER_SWITCH_BINARY</specificDeviceClass>
        </deviceClass>
        <endpointId>0</endpointId>
        <secureCommandClasses/>
        <supportedCommandClasses class="concurrent-hash-map">
          <entry>
            <commandClass>COMMAND_CLASS_NO_OPERATION</commandClass>
            <COMMAND__CLASS__NO__OPERATION>
              <version>1</version>
              <instances>1</instances>
              <control>false</control>
              <versionSupported>1</versionSupported>
            </COMMAND__CLASS__NO__OPERATION>
          </entry>
          <entry>
            <commandClass>COMMAND_CLASS_BASIC</commandClass>
            <COMMAND__CLASS__BASIC>
              <version>0</version>
              <instances>1</instances>
              <control>false</control>
              <versionSupported>0</versionSupported>
              <isGetSupported>true</isGetSupported>
            </COMMAND__CLASS__BASIC>
          </entry>
          <entry>
            <commandClass>COMMAND_CLASS_MULTI_CHANNEL</commandClass>
            <COMMAND__CLASS__MULTI__CHANNEL>
              <version>0</version>
              <instances>0</instances>
              <control>false</control>
              <versionSupported>0</versionSupported>
              <useDestEndpointAsSource>false</useDestEndpointAsSource>
              <endpointsAreTheSameDeviceClass>false</endpointsAreTheSameDeviceClass>
            </COMMAND__CLASS__MULTI__CHANNEL>
          </entry>
        </supportedCommandClasses>
      </endPoint>
    </entry>
  </endpoints>
  <nodeNeighbors>
    <int>3</int>
    <int>6</int>
    <int>9</int>
    <int>12</int>
    <int>13</int>
    <int>14</int>
    <int>18</int>
    <int>21</int>
    <int>23</int>
    <int>28</int>
    <int>30</int>
    <int>31</int>
  </nodeNeighbors>
  <lastReceived>2023-08-12 21:41:51.960 UTC</lastReceived>
</node>

What I do not understand, why isn’t there a COMMAND_CLASS_SWITCH_BINARY in the supportedCommandClasses array?

I didn’t change anything in my soft- and hardware setup.

[apella12 (Bob Eckhoff)]

@kris_dg

What I do not understand, why isn’t there a COMMAND_CLASS_SWITCH_BINARY in the supportedCommandClasses array?

The switch_binary channel is under the BASIC CC.

I’ve never set up channels textually. From the XML extract the channels look like this;

<channel id="switch_binary1" typeId="switch_binary">
        <label>Switch 1</label>
        <properties>
          <property name="binding:*:OnOffType">COMMAND_CLASS_SWITCH_BINARY:1,COMMAND_CLASS_BASIC:1</property>
        </properties>
      </channel>
      <channel id="switch_binary2" typeId="switch_binary">
        <label>Switch 2</label>
        <properties>
          <property name="binding:*:OnOffType">COMMAND_CLASS_SWITCH_BINARY:2,COMMAND_CLASS_BASIC:2</property>
        </properties>
      </channel>
    </channels>

Maybe that would help with ideas.

[kris_dg (Kris)]

ZWave: COMMAND_CLASS_SWITCH_BINARY for endpoint 2 not found

I lately had a major issue with my OH installation that has run for months: all of a sudden all zwave devices (around 50) were lost in configuration. The only way to get them back after hours was to delete the zwave usb stick and readd it. What happened then was that the id of the device changed and with that all things’ ids completely changed (as they are based on the id). Hence, I had to read all devices as new. Most of the devices do work now but some don’t. It is not that the device is not c…

This seems to be the same issue. The problem description is the same. However, I don’t have the errors related to the Network Security Key. Also, it’s worth mentioning that I build OH from Docker, so every time I start a container, the filesystem remains the same. Therefore, the filesystem of OH couldn’t have become corrupted for any reason, as starting a new container should resolve it if that were the case.

I will try adding one node to another Z-Wave Controller. Let’s see if that solves anything.

[apella12 (Bob Eckhoff)]

So I did plow through that thread. The error does look the same, but most of the thread was about updating the zwave binding. The zwave binding is essentially unchanged and really unchanged about endpoints for about 2 years, so I do not think it is involved.

One piece of advice in that thread is the same as I would recommend (to delete the thing, not exclude) and then scan to pick up new/updated properties. The problem is that is for UI discovered things. I do not know the equivalent for textual. Maybe erase the texts completely, wait and then paste them back?

If the other controller idea works, it probably means nothing is wrong with either the device or binding, just need to rediscover.

Also (IMO) in the long run going to the UI discovery is going to be better.

[anon71759204]

@kris_dg

<manufacturer>0x7fffffff</manufacturer>
  <deviceId>0x7fffffff</deviceId>
  <deviceType>0x7fffffff</deviceType>

… doesn’t look healthy, doesn’t match your device:

Manufacturer ID	0258
Label	EU-2
Description	Light Switch 2 Channel
References	0003:008B,0003:108B,0003:208B

[kris_dg (Kris)]

It appeared that the registry in my Z-Wave Controller had become corrupted. In the Z-Wave PC Controller by Silicon Labs, I noticed the same VIDs and PIDs appearing as mentioned in the XML above by @anon71759204. After excluding and including all nodes, everything started working again.
Thanks all!