Z-Wave security testing ZW100 and MT02648

[maetz (Matthias)]

Hello,

because the Z-Wave security topic is so long i made a seperate one, maybe this one can be closed quickly.

I am testing the Z-Wave binding from here:

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

The latest version of the development binding dated 8th Sep 2018 is here. Toward the end of last year I spent some time doing some initial refactoring of the ZWave binding in OH2. This focussed on rewriting the way transactions work as this is an enabler for other areas of the code. At the same time I also restructured the different layers of the binding to make things cleaner, and done some changes to support a system of autocoding the command classes directly from the Z-Wave standard which s…

The first test with a AEON Labs ZW100 MultiSensor 6 (because they are not installed fix and are simple to trigger, i know there is no real need to use security for this devices), worked without any problems. I switched them back to normal inclusion and went on to the Devolo MT02648 Door/Window Contact. Inclusion seems to work and Habmin is showing that everything is okay:

But the device never triggers, the log shows repeatedly (every minute or so (i tried to wake up the device via the little push button)):

09-Sep-2017 11:37:44.911 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start
09-Sep-2017 11:37:44.912 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 46: listening == false, frequentlyListening == false, awake == false
09-Sep-2017 11:37:44.913 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 46: Node not awake!
09-Sep-2017 11:37:44.913 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: listening == false, frequentlyListening == false, awake == false
09-Sep-2017 11:37:44.915 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Node not awake!
09-Sep-2017 11:37:44.918 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: listening == false, frequentlyListening == false, awake == false
09-Sep-2017 11:37:44.919 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Node not awake!
09-Sep-2017 11:37:44.920 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: listening == false, frequentlyListening == false, awake == false
09-Sep-2017 11:37:44.920 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Node not awake!
09-Sep-2017 11:37:44.921 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction from controllerQueue

If i trigger the sensor (open and close the door) also something like this comes in:

09-Sep-2017 11:41:32.226 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction null
09-Sep-2017 11:41:32.227 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Application Command Request (ALIVE:DONE)
09-Sep-2017 11:41:32.228 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: resetResendCount initComplete=true isDead=false
09-Sep-2017 11:41:32.228 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
09-Sep-2017 11:41:32.229 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: SECURITY check internal
09-Sep-2017 11:41:32.230 [DEBUG] [e.internal.protocol.commandclass.ZWaveCommandClass] - NODE 49: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
09-Sep-2017 11:41:32.230 [DEBUG] [.protocol.commandclass.impl.CommandClassSecurityV1] - Creating command message SECURITY_NONCE_REPORT version 1
09-Sep-2017 11:41:32.231 [DEBUG] [saction.ZWaveCommandClassTransactionPayloadBuilder] - At build null
09-Sep-2017 11:41:32.232 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Added to secure queue - size 1
09-Sep-2017 11:41:32.232 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Commands processed 1.
09-Sep-2017 11:41:32.234 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1808de4.
09-Sep-2017 11:41:32.235 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
09-Sep-2017 11:41:32.236 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0


09-Sep-2017 11:41:32.343 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction null
09-Sep-2017 11:41:32.344 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Application Command Request (ALIVE:DONE)
09-Sep-2017 11:41:32.344 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: resetResendCount initComplete=true isDead=false
09-Sep-2017 11:41:32.345 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: Decapsulating COMMAND_CLASS_SECURITY
09-Sep-2017 11:41:32.347 [DEBUG] [al.protocol.commandclass.ZWaveSecurityCommandClass] - NODE 49: SECURITY_RXD 8F 01 04 03 80 03 64 04 30 03 FF 0A 05 31 05 03 01 06 06 31 05 01 0A 00 46 
09-Sep-2017 11:41:32.347 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: Incoming command class COMMAND_CLASS_MULTI_CMD, endpoint 0
09-Sep-2017 11:41:32.348 [DEBUG] [e.internal.protocol.commandclass.ZWaveCommandClass] - NODE 49: Received COMMAND_CLASS_MULTI_CMD V1 unknown command 1
09-Sep-2017 11:41:32.348 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Commands processed 1.
09-Sep-2017 11:41:32.349 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@587193.
09-Sep-2017 11:41:32.349 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0



09-Sep-2017 11:41:36.134 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction null
09-Sep-2017 11:41:36.135 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Application Command Request (ALIVE:DONE)
09-Sep-2017 11:41:36.138 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: resetResendCount initComplete=true isDead=false
09-Sep-2017 11:41:36.139 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
09-Sep-2017 11:41:36.140 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: SECURITY check internal
09-Sep-2017 11:41:36.141 [DEBUG] [e.internal.protocol.commandclass.ZWaveCommandClass] - NODE 49: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
09-Sep-2017 11:41:36.142 [DEBUG] [.protocol.commandclass.impl.CommandClassSecurityV1] - Creating command message SECURITY_NONCE_REPORT version 1
09-Sep-2017 11:41:36.143 [DEBUG] [saction.ZWaveCommandClassTransactionPayloadBuilder] - At build null
09-Sep-2017 11:41:36.144 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Added to secure queue - size 1
09-Sep-2017 11:41:36.145 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Commands processed 1.
09-Sep-2017 11:41:36.145 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1e9cfa0.
09-Sep-2017 11:41:36.146 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0


09-Sep-2017 17:19:58.924 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction null
09-Sep-2017 17:19:58.924 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Application Command Request (ALIVE:DONE)
09-Sep-2017 17:19:58.925 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: resetResendCount initComplete=true isDead=false
09-Sep-2017 17:19:58.926 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
09-Sep-2017 17:19:58.926 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: SECURITY check internal
09-Sep-2017 17:19:58.926 [DEBUG] [e.internal.protocol.commandclass.ZWaveCommandClass] - NODE 49: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
09-Sep-2017 17:19:58.927 [DEBUG] [.protocol.commandclass.impl.CommandClassSecurityV1] - Creating command message SECURITY_NONCE_REPORT version 1
09-Sep-2017 17:19:58.927 [DEBUG] [saction.ZWaveCommandClassTransactionPayloadBuilder] - At build null
09-Sep-2017 17:19:58.928 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Added to secure queue - size 1
09-Sep-2017 17:19:58.928 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Commands processed 1.
09-Sep-2017 17:19:58.929 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@44de12.
09-Sep-2017 17:19:58.929 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0

The manual says:

So the question is: does anyone have experience with this? Do i have to change something in the configuration parameters (some bits maybe in the costumer functions to get the sensor binary report Type: 0x0C, Value: 0x00 whatever this means ???)

If there is not enough information i could attach more from the logs, if this is simply just not meant to work at the moment it is also okay

Matthias

[chris (Chris Jackson)]

It should work but it looks like there might be an encap issue - I’ll take a look tonight.

[chris (Chris Jackson)]

There was a bug processing multiple encapsulations. Please try the latest version and see if it’s any better.

[maetz (Matthias)]

Hi Chris,

first of all thank you for putting so much effort into this project and sharing it!
It is working very fine now

Almost instant notification on my phone if the door gets opened

I have no idea if this is of interest for you, i attached a part of the log, but as said, everything is fine.

12-Sep-2017 18:40:35.695 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: listening == false, frequentlyListening == false, awake == false
12-Sep-2017 18:40:35.695 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Node not awake!
12-Sep-2017 18:40:35.695 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction from controllerQueue
12-Sep-2017 18:40:35.696 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage nothing
12-Sep-2017 18:40:35.696 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - STOP transaction timer
12-Sep-2017 18:40:35.697 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Response SENT 6
12-Sep-2017 18:40:35.700 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], dest=49, callback=0, payload=00 31 2D 98 81 15 0D B1 8D 23 8D C5 D5 C7 35 B6 FD FB F9 CA 6D 41 C7 BD 1D 03 E5 D3 40 91 B9 C9 B5 6F 19 D0 C7 BE 9E 5A 1D 18 03 B3 04 74 6A 6A 
12-Sep-2017 18:40:35.702 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage past lock Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], dest=49, callback=0, payload=00 31 2D 98 81 15 0D B1 8D 23 8D C5 D5 C7 35 B6 FD FB F9 CA 6D 41 C7 BD 1D 03 E5 D3 40 91 B9 C9 B5 6F 19 D0 C7 BE 9E 5A 1D 18 03 B3 04 74 6A 6A 
12-Sep-2017 18:40:35.704 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], dest=49, callback=0, payload=00 31 2D 98 81 15 0D B1 8D 23 8D C5 D5 C7 35 B6 FD FB F9 CA 6D 41 C7 BD 1D 03 E5 D3 40 91 B9 C9 B5 6F 19 D0 C7 BE 9E 5A 1D 18 03 B3 04 74 6A 6A 
12-Sep-2017 18:40:35.704 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction null
12-Sep-2017 18:40:35.705 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Application Command Request (ALIVE:REQUEST_NIF)
12-Sep-2017 18:40:35.705 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: Decapsulating COMMAND_CLASS_SECURITY
12-Sep-2017 18:40:35.709 [DEBUG] [al.protocol.commandclass.ZWaveSecurityCommandClass] - NODE 49: SECURITY_RXD 8F 01 04 03 80 03 64 04 30 03 00 0A 05 31 05 03 01 04 06 31 05 01 0A 00 44 
12-Sep-2017 18:40:35.709 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: Decapsulating COMMAND_CLASS_MULTI_CMD
12-Sep-2017 18:40:35.710 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: Incoming command class COMMAND_CLASS_BATTERY, endpoint 0
12-Sep-2017 18:40:35.710 [DEBUG] [e.internal.protocol.commandclass.ZWaveCommandClass] - NODE 49: Received COMMAND_CLASS_BATTERY V1 BATTERY_REPORT
12-Sep-2017 18:40:35.711 [DEBUG] [nal.protocol.commandclass.ZWaveBatteryCommandClass] - NODE 49: Battery report value = 100
12-Sep-2017 18:40:35.711 [DEBUG] [ab.binding.zwave.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
12-Sep-2017 18:40:35.711 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 49: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
12-Sep-2017 18:40:35.712 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 49: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_BATTERY, value = 100
12-Sep-2017 18:40:35.712 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 49: Updating channel state zwave:device:MaspZContr:node49:battery-level to 100 [DecimalType]
12-Sep-2017 18:40:35.715 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: Incoming command class COMMAND_CLASS_SENSOR_BINARY, endpoint 0
12-Sep-2017 18:40:35.715 [DEBUG] [e.internal.protocol.commandclass.ZWaveCommandClass] - NODE 49: Received COMMAND_CLASS_SENSOR_BINARY V2 SENSOR_BINARY_REPORT
12-Sep-2017 18:40:35.716 [DEBUG] [rotocol.commandclass.ZWaveBinarySensorCommandClass] - Processing Sensor Type 10
12-Sep-2017 18:40:35.716 [DEBUG] [rotocol.commandclass.ZWaveBinarySensorCommandClass] - Sensor Type is DOORWINDOW
12-Sep-2017 18:40:35.716 [DEBUG] [rotocol.commandclass.ZWaveBinarySensorCommandClass] - NODE 49: Sensor Binary report, type=Door/Window, value=0
12-Sep-2017 18:40:35.716 [DEBUG] [ab.binding.zwave.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveBinarySensorValueEvent
12-Sep-2017 18:40:35.717 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 49: Got an event from Z-Wave network: ZWaveBinarySensorValueEvent
12-Sep-2017 18:40:35.717 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 49: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SENSOR_BINARY, value = 0
12-Sep-2017 18:40:35.718 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 49: Updating channel state zwave:device:MaspZContr:node49:sensor_door to CLOSED [OpenClosedType]
12-Sep-2017 18:40:35.719 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
12-Sep-2017 18:40:35.720 [DEBUG] [e.internal.protocol.commandclass.ZWaveCommandClass] - NODE 49: Received COMMAND_CLASS_SENSOR_MULTILEVEL V5 SENSOR_MULTILEVEL_REPORT
12-Sep-2017 18:40:35.723 [DEBUG] [col.commandclass.ZWaveMultiLevelSensorCommandClass] - NODE 49: Sensor Type = Luminance(3), Scale = 0
12-Sep-2017 18:40:35.724 [DEBUG] [col.commandclass.ZWaveMultiLevelSensorCommandClass] - NODE 49: Sensor Value = 4
12-Sep-2017 18:40:35.725 [DEBUG] [ab.binding.zwave.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveMultiLevelSensorValueEvent
12-Sep-2017 18:40:35.725 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 49: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent
12-Sep-2017 18:40:35.725 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 49: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SENSOR_MULTILEVEL, value = 4
12-Sep-2017 18:40:35.726 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 49: Updating channel state zwave:device:MaspZContr:node49:sensor_luminance to 4 [DecimalType]
12-Sep-2017 18:40:35.727 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 49: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
12-Sep-2017 18:40:35.727 [DEBUG] [e.internal.protocol.commandclass.ZWaveCommandClass] - NODE 49: Received COMMAND_CLASS_SENSOR_MULTILEVEL V5 SENSOR_MULTILEVEL_REPORT
12-Sep-2017 18:40:35.728 [DEBUG] [col.commandclass.ZWaveMultiLevelSensorCommandClass] - NODE 49: Sensor Type = Temperature(1), Scale = 1
12-Sep-2017 18:40:35.728 [DEBUG] [col.commandclass.ZWaveMultiLevelSensorCommandClass] - NODE 49: Sensor Value = 68
12-Sep-2017 18:40:35.729 [DEBUG] [ab.binding.zwave.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveMultiLevelSensorValueEvent
12-Sep-2017 18:40:35.729 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 49: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent
12-Sep-2017 18:40:35.729 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 49: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SENSOR_MULTILEVEL, value = 68
12-Sep-2017 18:40:35.729 [DEBUG] [.internal.converter.ZWaveMultiLevelSensorConverter] - NODE 49: Sensor is reporting scale 1, requiring conversion to 0. Value is now 68.
12-Sep-2017 18:40:35.731 [DEBUG] [wave.internal.converter.ZWaveCommandClassConverter] - Converted temperature from 68F to 20.0C
12-Sep-2017 18:40:35.731 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 49: Updating channel state zwave:device:MaspZContr:node49:sensor_temperature to 20.0 [DecimalType]
12-Sep-2017 18:40:35.732 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Commands processed 4.
12-Sep-2017 18:40:35.733 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@da95cd.
12-Sep-2017 18:40:35.733 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
12-Sep-2017 18:40:35.733 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
12-Sep-2017 18:40:35.734 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@c76e42.
12-Sep-2017 18:40:35.734 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
12-Sep-2017 18:40:35.734 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
12-Sep-2017 18:40:35.734 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@f3574e.
12-Sep-2017 18:40:35.734 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
12-Sep-2017 18:40:35.734 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
12-Sep-2017 18:40:35.734 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 49: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@fa47b3.
12-Sep-2017 18:40:35.735 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
12-Sep-2017 18:40:35.735 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
12-Sep-2017 18:40:35.735 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
12-Sep-2017 18:40:35.735 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start