As I did not get any reaction to my previous post, I deciced to start from scratch.
So I excluded all zwave devices. Then started with just one WALLC-S Wall Controller (a battery powered device)…
That’s where my struggle started, I included the WALLC-S , it was added to the z-wave network as node3.
In OpenHab2 a thing was added Node3, “unknown device”. I woke up node 3 a couple of times manually (and saw in the zwave log that it was sending an information frame) but OpenHab kept saying Node3 " unknown device.
At a certain point the zwave log showed that the device was actually recognised but still Node3: unknown device…
And as long as a device is unrecognised I have no idea how to create items for that device (see previous post)…
I also cannot set the associations and change button press behaviour to selecting a scene.
After 2 days of unknown device I decided to remove Thing Node3… Openhab then reported a new thing:
Node 3: WALLC-S Wall Controller…
So after that correct configuration items show up, so I tried to set the associations and change other parameters… And that is where I am stuck… for more than a week now. I can wake-up the device by hand as often as I want, parameters are not getting across.And because of that, I can’t switch to using scenes and I can’t associate any groups to Node1…
So the controller does not see any commands from this switch…
What can I do to get past this point ??
In the zwave.log the wake-up always seems to end in ABORT:
2016-09-14 22:55:07.874 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling deferred until initialisation complete
2016-09-14 23:18:03.375 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 1E 00 49 84 03 18 04 18 01 5E 70 85 2D 8E 80 84 8F 5A 59 5B 73 86 72 EF 20 5B 26 27 2B 60 A8
2016-09-14 23:18:03.379 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-14 23:18:03.380 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 1E 00 49 84 03 18 04 18 01 5E 70 85 2D 8E 80 84 8F 5A 59 5B 73 86 72 EF 20 5B 26 27 2B 60 A8
2016-09-14 23:18:03.380 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 1E 00 49 84 03 18 04 18 01 5E 70 85 2D 8E 80 84 8F 5A 59 5B 73 86 72 EF 20 5B 26 27 2B 60 A8
2016-09-14 23:18:03.380 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, callback=0, payload=84 03 18 04 18 01 5E
70 85 2D 8E 80 84 8F 5A 59 5B 73 86 72 EF 20 5B 26 27 2B 60
2016-09-14 23:18:03.381 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 3: Application update request. Node information received.
2016-09-14 23:18:03.381 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Is awake with 1 messages in the wake-up queue.
2016-09-14 23:18:03.381 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent
2016-09-14 23:18:03.381 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveWakeUpEvent
2016-09-14 23:18:03.382 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Wakeup during initialisation.
2016-09-14 23:18:03.382 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - DETAILS: queue length(1), free to send(false)
2016-09-14 23:18:03.382 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - queued packet. Queue length is 1
2016-09-14 23:18:03.383 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2016-09-14 23:18:03.383 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2016-09-14 23:18:03.383 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2016-09-14 23:18:03.383 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 08 00 13 03 01 00 25 06 C5
2016-09-14 23:18:03.383 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Message has Ack Pending: Message: class=SendData[0x13], type=Request[0x00], priority=Immediate
, dest=3, callback=6, payload=03 01 00
2016-09-14 23:18:03.384 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 3: Sending REQUEST Message = 01 08 00 13 03 01 00 25 06 C5
2016-09-14 23:18:03.391 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 03 02 84 07 71
2016-09-14 23:18:03.393 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-14 23:18:03.393 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Protocol error (CAN), resending
2016-09-14 23:18:03.393 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 08 00 04 00 03 02 84 07 71
2016-09-14 23:18:03.393 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 08 00 04 00 03 02 84 07 71
2016-09-14 23:18:03.394 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 03 02 84
07
2016-09-14 23:18:03.394 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 3: Application Command Request (ALIVE:DETAILS)
2016-09-14 23:18:03.394 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 3: Incoming command class WAKE_UP
2016-09-14 23:18:03.394 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Received Wake Up Request
2016-09-14 23:18:03.394 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Received WAKE_UP_NOTIFICATION
2016-09-14 23:18:03.394 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Is awake with 0 messages in the wake-up queue.
2016-09-14 23:18:03.394 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent
2016-09-14 23:18:03.394 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveWakeUpEvent
2016-09-14 23:18:03.395 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Wakeup during initialisation.
2016-09-14 23:18:03.395 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - DETAILS: queue length(1), free to send(false)
2016-09-14 23:18:03.395 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - queued packet. Queue length is 1
2016-09-14 23:18:03.395 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 2. Queue={}
2016-09-14 23:18:03.396 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Message has Ack Pending: Message: class=SendData[0x13], type=Request[0x00], priority=Immediate, dest=3, callback=7, payload=03 01 00
2016-09-14 23:18:03.414 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 03 02 84 07 71
2016-09-14 23:18:03.417 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-14 23:18:03.417 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 08 00 04 00 03 02 84 07 71
2016-09-14 23:18:03.417 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 08 00 04 00 03 02 84 07 71
2016-09-14 23:18:03.418 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 03 02 84 07
2016-09-14 23:18:03.418 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 3: Application Command Request (ALIVE:DETAILS)
2016-09-14 23:18:03.418 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 3: Incoming command class WAKE_UP
2016-09-14 23:18:03.419 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Received Wake Up Request
2016-09-14 23:18:03.419 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Received WAKE_UP_NOTIFICATION
2016-09-14 23:18:03.419 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Is awake with 0 messages in the wake-up queue.
2016-09-14 23:18:03.419 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent
2016-09-14 23:18:03.419 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveWakeUpEvent
2016-09-14 23:18:03.420 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Wakeup during initialisation.
2016-09-14 23:18:03.420 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - DETAILS: queue length(1), free to send(false)
2016-09-14 23:18:03.420 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer: loop - DETAILS try 2: stageAdvanced(false)
2016-09-14 23:18:03.421 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer: received RequestNodeInfo
2016-09-14 23:18:03.421 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - advancing to INCLUSION_START
2016-09-14 23:18:03.421 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent
2016-09-14 23:18:03.421 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2016-09-14 23:18:03.422 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer: loop - INCLUSION_START try 0: stageAdvanced(true)
2016-09-14 23:18:03.422 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer: Unknown node state INCLUSION_START encountered.
2016-09-14 23:18:03.422 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - advancing to IDENTIFY_NODE
2016-09-14 23:18:03.422 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent
2016-09-14 23:18:03.423 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2016-09-14 23:18:03.423 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer: loop - IDENTIFY_NODE try 0: stageAdvanced(true)
2016-09-14 23:18:03.423 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer: PROTOINFO - send IdentifyNode
2016-09-14 23:18:03.423 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - queued packet. Queue length is 1
2016-09-14 23:18:03.424 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3. Queue={}
2016-09-14 23:18:03.424 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Message has Ack Pending: Message: class=SendData[0x13], type=Request[0x00], priority=Immediate, dest=3, callback=7, payload=03 01 00
2016-09-14 23:18:03.480 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 03 03 80 03 40 31
2016-09-14 23:18:03.481 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-14 23:18:03.482 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 04 00 03 03 80 03 40 31
2016-09-14 23:18:03.482 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 04 00 03 03 80 03 40 31
2016-09-14 23:18:03.482 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 03 03 80 03 40
2016-09-14 23:18:03.483 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 3: Application Command Request (ALIVE:IDENTIFY_NODE)
2016-09-14 23:18:03.483 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 3: Incoming command class BATTERY
2016-09-14 23:18:03.483 [DEBUG] [ommandclass.ZWaveBatteryCommandClass] - NODE 3: Received Battery Request
2016-09-14 23:18:03.483 [DEBUG] [ommandclass.ZWaveBatteryCommandClass] - NODE 3: Battery report value = 64
2016-09-14 23:18:03.484 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
2016-09-14 23:18:03.484 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2016-09-14 23:18:03.484 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint = 0, command class = BATTERY, value = 64
2016-09-14 23:18:03.484 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:42ea3240:node3:battery-level to 64 [DecimalType]
2016-09-14 23:18:03.485 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Message has Ack Pending: Message: class=SendData[0x13], type=Request[0x00], priority=Immediate, dest=3, callback=7, payload=03 01 00
2016-09-14 23:18:04.424 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: No more messages, go back to sleep
2016-09-14 23:18:04.425 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Creating new message for application command WAKE_UP_NO_MORE_INFORMATION
2016-09-14 23:18:04.425 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 4. Queue={}
2016-09-14 23:18:08.391 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA
2016-09-14 23:18:08.391 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 3: Sending ABORT Message = 01 03 00 16 EA
2016-09-14 23:18:08.391 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA
2016-09-14 23:18:08.392 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA
2016-09-14 23:18:08.836 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 3: Timeout while sending message. Requeueing - 0 attempts left!
2016-09-14 23:18:08.837 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Is sleeping
2016-09-14 23:18:08.837 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Putting message SendData in wakeup queue.
2016-09-14 23:18:08.837 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3
2016-09-14 23:18:08.837 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Message already on the wake-up queue. Removing original.
2016-09-14 23:18:08.837 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Putting message SendData in wakeup queue.
2016-09-14 23:18:08.838 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 2
2016-09-14 23:18:08.838 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 00 41 03 B9
2016-09-14 23:18:08.838 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 04 00 41 03 B9
2016-09-14 23:18:08.855 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 01 41 53 9C 01 04 18 01 65
2016-09-14 23:18:08.857 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-14 23:18:08.857 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 01 41 53 9C 01 04 18 01 65
2016-09-14 23:18:08.858 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 01 41 53 9C 01 04 18 01 65
2016-09-14 23:18:08.858 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=IdentifyNode[0x41], type=Response[0x01], priority=High, dest=255, callback=0, payload=53 9C 01 04 18 01
2016-09-14 23:18:08.859 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 3: ProtocolInfo
2016-09-14 23:18:08.859 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 3: Listening = false
2016-09-14 23:18:08.859 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 3: Routing = true
2016-09-14 23:18:08.859 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 3: Beaming = true
2016-09-14 23:18:08.859 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 3: Version = 4
2016-09-14 23:18:08.860 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 3: FLIRS = false
2016-09-14 23:18:08.860 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 3: Security = false
2016-09-14 23:18:08.860 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 3: Max Baud = 40000
2016-09-14 23:18:08.860 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 3: Basic = Routing Slave
2016-09-14 23:18:08.860 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 3: Generic = Remote Switch 2
2016-09-14 23:18:08.860 [DEBUG] [rialmessage.IdentifyNodeMessageClass] - NODE 3: Specific = Multilevel Remote Switch
2016-09-14 23:18:08.861 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Creating new instance of command class NO_OPERATION
2016-09-14 23:18:08.861 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Command class NO_OPERATION, endpoint null created
2016-09-14 23:18:08.861 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Version = 1, version set. Enabling extra functionality.
2016-09-14 23:18:08.861 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Creating new instance of command class BASIC
2016-09-14 23:18:08.861 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Command class BASIC, endpoint null created
2016-09-14 23:18:08.862 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=IdentifyNode[0x41], type=Request[0x00], priority=High, dest=255, callback=0, payload=03
2016-09-14 23:18:08.862 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=IdentifyNode[0x41], type=Response[0x01], priority=High, dest=255, callback=0, payload=53 9C 01 04 18 01
2016-09-14 23:18:08.862 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=IdentifyNode, callback id=0, expected=IdentifyNode, cancelled=false transaction complete!
2016-09-14 23:18:08.862 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2016-09-14 23:18:08.862 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - IDENTIFY_NODE: Transaction complete (IdentifyNode:Request) success(true)
2016-09-14 23:18:08.863 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - checking initialisation queue. Queue size 1.
2016-09-14 23:18:08.863 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - message removed from queue. Queue size 0.
2016-09-14 23:18:08.863 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - IDENTIFY_NODE: queue length(0), free to send(true)
2016-09-14 23:18:08.863 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer: loop - IDENTIFY_NODE try 1: stageAdvanced(false)
2016-09-14 23:18:08.863 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - advancing to MANUFACTURER
2016-09-14 23:18:08.863 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent
2016-09-14 23:18:08.864 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2016-09-14 23:18:08.864 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer: loop - MANUFACTURER try 0: stageAdvanced(true)
2016-09-14 23:18:08.864 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer: MANUFACTURER - send ManufacturerSpecific
2016-09-14 23:18:08.865 [DEBUG] [WaveManufacturerSpecificCommandClass] - NODE 3: Creating new message for command MANUFACTURER_SPECIFIC_GET
2016-09-14 23:18:08.865 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - queued packet. Queue length is 1
2016-09-14 23:18:08.865 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Putting message SendData in wakeup queue.
2016-09-14 23:18:08.865 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Putting message SendData in wakeup queue.
2016-09-14 23:18:08.866 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Response processed after 25ms/131ms.
2016-09-14 23:18:08.866 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1
2016-09-14 23:18:08.866 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Message already on the wake-up queue. Removing original.
2016-09-14 23:18:08.866 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Putting message SendData in wakeup queue.
2016-09-14 23:18:08.867 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2016-09-14 23:18:08.867 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 3: Putting message SendData in wakeup queue.