{"action":"created","issue":{"url":"https://api.github.com/repos/openhab/openhab2-addons/issues/703","repository_url":"https://api.github.com/repos/openhab/openhab2-addons","labels_url":"https://api.github.com/repos/openhab/openhab2-addons/issues/703/labels{/name}","comments_url":"https://api.github.com/repos/openhab/openhab2-addons/issues/703/comments","events_url":"https://api.github.com/repos/openhab/openhab2-addons/issues/703/events","html_url":"https://github.com/openhab/openhab2-addons/issues/703","id":138469814,"number":703,"title":"Nexia Doorbell Sensor not working (zwave)","user":{"login":"feens","id":3578317,"avatar_url":"https://avatars.githubusercontent.com/u/3578317?v=3","gravatar_id":"","url":"https://api.github.com/users/feens","html_url":"https://github.com/feens","followers_url":"https://api.github.com/users/feens/followers","following_url":"https://api.github.com/users/feens/following{/other_user}","gists_url":"https://api.github.com/users/feens/gists{/gist_id}","starred_url":"https://api.github.com/users/feens/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/feens/subscriptions","organizations_url":"https://api.github.com/users/feens/orgs","repos_url":"https://api.github.com/users/feens/repos","events_url":"https://api.github.com/users/feens/events{/privacy}","received_events_url":"https://api.github.com/users/feens/received_events","type":"User","site_admin":false},"labels":[],"state":"closed","locked":false,"assignee":null,"milestone":null,"comments":27,"created_at":"2016-03-04T12:58:15Z","updated_at":"2016-04-12T16:29:32Z","closed_at":"2016-03-06T14:35:04Z","body":"Filing this as an issue as requested.  I actually did have some progress in that OH was finally able to add the node as a thing, but it doesn't have a channel and still no xml.  I've captured as much of the logs as I can, so I'll drop them all here (is there a better way to paste log content?).  There's 2 sets of logs there, both are from the first time I ring my doorbell after OH has been initialized.\r\n\r\n`21:34:19.812 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (INITIALIZING:PING)\r\n21:34:19.813 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Node is ALIVE. Init stage is PING:{}.\r\n21:34:19.815 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveNodeStatusEvent\r\n21:34:19.816 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Node Status event - Node is ALIVE\r\n21:34:19.818 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node Status event during initialisation - Node is ALIVE\r\n21:34:19.819 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - PING: queue length(0), free to send(true)\r\n21:34:19.821 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - PING try 1: stageAdvanced(false)\r\n21:34:19.822 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: PING - send NoOperation\r\n21:34:19.824 [DEBUG] [ndclass.ZWaveNoOperationCommandClass] - NODE 14: Creating new message for command No Operation\r\n21:34:19.826 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n21:34:19.827 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 1\r\n21:34:19.827 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0\r\n21:34:19.829 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 14: Node Status event - Node is ALIVE\r\n21:34:19.830 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class ALARM\r\n21:34:19.830 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Command class ALARM not found, trying to add it.\r\n21:34:19.831 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ALARM\r\n21:34:19.831 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 08 00 13 0E 01 00 25 69 A7 \r\n21:34:19.832 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ALARM, endpoint null created\r\n21:34:19.833 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Adding command class ALARM\r\n21:34:19.833 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 08 00 13 0E 01 00 25 69 A7 \r\n21:34:19.834 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class ALARM to the list of supported command classes.\r\n21:34:19.834 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Received Alarm Request\r\n21:34:19.835 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Process Alarm Report, V0, length 13\r\n21:34:19.836 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Alarm report - 0 = 0, source=0, event=1, status=255\r\n21:34:19.838 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Alarm Type = General (0)\r\n21:34:19.839 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveAlarmValueEvent\r\n21:34:19.840 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: CC event during initialisation stage IDLE\r\n21:34:19.840 [DEBUG] [ssage.ApplicationCommandMessageClass] - Transaction not completed: node address inconsistent.\r\n21:34:19.843 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n21:34:19.846 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:19.847 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n21:34:19.848 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n21:34:19.849 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n21:34:19.850 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n21:34:23.191 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 69 00 01 4F CC \r\n21:34:23.195 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:23.197 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 69 00 01 4F 00 00 C2 \r\n21:34:23.199 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 69 00 01 4F 00 00 C2 \r\n21:34:23.200 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 69 00 01 4F \r\n21:34:23.201 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 105, Status = Transmission complete and ACK received(0)\r\n21:34:23.203 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 01 00 \r\n21:34:23.204 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 69 00 01 4F \r\n21:34:23.205 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=SendData, cancelled=false\r\n21:34:23.205 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n21:34:23.206 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n21:34:23.207 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - DETAILS: Transaction complete (SendData:Request) success(true)\r\n21:34:23.207 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 1.\r\n21:34:23.208 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 0.\r\n21:34:23.209 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - DETAILS: queue length(0), free to send(true)\r\n21:34:23.209 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - DETAILS try 2: stageAdvanced(false)\r\n21:34:23.210 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DETAILS - send RequestNodeInfo\r\n21:34:23.212 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n21:34:23.212 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 1\r\n21:34:23.213 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Response processed after 3379ms/3379ms.\r\n21:34:23.214 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0\r\n21:34:23.216 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 00 60 0E 95 \r\n21:34:23.217 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 04 00 60 0E 95 \r\n21:34:23.227 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 60 01 9B \r\n21:34:23.229 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:23.231 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 60 01 9B \r\n21:34:23.232 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 60 01 9B \r\n21:34:23.233 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = RequestNodeInfo (0x60), type = Response (0x01), payload = 01 \r\n21:34:23.234 [DEBUG] [lmessage.RequestNodeInfoMessageClass] - Request node info successfully placed on stack.\r\n21:34:23.235 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = RequestNodeInfo (0x60), type = Request (0x00), payload = 0E \r\n21:34:23.236 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = RequestNodeInfo (0x60), type = Response (0x01), payload = 01 \r\n21:34:23.237 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=RequestNodeInfo, expected=ApplicationUpdate, cancelled=false\r\n21:34:23.281 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 10 0E 0A 71 05 00 00 00 FF 08 00 00 00 7C \r\n21:34:23.285 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:23.290 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 10 00 04 10 0E 0A 71 05 00 00 00 FF 08 00 00 00 7C \r\n21:34:23.294 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 10 00 04 10 0E 0A 71 05 00 00 00 FF 08 00 00 00 7C \r\n21:34:23.299 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 10 0E 0A 71 05 00 00 00 FF 08 00 00 00 \r\n21:34:23.302 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:DETAILS)\r\n21:34:23.305 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class ALARM\r\n21:34:23.306 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Received Alarm Request\r\n21:34:23.308 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Process Alarm Report, V0, length 13\r\n21:34:23.310 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Alarm report - 0 = 0, source=0, event=0, status=255\r\n21:34:23.311 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Alarm Type = General (0)\r\n21:34:23.312 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveAlarmValueEvent\r\n21:34:23.313 [DEBUG] [ssage.ApplicationCommandMessageClass] - Transaction not completed: node address inconsistent.\r\n21:34:23.529 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:23.534 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:23.537 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:23.540 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:23.543 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationUpdate (0x49), type = Request (0x00), payload = 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A \r\n21:34:23.544 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 14: Application update request. Node information received.\r\n21:34:23.546 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ZWAVE_PLUS_INFO\r\n21:34:23.548 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ZWAVE_PLUS_INFO, endpoint null created\r\n21:34:23.549 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class ZWAVE_PLUS_INFO to the list of supported command classes.\r\n21:34:23.550 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class VERSION\r\n21:34:23.552 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class VERSION, endpoint null created\r\n21:34:23.553 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class VERSION to the list of supported command classes.\r\n21:34:23.554 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class MANUFACTURER_SPECIFIC\r\n21:34:23.555 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class MANUFACTURER_SPECIFIC, endpoint null created\r\n21:34:23.556 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class MANUFACTURER_SPECIFIC to the list of supported command classes.\r\n21:34:23.558 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class DEVICE_RESET_LOCALLY\r\n21:34:23.560 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class DEVICE_RESET_LOCALLY, endpoint null created\r\n21:34:23.562 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class DEVICE_RESET_LOCALLY to the list of supported command classes.\r\n21:34:23.564 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class POWERLEVEL\r\n21:34:23.565 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class POWERLEVEL, endpoint null created\r\n21:34:23.567 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class POWERLEVEL to the list of supported command classes.\r\n21:34:23.568 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class BATTERY\r\n21:34:23.569 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class BATTERY, endpoint null created\r\n21:34:23.571 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class BATTERY to the list of supported command classes.\r\n21:34:23.572 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class CONFIGURATION\r\n21:34:23.573 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class CONFIGURATION, endpoint null created\r\n21:34:23.574 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class CONFIGURATION to the list of supported command classes.\r\n21:34:23.576 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ALARM\r\n21:34:23.577 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ALARM, endpoint null created\r\n21:34:23.578 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ASSOCIATION\r\n21:34:23.580 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ASSOCIATION, endpoint null created\r\n21:34:23.581 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class ASSOCIATION to the list of supported command classes.\r\n21:34:23.582 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Unsupported command class ASSOCIATION_GROUP_INFO\r\n21:34:23.583 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class WAKE_UP\r\n21:34:23.585 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class WAKE_UP, endpoint null created\r\n21:34:23.586 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class WAKE_UP to the list of supported command classes.\r\n21:34:23.588 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Unsupported command class FIRMWARE_UPDATE_MD\r\n21:34:23.590 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Is awake with 0 messages in the wake-up queue.\r\n21:34:23.591 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent\r\n21:34:23.593 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Wakeup during initialisation.\r\n21:34:23.594 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - DETAILS: queue length(1), free to send(false)\r\n21:34:23.595 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n21:34:23.596 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 1\r\n21:34:23.597 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = RequestNodeInfo (0x60), type = Request (0x00), payload = 0E \r\n21:34:23.599 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = ApplicationUpdate (0x49), type = Request (0x00), payload = 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A \r\n21:34:23.600 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationUpdate, expected=ApplicationUpdate, cancelled=false\r\n21:34:23.601 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n21:34:23.602 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n21:34:23.602 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - DETAILS: Transaction complete (RequestNodeInfo:Request) success(true)\r\n21:34:23.603 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 1.\r\n21:34:23.604 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 0.\r\n21:34:23.605 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - DETAILS: queue length(0), free to send(true)\r\n21:34:23.606 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - DETAILS try 3: stageAdvanced(false)\r\n21:34:23.607 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: received RequestNodeInfo\r\n21:34:23.608 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n21:34:23.609 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n21:34:23.610 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to MANUFACTURER\r\n21:34:23.611 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - MANUFACTURER try 0: stageAdvanced(true)\r\n21:34:23.612 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: MANUFACTURER - send ManufacturerSpecific\r\n21:34:23.614 [DEBUG] [WaveManufacturerSpecificCommandClass] - NODE 14: Creating new message for command MANUFACTURER_SPECIFIC_GET\r\n21:34:23.615 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n21:34:23.616 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 2\r\n21:34:23.617 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Response processed after 399ms/3379ms.\r\n21:34:23.618 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1\r\n21:34:23.624 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0E 02 72 04 25 6A D0 \r\n21:34:23.626 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 09 00 13 0E 02 72 04 25 6A D0 \r\n21:34:25.030 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 00 E9 \r\n21:34:25.032 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:25.035 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 00 E9 \r\n21:34:25.036 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 10 0E 0A 71 05 00 00 00 FF 08 00 00 00 7C \r\n21:34:25.038 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 00 E9 \r\n21:34:25.040 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 00 \r\n21:34:25.041 [ERROR] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data was not placed on stack due to error 0.\r\n21:34:25.042 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:25.044 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 10 00 04 10 0E 0A 71 05 00 00 00 FF 08 00 00 00 7C \r\n21:34:25.046 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 10 00 04 10 0E 0A 71 05 00 00 00 FF 08 00 00 00 7C \r\n21:34:25.048 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 10 0E 0A 71 05 00 00 00 FF 08 00 00 00 \r\n21:34:25.049 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:MANUFACTURER)\r\n21:34:25.050 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class ALARM\r\n21:34:25.051 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Received Alarm Request\r\n21:34:25.053 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Process Alarm Report, V0, length 13\r\n21:34:25.053 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Alarm report - 0 = 0, source=0, event=0, status=255\r\n21:34:25.054 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Alarm Type = General (0)\r\n21:34:25.056 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveAlarmValueEvent\r\n21:34:25.602 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:25.607 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:25.611 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:25.614 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:25.618 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationUpdate (0x49), type = Request (0x00), payload = 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A \r\n21:34:25.620 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 14: Application update request. Node information received.\r\n21:34:25.622 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ZWAVE_PLUS_INFO\r\n21:34:25.623 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ZWAVE_PLUS_INFO, endpoint null created\r\n21:34:25.625 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class VERSION\r\n21:34:25.632 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class VERSION, endpoint null created\r\n21:34:25.633 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class MANUFACTURER_SPECIFIC\r\n21:34:25.634 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class MANUFACTURER_SPECIFIC, endpoint null created\r\n21:34:25.636 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class DEVICE_RESET_LOCALLY\r\n21:34:25.637 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class DEVICE_RESET_LOCALLY, endpoint null created\r\n21:34:25.638 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class POWERLEVEL\r\n21:34:25.639 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class POWERLEVEL, endpoint null created\r\n21:34:25.641 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class BATTERY\r\n21:34:25.642 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class BATTERY, endpoint null created\r\n21:34:25.644 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class CONFIGURATION\r\n21:34:25.645 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class CONFIGURATION, endpoint null created\r\n21:34:25.647 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ALARM\r\n21:34:25.649 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ALARM, endpoint null created\r\n21:34:25.650 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ASSOCIATION\r\n21:34:25.652 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ASSOCIATION, endpoint null created\r\n21:34:25.653 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Unsupported command class ASSOCIATION_GROUP_INFO\r\n21:34:25.655 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class WAKE_UP\r\n21:34:25.657 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class WAKE_UP, endpoint null created\r\n21:34:25.659 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Unsupported command class FIRMWARE_UPDATE_MD\r\n21:34:25.661 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Is awake with 0 messages in the wake-up queue.\r\n21:34:25.662 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent\r\n21:34:25.663 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Wakeup during initialisation.\r\n21:34:25.665 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - MANUFACTURER: queue length(1), free to send(false)\r\n21:34:25.666 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n21:34:25.667 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 2\r\n21:34:26.668 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: No more messages, go back to sleep\r\n21:34:26.669 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Creating new message for application command WAKE_UP_NO_MORE_INFORMATION\r\n21:34:26.673 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 3\r\n21:34:27.113 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 10 0A 03 20 01 00 CA \r\n21:34:27.116 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:27.119 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 04 10 0A 03 20 01 00 CA \r\n21:34:27.122 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 04 10 0A 03 20 01 00 CA \r\n21:34:27.125 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 10 0A 03 20 01 00 \r\n21:34:27.127 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 10: Application Command Request (ALIVE:DONE)\r\n21:34:27.130 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 10: Incoming command class BASIC\r\n21:34:27.131 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 10: Received Basic Request\r\n21:34:27.131 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 10: Basic Set sent to the controller will be processed as Basic Report\r\n21:34:27.133 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 10: Basic report, value = 0x00\r\n21:34:27.134 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent\r\n21:34:27.135 [DEBUG] [ssage.ApplicationCommandMessageClass] - Transaction not completed: node address inconsistent.\r\n21:34:27.357 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:27.367 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:27.371 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:27.374 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:27.377 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationUpdate (0x49), type = Request (0x00), payload = 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A \r\n21:34:27.379 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 14: Application update request. Node information received.\r\n21:34:27.381 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ZWAVE_PLUS_INFO\r\n21:34:27.382 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ZWAVE_PLUS_INFO, endpoint null created\r\n21:34:27.384 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class VERSION\r\n21:34:27.385 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class VERSION, endpoint null created\r\n21:34:27.387 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class MANUFACTURER_SPECIFIC\r\n21:34:27.389 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class MANUFACTURER_SPECIFIC, endpoint null created\r\n21:34:27.391 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class DEVICE_RESET_LOCALLY\r\n21:34:27.393 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class DEVICE_RESET_LOCALLY, endpoint null created\r\n21:34:27.395 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class POWERLEVEL\r\n21:34:27.397 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class POWERLEVEL, endpoint null created\r\n21:34:27.399 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class BATTERY\r\n21:34:27.400 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class BATTERY, endpoint null created\r\n21:34:27.402 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class CONFIGURATION\r\n21:34:27.403 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class CONFIGURATION, endpoint null created\r\n21:34:27.404 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ALARM\r\n21:34:27.405 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ALARM, endpoint null created\r\n21:34:27.407 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ASSOCIATION\r\n21:34:27.408 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ASSOCIATION, endpoint null created\r\n21:34:27.409 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Unsupported command class ASSOCIATION_GROUP_INFO\r\n21:34:27.411 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class WAKE_UP\r\n21:34:27.412 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class WAKE_UP, endpoint null created\r\n21:34:27.415 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Unsupported command class FIRMWARE_UPDATE_MD\r\n21:34:27.416 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Is awake with 0 messages in the wake-up queue.\r\n21:34:27.417 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent\r\n21:34:27.418 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Wakeup during initialisation.\r\n21:34:27.419 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - MANUFACTURER: queue length(1), free to send(false)\r\n21:34:27.420 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - MANUFACTURER try 1: stageAdvanced(false)\r\n21:34:27.421 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: MANUFACTURER - send ManufacturerSpecific\r\n21:34:27.422 [DEBUG] [WaveManufacturerSpecificCommandClass] - NODE 14: Creating new message for command MANUFACTURER_SPECIFIC_GET\r\n21:34:27.423 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n21:34:27.424 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 4\r\n21:34:27.449 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:27.453 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:27.455 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:27.458 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:27.460 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationUpdate (0x49), type = Request (0x00), payload = 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A \r\n21:34:27.461 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 14: Application update request. Node information received.\r\n21:34:27.463 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ZWAVE_PLUS_INFO\r\n21:34:27.464 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ZWAVE_PLUS_INFO, endpoint null created\r\n21:34:27.465 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class VERSION\r\n21:34:27.467 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class VERSION, endpoint null created\r\n21:34:27.468 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class MANUFACTURER_SPECIFIC\r\n21:34:27.469 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class MANUFACTURER_SPECIFIC, endpoint null created\r\n21:34:27.471 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class DEVICE_RESET_LOCALLY\r\n21:34:27.472 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class DEVICE_RESET_LOCALLY, endpoint null created\r\n21:34:27.473 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class POWERLEVEL\r\n21:34:27.474 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class POWERLEVEL, endpoint null created\r\n21:34:27.475 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class BATTERY\r\n21:34:27.476 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class BATTERY, endpoint null created\r\n21:34:27.478 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class CONFIGURATION\r\n21:34:27.479 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class CONFIGURATION, endpoint null created\r\n21:34:27.481 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ALARM\r\n21:34:27.482 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ALARM, endpoint null created\r\n21:34:27.483 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ASSOCIATION\r\n21:34:27.484 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ASSOCIATION, endpoint null created\r\n21:34:27.486 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Unsupported command class ASSOCIATION_GROUP_INFO\r\n21:34:27.487 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class WAKE_UP\r\n21:34:27.488 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class WAKE_UP, endpoint null created\r\n21:34:27.491 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Unsupported command class FIRMWARE_UPDATE_MD\r\n21:34:27.492 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Is awake with 0 messages in the wake-up queue.\r\n21:34:27.493 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent\r\n21:34:27.494 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Wakeup during initialisation.\r\n21:34:27.494 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - MANUFACTURER: queue length(1), free to send(false)\r\n21:34:27.495 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n21:34:27.497 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 5\r\n21:34:28.498 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: No more messages, go back to sleep\r\n21:34:28.499 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Creating new message for application command WAKE_UP_NO_MORE_INFORMATION\r\n21:34:28.500 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 6\r\n21:34:28.628 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA \r\n21:34:28.629 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Sending ABORT Message = 01 03 00 16 EA \r\n21:34:28.630 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA \r\n21:34:28.631 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA \r\n21:34:28.632 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Timeout while sending message. Requeueing - 2 attempts left!\r\n21:34:28.633 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Is sleeping\r\n21:34:28.635 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Putting message SendData in wakeup queue.\r\n21:34:28.637 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 5\r\n21:34:28.637 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Putting message SendData in wakeup queue.\r\n21:34:28.638 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 4\r\n21:34:28.639 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Message already on the wake-up queue. Removing original.\r\n21:34:28.640 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Putting message SendData in wakeup queue.\r\n21:34:28.641 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3\r\n21:34:28.642 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Message already on the wake-up queue. Removing original.\r\n21:34:28.642 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Putting message SendData in wakeup queue.\r\n21:34:28.643 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 2\r\n21:34:28.644 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 00 60 0E 95 \r\n21:34:28.645 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 04 00 60 0E 95 \r\n21:34:28.655 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 60 01 9B \r\n21:34:28.657 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:28.658 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 60 01 9B \r\n21:34:28.659 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 60 01 9B \r\n21:34:28.660 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = RequestNodeInfo (0x60), type = Response (0x01), payload = 01 \r\n21:34:28.661 [DEBUG] [lmessage.RequestNodeInfoMessageClass] - Request node info successfully placed on stack.\r\n21:34:28.662 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = RequestNodeInfo (0x60), type = Request (0x00), payload = 0E \r\n21:34:28.663 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = RequestNodeInfo (0x60), type = Response (0x01), payload = 01 \r\n21:34:28.664 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=RequestNodeInfo, expected=ApplicationUpdate, cancelled=false\r\n21:34:28.834 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:28.837 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:28.839 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:28.841 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n21:34:28.843 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationUpdate (0x49), type = Request (0x00), payload = 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A \r\n21:34:28.844 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 14: Application update request. Node information received.\r\n21:34:28.845 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ZWAVE_PLUS_INFO\r\n21:34:28.846 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ZWAVE_PLUS_INFO, endpoint null created\r\n21:34:28.847 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class VERSION\r\n21:34:28.848 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class VERSION, endpoint null created\r\n21:34:28.849 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class MANUFACTURER_SPECIFIC\r\n21:34:28.850 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class MANUFACTURER_SPECIFIC, endpoint null created\r\n21:34:28.851 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class DEVICE_RESET_LOCALLY\r\n21:34:28.852 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class DEVICE_RESET_LOCALLY, endpoint null created\r\n21:34:28.853 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class POWERLEVEL\r\n21:34:28.854 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class POWERLEVEL, endpoint null created\r\n21:34:28.855 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class BATTERY\r\n21:34:28.856 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class BATTERY, endpoint null created\r\n21:34:28.857 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class CONFIGURATION\r\n21:34:28.858 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class CONFIGURATION, endpoint null created\r\n21:34:28.859 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ALARM\r\n21:34:28.860 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ALARM, endpoint null created\r\n21:34:28.861 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ASSOCIATION\r\n21:34:28.862 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ASSOCIATION, endpoint null created\r\n21:34:28.863 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Unsupported command class ASSOCIATION_GROUP_INFO\r\n21:34:28.864 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class WAKE_UP\r\n21:34:28.865 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class WAKE_UP, endpoint null created\r\n21:34:28.867 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Unsupported command class FIRMWARE_UPDATE_MD\r\n21:34:28.868 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Is awake with 2 messages in the wake-up queue.\r\n21:34:28.869 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent\r\n21:34:28.870 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Wakeup during initialisation.\r\n21:34:28.871 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - MANUFACTURER: queue length(1), free to send(false)\r\n21:34:28.871 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n21:34:28.872 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 3\r\n21:34:28.873 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 4\r\n21:34:28.875 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = RequestNodeInfo (0x60), type = Request (0x00), payload = 0E \r\n21:34:28.877 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = ApplicationUpdate (0x49), type = Request (0x00), payload = 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A \r\n21:34:28.877 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationUpdate, expected=ApplicationUpdate, cancelled=false\r\n21:34:28.890 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n21:34:28.891 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n21:34:28.892 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - MANUFACTURER: Transaction complete (RequestNodeInfo:Request) success(true)\r\n21:34:28.892 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 1.\r\n21:34:28.893 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 5\r\n21:34:28.895 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Response processed after 249ms/3379ms.\r\n21:34:28.896 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 4\r\n21:34:28.898 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0E 02 72 04 25 72 C8 \r\n21:34:28.899 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 09 00 13 0E 02 72 04 25 72 C8 \r\n21:34:28.909 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n21:34:28.911 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:28.913 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n21:34:28.914 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n21:34:28.917 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n21:34:28.918 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n21:34:29.074 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 72 00 00 11 88 \r\n21:34:29.076 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:29.078 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 72 00 00 11 00 00 86 \r\n21:34:29.079 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 72 00 00 11 00 00 86 \r\n21:34:29.080 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 72 00 00 11 \r\n21:34:29.081 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 114, Status = Transmission complete and ACK received(0)\r\n21:34:29.083 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 72 04 \r\n21:34:29.084 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 72 00 00 11 \r\n21:34:29.085 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false\r\n21:34:29.234 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0E 00 04 00 0E 08 72 05 01 78 44 42 31 30 FA \r\n21:34:29.237 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:29.240 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0E 00 04 00 0E 08 72 05 01 78 44 42 31 30 FA \r\n21:34:29.242 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0E 00 04 00 0E 08 72 05 01 78 44 42 31 30 FA \r\n21:34:29.244 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 08 72 05 01 78 44 42 31 30 \r\n21:34:29.245 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:MANUFACTURER)\r\n21:34:29.246 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class MANUFACTURER_SPECIFIC\r\n21:34:29.247 [DEBUG] [WaveManufacturerSpecificCommandClass] - NODE 14: Received Manufacture Specific Information\r\n21:34:29.248 [DEBUG] [WaveManufacturerSpecificCommandClass] - NODE 14: Manufacturer ID = 0x0178\r\n21:34:29.249 [DEBUG] [WaveManufacturerSpecificCommandClass] - NODE 14: Device Type     = 0x4442\r\n21:34:29.251 [DEBUG] [WaveManufacturerSpecificCommandClass] - NODE 14: Device ID       = 0x3130\r\n21:34:29.252 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 72 04 \r\n21:34:29.254 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 08 72 05 01 78 44 42 31 30 \r\n21:34:29.255 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, expected=ApplicationCommandHandler, cancelled=false\r\n21:34:29.256 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n21:34:29.257 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n21:34:29.258 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - MANUFACTURER: Transaction complete (SendData:Request) success(true)\r\n21:34:29.260 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 1.\r\n21:34:29.260 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 0.\r\n21:34:29.262 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - MANUFACTURER: queue length(0), free to send(true)\r\n21:34:29.263 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - MANUFACTURER try 2: stageAdvanced(false)\r\n21:34:29.264 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n21:34:29.265 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n21:34:29.266 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to APP_VERSION\r\n21:34:29.268 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - APP_VERSION try 0: stageAdvanced(true)\r\n21:34:29.269 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: APP_VERSION - send VersionMessage\r\n21:34:29.270 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Creating new message for command VERSION_GET\r\n21:34:29.272 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n21:34:29.273 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 5\r\n21:34:29.274 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Response processed after 373ms/3379ms.\r\n21:34:29.275 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 4\r\n21:34:29.276 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0E 02 84 08 25 71 31 \r\n21:34:29.278 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 09 00 13 0E 02 84 08 25 71 31 \r\n21:34:29.288 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n21:34:29.289 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:29.291 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n21:34:29.291 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n21:34:29.293 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n21:34:29.294 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n21:34:29.400 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 71 00 00 0C 96 \r\n21:34:29.402 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n21:34:29.403 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 71 00 00 0C 00 00 98 \r\n21:34:29.404 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 71 00 00 0C 00 00 98 \r\n21:34:29.405 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 71 00 00 0C \r\n21:34:29.406 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 113, Status = Transmission complete and ACK received(0)\r\n21:34:29.408 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 84 08 \r\n21:34:29.410 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 71 00 00 0C \r\n21:34:29.411 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=SendData, cancelled=false\r\n21:34:29.411 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n21:34:29.412 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n21:34:29.413 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - APP_VERSION: Transaction complete (SendData:Request) success(true)\r\n21:34:29.414 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 1.\r\n21:34:29.415 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Went to sleep\r\n21:34:29.415 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Is sleeping\r\n21:34:29.416 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Response processed after 138ms/3379ms.\r\n21:34:29.417 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3\r\n21:34:29.418 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Putting message SendData in wakeup queue.\r\n21:34:29.418 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 2\r\n21:34:29.419 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Message already on the wake-up queue. Removing original.\r\n21:34:29.420 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Putting message SendData in wakeup queue.\r\n21:34:29.421 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1\r\n21:34:29.422 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Message already on the wake-up queue. Removing original.\r\n21:34:29.422 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Putting message SendData in wakeup queue.\r\n21:34:29.423 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0\r\n21:34:29.424 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Putting message SendData in wakeup queue.`\r\n\r\n`07:44:17.034 [DEBUG] [ssage.ApplicationCommandMessageClass] - Transaction not completed: node address inconsistent.\r\n07:44:21.629 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 0E 0A 71 05 00 00 00 FF 08 01 00 00 6D \r\n07:44:21.634 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:21.636 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 10 00 04 00 0E 0A 71 05 00 00 00 FF 08 01 00 00 6D \r\n07:44:21.637 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 10 00 04 00 0E 0A 71 05 00 00 00 FF 08 01 00 00 6D \r\n07:44:21.639 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 0A 71 05 00 00 00 FF 08 01 00 00 \r\n07:44:21.640 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (INITIALIZING:PING)\r\n07:44:21.641 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Node is ALIVE. Init stage is PING:{}.\r\n07:44:21.641 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveNodeStatusEvent\r\n07:44:21.642 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Node Status event - Node is ALIVE\r\n07:44:21.643 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node Status event during initialisation - Node is ALIVE\r\n07:44:21.643 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - PING: queue length(0), free to send(true)\r\n07:44:21.644 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - PING try 1: stageAdvanced(false)\r\n07:44:21.644 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: PING - send NoOperation\r\n07:44:21.645 [DEBUG] [ndclass.ZWaveNoOperationCommandClass] - NODE 14: Creating new message for command No Operation\r\n07:44:21.646 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n07:44:21.647 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 1\r\n07:44:21.647 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0\r\n07:44:21.648 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 14: Node Status event - Node is ALIVE\r\n07:44:21.648 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class ALARM\r\n07:44:21.649 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 08 00 13 0E 01 00 25 70 BE \r\n07:44:21.649 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Command class ALARM not found, trying to add it.\r\n07:44:21.650 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ALARM\r\n07:44:21.650 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 08 00 13 0E 01 00 25 70 BE \r\n07:44:21.651 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ALARM, endpoint null created\r\n07:44:21.652 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Adding command class ALARM\r\n07:44:21.653 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class ALARM to the list of supported command classes.\r\n07:44:21.654 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Received Alarm Request\r\n07:44:21.655 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Process Alarm Report, V0, length 13\r\n07:44:21.656 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Alarm report - 0 = 0, source=0, event=1, status=255\r\n07:44:21.659 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Alarm Type = General (0)\r\n07:44:21.660 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveAlarmValueEvent\r\n07:44:21.661 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: CC event during initialisation stage IDLE\r\n07:44:21.662 [DEBUG] [ssage.ApplicationCommandMessageClass] - Transaction not completed: node address inconsistent.\r\n07:44:21.663 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n07:44:21.667 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:21.669 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n07:44:21.670 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n07:44:21.671 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n07:44:21.673 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n07:44:22.012 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 70 00 00 23 B8 \r\n07:44:22.017 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.018 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 70 00 00 23 00 00 B6 \r\n07:44:22.020 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 70 00 00 23 00 00 B6 \r\n07:44:22.021 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 70 00 00 23 \r\n07:44:22.022 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 112, Status = Transmission complete and ACK received(0)\r\n07:44:22.023 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 01 00 \r\n07:44:22.024 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 70 00 00 23 \r\n07:44:22.025 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=SendData, cancelled=false\r\n07:44:22.026 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n07:44:22.026 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n07:44:22.027 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - DETAILS: Transaction complete (SendData:Request) success(true)\r\n07:44:22.028 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 1.\r\n07:44:22.029 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 0.\r\n07:44:22.029 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - DETAILS: queue length(0), free to send(true)\r\n07:44:22.030 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - DETAILS try 2: stageAdvanced(false)\r\n07:44:22.031 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DETAILS - send RequestNodeInfo\r\n07:44:22.034 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n07:44:22.035 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 1\r\n07:44:22.036 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Response processed after 384ms/400ms.\r\n07:44:22.037 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0\r\n07:44:22.039 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 00 60 0E 95 \r\n07:44:22.041 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 04 00 60 0E 95 \r\n07:44:22.055 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 60 01 9B \r\n07:44:22.058 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.059 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 60 01 9B \r\n07:44:22.060 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 60 01 9B \r\n07:44:22.062 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = RequestNodeInfo (0x60), type = Response (0x01), payload = 01 \r\n07:44:22.063 [DEBUG] [lmessage.RequestNodeInfoMessageClass] - Request node info successfully placed on stack.\r\n07:44:22.064 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = RequestNodeInfo (0x60), type = Request (0x00), payload = 0E \r\n07:44:22.065 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = RequestNodeInfo (0x60), type = Response (0x01), payload = 01 \r\n07:44:22.066 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=RequestNodeInfo, expected=ApplicationUpdate, cancelled=false\r\n07:44:22.169 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 0E 0A 71 05 00 00 00 FF 08 01 00 00 6D \r\n07:44:22.173 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.174 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 10 00 04 00 0E 0A 71 05 00 00 00 FF 08 01 00 00 6D \r\n07:44:22.176 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 10 00 04 00 0E 0A 71 05 00 00 00 FF 08 01 00 00 6D \r\n07:44:22.177 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 0A 71 05 00 00 00 FF 08 01 00 00 \r\n07:44:22.178 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:DETAILS)\r\n07:44:22.178 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class ALARM\r\n07:44:22.179 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Received Alarm Request\r\n07:44:22.180 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Process Alarm Report, V0, length 13\r\n07:44:22.180 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Alarm report - 0 = 0, source=0, event=1, status=255\r\n07:44:22.181 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Alarm Type = General (0)\r\n07:44:22.181 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveAlarmValueEvent\r\n07:44:22.182 [DEBUG] [ssage.ApplicationCommandMessageClass] - Transaction not completed: node address inconsistent.\r\n07:44:22.208 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n07:44:22.213 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.214 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n07:44:22.216 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n07:44:22.217 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationUpdate (0x49), type = Request (0x00), payload = 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A \r\n07:44:22.218 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 14: Application update request. Node information received.\r\n07:44:22.219 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ZWAVE_PLUS_INFO\r\n07:44:22.220 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ZWAVE_PLUS_INFO, endpoint null created\r\n07:44:22.221 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class ZWAVE_PLUS_INFO to the list of supported command classes.\r\n07:44:22.222 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class VERSION\r\n07:44:22.223 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class VERSION, endpoint null created\r\n07:44:22.223 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class VERSION to the list of supported command classes.\r\n07:44:22.224 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class MANUFACTURER_SPECIFIC\r\n07:44:22.225 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class MANUFACTURER_SPECIFIC, endpoint null created\r\n07:44:22.226 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class MANUFACTURER_SPECIFIC to the list of supported command classes.\r\n07:44:22.226 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class DEVICE_RESET_LOCALLY\r\n07:44:22.228 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class DEVICE_RESET_LOCALLY, endpoint null created\r\n07:44:22.228 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class DEVICE_RESET_LOCALLY to the list of supported command classes.\r\n07:44:22.229 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class POWERLEVEL\r\n07:44:22.230 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class POWERLEVEL, endpoint null created\r\n07:44:22.231 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class POWERLEVEL to the list of supported command classes.\r\n07:44:22.232 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class BATTERY\r\n07:44:22.233 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class BATTERY, endpoint null created\r\n07:44:22.234 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class BATTERY to the list of supported command classes.\r\n07:44:22.234 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class CONFIGURATION\r\n07:44:22.235 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class CONFIGURATION, endpoint null created\r\n07:44:22.236 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class CONFIGURATION to the list of supported command classes.\r\n07:44:22.237 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ALARM\r\n07:44:22.238 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ALARM, endpoint null created\r\n07:44:22.239 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ASSOCIATION\r\n07:44:22.240 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ASSOCIATION, endpoint null created\r\n07:44:22.240 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class ASSOCIATION to the list of supported command classes.\r\n07:44:22.241 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Unsupported command class ASSOCIATION_GROUP_INFO\r\n07:44:22.242 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class WAKE_UP\r\n07:44:22.243 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class WAKE_UP, endpoint null created\r\n07:44:22.245 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 14: Adding command class WAKE_UP to the list of supported command classes.\r\n07:44:22.246 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Unsupported command class FIRMWARE_UPDATE_MD\r\n07:44:22.246 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Is awake with 0 messages in the wake-up queue.\r\n07:44:22.247 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent\r\n07:44:22.248 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Wakeup during initialisation.\r\n07:44:22.249 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - DETAILS: queue length(1), free to send(false)\r\n07:44:22.250 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n07:44:22.250 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 1\r\n07:44:22.251 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = RequestNodeInfo (0x60), type = Request (0x00), payload = 0E \r\n07:44:22.253 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = ApplicationUpdate (0x49), type = Request (0x00), payload = 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A \r\n07:44:22.254 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationUpdate, expected=ApplicationUpdate, cancelled=false\r\n07:44:22.254 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n07:44:22.255 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n07:44:22.255 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - DETAILS: Transaction complete (RequestNodeInfo:Request) success(true)\r\n07:44:22.256 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 1.\r\n07:44:22.257 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 0.\r\n07:44:22.257 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - DETAILS: queue length(0), free to send(true)\r\n07:44:22.258 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - DETAILS try 3: stageAdvanced(false)\r\n07:44:22.258 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: received RequestNodeInfo\r\n07:44:22.259 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:22.259 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:22.260 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to MANUFACTURER\r\n07:44:22.260 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - MANUFACTURER try 0: stageAdvanced(true)\r\n07:44:22.261 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: MANUFACTURER - send ManufacturerSpecific\r\n07:44:22.262 [DEBUG] [WaveManufacturerSpecificCommandClass] - NODE 14: Creating new message for command MANUFACTURER_SPECIFIC_GET\r\n07:44:22.263 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n07:44:22.264 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 2\r\n07:44:22.265 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Response processed after 220ms/400ms.\r\n07:44:22.266 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1\r\n07:44:22.269 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0E 02 72 04 25 71 CB \r\n07:44:22.271 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 09 00 13 0E 02 72 04 25 71 CB \r\n07:44:22.281 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n07:44:22.283 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.285 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n07:44:22.287 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n07:44:22.289 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n07:44:22.290 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n07:44:22.301 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 71 00 00 02 98 \r\n07:44:22.303 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.305 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 71 00 00 02 00 00 96 \r\n07:44:22.307 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 71 00 00 02 00 00 96 \r\n07:44:22.308 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 71 00 00 02 \r\n07:44:22.310 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 113, Status = Transmission complete and ACK received(0)\r\n07:44:22.311 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 72 04 \r\n07:44:22.313 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 71 00 00 02 \r\n07:44:22.314 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:22.317 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0E 00 04 00 0E 08 72 05 01 78 44 42 31 30 FA \r\n07:44:22.320 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.322 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0E 00 04 00 0E 08 72 05 01 78 44 42 31 30 FA \r\n07:44:22.323 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0E 00 04 00 0E 08 72 05 01 78 44 42 31 30 FA \r\n07:44:22.324 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 08 72 05 01 78 44 42 31 30 \r\n07:44:22.325 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:MANUFACTURER)\r\n07:44:22.326 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class MANUFACTURER_SPECIFIC\r\n07:44:22.327 [DEBUG] [WaveManufacturerSpecificCommandClass] - NODE 14: Received Manufacture Specific Information\r\n07:44:22.328 [DEBUG] [WaveManufacturerSpecificCommandClass] - NODE 14: Manufacturer ID = 0x0178\r\n07:44:22.329 [DEBUG] [WaveManufacturerSpecificCommandClass] - NODE 14: Device Type     = 0x4442\r\n07:44:22.330 [DEBUG] [WaveManufacturerSpecificCommandClass] - NODE 14: Device ID       = 0x3130\r\n07:44:22.331 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 72 04 \r\n07:44:22.333 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 08 72 05 01 78 44 42 31 30 \r\n07:44:22.334 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:22.334 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n07:44:22.335 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n07:44:22.336 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - MANUFACTURER: Transaction complete (SendData:Request) success(true)\r\n07:44:22.337 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 1.\r\n07:44:22.337 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 0.\r\n07:44:22.338 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - MANUFACTURER: queue length(0), free to send(true)\r\n07:44:22.339 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - MANUFACTURER try 1: stageAdvanced(false)\r\n07:44:22.340 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:22.340 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:22.341 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to APP_VERSION\r\n07:44:22.342 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - APP_VERSION try 0: stageAdvanced(true)\r\n07:44:22.343 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: APP_VERSION - send VersionMessage\r\n07:44:22.344 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Creating new message for command VERSION_GET\r\n07:44:22.345 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n07:44:22.346 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 2\r\n07:44:22.346 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Response processed after 68ms/400ms.\r\n07:44:22.347 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1\r\n07:44:22.348 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0E 02 86 11 25 72 29 \r\n07:44:22.349 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 09 00 13 0E 02 86 11 25 72 29 \r\n07:44:22.358 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n07:44:22.361 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.363 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n07:44:22.364 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n07:44:22.364 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n07:44:22.365 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n07:44:22.380 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 72 00 00 02 9B \r\n07:44:22.382 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.384 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 72 00 00 02 00 00 95 \r\n07:44:22.385 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 72 00 00 02 00 00 95 \r\n07:44:22.385 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 72 00 00 02 \r\n07:44:22.386 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 114, Status = Transmission complete and ACK received(0)\r\n07:44:22.387 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 86 11 \r\n07:44:22.388 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 72 00 00 02 \r\n07:44:22.389 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:22.396 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0F 00 04 00 0E 09 86 12 03 04 05 01 2C 01 00 49 \r\n07:44:22.398 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.400 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0F 00 04 00 0E 09 86 12 03 04 05 01 2C 01 00 49 \r\n07:44:22.401 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0F 00 04 00 0E 09 86 12 03 04 05 01 2C 01 00 49 \r\n07:44:22.402 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 09 86 12 03 04 05 01 2C 01 00 \r\n07:44:22.403 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:APP_VERSION)\r\n07:44:22.404 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class VERSION\r\n07:44:22.404 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Received Version Request\r\n07:44:22.405 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Process Version Report\r\n07:44:22.406 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Library Type        = 3 (Slave Enhanced)\r\n07:44:22.407 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Protocol Version    = 4.5\r\n07:44:22.407 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Application Version = 1.44\r\n07:44:22.408 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 86 11 \r\n07:44:22.410 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 09 86 12 03 04 05 01 2C 01 00 \r\n07:44:22.410 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:22.411 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n07:44:22.411 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n07:44:22.412 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - APP_VERSION: Transaction complete (SendData:Request) success(true)\r\n07:44:22.412 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 1.\r\n07:44:22.413 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 0.\r\n07:44:22.413 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - APP_VERSION: queue length(0), free to send(true)\r\n07:44:22.414 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - APP_VERSION try 1: stageAdvanced(false)\r\n07:44:22.414 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:22.415 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:22.415 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to DISCOVERY_COMPLETE\r\n07:44:22.416 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - DISCOVERY_COMPLETE try 0: stageAdvanced(true)\r\n07:44:22.416 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 14: Device discovery completed\r\n07:44:22.421 [WARN ] [wave.discovery.ZWaveDiscoveryService] - NODE 14: Device could not be resolved to a thingType! 0178:4442:3130::1.44\r\n07:44:22.603 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'zwave:unknown:1533f07f1de:node14' to inbox.\r\n07:44:22.604 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:22.604 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:22.605 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to DISCOVERY_WAIT\r\n07:44:22.605 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - DISCOVERY_WAIT try 0: stageAdvanced(true)\r\n07:44:22.606 [INFO ] [smarthome.event.InboxAddedEvent     ] - Discovery Result with UID 'zwave:unknown:1533f07f1de:node14' has been added.\r\n07:44:22.606 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DISCOVERY_WAIT - looking...\r\n07:44:22.609 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DISCOVERY_WAIT - thing not found ({})!\r\n07:44:22.609 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:22.610 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:22.611 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to VERSION\r\n07:44:22.612 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - VERSION try 0: stageAdvanced(true)\r\n07:44:22.613 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking BASIC, version is 0\r\n07:44:22.614 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - VERSION default to 1\r\n07:44:22.614 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking CONFIGURATION, version is 0\r\n07:44:22.615 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - VERSION default to 1\r\n07:44:22.615 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking VERSION, version is 0\r\n07:44:22.616 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - VERSION default to 1\r\n07:44:22.616 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking ZWAVE_PLUS_INFO, version is 0\r\n07:44:22.617 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - VERSION default to 1\r\n07:44:22.617 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking ALARM, version is 0\r\n07:44:22.618 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - queued   ALARM\r\n07:44:22.618 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Creating new message for application command VERSION_COMMAND_CLASS_GET command class ALARM\r\n07:44:22.619 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking NO_OPERATION, version is 0\r\n07:44:22.620 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - VERSION default to 1\r\n07:44:22.620 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking MANUFACTURER_SPECIFIC, version is 0\r\n07:44:22.621 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - VERSION default to 1\r\n07:44:22.621 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking POWERLEVEL, version is 0\r\n07:44:22.622 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - VERSION default to 1\r\n07:44:22.622 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking BATTERY, version is 0\r\n07:44:22.623 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - VERSION default to 1\r\n07:44:22.623 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking ASSOCIATION, version is 0\r\n07:44:22.624 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - VERSION default to 1\r\n07:44:22.624 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking WAKE_UP, version is 0\r\n07:44:22.625 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - queued   WAKE_UP\r\n07:44:22.625 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Creating new message for application command VERSION_COMMAND_CLASS_GET command class WAKE_UP\r\n07:44:22.626 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking DEVICE_RESET_LOCALLY, version is 0\r\n07:44:22.626 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - VERSION default to 1\r\n07:44:22.627 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - queued 2 frames\r\n07:44:22.627 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 2\r\n07:44:22.628 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 2\r\n07:44:22.629 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Response processed after 279ms/400ms.\r\n07:44:22.629 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1\r\n07:44:22.630 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 0E 03 86 13 71 25 73 59 \r\n07:44:22.632 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 0A 00 13 0E 03 86 13 71 25 73 59 \r\n07:44:22.642 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n07:44:22.643 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.644 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n07:44:22.645 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n07:44:22.646 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n07:44:22.646 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n07:44:22.654 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 0E 0A 71 05 00 00 00 FF 08 00 00 00 6C \r\n07:44:22.656 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.658 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 10 00 04 00 0E 0A 71 05 00 00 00 FF 08 00 00 00 6C \r\n07:44:22.660 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 10 00 04 00 0E 0A 71 05 00 00 00 FF 08 00 00 00 6C \r\n07:44:22.662 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 0A 71 05 00 00 00 FF 08 00 00 00 \r\n07:44:22.663 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:VERSION)\r\n07:44:22.664 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class ALARM\r\n07:44:22.664 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Received Alarm Request\r\n07:44:22.665 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Process Alarm Report, V0, length 13\r\n07:44:22.666 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Alarm report - 0 = 0, source=0, event=0, status=255\r\n07:44:22.667 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Alarm Type = General (0)\r\n07:44:22.667 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveAlarmValueEvent\r\n07:44:22.693 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 0E 04 86 14 71 04 1C \r\n07:44:22.696 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.698 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 04 00 0E 04 86 14 71 04 1C \r\n07:44:22.700 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0A 00 04 00 0E 04 86 14 71 04 1C \r\n07:44:22.701 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 04 86 14 71 04 \r\n07:44:22.703 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:VERSION)\r\n07:44:22.704 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class VERSION\r\n07:44:22.705 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Received Version Request\r\n07:44:22.706 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Process Version Command Class Report\r\n07:44:22.708 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Requested Command Class = ALARM, Version = 4\r\n07:44:22.709 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Version = 3, version set to maximum supported by the binding. Enabling extra functionality.\r\n07:44:22.718 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 73 00 00 08 90 \r\n07:44:22.721 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.723 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 73 00 00 08 00 00 9E \r\n07:44:22.725 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 73 00 00 08 00 00 9E \r\n07:44:22.727 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 73 00 00 08 \r\n07:44:22.728 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 115, Status = Transmission complete and ACK received(0)\r\n07:44:22.730 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 03 86 13 71 \r\n07:44:22.732 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 73 00 00 08 \r\n07:44:22.733 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 0E 04 86 14 71 04 1C \r\n07:44:22.734 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:22.736 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.738 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 04 00 0E 04 86 14 71 04 1C \r\n07:44:22.740 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0A 00 04 00 0E 04 86 14 71 04 1C \r\n07:44:22.742 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 04 86 14 71 04 \r\n07:44:22.744 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:VERSION)\r\n07:44:22.746 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class VERSION\r\n07:44:22.747 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Received Version Request\r\n07:44:22.748 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Process Version Command Class Report\r\n07:44:22.749 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Requested Command Class = ALARM, Version = 4\r\n07:44:22.751 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Version = 3, version set to maximum supported by the binding. Enabling extra functionality.\r\n07:44:22.752 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 03 86 13 71 \r\n07:44:22.754 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 04 86 14 71 04 \r\n07:44:22.756 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:22.758 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n07:44:22.759 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n07:44:22.760 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - VERSION: Transaction complete (SendData:Request) success(true)\r\n07:44:22.761 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 2.\r\n07:44:22.763 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 1.\r\n07:44:22.764 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - VERSION: queue length(1), free to send(true)\r\n07:44:22.765 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n07:44:22.767 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 2\r\n07:44:22.768 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Response processed after 136ms/400ms.\r\n07:44:22.768 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1\r\n07:44:22.770 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 0E 03 86 13 84 25 74 AB \r\n07:44:22.771 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 0A 00 13 0E 03 86 13 84 25 74 AB \r\n07:44:22.781 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n07:44:22.784 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.786 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n07:44:22.788 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n07:44:22.790 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n07:44:22.791 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n07:44:22.802 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 74 00 00 03 9C \r\n07:44:22.804 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.806 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 74 00 00 03 00 00 92 \r\n07:44:22.808 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 74 00 00 03 00 00 92 \r\n07:44:22.810 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 74 00 00 03 \r\n07:44:22.812 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 116, Status = Transmission complete and ACK received(0)\r\n07:44:22.814 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 03 86 13 84 \r\n07:44:22.815 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 74 00 00 03 \r\n07:44:22.817 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0A 00 04 00 0E 04 86 14 84 02 EF \r\n07:44:22.817 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:22.820 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.822 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 04 00 0E 04 86 14 84 02 EF \r\n07:44:22.824 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0A 00 04 00 0E 04 86 14 84 02 EF \r\n07:44:22.826 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 04 86 14 84 02 \r\n07:44:22.828 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:VERSION)\r\n07:44:22.830 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class VERSION\r\n07:44:22.831 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Received Version Request\r\n07:44:22.832 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Process Version Command Class Report\r\n07:44:22.834 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Requested Command Class = WAKE_UP, Version = 2\r\n07:44:22.835 [DEBUG] [ommandclass.ZWaveVersionCommandClass] - NODE 14: Version = 2, version set. Enabling extra functionality.\r\n07:44:22.837 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 03 86 13 84 \r\n07:44:22.839 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 04 86 14 84 02 \r\n07:44:22.840 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:22.842 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n07:44:22.843 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n07:44:22.844 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - VERSION: Transaction complete (SendData:Request) success(true)\r\n07:44:22.845 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 1.\r\n07:44:22.847 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 0.\r\n07:44:22.848 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - VERSION: queue length(0), free to send(true)\r\n07:44:22.849 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - VERSION try 1: stageAdvanced(false)\r\n07:44:22.850 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking BASIC, version is 1\r\n07:44:22.852 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking CONFIGURATION, version is 1\r\n07:44:22.853 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking VERSION, version is 1\r\n07:44:22.854 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking ZWAVE_PLUS_INFO, version is 1\r\n07:44:22.855 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking ALARM, version is 3\r\n07:44:22.857 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking NO_OPERATION, version is 1\r\n07:44:22.858 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking MANUFACTURER_SPECIFIC, version is 1\r\n07:44:22.859 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking POWERLEVEL, version is 1\r\n07:44:22.860 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking BATTERY, version is 1\r\n07:44:22.861 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking ASSOCIATION, version is 1\r\n07:44:22.863 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking WAKE_UP, version is 2\r\n07:44:22.864 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - checking DEVICE_RESET_LOCALLY, version is 1\r\n07:44:22.865 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: VERSION - queued 0 frames\r\n07:44:22.866 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:22.867 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:22.869 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to ENDPOINTS\r\n07:44:22.870 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - ENDPOINTS try 0: stageAdvanced(true)\r\n07:44:22.871 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: ENDPOINTS - MultiInstance not supported.\r\n07:44:22.873 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:22.874 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:22.875 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to UPDATE_DATABASE\r\n07:44:22.876 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - UPDATE_DATABASE try 0: stageAdvanced(true)\r\n07:44:22.878 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: UPDATE_DATABASE\r\n07:44:22.879 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: UPDATE_DATABASE - thing is null!\r\n07:44:22.880 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:22.881 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:22.883 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to STATIC_VALUES\r\n07:44:22.884 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - STATIC_VALUES try 0: stageAdvanced(true)\r\n07:44:22.885 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking BASIC\r\n07:44:22.886 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking CONFIGURATION\r\n07:44:22.888 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking VERSION\r\n07:44:22.889 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking ZWAVE_PLUS_INFO\r\n07:44:22.890 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - found    ZWAVE_PLUS_INFO\r\n07:44:22.891 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Found 1 instances of ZWAVE_PLUS_INFO\r\n07:44:22.893 [DEBUG] [l.commandclass.ZWavePlusCommandClass] - NODE 14: Creating new message for application command ZWAVE_PLUS_GET\r\n07:44:22.895 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking ALARM\r\n07:44:22.896 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking NO_OPERATION\r\n07:44:22.898 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking MANUFACTURER_SPECIFIC\r\n07:44:22.899 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking POWERLEVEL\r\n07:44:22.900 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking BATTERY\r\n07:44:22.901 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking ASSOCIATION\r\n07:44:22.903 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - found    ASSOCIATION\r\n07:44:22.904 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Found 1 instances of ASSOCIATION\r\n07:44:22.905 [DEBUG] [ndclass.ZWaveAssociationCommandClass] - NODE 14: Creating new message for application command ASSOCIATIONCMD_GROUPINGSGET\r\n07:44:22.907 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking WAKE_UP\r\n07:44:22.909 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - found    WAKE_UP\r\n07:44:22.910 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Found 1 instances of WAKE_UP\r\n07:44:22.912 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Creating new message for application command WAKE_UP_INTERVAL_GET\r\n07:44:22.913 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Creating new message for application command WAKE_UP_INTERVAL_CAPABILITIES_GET\r\n07:44:22.915 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking DEVICE_RESET_LOCALLY\r\n07:44:22.917 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - queued 4 frames\r\n07:44:22.918 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 4\r\n07:44:22.919 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 2\r\n07:44:22.921 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Response processed after 149ms/400ms.\r\n07:44:22.921 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1\r\n07:44:22.923 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0E 02 5E 01 25 75 E6 \r\n07:44:22.924 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 09 00 13 0E 02 5E 01 25 75 E6 \r\n07:44:22.933 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n07:44:22.937 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.939 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n07:44:22.940 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n07:44:22.941 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n07:44:22.942 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n07:44:22.954 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 75 00 00 03 9D \r\n07:44:22.957 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.959 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 75 00 00 03 00 00 93 \r\n07:44:22.961 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 75 00 00 03 00 00 93 \r\n07:44:22.963 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 75 00 00 03 \r\n07:44:22.964 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 117, Status = Transmission complete and ACK received(0)\r\n07:44:22.965 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 5E 01 \r\n07:44:22.967 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 75 00 00 03 \r\n07:44:22.968 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:22.971 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0F 00 04 00 0E 09 5E 02 01 06 00 0C 08 0C 08 A8 \r\n07:44:22.975 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:22.976 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0F 00 04 00 0E 09 5E 02 01 06 00 0C 08 0C 08 A8 \r\n07:44:22.978 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0F 00 04 00 0E 09 5E 02 01 06 00 0C 08 0C 08 A8 \r\n07:44:22.980 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 09 5E 02 01 06 00 0C 08 0C 08 \r\n07:44:22.981 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:STATIC_VALUES)\r\n07:44:22.982 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class ZWAVE_PLUS_INFO\r\n07:44:22.983 [DEBUG] [l.commandclass.ZWavePlusCommandClass] - NODE 14: Received ZWave Plus Request\r\n07:44:22.985 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 5E 01 \r\n07:44:22.986 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 09 5E 02 01 06 00 0C 08 0C 08 \r\n07:44:22.988 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:22.989 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n07:44:22.990 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n07:44:22.991 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - STATIC_VALUES: Transaction complete (SendData:Request) success(true)\r\n07:44:22.992 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 4.\r\n07:44:22.993 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 3.\r\n07:44:22.994 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - STATIC_VALUES: queue length(3), free to send(true)\r\n07:44:22.995 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 3\r\n07:44:22.996 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 2\r\n07:44:22.997 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Response processed after 72ms/400ms.\r\n07:44:22.998 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1\r\n07:44:22.999 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0E 02 85 05 25 76 3A \r\n07:44:23.000 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 09 00 13 0E 02 85 05 25 76 3A \r\n07:44:23.010 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n07:44:23.013 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.014 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n07:44:23.016 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n07:44:23.017 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n07:44:23.018 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n07:44:23.031 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 76 00 00 02 9F \r\n07:44:23.033 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.035 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 76 00 00 02 00 00 91 \r\n07:44:23.036 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 76 00 00 02 00 00 91 \r\n07:44:23.038 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 76 00 00 02 \r\n07:44:23.039 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 118, Status = Transmission complete and ACK received(0)\r\n07:44:23.040 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 85 05 \r\n07:44:23.042 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 76 00 00 02 \r\n07:44:23.043 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:23.046 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 0E 03 85 06 01 7D \r\n07:44:23.049 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.051 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 04 00 0E 03 85 06 01 7D \r\n07:44:23.052 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 04 00 0E 03 85 06 01 7D \r\n07:44:23.054 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 03 85 06 01 \r\n07:44:23.055 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:STATIC_VALUES)\r\n07:44:23.056 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class ASSOCIATION\r\n07:44:23.057 [DEBUG] [ndclass.ZWaveAssociationCommandClass] - NODE 14: Received Association Request\r\n07:44:23.058 [DEBUG] [ndclass.ZWaveAssociationCommandClass] - NODE Node 14. Manufacturer 0178, Type 4442, Id 3130: processGroupingsReport number of groups 1\r\n07:44:23.060 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 85 05 \r\n07:44:23.062 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 03 85 06 01 \r\n07:44:23.063 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:23.064 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n07:44:23.065 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n07:44:23.066 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - STATIC_VALUES: Transaction complete (SendData:Request) success(true)\r\n07:44:23.067 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 3.\r\n07:44:23.068 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 2.\r\n07:44:23.069 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - STATIC_VALUES: queue length(2), free to send(true)\r\n07:44:23.071 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 2\r\n07:44:23.072 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 2\r\n07:44:23.073 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Response processed after 72ms/400ms.\r\n07:44:23.074 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1\r\n07:44:23.075 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0E 02 84 05 25 77 3A \r\n07:44:23.076 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 09 00 13 0E 02 84 05 25 77 3A \r\n07:44:23.086 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n07:44:23.088 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.089 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n07:44:23.091 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n07:44:23.092 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n07:44:23.093 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n07:44:23.108 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 77 00 00 03 9F \r\n07:44:23.110 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.111 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 77 00 00 03 00 00 91 \r\n07:44:23.113 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 77 00 00 03 00 00 91 \r\n07:44:23.114 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 77 00 00 03 \r\n07:44:23.115 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 119, Status = Transmission complete and ACK received(0)\r\n07:44:23.117 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 84 05 \r\n07:44:23.118 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 77 00 00 03 \r\n07:44:23.119 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:23.122 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 0E 06 84 06 00 62 70 00 6F \r\n07:44:23.125 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.126 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0C 00 04 00 0E 06 84 06 00 62 70 00 6F \r\n07:44:23.128 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0C 00 04 00 0E 06 84 06 00 62 70 00 6F \r\n07:44:23.129 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 06 84 06 00 62 70 00 \r\n07:44:23.131 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:STATIC_VALUES)\r\n07:44:23.132 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class WAKE_UP\r\n07:44:23.133 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Received Wake Up Request\r\n07:44:23.134 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Wake up interval report, value = 25200 seconds, targetNodeId = 0\r\n07:44:23.135 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent\r\n07:44:23.137 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 84 05 \r\n07:44:23.138 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 06 84 06 00 62 70 00 \r\n07:44:23.139 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:23.140 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n07:44:23.141 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n07:44:23.142 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - STATIC_VALUES: Transaction complete (SendData:Request) success(true)\r\n07:44:23.143 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 2.\r\n07:44:23.145 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 1.\r\n07:44:23.146 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - STATIC_VALUES: queue length(1), free to send(true)\r\n07:44:23.146 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n07:44:23.148 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 2\r\n07:44:23.149 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Response processed after 71ms/400ms.\r\n07:44:23.149 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1\r\n07:44:23.151 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0E 02 84 09 25 78 39 \r\n07:44:23.152 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 09 00 13 0E 02 84 09 25 78 39 \r\n07:44:23.162 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n07:44:23.164 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.165 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n07:44:23.166 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n07:44:23.168 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n07:44:23.169 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n07:44:23.182 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 78 00 00 03 90 \r\n07:44:23.184 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.186 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 78 00 00 03 00 00 9E \r\n07:44:23.188 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 78 00 00 03 00 00 9E \r\n07:44:23.189 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 78 00 00 03 \r\n07:44:23.190 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 120, Status = Transmission complete and ACK received(0)\r\n07:44:23.192 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 84 09 \r\n07:44:23.193 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 78 00 00 03 \r\n07:44:23.194 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:23.200 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 14 00 04 00 0E 0E 84 0A 00 00 3C 01 51 80 00 62 70 00 00 3C A3 \r\n07:44:23.203 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.204 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 14 00 04 00 0E 0E 84 0A 00 00 3C 01 51 80 00 62 70 00 00 3C A3 \r\n07:44:23.206 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 14 00 04 00 0E 0E 84 0A 00 00 3C 01 51 80 00 62 70 00 00 3C A3 \r\n07:44:23.208 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 0E 84 0A 00 00 3C 01 51 80 00 62 70 00 00 3C \r\n07:44:23.209 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:STATIC_VALUES)\r\n07:44:23.211 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class WAKE_UP\r\n07:44:23.212 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Received Wake Up Request\r\n07:44:23.213 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Wake up interval capabilities report\r\n07:44:23.214 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Minimum interval = 60\r\n07:44:23.215 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Maximum interval = 86400\r\n07:44:23.215 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Default interval = 25200\r\n07:44:23.216 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Interval step    = 60\r\n07:44:23.217 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent\r\n07:44:23.219 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 84 09 \r\n07:44:23.221 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 0E 84 0A 00 00 3C 01 51 80 00 62 70 00 00 3C \r\n07:44:23.222 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:23.223 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n07:44:23.224 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n07:44:23.225 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - STATIC_VALUES: Transaction complete (SendData:Request) success(true)\r\n07:44:23.226 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 1.\r\n07:44:23.227 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 0.\r\n07:44:23.228 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - STATIC_VALUES: queue length(0), free to send(true)\r\n07:44:23.229 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - STATIC_VALUES try 1: stageAdvanced(false)\r\n07:44:23.230 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking BASIC\r\n07:44:23.231 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking CONFIGURATION\r\n07:44:23.232 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking VERSION\r\n07:44:23.233 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking ZWAVE_PLUS_INFO\r\n07:44:23.234 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - found    ZWAVE_PLUS_INFO\r\n07:44:23.235 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Found 1 instances of ZWAVE_PLUS_INFO\r\n07:44:23.236 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking ALARM\r\n07:44:23.237 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking NO_OPERATION\r\n07:44:23.238 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking MANUFACTURER_SPECIFIC\r\n07:44:23.239 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking POWERLEVEL\r\n07:44:23.240 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking BATTERY\r\n07:44:23.241 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking ASSOCIATION\r\n07:44:23.242 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - found    ASSOCIATION\r\n07:44:23.243 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Found 1 instances of ASSOCIATION\r\n07:44:23.244 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking WAKE_UP\r\n07:44:23.245 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - found    WAKE_UP\r\n07:44:23.245 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Found 1 instances of WAKE_UP\r\n07:44:23.246 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - checking DEVICE_RESET_LOCALLY\r\n07:44:23.247 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: STATIC_VALUES - queued 0 frames\r\n07:44:23.248 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:23.249 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:23.250 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to ASSOCIATIONS\r\n07:44:23.251 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - ASSOCIATIONS try 0: stageAdvanced(true)\r\n07:44:23.252 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: ASSOCIATIONS - thing is null!\r\n07:44:23.253 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:23.254 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:23.255 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to SET_WAKEUP\r\n07:44:23.256 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - SET_WAKEUP try 0: stageAdvanced(true)\r\n07:44:23.258 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: SET_WAKEUP - Set wakeup node to controller (1), period 25200\r\n07:44:23.259 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Creating new message for application command WAKE_UP_INTERVAL_SET to 25200\r\n07:44:23.261 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0D 00 13 0E 06 84 04 00 62 70 01 00 00 7A \r\n07:44:23.263 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Sending REQUEST Message = 01 0D 00 13 0E 06 84 04 00 62 70 01 00 00 7A \r\n07:44:23.264 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Creating new message for application command WAKE_UP_INTERVAL_GET\r\n07:44:23.265 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 2\r\n07:44:23.267 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 2\r\n07:44:23.268 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Response processed after 115ms/400ms.\r\n07:44:23.272 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1\r\n07:44:23.273 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0D 00 13 0E 06 84 04 00 62 70 01 25 79 26 \r\n07:44:23.274 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 0D 00 13 0E 06 84 04 00 62 70 01 25 79 26 \r\n07:44:23.283 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n07:44:23.287 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.288 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n07:44:23.290 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n07:44:23.291 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n07:44:23.292 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n07:44:23.305 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 79 00 00 03 91 \r\n07:44:23.309 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.311 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 79 00 00 03 00 00 9F \r\n07:44:23.312 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 79 00 00 03 00 00 9F \r\n07:44:23.314 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 79 00 00 03 \r\n07:44:23.315 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 121, Status = Transmission complete and ACK received(0)\r\n07:44:23.316 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 06 84 04 00 62 70 01 \r\n07:44:23.318 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 79 00 00 03 \r\n07:44:23.319 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=SendData, cancelled=false\r\n07:44:23.320 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n07:44:23.321 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n07:44:23.322 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - SET_WAKEUP: Transaction complete (SendData:Request) success(true)\r\n07:44:23.323 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 2.\r\n07:44:23.324 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 1.\r\n07:44:23.325 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - SET_WAKEUP: queue length(1), free to send(true)\r\n07:44:23.326 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 1\r\n07:44:23.327 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 2\r\n07:44:23.328 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Response processed after 53ms/400ms.\r\n07:44:23.329 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1\r\n07:44:23.330 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0E 02 84 05 25 7A 37 \r\n07:44:23.331 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 09 00 13 0E 02 84 05 25 7A 37 \r\n07:44:23.340 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n07:44:23.349 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.350 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n07:44:23.352 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n07:44:23.353 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n07:44:23.354 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n07:44:23.360 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 7A 00 00 02 93 \r\n07:44:23.364 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.365 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 7A 00 00 02 00 00 9D \r\n07:44:23.367 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 7A 00 00 02 00 00 9D \r\n07:44:23.368 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 7A 00 00 02 \r\n07:44:23.369 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 122, Status = Transmission complete and ACK received(0)\r\n07:44:23.371 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 84 05 \r\n07:44:23.372 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 7A 00 00 02 \r\n07:44:23.373 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:23.376 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 0E 06 84 06 00 62 70 01 6E \r\n07:44:23.379 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.381 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0C 00 04 00 0E 06 84 06 00 62 70 01 6E \r\n07:44:23.382 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0C 00 04 00 0E 06 84 06 00 62 70 01 6E \r\n07:44:23.384 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 06 84 06 00 62 70 01 \r\n07:44:23.385 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Application Command Request (ALIVE:SET_WAKEUP)\r\n07:44:23.386 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 14: Incoming command class WAKE_UP\r\n07:44:23.387 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Received Wake Up Request\r\n07:44:23.388 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Wake up interval report, value = 25200 seconds, targetNodeId = 1\r\n07:44:23.389 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent\r\n07:44:23.390 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 02 84 05 \r\n07:44:23.392 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0E 06 84 06 00 62 70 01 \r\n07:44:23.393 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:23.394 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n07:44:23.395 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n07:44:23.396 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - SET_WAKEUP: Transaction complete (SendData:Request) success(true)\r\n07:44:23.397 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 1.\r\n07:44:23.398 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - message removed from queue. Queue size 0.\r\n07:44:23.399 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - SET_WAKEUP: queue length(0), free to send(true)\r\n07:44:23.400 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - SET_WAKEUP try 1: stageAdvanced(false)\r\n07:44:23.401 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: SET_WAKEUP - TargetNode is set to controller\r\n07:44:23.402 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:23.403 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:23.404 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to SET_ASSOCIATION\r\n07:44:23.405 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - SET_ASSOCIATION try 0: stageAdvanced(true)\r\n07:44:23.406 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: SET_ASSOCIATION - thing is null!\r\n07:44:23.407 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:23.408 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:23.409 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to GET_CONFIGURATION\r\n07:44:23.410 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - GET_CONFIGURATION try 0: stageAdvanced(true)\r\n07:44:23.411 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: GET_CONFIGURATION - thing is null!\r\n07:44:23.412 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:23.413 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:23.414 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to STATIC_END\r\n07:44:23.415 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - STATIC_END try 0: stageAdvanced(true)\r\n07:44:23.416 [DEBUG] [l.initialization.ZWaveNodeSerializer] - NODE 14: Serialise aborted as static stages not complete\r\n07:44:23.417 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:23.418 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:23.419 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to SESSION_START\r\n07:44:23.420 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - SESSION_START try 0: stageAdvanced(true)\r\n07:44:23.421 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveInitializationStateEvent\r\n07:44:23.422 [DEBUG] [g.zwave.internal.ZWaveNetworkMonitor] - NODE 14: Network initialised - starting network monitor.\r\n07:44:23.423 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - advancing to DYNAMIC_VALUES\r\n07:44:23.424 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: loop - DYNAMIC_VALUES try 0: stageAdvanced(true)\r\n07:44:23.425 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - checking BASIC\r\n07:44:23.426 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - checking CONFIGURATION\r\n07:44:23.427 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - checking VERSION\r\n07:44:23.428 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - checking ZWAVE_PLUS_INFO\r\n07:44:23.429 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - checking ALARM\r\n07:44:23.430 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - found    ALARM\r\n07:44:23.432 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Found 1 instances of ALARM\r\n07:44:23.433 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 14: Creating new message for application command ALARM_GET V3\r\n07:44:23.436 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - checking NO_OPERATION\r\n07:44:23.437 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - checking MANUFACTURER_SPECIFIC\r\n07:44:23.438 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - checking POWERLEVEL\r\n07:44:23.440 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - checking BATTERY\r\n07:44:23.441 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - found    BATTERY\r\n07:44:23.442 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Found 1 instances of BATTERY\r\n07:44:23.443 [DEBUG] [ommandclass.ZWaveBatteryCommandClass] - NODE 14: Creating new message for application command BATTERY_GET\r\n07:44:23.445 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - checking ASSOCIATION\r\n07:44:23.446 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - checking WAKE_UP\r\n07:44:23.447 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - checking DEVICE_RESET_LOCALLY\r\n07:44:23.448 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer: DYNAMIC_VALUES - queued 2 frames\r\n07:44:23.449 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 2\r\n07:44:23.450 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 2\r\n07:44:23.451 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Response processed after 120ms/400ms.\r\n07:44:23.452 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1\r\n07:44:23.453 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0C 00 13 0E 05 71 04 00 00 01 25 7B C1 \r\n07:44:23.454 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 0C 00 13 0E 05 71 04 00 00 01 25 7B C1 \r\n07:44:23.464 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n07:44:23.467 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.468 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n07:44:23.469 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n07:44:23.471 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n07:44:23.472 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n07:44:23.485 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 7B 00 00 03 93 \r\n07:44:23.492 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:23.494 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 7B 00 00 03 00 00 9D \r\n07:44:23.495 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 7B 00 00 03 00 00 9D \r\n07:44:23.497 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 7B 00 00 03 \r\n07:44:23.498 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 123, Status = Transmission complete and ACK received(0)\r\n07:44:23.501 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 05 71 04 00 00 01 \r\n07:44:23.502 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 7B 00 00 03 \r\n07:44:23.503 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:24.565 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 0A 03 20 01 00 DA \r\n07:44:24.567 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:24.569 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 04 00 0A 03 20 01 00 DA \r\n07:44:24.571 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 04 00 0A 03 20 01 00 DA \r\n07:44:24.573 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationCommandHandler (0x04), type = Request (0x00), payload = 00 0A 03 20 01 00 \r\n07:44:24.574 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 10: Application Command Request (ALIVE:DETAILS)\r\n07:44:24.576 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 10: Incoming command class BASIC\r\n07:44:24.577 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 10: Received Basic Request\r\n07:44:24.578 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 10: Basic Set sent to the controller will be processed as Basic Report\r\n07:44:24.579 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 10: Basic report, value = 0x00\r\n07:44:24.580 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent\r\n07:44:24.581 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 10: Got an event from Z-Wave network: ZWaveCommandClassValueEvent\r\n07:44:24.583 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 10: Got a value event from Z-Wave network, endpoint = 0, command class = BASIC, value = 0\r\n07:44:24.584 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 10: Checking channel zwave:aeon_zw089_00_000:1533f07f1de:node10:alarm_general\r\n07:44:24.585 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 10: Checking channel zwave:aeon_zw089_00_000:1533f07f1de:node10:alarm_general\r\n07:44:24.586 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 10: Checking channel zwave:aeon_zw089_00_000:1533f07f1de:node10:battery-level\r\n07:44:24.588 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 10: Checking channel zwave:aeon_zw089_00_000:1533f07f1de:node10:battery-level\r\n07:44:24.590 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 10: Checking channel zwave:aeon_zw089_00_000:1533f07f1de:node10:sensor_binary\r\n07:44:24.592 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 10: Checking channel zwave:aeon_zw089_00_000:1533f07f1de:node10:sensor_binary\r\n07:44:24.594 [DEBUG] [ssage.ApplicationCommandMessageClass] - Transaction not completed: node address inconsistent.\r\n07:44:28.455 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Timeout while sending message. Requeueing - 2 attempts left!\r\n07:44:28.457 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Is sleeping\r\n07:44:28.457 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Putting message SendData in wakeup queue.\r\n07:44:28.458 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0\r\n07:44:28.459 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 00 60 0E 95 \r\n07:44:28.460 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 04 00 60 0E 95 \r\n07:44:28.470 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 60 01 9B \r\n07:44:28.473 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:28.475 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 60 01 9B \r\n07:44:28.477 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 60 01 9B \r\n07:44:28.479 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = RequestNodeInfo (0x60), type = Response (0x01), payload = 01 \r\n07:44:28.480 [DEBUG] [lmessage.RequestNodeInfoMessageClass] - Request node info successfully placed on stack.\r\n07:44:28.482 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = RequestNodeInfo (0x60), type = Request (0x00), payload = 0E \r\n07:44:28.484 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = RequestNodeInfo (0x60), type = Response (0x01), payload = 01 \r\n07:44:28.486 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=RequestNodeInfo, expected=ApplicationUpdate, cancelled=false\r\n07:44:28.511 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n07:44:28.517 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:28.520 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n07:44:28.523 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 15 00 49 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A 04 \r\n07:44:28.526 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = ApplicationUpdate (0x49), type = Request (0x00), payload = 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A \r\n07:44:28.531 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 14: Application update request. Node information received.\r\n07:44:28.535 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ZWAVE_PLUS_INFO\r\n07:44:28.538 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ZWAVE_PLUS_INFO, endpoint null created\r\n07:44:28.541 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class VERSION\r\n07:44:28.543 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class VERSION, endpoint null created\r\n07:44:28.545 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class MANUFACTURER_SPECIFIC\r\n07:44:28.547 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class MANUFACTURER_SPECIFIC, endpoint null created\r\n07:44:28.548 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class DEVICE_RESET_LOCALLY\r\n07:44:28.550 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class DEVICE_RESET_LOCALLY, endpoint null created\r\n07:44:28.551 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class POWERLEVEL\r\n07:44:28.553 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class POWERLEVEL, endpoint null created\r\n07:44:28.554 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class BATTERY\r\n07:44:28.555 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class BATTERY, endpoint null created\r\n07:44:28.557 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class CONFIGURATION\r\n07:44:28.558 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class CONFIGURATION, endpoint null created\r\n07:44:28.560 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ALARM\r\n07:44:28.561 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ALARM, endpoint null created\r\n07:44:28.562 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class ASSOCIATION\r\n07:44:28.564 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class ASSOCIATION, endpoint null created\r\n07:44:28.565 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Unsupported command class ASSOCIATION_GROUP_INFO\r\n07:44:28.567 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Creating new instance of command class WAKE_UP\r\n07:44:28.568 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Command class WAKE_UP, endpoint null created\r\n07:44:28.575 [WARN ] [tocol.commandclass.ZWaveCommandClass] - NODE 14: Unsupported command class FIRMWARE_UPDATE_MD\r\n07:44:28.580 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Is awake with 1 messages in the wake-up queue.\r\n07:44:28.583 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent\r\n07:44:28.586 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Wakeup during initialisation.\r\n07:44:28.589 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - DYNAMIC_VALUES: queue length(2), free to send(false)\r\n07:44:28.591 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - queued packet. Queue length is 2\r\n07:44:28.593 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 1\r\n07:44:28.594 [DEBUG] [ve.internal.protocol.ZWaveController] - Enqueueing message. Queue length = 2\r\n07:44:28.595 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = RequestNodeInfo (0x60), type = Request (0x00), payload = 0E \r\n07:44:28.597 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = ApplicationUpdate (0x49), type = Request (0x00), payload = 84 0E 0F 04 07 01 5E 86 72 5A 73 80 70 71 85 59 84 7A \r\n07:44:28.598 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationUpdate, expected=ApplicationUpdate, cancelled=false\r\n07:44:28.599 [DEBUG] [.serialmessage.ZWaveCommandProcessor] -          transaction complete!\r\n07:44:28.600 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent\r\n07:44:28.601 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - DYNAMIC_VALUES: Transaction complete (RequestNodeInfo:Request) success(true)\r\n07:44:28.601 [DEBUG] [nitialization.ZWaveNodeStageAdvancer] - NODE 14: Node advancer - checking initialisation queue. Queue size 2.\r\n07:44:28.603 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Response processed after 142ms/400ms.\r\n07:44:28.604 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1\r\n07:44:28.605 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0C 00 13 0E 05 71 04 00 00 01 25 7D C7 \r\n07:44:28.606 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 14: Sending REQUEST Message = 01 0C 00 13 0E 05 71 04 00 00 01 25 7D C7 \r\n07:44:28.616 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 \r\n07:44:28.617 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:28.618 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 \r\n07:44:28.619 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 \r\n07:44:28.620 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Response (0x01), payload = 01 \r\n07:44:28.621 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: Sent Data successfully placed on stack.\r\n07:44:28.637 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 7D 00 00 03 95 \r\n07:44:28.639 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0\r\n07:44:28.640 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 7D 00 00 03 00 00 9B \r\n07:44:28.641 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 7D 00 00 03 00 00 9B \r\n07:44:28.642 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class = SendData (0x13), type = Request (0x00), payload = 7D 00 00 03 \r\n07:44:28.643 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 14: SendData Request. CallBack ID = 125, Status = Transmission complete and ACK received(0)\r\n07:44:28.644 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Sent message Message: class = SendData (0x13), type = Request (0x00), payload = 0E 05 71 04 00 00 01 \r\n07:44:28.644 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Recv message Message: class = SendData (0x13), type = Request (0x00), payload = 7D 00 00 03 \r\n07:44:28.645 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, expected=ApplicationCommandHandler, cancelled=false\r\n07:44:33.608 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 14: Timeout while sending message. Requeueing - 1 attempts left!\r\n07:44:33.609 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Is sleeping\r\n07:44:33.610 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Putting message SendData in wakeup queue.\r\n07:44:33.611 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0\r\n07:44:33.611 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Message already on the wake-up queue. Removing original.\r\n07:44:33.612 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 14: Putting message SendData in wakeup queue.\r\n07:45:11.637 [INFO ] [smarthome.event.InboxRemovedEvent   ] - Discovery Result with UID 'zwave:unknown:1533f07f1de:node14' has been removed.\r\n07:45:11.644 [INFO ] [smarthome.event.ThingAddedEvent     ] - Thing 'zwave:unknown:1533f07f1de:node14' has been added.\r\n07:45:11.661 [DEBUG] [org.openhab.binding.zwave           ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandler}={thing.type=zwave:unknown, thing.id=zwave:unknown:1533f07f1de:node14, service.id=287, service.bundleid=156, service.scope=singleton} - org.openhab.binding.zwave\r\n07:45:11.676 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'zwave:unknown:1533f07f1de:node14' changed from UNINITIALIZED to INITIALIZING\r\n07:45:11.677 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler.\r\n07:45:11.680 [ERROR] [ding.zwave.handler.ZWaveThingHandler] - NodeID is not set in zwave:unknown:1533f07f1de:node14\r\n07:45:11.773 [INFO ] [smarthome.event.ItemAddedEvent      ] - Item 'zwave_unknown_1533f07f1de_node14' has been added.\r\n07:45:11.848 [INFO ] [rthome.event.ItemThingLinkAddedEvent] - Link 'zwave_unknown_1533f07f1de_node14-zwave:unknown:1533f07f1de:node14' has been added.\r\n`"},"comment":{"url":"https://api.github.com/repos/openhab/openhab2-addons/issues/comments/208992415","html_url":"https://github.com/openhab/openhab2-addons/issues/703#issuecomment-208992415","issue_url":"https://api.github.com/repos/openhab/openhab2-addons/issues/703","id":208992415,"user":{"login":"cdjackson","id":1041475,"avatar_url":"https://avatars.githubusercontent.com/u/1041475?v=3","gravatar_id":"","url":"https://api.github.com/users/cdjackson","html_url":"https://github.com/cdjackson","followers_url":"https://api.github.com/users/cdjackson/followers","following_url":"https://api.github.com/users/cdjackson/following{/other_user}","gists_url":"https://api.github.com/users/cdjackson/gists{/gist_id}","starred_url":"https://api.github.com/users/cdjackson/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/cdjackson/subscriptions","organizations_url":"https://api.github.com/users/cdjackson/orgs","repos_url":"https://api.github.com/users/cdjackson/repos","events_url":"https://api.github.com/users/cdjackson/events{/privacy}","received_events_url":"https://api.github.com/users/cdjackson/received_events","type":"User","site_admin":false},"created_at":"2016-04-12T16:29:32Z","updated_at":"2016-04-12T16:29:32Z","body":"Yes - we can still add devices to the OH1 binding - although of course we can’t add them to 1.8.2 :)"}}