OH2 Z-Wave refactoring and testing... and SECURITY

Is it possible to update the firmware of a FGMS001 without the Fibaro box ?

Regarding the Aeon Labs Minimote, I read in the documentation that we have one channel ā€œscene_numberā€. How is distinguised the short and the long press on a button ? Different scene numbers ?

.

No - Fibaro wonā€™t make their firmware available. Iā€™ve discussed this with them in the past, and that is their policy - they did say they might change it one day, but unfortunately itā€™s quite a common policy.

I think you can probably return it to Fibaro for them to do, but thatā€™s probably not a cheap option either.

I think itā€™s the decimal place - so from memory itā€™s <scene number>.<event type>. So you might have 3.1 or 3.2 for different events for scene 3.

For the Minimote, scene_number comes in from 1 through 8. Like thisā€¦

Physical Button Press Hold
1 1 2
2 3 4
3 5 6
4 7 8

Iā€™ve now added this to the documentation in the database. If you click on the Export button, and export the MD documentation, it should now describe this -:

image

Since the website documentation isnā€™t updated regularly (thereā€™s no CI for this still I think) it might be best using this for now as itā€™s generated liveā€¦

Thanks, I will try that.

Just a stupid question, do you know how you exclude/include a minimote from an existing Z-Wave network ?!
I see in the documentation how to do when you want the miniomote as a controller but I see nothing when you want the minimote as a simple device from the network !

There are 2 ā€œsceneā€ command classes - the older SCENE_ACTIVATION, and the newer CENTRAL_SCENE. The older one is just a number, the newer one has the event IDs added.

@chris : sorry for asking probably again. If I delcare my thing in a config file, I know that I canā€™t configure it with Paper UI but can I configure it with HABmin in this case ?

1 Like

Unfortunately not - they both use the same REST interface, and the ability to edit ā€œunmanagedā€ things is blocked in ESH.

Ok, thank you, thatā€™s clear now, I should not ask again in the future :slight_smile:

Apparently, to remove a minimote from a network, I have to reset it by pressing the butrtons Associate + Learn. To include it in a network, I have to press the button Learn.
Edit: the Learn button can be used for exclusion too.

After I posted, I headed to the db to update the device with this info and I missed these posts. :slightly_smiling_face: When I added the table, only two of the three columns are displaying (Usage Info).

TMK, the Minimote does not support CENTRAL_SCENE.

Are you sure? IIRC, the Minimote could not be excluded. I thought this was because it is added as as a secondary controller, which canā€™t just be excluded like a regular device. Itā€™s been a while since I tried though, so I could be mistaken.

My minimote has been added and is working. I got scene numbers 1, 3, 5 and 7 for short press and 2, 4, 6 and 8 for long press.

I have been troubleshooting why my lights are occasionally in the wrong state (ON when physically OFF, etc.), I believe Iā€™ve tracked it down to the binding and the command polling. I thought it was due to having a 30s fade off set in the dimmers (VRMX and DZMX). Iā€™m still looking into it and testing a longer command poll time. In the process, I found a device that is in a continual poll cycle (poll> app busy> poll). This has been going on for a few days, and Iā€™ve definitely restarted OH in that time. I do not see this with other devices and I did not have debugging on when it started. It may be a hardware issue, but it seems the binding is doing something odd here.

Log of one poll cycle
2018-08-17 23:48:11.233 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveCommandClass] - NODE 16: Received COMMAND_CLASS_APPLICATION_STATUS V0 APPLICATION_BUSY
2018-08-17 23:48:11.233 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveApplicationStatusCommandClass] - NODE Node 16: Manufacturer=001D, Type=0602, Id=0334: is busy and will be polled in 2 seconds
2018-08-17 23:48:11.233 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 16: Got an event from Z-Wave network: ZWaveDelayedPollEvent
2018-08-17 23:48:11.234 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 16: Polling intialised at 1800 seconds - start in 2000 milliseconds.
2018-08-17 23:48:11.234 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 16: Commands processed 1.
2018-08-17 23:48:11.234 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 16: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@ff02210.
2018-08-17 23:48:11.235 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 16: Command NOT verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@ff02210.
2018-08-17 23:48:11.235 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2018-08-17 23:48:11.235 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2018-08-17 23:48:11.235 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-08-17 23:48:11.235 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-08-17 23:48:13.234 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 16: Polling...
2018-08-17 23:48:13.234 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 16: Polling zwave:device:07cb40a2:node16:switch_dimmer
2018-08-17 23:48:13.234 [DEBUG] [org.openhab.binding.zwave.internal.converter.ZWaveMultiLevelSwitchConverter] - NODE 16: Generating poll message for COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2018-08-17 23:48:13.234 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveMultiLevelSwitchCommandClass] - NODE 16: Creating new message for command SWITCH_MULTILEVEL_GET
2018-08-17 23:48:13.234 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 16: SECURITY not supported
2018-08-17 23:48:13.234 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 16: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured
2018-08-17 23:48:13.235 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 16: Polling zwave:device:07cb40a2:node16:scene_number
2018-08-17 23:48:13.235 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 16: Polling skipped for zwave:device:07cb40a2:node16:scene_number on COMMAND_CLASS_BASIC
2018-08-17 23:48:13.235 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 16: Adding to device queue
2018-08-17 23:48:13.235 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-08-17 23:48:16.189 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager$ZWaveTransactionTimer] - NODE 16: TID 7623: Timeout at state WAIT_DATA. 3 retries remaining.
2018-08-17 23:48:16.189 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransaction] - TID 7623: Transaction CANCELLED
2018-08-17 23:48:16.189 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 16: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-08-17 23:48:16.189 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 16: notifyTransactionResponse TID:7623 CANCELLED
2018-08-17 23:48:16.190 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-08-17 23:48:16.190 [DEBUG] [org.openhab.binding.zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 10 02 26 02 25 9A 6C 
2018-08-17 23:48:16.190 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveSerialHandler] - NODE 16: Sending REQUEST Message = 01 09 00 13 10 02 26 02 25 9A 6C 
2018-08-17 23:48:16.193 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2018-08-17 23:48:16.193 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-08-17 23:48:16.194 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage past lock Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-08-17 23:48:16.194 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-08-17 23:48:16.194 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction null
2018-08-17 23:48:16.194 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Received msg: ACK
2018-08-17 23:48:16.194 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-08-17 23:48:16.194 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveSerialHandler] - Message SENT
2018-08-17 23:48:16.195 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 7624: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 154
2018-08-17 23:48:16.195 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-08-17 23:48:16.197 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2018-08-17 23:48:16.201 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-17 23:48:16.201 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage past lock Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-17 23:48:16.202 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-17 23:48:16.202 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction TID 7624: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 154
2018-08-17 23:48:16.202 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-08-17 23:48:16.202 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Last transaction: TID 7624: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 154
2018-08-17 23:48:16.202 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-17 23:48:16.202 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.SendDataMessageClass] - NODE 16: sentData successfully placed on stack.
2018-08-17 23:48:16.202 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - TID 7624: Advanced to WAIT_REQUEST
2018-08-17 23:48:16.202 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 16: TID 7624: Transaction not completed
2018-08-17 23:48:16.202 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-08-17 23:48:16.202 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-08-17 23:48:16.232 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 05 00 13 9A 00 73 
2018-08-17 23:48:16.236 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=154, payload=9A 00 
2018-08-17 23:48:16.237 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage past lock Message: class=SendData[19], type=Request[0], dest=0, callback=154, payload=9A 00 
2018-08-17 23:48:16.237 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=154, payload=9A 00 
2018-08-17 23:48:16.237 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction TID 7624: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 154
2018-08-17 23:48:16.237 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-08-17 23:48:16.237 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Last transaction: TID 7624: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 154
2018-08-17 23:48:16.237 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Checking TID 7624: (Callback 154)
2018-08-17 23:48:16.237 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.ZWaveCommandProcessor] - Callback match!
2018-08-17 23:48:16.237 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Correlated to TID 7624: callback 154
2018-08-17 23:48:16.237 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=154, payload=9A 00 
2018-08-17 23:48:16.238 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.SendDataMessageClass] - NODE 16: SendData Request. CallBack ID = 154, Status = Transmission complete and ACK received(0)
2018-08-17 23:48:16.238 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 16: resetResendCount initComplete=true isDead=false
2018-08-17 23:48:16.238 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - TID 7624: Advanced to WAIT_DATA
2018-08-17 23:48:16.238 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 16: TID 7624: Transaction not completed
2018-08-17 23:48:16.238 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-08-17 23:48:16.238 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-08-17 23:48:16.277 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 10 04 22 01 00 00 C6 
2018-08-17 23:48:16.281 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=16, callback=0, payload=00 10 04 22 01 00 00 
2018-08-17 23:48:16.282 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage past lock Message: class=ApplicationCommandHandler[4], type=Request[0], dest=16, callback=0, payload=00 10 04 22 01 00 00 
2018-08-17 23:48:16.282 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=16, callback=0, payload=00 10 04 22 01 00 00 
2018-08-17 23:48:16.282 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction null
2018-08-17 23:48:16.283 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 16: Application Command Request (ALIVE:DONE)
2018-08-17 23:48:16.283 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 16: resetResendCount initComplete=true isDead=false
2018-08-17 23:48:16.283 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 16: Incoming command class COMMAND_CLASS_APPLICATION_STATUS, endpoint 0
2018-08-17 23:48:16.283 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 16: SECURITY not supported
2018-08-17 23:48:16.283 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveCommandClass] - NODE 16: Received COMMAND_CLASS_APPLICATION_STATUS V0 APPLICATION_BUSY

Reinitializing the device seems to have corrected this, but command polling was not occurring until I had adjusted the poll time.

Log right after reinit with no command polling until interval was adjusted
2018-08-21 14:38:58.898 [DEBUG] [ZWaveThingHandler] - NODE 16: Command received zwave:device:07cb40a2:node16:switch_dimmer --> 34
2018-08-21 14:38:58.899 [DEBUG] [ZWaveMultiLevelSwitchCommandClass] - NODE 16: Creating new message for command SWITCH_MULTILEVEL_SET
2018-08-21 14:38:58.900 [DEBUG] [ZWaveNode] - NODE 16: SECURITY not supported
2018-08-21 14:38:58.901 [DEBUG] [ZWaveNode] - NODE 16: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured
2018-08-21 14:38:58.901 [DEBUG] [ZWaveTransactionManager] - NODE 16: Adding to device queue
2018-08-21 14:38:58.901 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-08-21 14:38:58.901 [DEBUG] [SerialMessage] - Assembled message buffer = 01 0A 00 13 10 03 26 01 22 25 62 B7 
2018-08-21 14:38:58.902 [DEBUG] [ZWaveSerialHandler] - NODE 16: Sending REQUEST Message = 01 0A 00 13 10 03 26 01 22 25 62 B7 
2018-08-21 14:38:58.905 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2018-08-21 14:38:58.905 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-08-21 14:38:58.905 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage past lock Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-08-21 14:38:58.905 [DEBUG] [ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-08-21 14:38:58.905 [DEBUG] [ZWaveTransactionManager] - lastTransaction null
2018-08-21 14:38:58.905 [DEBUG] [ZWaveTransactionManager] - Received msg: ACK
2018-08-21 14:38:58.905 [DEBUG] [ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-08-21 14:38:58.906 [DEBUG] [ZWaveSerialHandler] - Message SENT
2018-08-21 14:38:58.906 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage started: TID 26113: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 98
2018-08-21 14:38:58.906 [DEBUG] [ZWaveThingHandler] - NODE 16: Polling intialised at 86400 seconds - start in 86400 milliseconds.
2018-08-21 14:38:58.906 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-08-21 14:38:58.909 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2018-08-21 14:38:58.912 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-21 14:38:58.913 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage past lock Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-21 14:38:58.916 [DEBUG] [ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-21 14:38:58.916 [DEBUG] [ZWaveTransactionManager] - lastTransaction TID 26113: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 98
2018-08-21 14:38:58.916 [DEBUG] [ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-08-21 14:38:58.916 [DEBUG] [ZWaveTransactionManager] - Last transaction: TID 26113: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 98
2018-08-21 14:38:58.916 [DEBUG] [ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-21 14:38:58.916 [DEBUG] [serialmessage.SendDataMessageClass] - NODE 16: sentData successfully placed on stack.
2018-08-21 14:38:58.916 [DEBUG] [ZWaveTransactionManager] - TID 26113: Advanced to WAIT_REQUEST
2018-08-21 14:38:58.916 [DEBUG] [ZWaveTransactionManager] - NODE 16: TID 26113: Transaction not completed
2018-08-21 14:38:58.916 [DEBUG] [ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-08-21 14:38:58.917 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-08-21 14:38:58.944 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 05 00 13 62 00 8B 
2018-08-21 14:38:58.948 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=98, payload=62 00 
2018-08-21 14:38:58.949 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage past lock Message: class=SendData[19], type=Request[0], dest=0, callback=98, payload=62 00 
2018-08-21 14:38:58.949 [DEBUG] [ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=98, payload=62 00 
2018-08-21 14:38:58.949 [DEBUG] [ZWaveTransactionManager] - lastTransaction TID 26113: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 98
2018-08-21 14:38:58.949 [DEBUG] [ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-08-21 14:38:58.949 [DEBUG] [ZWaveTransactionManager] - Last transaction: TID 26113: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 98
2018-08-21 14:38:58.949 [DEBUG] [ZWaveTransactionManager] - Checking TID 26113: (Callback 98)
2018-08-21 14:38:58.949 [DEBUG] [serialmessage.ZWaveCommandProcessor] - Callback match!
2018-08-21 14:38:58.949 [DEBUG] [ZWaveTransactionManager] - Correlated to TID 26113: callback 98
2018-08-21 14:38:58.950 [DEBUG] [ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=98, payload=62 00 
2018-08-21 14:38:58.950 [DEBUG] [serialmessage.SendDataMessageClass] - NODE 16: SendData Request. CallBack ID = 98, Status = Transmission complete and ACK received(0)
2018-08-21 14:38:58.950 [DEBUG] [ZWaveNode] - NODE 16: resetResendCount initComplete=true isDead=false
2018-08-21 14:38:58.950 [DEBUG] [ZWaveTransaction] - TID 26113: Transaction COMPLETED
2018-08-21 14:38:58.951 [DEBUG] [ZWaveTransactionManager] - NODE 16: Response processed after 45ms
2018-08-21 14:38:58.951 [DEBUG] [ZWaveTransactionManager] - NODE 16: TID 26113: Transaction completed
2018-08-21 14:38:58.951 [DEBUG] [ZWaveTransactionManager] - NODE 16: notifyTransactionResponse TID:26113 DONE
2018-08-21 14:38:58.952 [DEBUG] [ZWaveThingHandler] - NODE 16: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-08-21 14:38:58.952 [DEBUG] [ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-08-21 14:38:58.953 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-08-21 14:40:10.648 [DEBUG] [ZWaveThingHandler] - NODE 16: Configuration update received
2018-08-21 14:40:10.649 [DEBUG] [ZWaveThingHandler] - NODE 16: Configuration update set binding_cmdrepollperiod to 1505
2018-08-21 14:40:21.435 [DEBUG] [ZWaveThingHandler] - NODE 16: Configuration update received
2018-08-21 14:40:21.436 [DEBUG] [ZWaveThingHandler] - NODE 16: Configuration update set binding_cmdrepollperiod to 1500
2018-08-21 14:40:25.306 [DEBUG] [ZWaveThingHandler] - NODE 16: Polling...
[snip]
2018-08-21 14:40:32.295 [DEBUG] [ZWaveThingHandler] - NODE 16: Command received zwave:device:07cb40a2:node16:switch_dimmer --> 0
2018-08-21 14:40:32.295 [DEBUG] [ZWaveMultiLevelSwitchCommandClass] - NODE 16: Creating new message for command SWITCH_MULTILEVEL_SET
2018-08-21 14:40:32.295 [DEBUG] [ZWaveNode] - NODE 16: SECURITY not supported
2018-08-21 14:40:32.296 [DEBUG] [ZWaveNode] - NODE 16: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured
2018-08-21 14:40:32.296 [DEBUG] [ZWaveTransactionManager] - NODE 16: Adding to device queue
2018-08-21 14:40:32.296 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-08-21 14:40:32.297 [DEBUG] [SerialMessage] - Assembled message buffer = 01 0A 00 13 10 03 26 01 00 25 6F 98 
2018-08-21 14:40:32.300 [DEBUG] [ZWaveSerialHandler] - NODE 16: Sending REQUEST Message = 01 0A 00 13 10 03 26 01 00 25 6F 98 
2018-08-21 14:40:32.303 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2018-08-21 14:40:32.303 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-08-21 14:40:32.303 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage past lock Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-08-21 14:40:32.303 [DEBUG] [ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-08-21 14:40:32.303 [DEBUG] [ZWaveTransactionManager] - lastTransaction null
2018-08-21 14:40:32.303 [DEBUG] [ZWaveTransactionManager] - Received msg: ACK
2018-08-21 14:40:32.304 [DEBUG] [ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-08-21 14:40:32.304 [DEBUG] [ZWaveSerialHandler] - Message SENT
2018-08-21 14:40:32.304 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage started: TID 26132: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 111
2018-08-21 14:40:32.304 [DEBUG] [ZWaveThingHandler] - NODE 16: Polling intialised at 86400 seconds - start in 1500 milliseconds.
2018-08-21 14:40:32.304 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-08-21 14:40:32.306 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2018-08-21 14:40:32.310 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-21 14:40:32.310 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage past lock Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-21 14:40:32.310 [DEBUG] [ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-21 14:40:32.311 [DEBUG] [ZWaveTransactionManager] - lastTransaction TID 26132: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 111
2018-08-21 14:40:32.311 [DEBUG] [ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-08-21 14:40:32.311 [DEBUG] [ZWaveTransactionManager] - Last transaction: TID 26132: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 111
2018-08-21 14:40:32.311 [DEBUG] [ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-21 14:40:32.311 [DEBUG] [serialmessage.SendDataMessageClass] - NODE 16: sentData successfully placed on stack.
2018-08-21 14:40:32.311 [DEBUG] [ZWaveTransactionManager] - TID 26132: Advanced to WAIT_REQUEST
2018-08-21 14:40:32.311 [DEBUG] [ZWaveTransactionManager] - NODE 16: TID 26132: Transaction not completed
2018-08-21 14:40:32.311 [DEBUG] [ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-08-21 14:40:32.311 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-08-21 14:40:32.361 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 05 00 13 6F 00 86 
2018-08-21 14:40:32.365 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=111, payload=6F 00 
2018-08-21 14:40:32.366 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage past lock Message: class=SendData[19], type=Request[0], dest=0, callback=111, payload=6F 00 
2018-08-21 14:40:32.366 [DEBUG] [ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=111, payload=6F 00 
2018-08-21 14:40:32.366 [DEBUG] [ZWaveTransactionManager] - lastTransaction TID 26132: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 111
2018-08-21 14:40:32.366 [DEBUG] [ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-08-21 14:40:32.366 [DEBUG] [ZWaveTransactionManager] - Last transaction: TID 26132: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 111
2018-08-21 14:40:32.366 [DEBUG] [ZWaveTransactionManager] - Checking TID 26132: (Callback 111)
2018-08-21 14:40:32.367 [DEBUG] [serialmessage.ZWaveCommandProcessor] - Callback match!
2018-08-21 14:40:32.367 [DEBUG] [ZWaveTransactionManager] - Correlated to TID 26132: callback 111
2018-08-21 14:40:32.367 [DEBUG] [ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=111, payload=6F 00 
2018-08-21 14:40:32.367 [DEBUG] [serialmessage.SendDataMessageClass] - NODE 16: SendData Request. CallBack ID = 111, Status = Transmission complete and ACK received(0)
2018-08-21 14:40:32.367 [DEBUG] [ZWaveNode] - NODE 16: resetResendCount initComplete=true isDead=false
2018-08-21 14:40:32.367 [DEBUG] [ZWaveTransaction] - TID 26132: Transaction COMPLETED
2018-08-21 14:40:32.367 [DEBUG] [ZWaveTransactionManager] - NODE 16: Response processed after 63ms
2018-08-21 14:40:32.367 [DEBUG] [ZWaveTransactionManager] - NODE 16: TID 26132: Transaction completed
2018-08-21 14:40:32.368 [DEBUG] [ZWaveTransactionManager] - NODE 16: notifyTransactionResponse TID:26132 DONE
2018-08-21 14:40:32.368 [DEBUG] [ZWaveThingHandler] - NODE 16: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-08-21 14:40:32.368 [DEBUG] [ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-08-21 14:40:32.368 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-08-21 14:40:33.804 [DEBUG] [ZWaveThingHandler] - NODE 16: Polling...
2018-08-21 14:40:33.805 [DEBUG] [ZWaveThingHandler] - NODE 16: Polling zwave:device:07cb40a2:node16:switch_dimmer
2018-08-21 14:40:33.805 [DEBUG] [internal.converter.ZWaveMultiLevelSwitchConverter] - NODE 16: Generating poll message for COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2018-08-21 14:40:33.805 [DEBUG] [ZWaveMultiLevelSwitchCommandClass] - NODE 16: Creating new message for command SWITCH_MULTILEVEL_GET
2018-08-21 14:40:33.805 [DEBUG] [ZWaveNode] - NODE 16: SECURITY not supported
2018-08-21 14:40:33.805 [DEBUG] [ZWaveNode] - NODE 16: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured
2018-08-21 14:40:33.805 [DEBUG] [ZWaveThingHandler] - NODE 16: Polling zwave:device:07cb40a2:node16:scene_number
2018-08-21 14:40:33.805 [DEBUG] [ZWaveThingHandler] - NODE 16: Polling skipped for zwave:device:07cb40a2:node16:scene_number on COMMAND_CLASS_BASIC
2018-08-21 14:40:33.805 [DEBUG] [ZWaveTransactionManager] - NODE 16: Adding to device queue
2018-08-21 14:40:33.805 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-08-21 14:40:33.805 [DEBUG] [SerialMessage] - Assembled message buffer = 01 09 00 13 10 02 26 02 25 70 86 
2018-08-21 14:40:33.805 [DEBUG] [ZWaveSerialHandler] - NODE 16: Sending REQUEST Message = 01 09 00 13 10 02 26 02 25 70 86 
2018-08-21 14:40:33.807 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2018-08-21 14:40:33.807 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-08-21 14:40:33.808 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage past lock Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-08-21 14:40:33.808 [DEBUG] [ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-08-21 14:40:33.808 [DEBUG] [ZWaveTransactionManager] - lastTransaction null
2018-08-21 14:40:33.808 [DEBUG] [ZWaveTransactionManager] - Received msg: ACK
2018-08-21 14:40:33.808 [DEBUG] [ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-08-21 14:40:33.809 [DEBUG] [ZWaveSerialHandler] - Message SENT
2018-08-21 14:40:33.809 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage started: TID 26133: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 112
2018-08-21 14:40:33.809 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-08-21 14:40:33.811 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2018-08-21 14:40:33.815 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-21 14:40:33.815 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage past lock Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-21 14:40:33.815 [DEBUG] [ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-21 14:40:33.816 [DEBUG] [ZWaveTransactionManager] - lastTransaction TID 26133: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 112
2018-08-21 14:40:33.816 [DEBUG] [ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-08-21 14:40:33.816 [DEBUG] [ZWaveTransactionManager] - Last transaction: TID 26133: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 112
2018-08-21 14:40:33.816 [DEBUG] [ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-08-21 14:40:33.816 [DEBUG] [serialmessage.SendDataMessageClass] - NODE 16: sentData successfully placed on stack.
2018-08-21 14:40:33.816 [DEBUG] [ZWaveTransactionManager] - TID 26133: Advanced to WAIT_REQUEST
2018-08-21 14:40:33.816 [DEBUG] [ZWaveTransactionManager] - NODE 16: TID 26133: Transaction not completed
2018-08-21 14:40:33.816 [DEBUG] [ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-08-21 14:40:33.816 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-08-21 14:40:33.847 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 05 00 13 70 00 99 
2018-08-21 14:40:33.851 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=112, payload=70 00 
2018-08-21 14:40:33.852 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage past lock Message: class=SendData[19], type=Request[0], dest=0, callback=112, payload=70 00 
2018-08-21 14:40:33.853 [DEBUG] [ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=112, payload=70 00 
2018-08-21 14:40:33.853 [DEBUG] [ZWaveTransactionManager] - lastTransaction TID 26133: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 112
2018-08-21 14:40:33.853 [DEBUG] [ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-08-21 14:40:33.853 [DEBUG] [ZWaveTransactionManager] - Last transaction: TID 26133: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 112
2018-08-21 14:40:33.853 [DEBUG] [ZWaveTransactionManager] - Checking TID 26133: (Callback 112)
2018-08-21 14:40:33.854 [DEBUG] [serialmessage.ZWaveCommandProcessor] - Callback match!
2018-08-21 14:40:33.854 [DEBUG] [ZWaveTransactionManager] - Correlated to TID 26133: callback 112
2018-08-21 14:40:33.854 [DEBUG] [ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=112, payload=70 00 
2018-08-21 14:40:33.854 [DEBUG] [serialmessage.SendDataMessageClass] - NODE 16: SendData Request. CallBack ID = 112, Status = Transmission complete and ACK received(0)
2018-08-21 14:40:33.854 [DEBUG] [ZWaveNode] - NODE 16: resetResendCount initComplete=true isDead=false
2018-08-21 14:40:33.854 [DEBUG] [ZWaveTransactionManager] - TID 26133: Advanced to WAIT_DATA
2018-08-21 14:40:33.854 [DEBUG] [ZWaveTransactionManager] - NODE 16: TID 26133: Transaction not completed
2018-08-21 14:40:33.854 [DEBUG] [ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-08-21 14:40:33.854 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-08-21 14:40:33.892 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 10 03 26 03 00 C4 
2018-08-21 14:40:33.896 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=16, callback=0, payload=00 10 03 26 03 00 
2018-08-21 14:40:33.897 [DEBUG] [ZWaveTransactionManager] - processReceiveMessage past lock Message: class=ApplicationCommandHandler[4], type=Request[0], dest=16, callback=0, payload=00 10 03 26 03 00 
2018-08-21 14:40:33.897 [DEBUG] [ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=16, callback=0, payload=00 10 03 26 03 00 
2018-08-21 14:40:33.897 [DEBUG] [ZWaveTransactionManager] - lastTransaction null
2018-08-21 14:40:33.897 [DEBUG] [ZWaveTransactionManager] - NODE 16: Application Command Request (ALIVE:DONE)
2018-08-21 14:40:33.898 [DEBUG] [ZWaveNode] - NODE 16: resetResendCount initComplete=true isDead=false
2018-08-21 14:40:33.898 [DEBUG] [ZWaveNode] - NODE 16: Incoming command class COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2018-08-21 14:40:33.898 [DEBUG] [ZWaveNode] - NODE 16: SECURITY not supported
2018-08-21 14:40:33.898 [DEBUG] [ZWaveCommandClass] - NODE 16: Received COMMAND_CLASS_SWITCH_MULTILEVEL V1 SWITCH_MULTILEVEL_REPORT
2018-08-21 14:40:33.898 [DEBUG] [ZWaveMultiLevelSwitchCommandClass] - NODE 16: Switch Multi Level report, value = 0
2018-08-21 14:40:33.898 [DEBUG] [ZWaveThingHandler] - NODE 16: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2018-08-21 14:40:33.898 [DEBUG] [ZWaveThingHandler] - NODE 16: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SWITCH_MULTILEVEL, value = 0
2018-08-21 14:40:33.898 [DEBUG] [ZWaveThingHandler] - NODE 16: Updating channel state zwave:device:07cb40a2:node16:switch_dimmer to 0 [PercentType]
2018-08-21 14:40:33.901 [DEBUG] [ZWaveTransactionManager] - NODE 16: Commands processed 1.
2018-08-21 14:40:33.901 [DEBUG] [ZWaveTransactionManager] - NODE 16: Checking command ZWaveCommandClassPayload@45d0d852.
2018-08-21 14:40:33.901 [DEBUG] [ZWaveTransactionManager] - NODE 16: Command verified ZWaveCommandClassPayload@45d0d852.
2018-08-21 14:40:33.902 [DEBUG] [ZWaveTransactionManager] - NODE 16: notifyTransactionResponse TID:26133 DONE
2018-08-21 14:40:33.902 [DEBUG] [ZWaveThingHandler] - NODE 16: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-08-21 14:40:33.902 [DEBUG] [ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2018-08-21 14:40:33.902 [DEBUG] [ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2018-08-21 14:40:33.902 [DEBUG] [ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-08-21 14:40:33.902 [DEBUG] [ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

Here are several examples of a dimmer being set to a level, but the command polling comes back with the previous value of the light. This is with the command polling set to 15s. What makes this even odder, is that it does not happen for all devices of the same type, and it does not always happen for the same device. Adjusting the command polling interval did not have any affect. Other people have previously reported something similar.

Previous values reported by poll (filtered)
2018-08-21 16:00:41.654 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Command received zwave:device:07cb40a2:node30:switch_dimmer --> 21
2018-08-21 16:00:41.654 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveMultiLevelSwitchCommandClass] - NODE 30: Creating new message for command SWITCH_MULTILEVEL_SET
2018-08-21 16:00:41.654 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: SECURITY not supported
2018-08-21 16:00:41.655 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured
2018-08-21 16:00:41.655 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Adding to device queue
2018-08-21 16:00:41.657 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveSerialHandler] - NODE 30: Sending REQUEST Message = 01 0A 00 13 1E 03 26 01 15 25 85 69 
2018-08-21 16:00:41.662 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling intialised at 1800 seconds - start in 15000 milliseconds.
2018-08-21 16:00:41.668 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.SendDataMessageClass] - NODE 30: sentData successfully placed on stack.
2018-08-21 16:00:41.668 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: TID 26788: Transaction not completed
2018-08-21 16:00:41.686 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.SendDataMessageClass] - NODE 30: SendData Request. CallBack ID = 133, Status = Transmission complete and ACK received(0)
2018-08-21 16:00:41.686 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: resetResendCount initComplete=true isDead=false
2018-08-21 16:00:41.686 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Response processed after 25ms
2018-08-21 16:00:41.686 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: TID 26788: Transaction completed
2018-08-21 16:00:41.686 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: notifyTransactionResponse TID:26788 DONE
2018-08-21 16:00:41.687 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-08-21 16:00:56.662 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling...
2018-08-21 16:00:56.662 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling zwave:device:07cb40a2:node30:switch_dimmer
2018-08-21 16:00:56.662 [DEBUG] [org.openhab.binding.zwave.internal.converter.ZWaveMultiLevelSwitchConverter] - NODE 30: Generating poll message for COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2018-08-21 16:00:56.662 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveMultiLevelSwitchCommandClass] - NODE 30: Creating new message for command SWITCH_MULTILEVEL_GET
2018-08-21 16:00:56.663 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: SECURITY not supported
2018-08-21 16:00:56.663 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured
2018-08-21 16:00:56.663 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling zwave:device:07cb40a2:node30:scene_number
2018-08-21 16:00:56.663 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling skipped for zwave:device:07cb40a2:node30:scene_number on COMMAND_CLASS_BASIC
2018-08-21 16:00:56.663 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Adding to device queue
2018-08-21 16:00:56.663 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveSerialHandler] - NODE 30: Sending REQUEST Message = 01 09 00 13 1E 02 26 02 25 86 7E 
2018-08-21 16:00:56.674 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.SendDataMessageClass] - NODE 30: sentData successfully placed on stack.
2018-08-21 16:00:56.674 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: TID 26792: Transaction not completed
2018-08-21 16:00:56.693 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.SendDataMessageClass] - NODE 30: SendData Request. CallBack ID = 134, Status = Transmission complete and ACK received(0)
2018-08-21 16:00:56.693 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: resetResendCount initComplete=true isDead=false
2018-08-21 16:00:56.693 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: TID 26792: Transaction not completed
2018-08-21 16:00:56.701 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Application Command Request (ALIVE:DONE)
2018-08-21 16:00:56.701 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: resetResendCount initComplete=true isDead=false
2018-08-21 16:00:56.701 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: Incoming command class COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2018-08-21 16:00:56.701 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: SECURITY not supported
2018-08-21 16:00:56.701 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveCommandClass] - NODE 30: Received COMMAND_CLASS_SWITCH_MULTILEVEL V1 SWITCH_MULTILEVEL_REPORT
2018-08-21 16:00:56.701 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveMultiLevelSwitchCommandClass] - NODE 30: Switch Multi Level report, value = 0
2018-08-21 16:00:56.701 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2018-08-21 16:00:56.701 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SWITCH_MULTILEVEL, value = 0
2018-08-21 16:00:56.701 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Updating channel state zwave:device:07cb40a2:node30:switch_dimmer to 0 [PercentType]
2018-08-21 16:00:56.702 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Commands processed 1.
2018-08-21 16:00:56.702 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5a9fc4aa.
2018-08-21 16:00:56.703 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5a9fc4aa.
2018-08-21 16:00:56.708 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: notifyTransactionResponse TID:26792 DONE
2018-08-21 16:00:56.710 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-08-21 16:01:46.029 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Command received zwave:device:07cb40a2:node30:switch_dimmer --> 58
2018-08-21 16:01:46.030 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveMultiLevelSwitchCommandClass] - NODE 30: Creating new message for command SWITCH_MULTILEVEL_SET
2018-08-21 16:01:46.031 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: SECURITY not supported
2018-08-21 16:01:46.031 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured
2018-08-21 16:01:46.032 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Adding to device queue
2018-08-21 16:01:46.033 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveSerialHandler] - NODE 30: Sending REQUEST Message = 01 0A 00 13 1E 03 26 01 3A 25 88 4B 
2018-08-21 16:01:46.043 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling intialised at 1800 seconds - start in 15000 milliseconds.
2018-08-21 16:01:46.047 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.SendDataMessageClass] - NODE 30: sentData successfully placed on stack.
2018-08-21 16:01:46.047 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: TID 26795: Transaction not completed
2018-08-21 16:01:46.060 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.SendDataMessageClass] - NODE 30: SendData Request. CallBack ID = 136, Status = Transmission complete and ACK received(0)
2018-08-21 16:01:46.060 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: resetResendCount initComplete=true isDead=false
2018-08-21 16:01:46.060 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Response processed after 18ms
2018-08-21 16:01:46.060 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: TID 26795: Transaction completed
2018-08-21 16:01:46.060 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: notifyTransactionResponse TID:26795 DONE
2018-08-21 16:01:46.061 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-08-21 16:02:01.043 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling...
2018-08-21 16:02:01.043 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling zwave:device:07cb40a2:node30:switch_dimmer
2018-08-21 16:02:01.043 [DEBUG] [org.openhab.binding.zwave.internal.converter.ZWaveMultiLevelSwitchConverter] - NODE 30: Generating poll message for COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2018-08-21 16:02:01.043 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveMultiLevelSwitchCommandClass] - NODE 30: Creating new message for command SWITCH_MULTILEVEL_GET
2018-08-21 16:02:01.043 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: SECURITY not supported
2018-08-21 16:02:01.043 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured
2018-08-21 16:02:01.043 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling zwave:device:07cb40a2:node30:scene_number
2018-08-21 16:02:01.043 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling skipped for zwave:device:07cb40a2:node30:scene_number on COMMAND_CLASS_BASIC
2018-08-21 16:02:01.043 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Adding to device queue
2018-08-21 16:02:01.044 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveSerialHandler] - NODE 30: Sending REQUEST Message = 01 09 00 13 1E 02 26 02 25 89 71 
2018-08-21 16:02:01.059 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.SendDataMessageClass] - NODE 30: sentData successfully placed on stack.
2018-08-21 16:02:01.059 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: TID 26796: Transaction not completed
2018-08-21 16:02:01.072 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.SendDataMessageClass] - NODE 30: SendData Request. CallBack ID = 137, Status = Transmission complete and ACK received(0)
2018-08-21 16:02:01.072 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: resetResendCount initComplete=true isDead=false
2018-08-21 16:02:01.072 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: TID 26796: Transaction not completed
2018-08-21 16:02:01.080 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Application Command Request (ALIVE:DONE)
2018-08-21 16:02:01.080 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: resetResendCount initComplete=true isDead=false
2018-08-21 16:02:01.080 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: Incoming command class COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2018-08-21 16:02:01.080 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: SECURITY not supported
2018-08-21 16:02:01.081 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveCommandClass] - NODE 30: Received COMMAND_CLASS_SWITCH_MULTILEVEL V1 SWITCH_MULTILEVEL_REPORT
2018-08-21 16:02:01.081 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveMultiLevelSwitchCommandClass] - NODE 30: Switch Multi Level report, value = 21
2018-08-21 16:02:01.081 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2018-08-21 16:02:01.081 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SWITCH_MULTILEVEL, value = 21
2018-08-21 16:02:01.081 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Updating channel state zwave:device:07cb40a2:node30:switch_dimmer to 21 [PercentType]
2018-08-21 16:02:01.086 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Commands processed 1.
2018-08-21 16:02:01.086 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@9446fef.
2018-08-21 16:02:01.087 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@9446fef.
2018-08-21 16:02:01.087 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: notifyTransactionResponse TID:26796 DONE
2018-08-21 16:02:01.088 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-08-21 16:02:21.533 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Command received zwave:device:07cb40a2:node30:switch_dimmer --> 0
2018-08-21 16:02:21.534 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveMultiLevelSwitchCommandClass] - NODE 30: Creating new message for command SWITCH_MULTILEVEL_SET
2018-08-21 16:02:21.534 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: SECURITY not supported
2018-08-21 16:02:21.534 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured
2018-08-21 16:02:21.535 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Adding to device queue
2018-08-21 16:02:21.535 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveSerialHandler] - NODE 30: Sending REQUEST Message = 01 0A 00 13 1E 03 26 01 00 25 8A 73 
2018-08-21 16:02:21.540 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling intialised at 1800 seconds - start in 15000 milliseconds.
2018-08-21 16:02:21.553 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.SendDataMessageClass] - NODE 30: sentData successfully placed on stack.
2018-08-21 16:02:21.553 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: TID 26797: Transaction not completed
2018-08-21 16:02:21.564 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.SendDataMessageClass] - NODE 30: SendData Request. CallBack ID = 138, Status = Transmission complete and ACK received(0)
2018-08-21 16:02:21.564 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: resetResendCount initComplete=true isDead=false
2018-08-21 16:02:21.565 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Response processed after 25ms
2018-08-21 16:02:21.565 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: TID 26797: Transaction completed
2018-08-21 16:02:21.565 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: notifyTransactionResponse TID:26797 DONE
2018-08-21 16:02:21.565 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-08-21 16:02:36.540 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling...
2018-08-21 16:02:36.540 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling zwave:device:07cb40a2:node30:switch_dimmer
2018-08-21 16:02:36.540 [DEBUG] [org.openhab.binding.zwave.internal.converter.ZWaveMultiLevelSwitchConverter] - NODE 30: Generating poll message for COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2018-08-21 16:02:36.540 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveMultiLevelSwitchCommandClass] - NODE 30: Creating new message for command SWITCH_MULTILEVEL_GET
2018-08-21 16:02:36.540 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: SECURITY not supported
2018-08-21 16:02:36.540 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured
2018-08-21 16:02:36.540 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling zwave:device:07cb40a2:node30:scene_number
2018-08-21 16:02:36.540 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Polling skipped for zwave:device:07cb40a2:node30:scene_number on COMMAND_CLASS_BASIC
2018-08-21 16:02:36.541 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Adding to device queue
2018-08-21 16:02:36.541 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveSerialHandler] - NODE 30: Sending REQUEST Message = 01 09 00 13 1E 02 26 02 25 8B 73 
2018-08-21 16:02:36.552 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.SendDataMessageClass] - NODE 30: sentData successfully placed on stack.
2018-08-21 16:02:36.552 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: TID 26798: Transaction not completed
2018-08-21 16:02:36.567 [DEBUG] [org.openhab.binding.zwave.internal.protocol.serialmessage.SendDataMessageClass] - NODE 30: SendData Request. CallBack ID = 139, Status = Transmission complete and ACK received(0)
2018-08-21 16:02:36.567 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: resetResendCount initComplete=true isDead=false
2018-08-21 16:02:36.567 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: TID 26798: Transaction not completed
2018-08-21 16:02:36.577 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Application Command Request (ALIVE:DONE)
2018-08-21 16:02:36.577 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: resetResendCount initComplete=true isDead=false
2018-08-21 16:02:36.577 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: Incoming command class COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2018-08-21 16:02:36.577 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 30: SECURITY not supported
2018-08-21 16:02:36.577 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveCommandClass] - NODE 30: Received COMMAND_CLASS_SWITCH_MULTILEVEL V1 SWITCH_MULTILEVEL_REPORT
2018-08-21 16:02:36.577 [DEBUG] [org.openhab.binding.zwave.internal.protocol.commandclass.ZWaveMultiLevelSwitchCommandClass] - NODE 30: Switch Multi Level report, value = 58
2018-08-21 16:02:36.577 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2018-08-21 16:02:36.577 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SWITCH_MULTILEVEL, value = 58
2018-08-21 16:02:36.577 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Updating channel state zwave:device:07cb40a2:node30:switch_dimmer to 58 [PercentType]
2018-08-21 16:02:36.580 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Commands processed 1.
2018-08-21 16:02:36.580 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@19d53a18.
2018-08-21 16:02:36.580 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@19d53a18.
2018-08-21 16:02:36.580 [DEBUG] [org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager] - NODE 30: notifyTransactionResponse TID:26798 DONE
2018-08-21 16:02:36.581 [DEBUG] [org.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 30: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

EDIT: The binding seems to be doing everything right, and the device is just sending the wrong value. By popping the air gap (essentially power cycling the device) the dimmer began sending the correct values! In case anyone sees something similar, a power cycle may resolve it. Hopefully, this is not just a temporary fix. This was occurring with Leviton VRMX and DZMX1 dimmers.

How did you get this device working? Mine shows ā€œunknownā€ device.

Thanks

Check the database if you have a different version which then may need to be added:

https://www.cd-jackson.com/index.php/zwave/zwave-device-database/zwave-device-list/devicesummary/664

At binding startup, I can see these errors:

2018-08-22 12:02:28.020 [ERROR] [serialmessage.SetSucNodeMessageClass] - NODE 0: SetSucNodeID command failed.
2018-08-22 12:02:28.362 [ERROR] [serialmessage.SetSucNodeMessageClass] - NODE 0: SetSucNodeID command failed.
2018-08-22 12:02:28.654 [ERROR] [serialmessage.SetSucNodeMessageClass] - NODE 0: SetSucNodeID command failed.

Is it important ?