tail -f /var/log/openhab2/openhab.log /var/log/openhab2/events.log zwave 2020-11-21 10:14:11.878 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_SWITCH_BINARY V1 SWITCH_BINARY_REPORT 2020-11-21 10:14:11.880 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 3: Switch Binary report, value = 0 2020-11-21 10:14:11.883 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveCommandClassValueEvent 2020-11-21 10:14:11.886 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=3, command class=COMMAND_CLASS_SWITCH_BINARY, value=0 2020-11-21 10:14:11.889 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:16f41b43916:node3:switch_binary3 to OFF [OnOffType] 2020-11-21 10:14:11.895 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:14:11.897 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@c85c7d. 2020-11-21 10:14:11.901 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@c85c7d. 2020-11-21 10:14:11.904 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: notifyTransactionResponse TID:17412 DONE 2020-11-21 10:14:11.909 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2020-11-21 10:14:11.912 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2020-11-21 10:14:11.915 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:14:11.917 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:14:11.920 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:18:59.688 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 02 06 31 05 03 0A 07 D0 19 2020-11-21 10:18:59.694 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 06 31 05 03 0A 07 D0 2020-11-21 10:18:59.698 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 06 31 05 03 0A 07 D0 2020-11-21 10:18:59.699 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:18:59.701 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE) 2020-11-21 10:18:59.704 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false 2020-11-21 10:18:59.707 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0 2020-11-21 10:18:59.710 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY not supported 2020-11-21 10:18:59.712 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SENSOR_MULTILEVEL V4 SENSOR_MULTILEVEL_REPORT 2020-11-21 10:18:59.715 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Type = Luminance(3), Scale = 1 2020-11-21 10:18:59.718 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Value = 2.00E+3 2020-11-21 10:18:59.721 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent 2020-11-21 10:18:59.724 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SENSOR_MULTILEVEL, value=2.00E+3 2020-11-21 10:18:59.728 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:16f41b43916:node2:sensor_luminance to 2.00E+3 % [QuantityType] 2020-11-21 10:18:59.731 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1. 2020-11-21 10:18:59.734 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@172218d. 2020-11-21 10:18:59.737 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:18:59.738 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:18:59.740 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:18:59.742 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:19:00.347 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 04 0A 60 0D 02 01 31 05 03 0A 07 D0 61 2020-11-21 10:19:00.351 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 0A 60 0D 02 01 31 05 03 0A 07 D0 2020-11-21 10:19:00.354 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 0A 60 0D 02 01 31 05 03 0A 07 D0 2020-11-21 10:19:00.356 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:19:00.358 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:DONE) 2020-11-21 10:19:00.360 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: resetResendCount initComplete=true isDead=false 2020-11-21 10:19:00.362 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL 2020-11-21 10:19:00.363 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 2 2020-11-21 10:19:00.366 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported 2020-11-21 10:19:00.367 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_SENSOR_MULTILEVEL V4 SENSOR_MULTILEVEL_REPORT 2020-11-21 10:19:00.369 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 4: Sensor Type = Luminance(3), Scale = 1 2020-11-21 10:19:00.371 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 4: Sensor Value = 2.00E+3 2020-11-21 10:19:00.373 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent 2020-11-21 10:19:00.375 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint=2, command class=COMMAND_CLASS_SENSOR_MULTILEVEL, value=2.00E+3 2020-11-21 10:19:00.378 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Updating channel state zwave:device:16f41b43916:node4:sensor_luminance2 to 2.00E+3 % [QuantityType] 2020-11-21 10:19:00.381 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1. 2020-11-21 10:19:00.385 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@13ca131. 2020-11-21 10:19:00.387 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:19:00.390 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:19:00.392 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:19:00.395 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:20:25.894 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0F 00 04 00 03 09 71 05 00 00 00 FF 07 08 00 7A 2020-11-21 10:20:25.910 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 09 71 05 00 00 00 FF 07 08 00 2020-11-21 10:20:25.924 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 09 71 05 00 00 00 FF 07 08 00 2020-11-21 10:20:25.927 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:20:25.931 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE) 2020-11-21 10:20:25.934 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:20:25.937 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2020-11-21 10:20:25.940 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:20:25.943 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2020-11-21 10:20:25.946 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 3: NOTIFICATION report - 0 = 0, event=8, status=255, plen=0 2020-11-21 10:20:25.948 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 3: Alarm Type = BURGLAR (0) 2020-11-21 10:20:25.951 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2020-11-21 10:20:25.954 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_ALARM, value=255 2020-11-21 10:20:25.957 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter processing NOTIFICATION 2020-11-21 10:20:25.960 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 8, type OnOffType 2020-11-21 10:20:25.963 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter processing NOTIFICATION 2020-11-21 10:20:25.966 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 8, type OnOffType 2020-11-21 10:20:25.969 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 8, channel alarm_system is not implemented. 2020-11-21 10:20:25.972 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:20:25.975 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1a0052a. 2020-11-21 10:20:25.978 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:20:25.981 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:20:25.984 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:20:25.987 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:20:38.904 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 03 0A 71 05 00 00 00 FF 07 00 01 08 67 2020-11-21 10:20:38.918 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 0A 71 05 00 00 00 FF 07 00 01 08 2020-11-21 10:20:38.924 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 0A 71 05 00 00 00 FF 07 00 01 08 2020-11-21 10:20:38.927 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:20:38.930 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE) 2020-11-21 10:20:38.934 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:20:38.944 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2020-11-21 10:20:38.947 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:20:38.950 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2020-11-21 10:20:38.952 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 3: NOTIFICATION report - 0 = 0, event=0, status=255, plen=1 2020-11-21 10:20:38.957 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 3: Alarm Type = BURGLAR (0) 2020-11-21 10:20:38.960 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2020-11-21 10:20:38.963 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_ALARM, value=255 2020-11-21 10:20:38.967 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter processing NOTIFICATION 2020-11-21 10:20:38.969 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 0, type OnOffType 2020-11-21 10:20:38.973 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:16f41b43916:node3:alarm_burglar to OFF [OnOffType] 2020-11-21 10:20:38.978 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter processing NOTIFICATION 2020-11-21 10:20:38.983 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 0, type OnOffType 2020-11-21 10:20:38.988 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 0, channel alarm_system is not implemented. 2020-11-21 10:20:38.993 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:20:38.995 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1179f17. 2020-11-21 10:20:38.998 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:20:39.001 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:20:39.003 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:20:39.006 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:22:19.099 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Command received zwave:device:16f41b43916:node3:switch_binary --> ON [OnOffType] 2020-11-21 10:22:19.101 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 3: Creating new message for application command SWITCH_BINARY_SET 2020-11-21 10:22:19.103 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:19.105 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Command Class COMMAND_CLASS_SWITCH_BINARY is NOT required to be secured 2020-11-21 10:22:19.107 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Adding to device queue 2020-11-21 10:22:19.109 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Added 17413 to queue - size 1 2020-11-21 10:22:19.110 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:22:19.117 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 3: Sending REQUEST Message = 01 0A 00 13 03 03 25 01 FF 25 88 90 2020-11-21 10:22:19.119 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT 2020-11-21 10:22:19.121 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 17413: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 136 2020-11-21 10:22:19.122 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2020-11-21 10:22:19.123 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling initialised at 1800 seconds - start in 1500 milliseconds. 2020-11-21 10:22:19.124 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:19.129 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:19.130 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 2020-11-21 10:22:19.131 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17413: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 136 2020-11-21 10:22:19.132 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK 2020-11-21 10:22:19.134 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:19.136 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:19.138 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:19.150 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:19.152 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17413: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 136 2020-11-21 10:22:19.153 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:19.155 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17413: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 136 2020-11-21 10:22:19.158 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:19.162 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 17413: Advanced to WAIT_REQUEST 2020-11-21 10:22:19.165 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17413: Transaction not completed 2020-11-21 10:22:19.166 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:19.168 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:19.270 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 88 00 00 0F 6C 2020-11-21 10:22:19.275 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=136, payload=88 00 00 0F 2020-11-21 10:22:19.277 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=136, payload=88 00 00 0F 2020-11-21 10:22:19.279 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17413: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 136 2020-11-21 10:22:19.280 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:19.282 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17413: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 136 2020-11-21 10:22:19.284 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 17413: (Callback 136) 2020-11-21 10:22:19.286 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match! 2020-11-21 10:22:19.288 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 17413: callback 136 2020-11-21 10:22:19.290 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=136, payload=88 00 00 0F 2020-11-21 10:22:19.294 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:19.296 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 17413: Transaction COMPLETED 2020-11-21 10:22:19.298 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Response processed after 177ms 2020-11-21 10:22:19.300 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17413: Transaction completed 2020-11-21 10:22:19.302 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: notifyTransactionResponse TID:17413 DONE 2020-11-21 10:22:19.304 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2020-11-21 10:22:19.306 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:19.307 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:22:19.400 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 03 03 25 03 FF 2B 2020-11-21 10:22:19.404 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 03 25 03 FF 2020-11-21 10:22:19.407 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 03 25 03 FF 2020-11-21 10:22:19.408 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:22:19.411 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE) 2020-11-21 10:22:19.412 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:19.415 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_SWITCH_BINARY, endpoint 0 2020-11-21 10:22:19.416 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:19.418 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_SWITCH_BINARY V1 SWITCH_BINARY_REPORT 2020-11-21 10:22:19.420 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 3: Switch Binary report, value = 255 2020-11-21 10:22:19.422 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveCommandClassValueEvent 2020-11-21 10:22:19.423 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SWITCH_BINARY, value=255 2020-11-21 10:22:19.426 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:16f41b43916:node3:switch_binary to ON [OnOffType] 2020-11-21 10:22:19.429 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:22:19.431 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@121beb1. 2020-11-21 10:22:19.433 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:22:19.435 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:22:19.437 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:19.438 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:22:20.624 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling... 2020-11-21 10:22:20.627 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:16f41b43916:node3:switch_binary 2020-11-21 10:22:20.630 [DEBUG] [converter.ZWaveBinarySwitchConverter] - NODE 3: Generating poll message for COMMAND_CLASS_SWITCH_BINARY, endpoint 0 2020-11-21 10:22:20.633 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 3: Creating new message for application command SWITCH_BINARY_GET 2020-11-21 10:22:20.636 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:20.638 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Command Class COMMAND_CLASS_SWITCH_BINARY is NOT required to be secured 2020-11-21 10:22:20.642 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling skipped for zwave:device:16f41b43916:node3:switch_binary on COMMAND_CLASS_BASIC 2020-11-21 10:22:20.645 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:16f41b43916:node3:alarm_burglar 2020-11-21 10:22:20.648 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:16f41b43916:node3:alarm_system 2020-11-21 10:22:20.650 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:16f41b43916:node3:alarm_motion1 2020-11-21 10:22:20.653 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling skipped for zwave:device:16f41b43916:node3:alarm_motion1 on COMMAND_CLASS_BASIC 2020-11-21 10:22:20.656 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:16f41b43916:node3:sensor_luminance2 2020-11-21 10:22:20.659 [DEBUG] [erter.ZWaveMultiLevelSensorConverter] - NODE 3: Generating poll message for COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 2 2020-11-21 10:22:20.662 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 3: Creating new message for command SENSOR_MULTILEVEL_GET 2020-11-21 10:22:20.665 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Encapsulating message, instance / endpoint 2 2020-11-21 10:22:20.667 [DEBUG] [class.ZWaveMultiInstanceCommandClass] - NODE 3: Creating new message for command MULTI_CHANNEL_ENCAP endpoint 2 2020-11-21 10:22:20.670 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:20.673 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Command Class COMMAND_CLASS_MULTI_CHANNEL is NOT required to be secured 2020-11-21 10:22:20.676 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling skipped for zwave:device:16f41b43916:node3:sensor_luminance2 on COMMAND_CLASS_BASIC 2020-11-21 10:22:20.679 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:16f41b43916:node3:switch_binary3 2020-11-21 10:22:20.682 [DEBUG] [converter.ZWaveBinarySwitchConverter] - NODE 3: Generating poll message for COMMAND_CLASS_SWITCH_BINARY, endpoint 3 2020-11-21 10:22:20.685 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 3: Creating new message for application command SWITCH_BINARY_GET 2020-11-21 10:22:20.688 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Encapsulating message, instance / endpoint 3 2020-11-21 10:22:20.691 [DEBUG] [class.ZWaveMultiInstanceCommandClass] - NODE 3: Creating new message for command MULTI_CHANNEL_ENCAP endpoint 3 2020-11-21 10:22:20.694 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:20.697 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Command Class COMMAND_CLASS_MULTI_CHANNEL is NOT required to be secured 2020-11-21 10:22:20.700 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling skipped for zwave:device:16f41b43916:node3:switch_binary3 on COMMAND_CLASS_BASIC 2020-11-21 10:22:20.703 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Adding to device queue 2020-11-21 10:22:20.706 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Added 17414 to queue - size 1 2020-11-21 10:22:20.709 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:22:20.720 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 3: Sending REQUEST Message = 01 09 00 13 03 02 25 02 25 89 6F 2020-11-21 10:22:20.723 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT 2020-11-21 10:22:20.726 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 17414: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 137 2020-11-21 10:22:20.727 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2020-11-21 10:22:20.730 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:20.730 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Adding to device queue 2020-11-21 10:22:20.733 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Added 17415 to queue - size 1 2020-11-21 10:22:20.736 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 2020-11-21 10:22:20.737 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:20.740 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Adding to device queue 2020-11-21 10:22:20.741 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:20.744 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Added 17416 to queue - size 2 2020-11-21 10:22:20.747 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:20.744 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17414: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 137 2020-11-21 10:22:20.747 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:20.749 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK 2020-11-21 10:22:20.753 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:20.755 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17414: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 137 2020-11-21 10:22:20.758 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:20.761 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17414: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 137 2020-11-21 10:22:20.764 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:20.769 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 17414: Advanced to WAIT_REQUEST 2020-11-21 10:22:20.772 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17414: Transaction not completed 2020-11-21 10:22:20.774 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:20.776 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:20.873 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 89 00 00 0E 6C 2020-11-21 10:22:20.878 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=137, payload=89 00 00 0E 2020-11-21 10:22:20.880 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=137, payload=89 00 00 0E 2020-11-21 10:22:20.882 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17414: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 137 2020-11-21 10:22:20.884 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:20.886 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17414: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 137 2020-11-21 10:22:20.887 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 17414: (Callback 137) 2020-11-21 10:22:20.889 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match! 2020-11-21 10:22:20.891 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 17414: callback 137 2020-11-21 10:22:20.893 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=137, payload=89 00 00 0E 2020-11-21 10:22:20.897 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:20.898 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 17414: Advanced to WAIT_DATA 2020-11-21 10:22:20.900 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17414: Transaction not completed 2020-11-21 10:22:20.901 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:20.903 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:21.001 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 03 03 25 03 FF 2B 2020-11-21 10:22:21.006 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 03 25 03 FF 2020-11-21 10:22:21.008 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 03 25 03 FF 2020-11-21 10:22:21.010 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:22:21.012 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE) 2020-11-21 10:22:21.014 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:21.015 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_SWITCH_BINARY, endpoint 0 2020-11-21 10:22:21.017 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:21.019 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_SWITCH_BINARY V1 SWITCH_BINARY_REPORT 2020-11-21 10:22:21.020 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 3: Switch Binary report, value = 255 2020-11-21 10:22:21.022 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveCommandClassValueEvent 2020-11-21 10:22:21.024 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SWITCH_BINARY, value=255 2020-11-21 10:22:21.027 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:16f41b43916:node3:switch_binary to ON [OnOffType] 2020-11-21 10:22:21.030 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:22:21.031 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1fcbdcd. 2020-11-21 10:22:21.034 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1fcbdcd. 2020-11-21 10:22:21.035 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: notifyTransactionResponse TID:17414 DONE 2020-11-21 10:22:21.038 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2020-11-21 10:22:21.040 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2020-11-21 10:22:21.042 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:22:21.043 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:21.049 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:22:21.056 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 3: Sending REQUEST Message = 01 0D 00 13 03 06 60 0D 01 02 31 04 25 8A 10 2020-11-21 10:22:21.058 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT 2020-11-21 10:22:21.060 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 17415: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 138 2020-11-21 10:22:21.060 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2020-11-21 10:22:21.063 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:21.065 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:21.067 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 2020-11-21 10:22:21.067 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17415: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 138 2020-11-21 10:22:21.069 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK 2020-11-21 10:22:21.071 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:21.072 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:21.074 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:21.076 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:21.079 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17415: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 138 2020-11-21 10:22:21.081 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:21.083 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17415: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 138 2020-11-21 10:22:21.085 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:21.089 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 17415: Advanced to WAIT_REQUEST 2020-11-21 10:22:21.092 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17415: Transaction not completed 2020-11-21 10:22:21.093 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:21.096 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:21.272 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 8A 00 00 15 74 2020-11-21 10:22:21.275 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=138, payload=8A 00 00 15 2020-11-21 10:22:21.278 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=138, payload=8A 00 00 15 2020-11-21 10:22:21.280 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17415: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 138 2020-11-21 10:22:21.281 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:21.284 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17415: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 138 2020-11-21 10:22:21.285 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 17415: (Callback 138) 2020-11-21 10:22:21.288 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match! 2020-11-21 10:22:21.289 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 17415: callback 138 2020-11-21 10:22:21.292 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=138, payload=8A 00 00 15 2020-11-21 10:22:21.296 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:21.297 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 17415: Advanced to WAIT_DATA 2020-11-21 10:22:21.300 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17415: Transaction not completed 2020-11-21 10:22:21.301 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:21.303 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:21.413 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 03 0A 60 0D 00 01 31 05 03 0A 07 D0 64 2020-11-21 10:22:21.418 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 0A 60 0D 00 01 31 05 03 0A 07 D0 2020-11-21 10:22:21.423 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 0A 60 0D 00 01 31 05 03 0A 07 D0 2020-11-21 10:22:21.425 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:22:21.427 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE) 2020-11-21 10:22:21.430 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:21.431 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Decapsulating COMMAND_CLASS_MULTI_CHANNEL 2020-11-21 10:22:21.434 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0 2020-11-21 10:22:21.435 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:21.437 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_SENSOR_MULTILEVEL V4 SENSOR_MULTILEVEL_REPORT 2020-11-21 10:22:21.439 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 3: Sensor Type = Luminance(3), Scale = 1 2020-11-21 10:22:21.443 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 3: Sensor Value = 2.00E+3 2020-11-21 10:22:21.445 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent 2020-11-21 10:22:21.448 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SENSOR_MULTILEVEL, value=2.00E+3 2020-11-21 10:22:21.451 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:16f41b43916:node3:sensor_luminance to 2.00E+3 % [QuantityType] 2020-11-21 10:22:21.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:22:21.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5a63cd. 2020-11-21 10:22:21.457 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5a63cd. 2020-11-21 10:22:21.458 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: notifyTransactionResponse TID:17415 DONE 2020-11-21 10:22:21.461 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2020-11-21 10:22:21.463 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2020-11-21 10:22:21.466 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:22:21.468 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:21.470 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:22:21.476 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 3: Sending REQUEST Message = 01 0D 00 13 03 06 60 0D 01 03 25 02 25 8B 02 2020-11-21 10:22:21.477 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT 2020-11-21 10:22:21.480 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 17416: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 139 2020-11-21 10:22:21.481 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2020-11-21 10:22:21.484 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:21.487 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:21.488 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 2020-11-21 10:22:21.490 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17416: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 139 2020-11-21 10:22:21.493 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK 2020-11-21 10:22:21.494 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:21.496 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:21.499 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:21.502 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:21.505 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17416: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 139 2020-11-21 10:22:21.508 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:21.510 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17416: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 139 2020-11-21 10:22:21.513 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:21.520 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 17416: Advanced to WAIT_REQUEST 2020-11-21 10:22:21.524 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17416: Transaction not completed 2020-11-21 10:22:21.527 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:21.530 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:21.672 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 8B 00 00 13 73 2020-11-21 10:22:21.675 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=139, payload=8B 00 00 13 2020-11-21 10:22:21.678 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=139, payload=8B 00 00 13 2020-11-21 10:22:21.680 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17416: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 139 2020-11-21 10:22:21.681 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:21.683 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17416: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 139 2020-11-21 10:22:21.685 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 17416: (Callback 139) 2020-11-21 10:22:21.687 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match! 2020-11-21 10:22:21.688 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 17416: callback 139 2020-11-21 10:22:21.690 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=139, payload=8B 00 00 13 2020-11-21 10:22:21.694 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:21.696 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 17416: Advanced to WAIT_DATA 2020-11-21 10:22:21.697 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17416: Transaction not completed 2020-11-21 10:22:21.699 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:21.701 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:21.806 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0D 00 04 00 03 07 60 0D 03 01 25 03 FF 44 2020-11-21 10:22:21.810 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 07 60 0D 03 01 25 03 FF 2020-11-21 10:22:21.813 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 07 60 0D 03 01 25 03 FF 2020-11-21 10:22:21.815 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:22:21.816 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE) 2020-11-21 10:22:21.818 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:21.820 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Decapsulating COMMAND_CLASS_MULTI_CHANNEL 2020-11-21 10:22:21.822 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_SWITCH_BINARY, endpoint 3 2020-11-21 10:22:21.823 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:21.825 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_SWITCH_BINARY V1 SWITCH_BINARY_REPORT 2020-11-21 10:22:21.827 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 3: Switch Binary report, value = 255 2020-11-21 10:22:21.829 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveCommandClassValueEvent 2020-11-21 10:22:21.830 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=3, command class=COMMAND_CLASS_SWITCH_BINARY, value=255 2020-11-21 10:22:21.833 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:16f41b43916:node3:switch_binary3 to ON [OnOffType] 2020-11-21 10:22:21.836 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:22:21.843 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1baac76. 2020-11-21 10:22:21.845 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1baac76. 2020-11-21 10:22:21.847 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: notifyTransactionResponse TID:17416 DONE 2020-11-21 10:22:21.850 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2020-11-21 10:22:21.852 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2020-11-21 10:22:21.854 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:22:21.856 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:21.858 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:22:33.657 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Command received zwave:device:16f41b43916:node3:switch_binary --> OFF [OnOffType] 2020-11-21 10:22:33.660 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 3: Creating new message for application command SWITCH_BINARY_SET 2020-11-21 10:22:33.663 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:33.666 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Command Class COMMAND_CLASS_SWITCH_BINARY is NOT required to be secured 2020-11-21 10:22:33.668 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Adding to device queue 2020-11-21 10:22:33.671 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Added 17417 to queue - size 1 2020-11-21 10:22:33.674 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:22:33.683 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 3: Sending REQUEST Message = 01 0A 00 13 03 03 25 01 00 25 8C 6B 2020-11-21 10:22:33.686 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT 2020-11-21 10:22:33.689 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2020-11-21 10:22:33.689 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 17417: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 140 2020-11-21 10:22:33.693 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:33.694 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling initialised at 1800 seconds - start in 1500 milliseconds. 2020-11-21 10:22:33.696 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:33.699 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17417: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 140 2020-11-21 10:22:33.700 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 2020-11-21 10:22:33.701 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK 2020-11-21 10:22:33.703 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:33.703 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:33.704 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:33.707 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:33.708 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17417: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 140 2020-11-21 10:22:33.711 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:33.713 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17417: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 140 2020-11-21 10:22:33.716 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:33.720 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 17417: Advanced to WAIT_REQUEST 2020-11-21 10:22:33.722 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17417: Transaction not completed 2020-11-21 10:22:33.725 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:33.726 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:33.837 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 8C 00 00 0F 68 2020-11-21 10:22:33.840 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=140, payload=8C 00 00 0F 2020-11-21 10:22:33.842 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=140, payload=8C 00 00 0F 2020-11-21 10:22:33.844 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17417: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 140 2020-11-21 10:22:33.846 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:33.847 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17417: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 140 2020-11-21 10:22:33.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 17417: (Callback 140) 2020-11-21 10:22:33.852 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match! 2020-11-21 10:22:33.854 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 17417: callback 140 2020-11-21 10:22:33.856 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=140, payload=8C 00 00 0F 2020-11-21 10:22:33.860 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:33.862 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 17417: Transaction COMPLETED 2020-11-21 10:22:33.863 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Response processed after 174ms 2020-11-21 10:22:33.866 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17417: Transaction completed 2020-11-21 10:22:33.868 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: notifyTransactionResponse TID:17417 DONE 2020-11-21 10:22:33.870 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2020-11-21 10:22:33.872 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:33.874 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:22:33.969 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 03 03 25 03 00 D4 2020-11-21 10:22:33.972 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 03 25 03 00 2020-11-21 10:22:33.974 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 03 25 03 00 2020-11-21 10:22:33.976 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:22:33.978 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE) 2020-11-21 10:22:33.980 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:33.981 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_SWITCH_BINARY, endpoint 0 2020-11-21 10:22:33.983 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:33.985 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_SWITCH_BINARY V1 SWITCH_BINARY_REPORT 2020-11-21 10:22:33.987 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 3: Switch Binary report, value = 0 2020-11-21 10:22:33.988 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveCommandClassValueEvent 2020-11-21 10:22:33.990 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SWITCH_BINARY, value=0 2020-11-21 10:22:33.993 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:16f41b43916:node3:switch_binary to OFF [OnOffType] 2020-11-21 10:22:33.996 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:22:33.998 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1984886. 2020-11-21 10:22:34.001 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:22:34.002 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:22:34.005 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:34.006 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:22:35.194 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling... 2020-11-21 10:22:35.197 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:16f41b43916:node3:switch_binary 2020-11-21 10:22:35.200 [DEBUG] [converter.ZWaveBinarySwitchConverter] - NODE 3: Generating poll message for COMMAND_CLASS_SWITCH_BINARY, endpoint 0 2020-11-21 10:22:35.203 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 3: Creating new message for application command SWITCH_BINARY_GET 2020-11-21 10:22:35.206 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:35.209 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Command Class COMMAND_CLASS_SWITCH_BINARY is NOT required to be secured 2020-11-21 10:22:35.212 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling skipped for zwave:device:16f41b43916:node3:switch_binary on COMMAND_CLASS_BASIC 2020-11-21 10:22:35.215 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:16f41b43916:node3:alarm_burglar 2020-11-21 10:22:35.218 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:16f41b43916:node3:alarm_system 2020-11-21 10:22:35.221 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:16f41b43916:node3:alarm_motion1 2020-11-21 10:22:35.224 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling skipped for zwave:device:16f41b43916:node3:alarm_motion1 on COMMAND_CLASS_BASIC 2020-11-21 10:22:35.227 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:16f41b43916:node3:sensor_luminance2 2020-11-21 10:22:35.230 [DEBUG] [erter.ZWaveMultiLevelSensorConverter] - NODE 3: Generating poll message for COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 2 2020-11-21 10:22:35.232 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 3: Creating new message for command SENSOR_MULTILEVEL_GET 2020-11-21 10:22:35.235 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Encapsulating message, instance / endpoint 2 2020-11-21 10:22:35.238 [DEBUG] [class.ZWaveMultiInstanceCommandClass] - NODE 3: Creating new message for command MULTI_CHANNEL_ENCAP endpoint 2 2020-11-21 10:22:35.241 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:35.244 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Command Class COMMAND_CLASS_MULTI_CHANNEL is NOT required to be secured 2020-11-21 10:22:35.247 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling skipped for zwave:device:16f41b43916:node3:sensor_luminance2 on COMMAND_CLASS_BASIC 2020-11-21 10:22:35.250 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling zwave:device:16f41b43916:node3:switch_binary3 2020-11-21 10:22:35.253 [DEBUG] [converter.ZWaveBinarySwitchConverter] - NODE 3: Generating poll message for COMMAND_CLASS_SWITCH_BINARY, endpoint 3 2020-11-21 10:22:35.256 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 3: Creating new message for application command SWITCH_BINARY_GET 2020-11-21 10:22:35.258 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Encapsulating message, instance / endpoint 3 2020-11-21 10:22:35.261 [DEBUG] [class.ZWaveMultiInstanceCommandClass] - NODE 3: Creating new message for command MULTI_CHANNEL_ENCAP endpoint 3 2020-11-21 10:22:35.264 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:35.267 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Command Class COMMAND_CLASS_MULTI_CHANNEL is NOT required to be secured 2020-11-21 10:22:35.270 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Polling skipped for zwave:device:16f41b43916:node3:switch_binary3 on COMMAND_CLASS_BASIC 2020-11-21 10:22:35.273 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Adding to device queue 2020-11-21 10:22:35.275 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Added 17418 to queue - size 1 2020-11-21 10:22:35.278 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:22:35.287 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 3: Sending REQUEST Message = 01 09 00 13 03 02 25 02 25 8D 6B 2020-11-21 10:22:35.290 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT 2020-11-21 10:22:35.293 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2020-11-21 10:22:35.294 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 17418: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 141 2020-11-21 10:22:35.296 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:35.297 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Adding to device queue 2020-11-21 10:22:35.299 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:35.301 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Added 17419 to queue - size 1 2020-11-21 10:22:35.301 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 2020-11-21 10:22:35.302 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17418: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 141 2020-11-21 10:22:35.306 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:35.306 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK 2020-11-21 10:22:35.309 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Adding to device queue 2020-11-21 10:22:35.312 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:35.310 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:35.314 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Added 17420 to queue - size 2 2020-11-21 10:22:35.316 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:35.318 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:35.320 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:35.322 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17418: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 141 2020-11-21 10:22:35.324 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:35.325 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17418: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 141 2020-11-21 10:22:35.328 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:35.332 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 17418: Advanced to WAIT_REQUEST 2020-11-21 10:22:35.333 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17418: Transaction not completed 2020-11-21 10:22:35.335 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:35.336 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:35.440 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 8D 00 00 0F 69 2020-11-21 10:22:35.443 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=141, payload=8D 00 00 0F 2020-11-21 10:22:35.445 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=141, payload=8D 00 00 0F 2020-11-21 10:22:35.447 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17418: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 141 2020-11-21 10:22:35.449 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:35.450 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17418: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 141 2020-11-21 10:22:35.452 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 17418: (Callback 141) 2020-11-21 10:22:35.454 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match! 2020-11-21 10:22:35.456 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 17418: callback 141 2020-11-21 10:22:35.458 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=141, payload=8D 00 00 0F 2020-11-21 10:22:35.462 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:35.465 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 17418: Advanced to WAIT_DATA 2020-11-21 10:22:35.466 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17418: Transaction not completed 2020-11-21 10:22:35.468 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:35.469 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:35.570 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 03 03 25 03 00 D4 2020-11-21 10:22:35.573 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 03 25 03 00 2020-11-21 10:22:35.575 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 03 25 03 00 2020-11-21 10:22:35.577 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:22:35.579 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE) 2020-11-21 10:22:35.581 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:35.583 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_SWITCH_BINARY, endpoint 0 2020-11-21 10:22:35.584 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:35.587 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_SWITCH_BINARY V1 SWITCH_BINARY_REPORT 2020-11-21 10:22:35.588 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 3: Switch Binary report, value = 0 2020-11-21 10:22:35.591 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveCommandClassValueEvent 2020-11-21 10:22:35.592 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SWITCH_BINARY, value=0 2020-11-21 10:22:35.595 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:16f41b43916:node3:switch_binary to OFF [OnOffType] 2020-11-21 10:22:35.599 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:22:35.602 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@17c972d. 2020-11-21 10:22:35.603 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@17c972d. 2020-11-21 10:22:35.606 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: notifyTransactionResponse TID:17418 DONE 2020-11-21 10:22:35.608 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2020-11-21 10:22:35.610 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2020-11-21 10:22:35.611 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:22:35.613 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:35.615 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:22:35.621 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 3: Sending REQUEST Message = 01 0D 00 13 03 06 60 0D 01 02 31 04 25 8E 14 2020-11-21 10:22:35.623 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT 2020-11-21 10:22:35.624 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 17419: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 142 2020-11-21 10:22:35.626 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2020-11-21 10:22:35.628 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:35.630 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:35.631 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17419: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 142 2020-11-21 10:22:35.633 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 2020-11-21 10:22:35.634 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK 2020-11-21 10:22:35.636 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:35.636 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:35.637 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:35.640 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:35.642 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17419: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 142 2020-11-21 10:22:35.643 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:35.645 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17419: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 142 2020-11-21 10:22:35.647 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:35.651 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 17419: Advanced to WAIT_REQUEST 2020-11-21 10:22:35.653 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17419: Transaction not completed 2020-11-21 10:22:35.655 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:35.657 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:35.833 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 8E 00 00 14 71 2020-11-21 10:22:35.836 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=142, payload=8E 00 00 14 2020-11-21 10:22:35.837 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=142, payload=8E 00 00 14 2020-11-21 10:22:35.840 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17419: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 142 2020-11-21 10:22:35.841 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:35.843 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17419: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 142 2020-11-21 10:22:35.845 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 17419: (Callback 142) 2020-11-21 10:22:35.847 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match! 2020-11-21 10:22:35.849 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 17419: callback 142 2020-11-21 10:22:35.851 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=142, payload=8E 00 00 14 2020-11-21 10:22:35.855 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:35.857 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 17419: Advanced to WAIT_DATA 2020-11-21 10:22:35.859 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17419: Transaction not completed 2020-11-21 10:22:35.860 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:35.862 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:35.972 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 03 0A 60 0D 00 01 31 05 03 0A 07 D0 64 2020-11-21 10:22:35.976 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 0A 60 0D 00 01 31 05 03 0A 07 D0 2020-11-21 10:22:35.978 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 0A 60 0D 00 01 31 05 03 0A 07 D0 2020-11-21 10:22:35.981 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:22:35.982 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE) 2020-11-21 10:22:35.984 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:35.986 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Decapsulating COMMAND_CLASS_MULTI_CHANNEL 2020-11-21 10:22:35.988 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0 2020-11-21 10:22:35.990 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:35.992 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_SENSOR_MULTILEVEL V4 SENSOR_MULTILEVEL_REPORT 2020-11-21 10:22:35.993 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 3: Sensor Type = Luminance(3), Scale = 1 2020-11-21 10:22:35.996 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 3: Sensor Value = 2.00E+3 2020-11-21 10:22:35.997 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent 2020-11-21 10:22:36.000 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SENSOR_MULTILEVEL, value=2.00E+3 2020-11-21 10:22:36.002 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:16f41b43916:node3:sensor_luminance to 2.00E+3 % [QuantityType] 2020-11-21 10:22:36.005 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:22:36.007 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@d7de84. 2020-11-21 10:22:36.009 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@d7de84. 2020-11-21 10:22:36.010 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: notifyTransactionResponse TID:17419 DONE 2020-11-21 10:22:36.013 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2020-11-21 10:22:36.015 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2020-11-21 10:22:36.017 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:22:36.019 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:36.022 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:22:36.032 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 3: Sending REQUEST Message = 01 0D 00 13 03 06 60 0D 01 03 25 02 25 8F 06 2020-11-21 10:22:36.036 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT 2020-11-21 10:22:36.038 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2020-11-21 10:22:36.040 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 17420: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 143 2020-11-21 10:22:36.041 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:36.045 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2020-11-21 10:22:36.046 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 2020-11-21 10:22:36.048 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17420: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 143 2020-11-21 10:22:36.051 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK 2020-11-21 10:22:36.052 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:36.053 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:36.056 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:36.059 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:36.061 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17420: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 143 2020-11-21 10:22:36.063 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:36.065 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17420: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 143 2020-11-21 10:22:36.068 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2020-11-21 10:22:36.073 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 17420: Advanced to WAIT_REQUEST 2020-11-21 10:22:36.075 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17420: Transaction not completed 2020-11-21 10:22:36.077 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:36.079 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:36.233 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 8F 00 00 13 77 2020-11-21 10:22:36.235 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=143, payload=8F 00 00 13 2020-11-21 10:22:36.238 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=143, payload=8F 00 00 13 2020-11-21 10:22:36.239 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 17420: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 143 2020-11-21 10:22:36.241 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2020-11-21 10:22:36.242 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 17420: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 143 2020-11-21 10:22:36.243 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 17420: (Callback 143) 2020-11-21 10:22:36.245 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match! 2020-11-21 10:22:36.246 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 17420: callback 143 2020-11-21 10:22:36.248 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=143, payload=8F 00 00 13 2020-11-21 10:22:36.251 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:36.253 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 17420: Advanced to WAIT_DATA 2020-11-21 10:22:36.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: TID 17420: Transaction not completed 2020-11-21 10:22:36.255 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:36.257 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2020-11-21 10:22:36.367 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0D 00 04 00 03 07 60 0D 03 01 25 03 00 BB 2020-11-21 10:22:36.370 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 07 60 0D 03 01 25 03 00 2020-11-21 10:22:36.373 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 07 60 0D 03 01 25 03 00 2020-11-21 10:22:36.374 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:22:36.375 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE) 2020-11-21 10:22:36.376 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:22:36.378 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Decapsulating COMMAND_CLASS_MULTI_CHANNEL 2020-11-21 10:22:36.379 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_SWITCH_BINARY, endpoint 3 2020-11-21 10:22:36.380 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:22:36.382 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_SWITCH_BINARY V1 SWITCH_BINARY_REPORT 2020-11-21 10:22:36.383 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 3: Switch Binary report, value = 0 2020-11-21 10:22:36.385 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveCommandClassValueEvent 2020-11-21 10:22:36.386 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=3, command class=COMMAND_CLASS_SWITCH_BINARY, value=0 2020-11-21 10:22:36.388 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:16f41b43916:node3:switch_binary3 to OFF [OnOffType] 2020-11-21 10:22:36.391 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:22:36.394 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@e80074. 2020-11-21 10:22:36.395 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@e80074. 2020-11-21 10:22:36.396 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: notifyTransactionResponse TID:17420 DONE 2020-11-21 10:22:36.398 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2020-11-21 10:22:36.400 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2020-11-21 10:22:36.402 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:22:36.403 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:22:36.405 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:24:09.144 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0F 00 04 00 03 09 71 05 00 00 00 FF 07 08 00 7A 2020-11-21 10:24:09.157 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 09 71 05 00 00 00 FF 07 08 00 2020-11-21 10:24:09.163 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 09 71 05 00 00 00 FF 07 08 00 2020-11-21 10:24:09.166 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:24:09.169 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE) 2020-11-21 10:24:09.171 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:24:09.183 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2020-11-21 10:24:09.186 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:24:09.189 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2020-11-21 10:24:09.194 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 3: NOTIFICATION report - 0 = 0, event=8, status=255, plen=0 2020-11-21 10:24:09.198 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 3: Alarm Type = BURGLAR (0) 2020-11-21 10:24:09.201 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2020-11-21 10:24:09.204 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_ALARM, value=255 2020-11-21 10:24:09.207 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter processing NOTIFICATION 2020-11-21 10:24:09.209 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 8, type OnOffType 2020-11-21 10:24:09.212 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter processing NOTIFICATION 2020-11-21 10:24:09.215 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 8, type OnOffType 2020-11-21 10:24:09.217 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 8, channel alarm_system is not implemented. 2020-11-21 10:24:09.220 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:24:09.222 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@133a3d7. 2020-11-21 10:24:09.224 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:24:09.227 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:24:09.229 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:24:09.232 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:24:11.487 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0F 00 04 00 02 09 71 05 00 00 00 FF 07 08 00 7B 2020-11-21 10:24:11.495 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 09 71 05 00 00 00 FF 07 08 00 2020-11-21 10:24:11.499 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 09 71 05 00 00 00 FF 07 08 00 2020-11-21 10:24:11.502 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:24:11.504 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE) 2020-11-21 10:24:11.507 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false 2020-11-21 10:24:11.509 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2020-11-21 10:24:11.512 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY not supported 2020-11-21 10:24:11.514 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2020-11-21 10:24:11.516 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 2: NOTIFICATION report - 0 = 0, event=8, status=255, plen=0 2020-11-21 10:24:11.519 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 2: Alarm Type = BURGLAR (0) 2020-11-21 10:24:11.521 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2020-11-21 10:24:11.524 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_ALARM, value=255 2020-11-21 10:24:11.527 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 2: Alarm converter processing NOTIFICATION 2020-11-21 10:24:11.529 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 2: Alarm converter NOTIFICATION event is 8, type OnOffType 2020-11-21 10:24:11.532 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 2: Alarm converter processing NOTIFICATION 2020-11-21 10:24:11.534 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 2: Alarm converter NOTIFICATION event is 8, type OnOffType 2020-11-21 10:24:11.537 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 2: Alarm converter NOTIFICATION event is 8, channel alarm_system is not implemented. 2020-11-21 10:24:11.540 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1. 2020-11-21 10:24:11.542 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@219ea3. 2020-11-21 10:24:11.545 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:24:11.547 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:24:11.549 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:24:11.552 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:24:17.396 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 03 0A 71 05 00 00 00 FF 07 00 01 08 67 2020-11-21 10:24:17.404 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 0A 71 05 00 00 00 FF 07 00 01 08 2020-11-21 10:24:17.410 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 0A 71 05 00 00 00 FF 07 00 01 08 2020-11-21 10:24:17.413 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:24:17.417 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE) 2020-11-21 10:24:17.421 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:24:17.424 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2020-11-21 10:24:17.428 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:24:17.431 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2020-11-21 10:24:17.435 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 3: NOTIFICATION report - 0 = 0, event=0, status=255, plen=1 2020-11-21 10:24:17.438 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 3: Alarm Type = BURGLAR (0) 2020-11-21 10:24:17.442 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2020-11-21 10:24:17.446 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_ALARM, value=255 2020-11-21 10:24:17.450 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter processing NOTIFICATION 2020-11-21 10:24:17.453 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 0, type OnOffType 2020-11-21 10:24:17.457 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:16f41b43916:node3:alarm_burglar to OFF [OnOffType] 2020-11-21 10:24:17.463 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter processing NOTIFICATION 2020-11-21 10:24:17.466 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 0, type OnOffType 2020-11-21 10:24:17.469 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 0, channel alarm_system is not implemented. 2020-11-21 10:24:17.471 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:24:17.474 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@605e9d. 2020-11-21 10:24:17.476 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:24:17.478 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:24:17.480 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:24:17.483 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:24:18.688 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 02 0A 71 05 00 00 00 FF 07 00 01 08 66 2020-11-21 10:24:18.695 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 0A 71 05 00 00 00 FF 07 00 01 08 2020-11-21 10:24:18.700 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 0A 71 05 00 00 00 FF 07 00 01 08 2020-11-21 10:24:18.702 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:24:18.705 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE) 2020-11-21 10:24:18.707 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false 2020-11-21 10:24:18.710 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2020-11-21 10:24:18.712 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY not supported 2020-11-21 10:24:18.714 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2020-11-21 10:24:18.716 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 2: NOTIFICATION report - 0 = 0, event=0, status=255, plen=1 2020-11-21 10:24:18.719 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 2: Alarm Type = BURGLAR (0) 2020-11-21 10:24:18.722 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2020-11-21 10:24:18.724 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_ALARM, value=255 2020-11-21 10:24:18.728 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 2: Alarm converter processing NOTIFICATION 2020-11-21 10:24:18.730 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 2: Alarm converter NOTIFICATION event is 0, type OnOffType 2020-11-21 10:24:18.733 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:16f41b43916:node2:alarm_burglar to OFF [OnOffType] 2020-11-21 10:24:18.738 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 2: Alarm converter processing NOTIFICATION 2020-11-21 10:24:18.741 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 2: Alarm converter NOTIFICATION event is 0, type OnOffType 2020-11-21 10:24:18.744 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 2: Alarm converter NOTIFICATION event is 0, channel alarm_system is not implemented. 2020-11-21 10:24:18.746 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1. 2020-11-21 10:24:18.749 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@f10445. 2020-11-21 10:24:18.751 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:24:18.753 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:24:18.755 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:24:18.758 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:25:15.849 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0F 00 04 00 03 09 71 05 00 00 00 FF 07 08 00 7A 2020-11-21 10:25:15.858 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 09 71 05 00 00 00 FF 07 08 00 2020-11-21 10:25:15.863 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 09 71 05 00 00 00 FF 07 08 00 2020-11-21 10:25:15.866 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:25:15.869 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE) 2020-11-21 10:25:15.872 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:25:15.876 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2020-11-21 10:25:15.880 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:25:15.883 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2020-11-21 10:25:15.887 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 3: NOTIFICATION report - 0 = 0, event=8, status=255, plen=0 2020-11-21 10:25:15.891 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 3: Alarm Type = BURGLAR (0) 2020-11-21 10:25:15.895 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2020-11-21 10:25:15.899 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_ALARM, value=255 2020-11-21 10:25:15.904 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter processing NOTIFICATION 2020-11-21 10:25:15.906 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 8, type OnOffType 2020-11-21 10:25:15.910 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter processing NOTIFICATION 2020-11-21 10:25:15.918 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 8, type OnOffType 2020-11-21 10:25:15.922 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 8, channel alarm_system is not implemented. 2020-11-21 10:25:15.925 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:25:15.929 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@7c2cd7. 2020-11-21 10:25:15.932 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:25:15.934 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:25:15.936 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:25:15.939 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2020-11-21 10:25:25.397 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 03 0A 71 05 00 00 00 FF 07 00 01 08 67 2020-11-21 10:25:25.407 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 0A 71 05 00 00 00 FF 07 00 01 08 2020-11-21 10:25:25.411 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=3, callback=0, payload=00 03 0A 71 05 00 00 00 FF 07 00 01 08 2020-11-21 10:25:25.414 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2020-11-21 10:25:25.417 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Application Command Request (ALIVE:DONE) 2020-11-21 10:25:25.420 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: resetResendCount initComplete=true isDead=false 2020-11-21 10:25:25.422 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2020-11-21 10:25:25.425 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: SECURITY not supported 2020-11-21 10:25:25.428 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 3: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2020-11-21 10:25:25.431 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 3: NOTIFICATION report - 0 = 0, event=0, status=255, plen=1 2020-11-21 10:25:25.433 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 3: Alarm Type = BURGLAR (0) 2020-11-21 10:25:25.436 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2020-11-21 10:25:25.439 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_ALARM, value=255 2020-11-21 10:25:25.442 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter processing NOTIFICATION 2020-11-21 10:25:25.445 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 0, type OnOffType 2020-11-21 10:25:25.448 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 3: Updating channel state zwave:device:16f41b43916:node3:alarm_burglar to OFF [OnOffType] 2020-11-21 10:25:25.453 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter processing NOTIFICATION 2020-11-21 10:25:25.456 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 0, type OnOffType 2020-11-21 10:25:25.459 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 3: Alarm converter NOTIFICATION event is 0, channel alarm_system is not implemented. 2020-11-21 10:25:25.463 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Commands processed 1. 2020-11-21 10:25:25.466 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@4e74bd. 2020-11-21 10:25:25.468 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:25:25.471 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2020-11-21 10:25:25.473 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2020-11-21 10:25:25.476 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.