[SOLVED] Not able to detect Zwave key presses inside rules

pedrolima · October 2, 2023, 10:23pm

@apella12 I’m oppening this new thread based on this suggestion from you, which unfortunately and strangely, did not worked unfortunately.

First of, I’m using OH 3.4.0 M3 in a RPi 4 8Gb w/ SSD. I have already some experience working with multiple solutions since OH 2 and integrating different systems. In many situations I have to thank this great community for all the help I had over the years.

Now, for everyone else that wasn’t following the previous thread, here’s a resume:

I have some Simon Master Switches that are called like this because they are Zwave blind switches that do not connect directly to anything. They only serve the purpose to receive the button click and then we do whatever we want with it (e.g. with a rule in OH, controlling 3 different blinds at the same time by simply click that Master switch UP or DOWN)
Simon actually have made these Master Switches to interact with their own Hub that then we can setup in their own APP, but this is Zwave so being connected to a Zwave network, we SHOULD be able to use it anyway
I first started this thread because I wasn’t being able to add the switch to the database and after a long battle, I finally could add it successfully.
Now that the equipment is successfully recognized, I tried to use it as I use any other blinds switch, so if someone would click, something should be received in OH from the Zwave binding, being recognized as a UP or DOWN click and I could do whatever I wanted with that… weird thing is, that do NOT happen, neither with this Master blinds switch nor with ANY blinds switch (or ANY Zwave switch I clicked)!

So, here’s what I did so far:

I went into OH console and set DEBUG level for Zwave binding
Clicked the UP and DOWN in Master switch and also clicked in the regular Blinds switch as well as in a regular light switch… NO LOG AT ALL!!!
Tried to force a sync (by clicking and holding the Master for 3 secs) and I did got info in the log finally, but no info about any clicks
Changed level from DEBUG to TRACE, to make it even more sensible… NO CLICKS REGISTERED FROM ANYTHING! I never thought this would happen, I am very surprised.
Tried to create a rule in OH to literally register in the log something whenever there would be a change in the “Thing” for the Master switch… nothing.
Did the same rule but for a regular Blinds switch… nothing.

Next step will be installing the Simplicity Studio from Silicon Labs and then try to see if I can get something.

The thing is, all switches /apart from these Master switches) are working just fine. They are close to a total of 50 or 60 switches between blinds and light switches. Network is working very well, very responsive and if I turn ON a light, it DOES change the status in OH, so I do not understand how I cannot see any log for a click.

The Master switch I’m referring to is this one in the database.

As for the log, when I forced a re-sync, this was what I got from there (the only time that Master switch actually registered something into the log file):

So if anyone can help me out here to make this work, I will appreciate it very much and buy you a beer.

rlkoshak · October 3, 2023, 2:43pm

I could be totally wrong here but IIRC the way to get a Zwave device to report changes made locally to the device (e.g. someone physically flipping the switch) you need to add the device to association group 1 (I think) which is the controller.

If that’s not it, I don’t know what else it can be. What little Zwave knowledge I once had has long since atrophied due to disuse (not because I got rid of my Zwave devices, just those devices tend to just work and don’t need a lot of attention once set up).

pedrolima · October 3, 2023, 11:18pm

Hum, that is a very interesting thing actually… do you refer here?

I mean, Lifeline is by default with “Controller” but “ctrl” is by default empty. Should I select “Controller” there? Is that what you mean?

EDIT: Ok, where I am right now I do not have access to any Master, but I do have some zwave Blinds switches here. I just tried to set the “ctrl” for one of those and I finally got some info that I never got before.

Here’s the log:

2023-10-04 00:48:30.328 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 0D 03 20 03 5C 83 
2023-10-04 00:48:30.332 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=13, callback=0, payload=00 0D 03 20 03 5C 
2023-10-04 00:48:30.338 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=13, callback=0, payload=00 0D 03 20 03 5C 
2023-10-04 00:48:30.340 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-10-04 00:48:30.343 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-10-04 00:48:30.345 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-10-04 00:48:30.348 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-10-04 00:48:30.351 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: SECURITY not supported
2023-10-04 00:48:30.354 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 13: Received COMMAND_CLASS_BASIC V1 BASIC_REPORT
2023-10-04 00:48:30.375 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 13: Basic report, value = 92
2023-10-04 00:48:30.378 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-10-04 00:48:30.380 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=92
2023-10-04 00:48:30.383 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Commands processed 1.
2023-10-04 00:48:30.386 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1e0f4cb.
2023-10-04 00:48:30.390 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-04 00:48:30.392 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-04 00:48:30.394 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-10-04 00:48:30.396 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-10-04 00:48:30.432 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 0D 03 20 03 5C 83 
2023-10-04 00:48:30.435 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=13, callback=0, payload=00 0D 03 20 03 5C 
2023-10-04 00:48:30.437 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=13, callback=0, payload=00 0D 03 20 03 5C 
2023-10-04 00:48:30.438 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-10-04 00:48:30.439 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-10-04 00:48:30.440 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-10-04 00:48:30.442 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-10-04 00:48:30.449 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: SECURITY not supported
2023-10-04 00:48:30.454 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 13: Received COMMAND_CLASS_BASIC V1 BASIC_REPORT
2023-10-04 00:48:30.456 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 13: Basic report, value = 92
2023-10-04 00:48:30.461 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-10-04 00:48:30.462 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=92
2023-10-04 00:48:30.463 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Commands processed 1.
2023-10-04 00:48:30.464 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@147e6b8.
2023-10-04 00:48:30.465 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-04 00:48:30.466 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-04 00:48:30.467 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-10-04 00:48:30.468 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-10-04 00:48:36.874 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 0D 03 20 03 63 BC 
2023-10-04 00:48:36.878 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=13, callback=0, payload=00 0D 03 20 03 63 
2023-10-04 00:48:36.883 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=13, callback=0, payload=00 0D 03 20 03 63 
2023-10-04 00:48:36.886 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-10-04 00:48:36.888 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-10-04 00:48:36.894 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-10-04 00:48:36.903 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-10-04 00:48:36.907 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: SECURITY not supported
2023-10-04 00:48:36.913 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 13: Received COMMAND_CLASS_BASIC V1 BASIC_REPORT
2023-10-04 00:48:36.915 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 13: Basic report, value = 99
2023-10-04 00:48:36.916 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-10-04 00:48:36.917 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=99
2023-10-04 00:48:36.919 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Commands processed 1.
2023-10-04 00:48:36.920 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@190e07a.
2023-10-04 00:48:36.921 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-04 00:48:36.928 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-04 00:48:36.929 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-10-04 00:48:36.930 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-10-04 00:48:36.979 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 0D 03 20 03 63 BC 
2023-10-04 00:48:36.985 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=13, callback=0, payload=00 0D 03 20 03 63 
2023-10-04 00:48:36.991 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=13, callback=0, payload=00 0D 03 20 03 63 
2023-10-04 00:48:36.993 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-10-04 00:48:36.996 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Application Command Request (ALIVE:DONE)
2023-10-04 00:48:37.002 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: resetResendCount initComplete=true isDead=false
2023-10-04 00:48:37.011 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-10-04 00:48:37.019 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 13: SECURITY not supported
2023-10-04 00:48:37.025 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 13: Received COMMAND_CLASS_BASIC V1 BASIC_REPORT
2023-10-04 00:48:37.034 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 13: Basic report, value = 99
2023-10-04 00:48:37.041 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2023-10-04 00:48:37.047 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 13: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=99
2023-10-04 00:48:37.049 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Commands processed 1.
2023-10-04 00:48:37.059 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@14b0b01.
2023-10-04 00:48:37.063 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-04 00:48:37.065 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-04 00:48:37.067 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-10-04 00:48:37.068 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

Here’s in the log viewer:

Can anyone get something out of this? I mean, I still get nothing when I try to create a rule to get when the “Thing” changed, when the “Item” changed, when the “Item” received command, nothing prints the “logInfo” I’ve put in the rule

rlkoshak · October 4, 2023, 12:54pm

No, I think I’m referring to the Lifeline which is already the controller. So that’s not it.

You might verify that the device actually reports back to the controller when it’s toggled. There was a patent (still is?) that has been litigated. For a time only one brand (I can’t remember which) was allowed to report manual toggles. But I thought that patent had expired so .

I do know I had a Zwave switch that would not report back it’s state when manually toggled for that reason. But that was nearly a decade ago.

pedrolima · October 4, 2023, 1:56pm

You see, but that’s the weird thing. These Simon devices, when I turn ON of OFF a light, they do send their status.

When I press UP or DOWN on a blinds switch, they do communicate their opening percentage level.

Same happens with their Dimmer switch.

I’ve reached out to them and they told me their Master do send the manual pressing status, as that’s the way they interpret the key press with their Hub.

They obviously suggested me to simply acquire their Hub, but that’s something I don’t see that makes any sense…

What would be your personal opinion on this? Is there a possibility that this actually only communicates to the Zwave network these key presses via their Hub? I find it hard to believe as for me it does not make sense since the Master switch do communicate with their Hub via Zwave as well, so we should see something happening on that communication as well.

I’m stuck with this and I cannot simply have these devices sitting right there doing nothing because each one is very expensive.

rlkoshak · October 4, 2023, 3:06pm

I doubt that. Zwave is a lot more strict as a standard. I doubt the device only works with their hub alone.

I’m mostly grasping at straws. I don’t really know how to read the logs so I’m not much help there.

apella12 · October 4, 2023, 3:27pm

This might work since you are getting Basic messages.

In the DB change the multichannel CC to include Basic = true

PS: I do not think blinds_shutter is going to do anything.

pedrolima · October 4, 2023, 3:35pm

Yup, they do claim on their manual that this is perfectly suitable to work with any zwave device. So you are right.

Hum, thanks for the advice Bob. I will try just that!

This was actually my “desperate mode” kicking in!

apella12 · October 4, 2023, 9:32pm

When you are finished, do not forget to request review.

pedrolima · October 14, 2023, 5:55pm

Ok at least now I can see something in the log related to this node (which is 98). But I do not understand what it is. This appears when I click UP or DOWN.

2023-10-14 18:50:34.214 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Received SOF
2023-10-14 18:50:34.216 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 62 02 20 02 C9 00 7A 
2023-10-14 18:50:34.217 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Creating new SerialMessage from buffer = 01 0A 00 04 00 62 02 20 02 C9 00 7A 
2023-10-14 18:50:34.218 [TRACE] [wave.internal.protocol.SerialMessage] - Calculated checksum = 122
2023-10-14 18:50:34.219 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Checksum matched
2023-10-14 18:50:34.220 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 98: Message payload = 00 62 02 20 02 C9 00 
2023-10-14 18:50:34.221 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Message is valid, sending ACK
2023-10-14 18:50:34.223 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Response SENT 6
2023-10-14 18:50:34.224 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=98, callback=0, payload=00 62 02 20 02 C9 00 
2023-10-14 18:50:34.225 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=98, callback=0, payload=00 62 02 20 02 C9 00 
2023-10-14 18:50:34.227 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-10-14 18:50:34.227 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Application Command Request (ALIVE:DONE)
2023-10-14 18:50:34.228 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: resetResendCount initComplete=true isDead=false
2023-10-14 18:50:34.229 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-10-14 18:50:34.230 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: SECURITY not supported
2023-10-14 18:50:34.232 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 98: Received COMMAND_CLASS_BASIC V1 unknown command 2
2023-10-14 18:50:34.233 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Commands processed 1.
2023-10-14 18:50:34.234 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@e7aefc.
2023-10-14 18:50:34.235 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-14 18:50:34.236 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-14 18:50:34.237 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-10-14 18:50:34.238 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-10-14 18:50:34.239 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 89: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:34.240 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 89: Node not awake!
2023-10-14 18:50:34.241 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 92: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:34.243 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 92: Node not awake!
2023-10-14 18:50:34.244 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 88: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:34.245 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 88: Node not awake!
2023-10-14 18:50:34.247 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 71: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:34.248 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 71: Node not awake!
2023-10-14 18:50:34.249 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 81: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:34.250 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 81: Node not awake!
2023-10-14 18:50:34.252 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 82: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:34.253 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 82: Node not awake!
2023-10-14 18:50:34.254 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 72: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:34.256 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 72: Node not awake!
2023-10-14 18:50:34.257 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 55: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:34.259 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 55: Node not awake!
2023-10-14 18:50:34.261 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 61: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:34.262 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 61: Node not awake!
2023-10-14 18:50:34.263 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 73: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:34.264 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 73: Node not awake!
2023-10-14 18:50:34.265 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 79: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:34.266 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 79: Node not awake!
2023-10-14 18:50:34.266 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 58: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:34.267 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 58: Node not awake!
2023-10-14 18:50:34.268 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 74: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:34.269 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 74: Node not awake!
2023-10-14 18:50:34.270 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 80: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:34.270 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 80: Node not awake!
2023-10-14 18:50:34.271 [TRACE] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage nothing
2023-10-14 18:50:39.272 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Received SOF
2023-10-14 18:50:39.274 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0E 00 04 00 62 06 26 04 78 00 FF 00 CA 00 FE 
2023-10-14 18:50:39.275 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Creating new SerialMessage from buffer = 01 0E 00 04 00 62 06 26 04 78 00 FF 00 CA 00 FE 
2023-10-14 18:50:39.276 [TRACE] [wave.internal.protocol.SerialMessage] - Calculated checksum = -2
2023-10-14 18:50:39.276 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Checksum matched
2023-10-14 18:50:39.277 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 98: Message payload = 00 62 06 26 04 78 00 FF 00 CA 00 
2023-10-14 18:50:39.278 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Message is valid, sending ACK
2023-10-14 18:50:39.279 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Response SENT 6
2023-10-14 18:50:39.280 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=98, callback=0, payload=00 62 06 26 04 78 00 FF 00 CA 00 
2023-10-14 18:50:39.281 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=98, callback=0, payload=00 62 06 26 04 78 00 FF 00 CA 00 
2023-10-14 18:50:39.281 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-10-14 18:50:39.282 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Application Command Request (ALIVE:DONE)
2023-10-14 18:50:39.283 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: resetResendCount initComplete=true isDead=false
2023-10-14 18:50:39.284 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: Incoming command class COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2023-10-14 18:50:39.285 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: SECURITY not supported
2023-10-14 18:50:39.286 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 98: Received COMMAND_CLASS_SWITCH_MULTILEVEL V3 SWITCH_MULTILEVEL_START_LEVEL_CHANGE
2023-10-14 18:50:39.287 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 98: Switch Multi Level start level change, direction = DECREASE
2023-10-14 18:50:39.288 [TRACE] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveStartStopEvent
2023-10-14 18:50:39.288 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 98: Got an event from Z-Wave network: ZWaveStartStopEvent
2023-10-14 18:50:39.289 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 98: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SWITCH_MULTILEVEL, value=DECREASE
2023-10-14 18:50:39.290 [TRACE] [ding.zwave.handler.ZWaveThingHandler] - NODE 98: Checking channel=zwave:device:zwave-controller:node98:blinds_control, cmdClass=COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint=0
2023-10-14 18:50:39.291 [DEBUG] [erter.ZWaveMultiLevelSwitchConverter] - NODE 98: ZWaveMultiLevelSwitchConverter.handleEvent() <<blinds_control>>
2023-10-14 18:50:39.292 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Commands processed 1.
2023-10-14 18:50:39.293 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@d53628.
2023-10-14 18:50:39.293 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-14 18:50:39.294 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-14 18:50:39.295 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-10-14 18:50:39.296 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-10-14 18:50:39.296 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 89: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:39.297 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 89: Node not awake!
2023-10-14 18:50:39.298 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 92: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:39.299 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 92: Node not awake!
2023-10-14 18:50:39.299 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 88: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:39.300 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 88: Node not awake!
2023-10-14 18:50:39.301 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 71: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:39.302 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 71: Node not awake!
2023-10-14 18:50:39.302 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 81: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:39.303 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 81: Node not awake!
2023-10-14 18:50:39.304 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 82: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:39.305 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 82: Node not awake!
2023-10-14 18:50:39.305 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 72: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:39.306 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 72: Node not awake!
2023-10-14 18:50:39.307 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 55: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:39.308 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 55: Node not awake!
2023-10-14 18:50:39.308 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 61: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:39.309 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 61: Node not awake!
2023-10-14 18:50:39.310 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 73: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:39.310 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 73: Node not awake!
2023-10-14 18:50:39.311 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 79: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:39.312 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 79: Node not awake!
2023-10-14 18:50:39.313 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 58: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:39.313 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 58: Node not awake!
2023-10-14 18:50:39.314 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 74: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:39.315 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 74: Node not awake!
2023-10-14 18:50:39.316 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 80: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:39.317 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 80: Node not awake!
2023-10-14 18:50:39.317 [TRACE] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage nothing
2023-10-14 18:50:44.355 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Received SOF
2023-10-14 18:50:44.358 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 62 02 20 02 CA 00 79 
2023-10-14 18:50:44.361 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Creating new SerialMessage from buffer = 01 0A 00 04 00 62 02 20 02 CA 00 79 
2023-10-14 18:50:44.363 [TRACE] [wave.internal.protocol.SerialMessage] - Calculated checksum = 121
2023-10-14 18:50:44.365 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Checksum matched
2023-10-14 18:50:44.367 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 98: Message payload = 00 62 02 20 02 CA 00 
2023-10-14 18:50:44.368 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Message is valid, sending ACK
2023-10-14 18:50:44.370 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Response SENT 6
2023-10-14 18:50:44.371 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=98, callback=0, payload=00 62 02 20 02 CA 00 
2023-10-14 18:50:44.372 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=98, callback=0, payload=00 62 02 20 02 CA 00 
2023-10-14 18:50:44.373 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-10-14 18:50:44.374 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Application Command Request (ALIVE:DONE)
2023-10-14 18:50:44.375 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: resetResendCount initComplete=true isDead=false
2023-10-14 18:50:44.376 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-10-14 18:50:44.377 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: SECURITY not supported
2023-10-14 18:50:44.378 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 98: Received COMMAND_CLASS_BASIC V1 unknown command 2
2023-10-14 18:50:44.379 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Commands processed 1.
2023-10-14 18:50:44.380 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@11fc51d.
2023-10-14 18:50:44.380 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-14 18:50:44.381 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-14 18:50:44.382 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-10-14 18:50:44.383 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-10-14 18:50:44.384 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 89: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:44.385 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 89: Node not awake!
2023-10-14 18:50:44.386 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 92: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:44.387 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 92: Node not awake!
2023-10-14 18:50:44.388 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 88: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:44.389 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 88: Node not awake!
2023-10-14 18:50:44.390 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 71: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:44.391 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 71: Node not awake!
2023-10-14 18:50:44.392 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 81: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:44.392 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 81: Node not awake!
2023-10-14 18:50:44.393 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 82: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:44.394 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 82: Node not awake!
2023-10-14 18:50:44.395 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 72: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:44.396 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 72: Node not awake!
2023-10-14 18:50:44.397 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 55: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:44.399 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 55: Node not awake!
2023-10-14 18:50:44.400 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 61: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:44.401 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 61: Node not awake!
2023-10-14 18:50:44.402 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 73: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:44.403 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 73: Node not awake!
2023-10-14 18:50:44.404 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 79: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:44.406 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 79: Node not awake!
2023-10-14 18:50:44.408 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 58: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:44.409 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 58: Node not awake!
2023-10-14 18:50:44.410 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 74: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:44.412 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 74: Node not awake!
2023-10-14 18:50:44.414 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 80: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:44.417 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 80: Node not awake!
2023-10-14 18:50:44.419 [TRACE] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage nothing
2023-10-14 18:50:49.438 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Received SOF
2023-10-14 18:50:49.440 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 62 02 20 02 C9 00 7A 
2023-10-14 18:50:49.441 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Creating new SerialMessage from buffer = 01 0A 00 04 00 62 02 20 02 C9 00 7A 
2023-10-14 18:50:49.441 [TRACE] [wave.internal.protocol.SerialMessage] - Calculated checksum = 122
2023-10-14 18:50:49.442 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Checksum matched
2023-10-14 18:50:49.443 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 98: Message payload = 00 62 02 20 02 C9 00 
2023-10-14 18:50:49.443 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Message is valid, sending ACK
2023-10-14 18:50:49.444 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Response SENT 6
2023-10-14 18:50:49.445 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=98, callback=0, payload=00 62 02 20 02 C9 00 
2023-10-14 18:50:49.446 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=98, callback=0, payload=00 62 02 20 02 C9 00 
2023-10-14 18:50:49.447 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-10-14 18:50:49.448 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Application Command Request (ALIVE:DONE)
2023-10-14 18:50:49.448 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: resetResendCount initComplete=true isDead=false
2023-10-14 18:50:49.449 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-10-14 18:50:49.450 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: SECURITY not supported
2023-10-14 18:50:49.451 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 98: Received COMMAND_CLASS_BASIC V1 unknown command 2
2023-10-14 18:50:49.452 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Commands processed 1.
2023-10-14 18:50:49.454 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@d8df9c.
2023-10-14 18:50:49.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-14 18:50:49.456 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-14 18:50:49.457 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-10-14 18:50:49.457 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-10-14 18:50:49.458 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 89: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:49.459 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 89: Node not awake!
2023-10-14 18:50:49.460 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 92: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:49.461 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 92: Node not awake!
2023-10-14 18:50:49.462 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 88: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:49.463 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 88: Node not awake!
2023-10-14 18:50:49.464 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 71: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:49.464 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 71: Node not awake!
2023-10-14 18:50:49.465 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 81: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:49.466 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 81: Node not awake!
2023-10-14 18:50:49.467 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 82: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:49.468 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 82: Node not awake!
2023-10-14 18:50:49.469 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 72: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:49.469 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 72: Node not awake!
2023-10-14 18:50:49.470 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 55: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:49.471 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 55: Node not awake!
2023-10-14 18:50:49.472 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 61: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:49.473 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 61: Node not awake!
2023-10-14 18:50:49.474 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 73: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:49.475 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 73: Node not awake!
2023-10-14 18:50:49.476 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 79: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:49.477 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 79: Node not awake!
2023-10-14 18:50:49.478 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 58: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:49.478 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 58: Node not awake!
2023-10-14 18:50:49.479 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 74: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:49.480 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 74: Node not awake!
2023-10-14 18:50:49.483 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 80: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:49.484 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 80: Node not awake!
2023-10-14 18:50:49.485 [TRACE] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage nothing
2023-10-14 18:50:54.524 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Received SOF
2023-10-14 18:50:54.526 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 62 02 20 02 CA 00 79 
2023-10-14 18:50:54.527 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Creating new SerialMessage from buffer = 01 0A 00 04 00 62 02 20 02 CA 00 79 
2023-10-14 18:50:54.528 [TRACE] [wave.internal.protocol.SerialMessage] - Calculated checksum = 121
2023-10-14 18:50:54.529 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Checksum matched
2023-10-14 18:50:54.530 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 98: Message payload = 00 62 02 20 02 CA 00 
2023-10-14 18:50:54.531 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Message is valid, sending ACK
2023-10-14 18:50:54.531 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Response SENT 6
2023-10-14 18:50:54.532 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=98, callback=0, payload=00 62 02 20 02 CA 00 
2023-10-14 18:50:54.534 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=98, callback=0, payload=00 62 02 20 02 CA 00 
2023-10-14 18:50:54.534 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-10-14 18:50:54.535 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Application Command Request (ALIVE:DONE)
2023-10-14 18:50:54.536 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: resetResendCount initComplete=true isDead=false
2023-10-14 18:50:54.537 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-10-14 18:50:54.537 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: SECURITY not supported
2023-10-14 18:50:54.538 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 98: Received COMMAND_CLASS_BASIC V1 unknown command 2
2023-10-14 18:50:54.539 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Commands processed 1.
2023-10-14 18:50:54.539 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1610ab5.
2023-10-14 18:50:54.540 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-14 18:50:54.541 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-14 18:50:54.541 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-10-14 18:50:54.542 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-10-14 18:50:54.543 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 89: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:54.543 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 89: Node not awake!
2023-10-14 18:50:54.544 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 92: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:54.545 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 92: Node not awake!
2023-10-14 18:50:54.545 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 88: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:54.546 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 88: Node not awake!
2023-10-14 18:50:54.547 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 71: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:54.548 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 71: Node not awake!
2023-10-14 18:50:54.549 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 81: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:54.549 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 81: Node not awake!
2023-10-14 18:50:54.550 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 82: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:54.551 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 82: Node not awake!
2023-10-14 18:50:54.552 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 72: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:54.552 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 72: Node not awake!
2023-10-14 18:50:54.553 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 55: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:54.554 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 55: Node not awake!
2023-10-14 18:50:54.554 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 61: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:54.555 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 61: Node not awake!
2023-10-14 18:50:54.556 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 73: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:54.556 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 73: Node not awake!
2023-10-14 18:50:54.557 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 79: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:54.558 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 79: Node not awake!
2023-10-14 18:50:54.558 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 58: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:54.559 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 58: Node not awake!
2023-10-14 18:50:54.560 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 74: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:54.560 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 74: Node not awake!
2023-10-14 18:50:54.561 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 80: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:50:54.562 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 80: Node not awake!
2023-10-14 18:50:54.562 [TRACE] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage nothing
2023-10-14 18:51:01.021 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Received SOF
2023-10-14 18:51:01.022 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 62 02 20 02 C9 00 7A 
2023-10-14 18:51:01.024 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Creating new SerialMessage from buffer = 01 0A 00 04 00 62 02 20 02 C9 00 7A 
2023-10-14 18:51:01.024 [TRACE] [wave.internal.protocol.SerialMessage] - Calculated checksum = 122
2023-10-14 18:51:01.025 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Checksum matched
2023-10-14 18:51:01.026 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 98: Message payload = 00 62 02 20 02 C9 00 
2023-10-14 18:51:01.027 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Message is valid, sending ACK
2023-10-14 18:51:01.028 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Response SENT 6
2023-10-14 18:51:01.029 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=98, callback=0, payload=00 62 02 20 02 C9 00 
2023-10-14 18:51:01.031 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=98, callback=0, payload=00 62 02 20 02 C9 00 
2023-10-14 18:51:01.032 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2023-10-14 18:51:01.032 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Application Command Request (ALIVE:DONE)
2023-10-14 18:51:01.033 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: resetResendCount initComplete=true isDead=false
2023-10-14 18:51:01.034 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: Incoming command class COMMAND_CLASS_BASIC, endpoint 0
2023-10-14 18:51:01.035 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 98: SECURITY not supported
2023-10-14 18:51:01.036 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 98: Received COMMAND_CLASS_BASIC V1 unknown command 2
2023-10-14 18:51:01.037 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Commands processed 1.
2023-10-14 18:51:01.040 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 98: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@a81647.
2023-10-14 18:51:01.041 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-14 18:51:01.046 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2023-10-14 18:51:01.050 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2023-10-14 18:51:01.055 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2023-10-14 18:51:01.057 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 89: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:51:01.060 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 89: Node not awake!
2023-10-14 18:51:01.063 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 92: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:51:01.067 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 92: Node not awake!
2023-10-14 18:51:01.068 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 88: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:51:01.069 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 88: Node not awake!
2023-10-14 18:51:01.070 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 71: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:51:01.071 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 71: Node not awake!
2023-10-14 18:51:01.072 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 81: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:51:01.073 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 81: Node not awake!
2023-10-14 18:51:01.074 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 82: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:51:01.075 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 82: Node not awake!
2023-10-14 18:51:01.076 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 72: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:51:01.079 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 72: Node not awake!
2023-10-14 18:51:01.081 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 55: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:51:01.083 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 55: Node not awake!
2023-10-14 18:51:01.084 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 61: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:51:01.086 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 61: Node not awake!
2023-10-14 18:51:01.087 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 73: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:51:01.088 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 73: Node not awake!
2023-10-14 18:51:01.089 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 79: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:51:01.090 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 79: Node not awake!
2023-10-14 18:51:01.091 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 58: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:51:01.092 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 58: Node not awake!
2023-10-14 18:51:01.093 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 74: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:51:01.094 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 74: Node not awake!
2023-10-14 18:51:01.095 [TRACE] [ng.zwave.internal.protocol.ZWaveNode] - NODE 80: listening == false, frequentlyListening == false, awake == false
2023-10-14 18:51:01.096 [TRACE] [nal.protocol.ZWaveTransactionManager] - NODE 80: Node not awake!
2023-10-14 18:51:01.097 [TRACE] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage nothing

Does this tell you something? Since there is clearly something received when we click the device, it means it’s definitely communicating. But it is not assuming, on the Thing inside OH neither on the Item associated to it, anything at all. Also in the rules, it is not capturing no change at all since I have a “logInfo” there to test if any change happened and nothing at all…

Any help will be much appreciated!

apella12 · October 15, 2023, 1:26am

Did you delete (do not exclude) the node and rescan after updating the binding to pick up the changes.
Don’t use trace too confusing.
Need slower testing, too much going on. It does appear one test was different than the rest.

Simon 2023-10-14 2123171114×216 11.5 KB
This could be a problem that I do not know how to solve;
Received COMMAND_CLASS_BASIC V1 unknown command 2

pedrolima · October 17, 2023, 6:17pm

Ok, I just did that, rebooted after removing and then added after reboot.

Did some tests clicking on the button and I’ve done these rule tests, with no success:

rule "Test Master Guest Room Thing"

when
   Thing "zwave:device:zwave-controller:node98" changed
then
   logInfo("CHANGE","Something changed on the thing...")
end


rule "Test Master Guest Room Item"

when
   Item MasterControlerGuestRoom changed
then
   logInfo("CHANGE","Something changed on the item...")
end




rule "Master Controlers Guest Room"

when
   Item MasterControlerGuestRoom received command
then
   if(receivedCommand == UP) {
      BlackoutGuestRoom.sendCommand(UP)
      BlindsGuestRoom.sendCommand(UP)
   }

   if(receivedCommand == STOP) {
      BlackoutGuestRoom.sendCommand(STOP)
      BlindsGuestRoom.sendCommand(STOP)
   }

   if(receivedCommand == DOWN) {
      BlackoutGuestRoom.sendCommand(DOWN)
      BlindsGuestRoom.sendCommand(DOWN)
   }
end

This is the result from the log view:

What I am finding very, very weird is that, if there is a DIRECTION=UP and DIRECTION=DOWN on the log, why is that I cannot track any change at all in OH? This is so weird…

I really cannot understand what’s going on here.

apella12 · October 17, 2023, 9:56pm

I need a refresher. Does node 98 represent a specific blind in a room or is it a controller for several blinds with separate node numbers? Forgetting the OH UI displays for a moment, does the node 98 buttons actually control the node 98 blind (or if it is only a controller for other nodes, are those blinds controlled by the device (node 98)? Lastly if it only controls other nodes, how were those linked? (Not relevant if node 98 only controls one blind).

Is the zstick controller (node 1) in the control group (association 2) for Node 98? I don’t think that is helping.

pedrolima · October 17, 2023, 10:17pm

Second guess. It’s a “master controler” that when I click, I want to control other things (in my case, a blind and a blackout at the same time, that’s what these “master controlers” from Simon brand are used to).

No, it’s like I mentioned above.

I created that rule in order to send the commands to the blind and blackout I want to control. I tested clicking in the OH UI item and, as expected, it worked.

Do you refer to this (green arrows)? What about the generic class, should I eventually try and change that in the database? Maybe that’s why I am not being able to get the proper reading in OH (red arrow).

apella12 · October 17, 2023, 10:36pm

Ok, sorry, more questions How is node 98 involved with this rule? Let’s say the blind and blackout are nodes 90 and 91. Couldn’t the rule just send Up/down/stop to 90 and 91? Does node 98 buttons also control nodes 90 and 91 outside of OH? Further down on the UI page for node 98, what is in the Association groups for node 98? if not 90 and 91 how did you get 98 to control them (assuming it does control them)?

Edit: Depending on your feedback, but what I am wondering is of you operate the blinds and blackout with node 98 buttons (not by rule), do nodes 90 and 91 reflect the changes in OH? (I see one of the child nodes is 23, now)

pedrolima · October 17, 2023, 10:49pm

Totally fine, I just have to be grateful for your kind help!

Outside OH the device is a dumb device, does nothing. It only has power to be on and that’s it. It’s not connected to anything at all. The way it works originally, is connected to a Hub from Simon and then on their APP we setup what we want to control when we click it. We can actually create any rule with it because it’s a click that produces a result. It’s kind of the same thing we can do with rules in OH honestly.

I want it to control them, but it’s not controlling anything at all and that’s my problem.

I need to first be able to get whatever information there’s in the zwave network when I click the button (which, by the log file, there is definitely something there), but for some reason OH is not capturing nothing at all (nothing in those rules above translated into anything whatsoever).

So yeah, that’s it, I’m stuck for now. Should I try to change the generic class in the database and then try again?

EDIT:

You are referring to the neighbours for the wave network.

PS: Blackout arrow is pointing to 20 but it’s actually node 75).

apella12 · October 17, 2023, 10:56pm

This not the problem.

Try putting the nodes you want to control in Association group 2 for node 98 (remove node 1, if it there), then press the buttons in Debug, lets see what that shows. PS- I have to step away for a bit.

pedrolima · October 17, 2023, 10:59pm

How can I do this?

Sure, not a problem.

I also cannot test it right now, I do not have access to that one where I am. Only tomorrow maybe.

apella12 · October 17, 2023, 11:58pm

There could be a problem doing this in OH, the DB needs to be fixed. Control should be group 2. I’m not sure what your UI page is showing.
master 2023-10-17 195201

However, you may be able to use the Association process in the manual using the buttons.

s100_io_masterrollerblind_991030_990916.pdf (957.2 KB)

pedrolima · October 18, 2023, 12:15am

EXACTLY!

It should indeed be that where the problem is. This should actually be the correct setup:

I will definitely try tomorrow to test this.