2018-11-25 21:55:53.651 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 10 06 0A 71 05 07 FF 00 FF 07 03 00 00 80 2018-11-25 21:55:53.655 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:53.657 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:53.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2018-11-25 21:55:53.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:STATIC_END) 2018-11-25 21:55:53.659 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2018-11-25 21:55:53.660 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_ALARM 2018-11-25 21:55:53.661 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2018-11-25 21:55:53.662 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: NOTIFICATION report - 7 = 255, event=3, status=255, plen=0 2018-11-25 21:55:53.663 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: Alarm Type = BURGLAR (7) 2018-11-25 21:55:53.664 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2018-11-25 21:55:53.665 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_ALARM, value = 255 2018-11-25 21:55:53.666 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter processing NOTIFICATION 2018-11-25 21:55:53.667 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter NOTIFICATION event is 3, type OpenClosedType 2018-11-25 21:55:53.668 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1. 2018-11-25 21:55:53.669 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1fb555a. 2018-11-25 21:55:53.670 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:53.671 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:53.671 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:55:53.672 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:55:54.061 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 10 06 0A 71 05 07 FF 00 FF 07 03 00 00 80 2018-11-25 21:55:54.065 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:54.067 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:54.068 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2018-11-25 21:55:54.069 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:STATIC_END) 2018-11-25 21:55:54.070 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2018-11-25 21:55:54.071 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_ALARM 2018-11-25 21:55:54.071 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2018-11-25 21:55:54.072 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: NOTIFICATION report - 7 = 255, event=3, status=255, plen=0 2018-11-25 21:55:54.073 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: Alarm Type = BURGLAR (7) 2018-11-25 21:55:54.074 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2018-11-25 21:55:54.075 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_ALARM, value = 255 2018-11-25 21:55:54.076 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter processing NOTIFICATION 2018-11-25 21:55:54.077 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter NOTIFICATION event is 3, type OpenClosedType 2018-11-25 21:55:54.078 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1. 2018-11-25 21:55:54.079 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@81ed37. 2018-11-25 21:55:54.080 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:54.081 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:54.082 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:55:54.083 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:55:54.108 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 10 06 0A 71 05 07 FF 00 FF 07 03 00 00 80 2018-11-25 21:55:54.111 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:54.113 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:54.114 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2018-11-25 21:55:54.114 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:STATIC_END) 2018-11-25 21:55:54.115 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2018-11-25 21:55:54.116 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_ALARM 2018-11-25 21:55:54.116 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2018-11-25 21:55:54.117 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: NOTIFICATION report - 7 = 255, event=3, status=255, plen=0 2018-11-25 21:55:54.118 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: Alarm Type = BURGLAR (7) 2018-11-25 21:55:54.119 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2018-11-25 21:55:54.119 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_ALARM, value = 255 2018-11-25 21:55:54.121 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter processing NOTIFICATION 2018-11-25 21:55:54.122 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter NOTIFICATION event is 3, type OpenClosedType 2018-11-25 21:55:54.122 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1. 2018-11-25 21:55:54.123 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@d5b3f8. 2018-11-25 21:55:54.124 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:54.125 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:54.126 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:55:54.127 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:55:54.251 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 10 06 0A 71 05 07 FF 00 FF 07 03 00 00 80 2018-11-25 21:55:54.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:54.256 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:54.257 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2018-11-25 21:55:54.257 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:STATIC_END) 2018-11-25 21:55:54.258 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2018-11-25 21:55:54.259 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_ALARM 2018-11-25 21:55:54.260 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2018-11-25 21:55:54.260 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: NOTIFICATION report - 7 = 255, event=3, status=255, plen=0 2018-11-25 21:55:54.261 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: Alarm Type = BURGLAR (7) 2018-11-25 21:55:54.262 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2018-11-25 21:55:54.263 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_ALARM, value = 255 2018-11-25 21:55:54.264 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter processing NOTIFICATION 2018-11-25 21:55:54.264 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter NOTIFICATION event is 3, type OpenClosedType 2018-11-25 21:55:54.265 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1. 2018-11-25 21:55:54.266 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@c5e7b7. 2018-11-25 21:55:54.267 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:54.267 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:54.268 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:55:54.269 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:55:54.563 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 10 06 0A 71 05 07 FF 00 FF 07 03 00 00 80 2018-11-25 21:55:54.566 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:54.568 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:54.569 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2018-11-25 21:55:54.570 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:STATIC_END) 2018-11-25 21:55:54.571 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2018-11-25 21:55:54.571 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_ALARM 2018-11-25 21:55:54.572 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2018-11-25 21:55:54.573 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: NOTIFICATION report - 7 = 255, event=3, status=255, plen=0 2018-11-25 21:55:54.574 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: Alarm Type = BURGLAR (7) 2018-11-25 21:55:54.575 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2018-11-25 21:55:54.575 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 10 06 0A 71 05 07 FF 00 FF 07 03 00 00 80 2018-11-25 21:55:54.575 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_ALARM, value = 255 2018-11-25 21:55:54.576 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter processing NOTIFICATION 2018-11-25 21:55:54.577 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter NOTIFICATION event is 3, type OpenClosedType 2018-11-25 21:55:54.578 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1. 2018-11-25 21:55:54.578 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:54.578 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1073cf0. 2018-11-25 21:55:54.579 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:54.580 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:54.581 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:54.582 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2018-11-25 21:55:54.583 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:STATIC_END) 2018-11-25 21:55:54.583 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2018-11-25 21:55:54.584 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_ALARM 2018-11-25 21:55:54.585 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2018-11-25 21:55:54.585 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: NOTIFICATION report - 7 = 255, event=3, status=255, plen=0 2018-11-25 21:55:54.586 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: Alarm Type = BURGLAR (7) 2018-11-25 21:55:54.587 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2018-11-25 21:55:54.588 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_ALARM, value = 255 2018-11-25 21:55:54.589 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter processing NOTIFICATION 2018-11-25 21:55:54.589 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter NOTIFICATION event is 3, type OpenClosedType 2018-11-25 21:55:54.590 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1. 2018-11-25 21:55:54.591 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@269c72. 2018-11-25 21:55:54.591 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:54.592 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:54.593 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:55:54.593 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:55:55.024 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 10 06 0A 71 05 07 FF 00 FF 07 03 00 00 80 2018-11-25 21:55:55.028 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:55.030 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:55.030 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2018-11-25 21:55:55.031 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:STATIC_END) 2018-11-25 21:55:55.032 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2018-11-25 21:55:55.033 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_ALARM 2018-11-25 21:55:55.033 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2018-11-25 21:55:55.034 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: NOTIFICATION report - 7 = 255, event=3, status=255, plen=0 2018-11-25 21:55:55.035 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: Alarm Type = BURGLAR (7) 2018-11-25 21:55:55.036 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2018-11-25 21:55:55.037 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_ALARM, value = 255 2018-11-25 21:55:55.038 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter processing NOTIFICATION 2018-11-25 21:55:55.039 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter NOTIFICATION event is 3, type OpenClosedType 2018-11-25 21:55:55.039 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1. 2018-11-25 21:55:55.040 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@151a13d. 2018-11-25 21:55:55.041 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:55.042 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:55.042 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:55:55.043 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:55:57.941 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 10 06 0A 71 05 07 00 00 FF 07 00 00 00 7C 2018-11-25 21:55:57.945 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 00 00 FF 07 00 00 00 2018-11-25 21:55:57.946 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 00 00 FF 07 00 00 00 2018-11-25 21:55:57.948 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2018-11-25 21:55:57.949 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:STATIC_END) 2018-11-25 21:55:57.950 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2018-11-25 21:55:57.951 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_ALARM 2018-11-25 21:55:57.953 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2018-11-25 21:55:57.954 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: NOTIFICATION report - 7 = 0, event=0, status=255, plen=0 2018-11-25 21:55:57.954 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: Alarm Type = BURGLAR (7) 2018-11-25 21:55:57.956 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2018-11-25 21:55:57.957 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_ALARM, value = 255 2018-11-25 21:55:57.958 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter processing NOTIFICATION 2018-11-25 21:55:57.959 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter NOTIFICATION event is 0, type OpenClosedType 2018-11-25 21:55:57.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1. 2018-11-25 21:55:57.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@fa05bf. 2018-11-25 21:55:57.961 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:57.962 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:57.962 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:55:57.963 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:55:58.158 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 10 06 0A 71 05 07 00 00 FF 07 00 00 00 7C 2018-11-25 21:55:58.162 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 00 00 FF 07 00 00 00 2018-11-25 21:55:58.164 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 00 00 FF 07 00 00 00 2018-11-25 21:55:58.165 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2018-11-25 21:55:58.166 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:STATIC_END) 2018-11-25 21:55:58.167 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2018-11-25 21:55:58.168 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_ALARM 2018-11-25 21:55:58.169 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2018-11-25 21:55:58.170 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: NOTIFICATION report - 7 = 0, event=0, status=255, plen=0 2018-11-25 21:55:58.171 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: Alarm Type = BURGLAR (7) 2018-11-25 21:55:58.173 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2018-11-25 21:55:58.174 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_ALARM, value = 255 2018-11-25 21:55:58.175 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter processing NOTIFICATION 2018-11-25 21:55:58.176 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter NOTIFICATION event is 0, type OpenClosedType 2018-11-25 21:55:58.178 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1. 2018-11-25 21:55:58.179 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@cc50ec. 2018-11-25 21:55:58.180 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:58.181 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:58.182 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:55:58.182 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:55:58.346 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 10 06 0A 71 05 07 00 00 FF 07 00 00 00 7C 2018-11-25 21:55:58.349 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 00 00 FF 07 00 00 00 2018-11-25 21:55:58.351 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 00 00 FF 07 00 00 00 2018-11-25 21:55:58.352 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2018-11-25 21:55:58.352 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:STATIC_END) 2018-11-25 21:55:58.354 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2018-11-25 21:55:58.355 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_ALARM 2018-11-25 21:55:58.355 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2018-11-25 21:55:58.356 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: NOTIFICATION report - 7 = 0, event=0, status=255, plen=0 2018-11-25 21:55:58.357 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: Alarm Type = BURGLAR (7) 2018-11-25 21:55:58.358 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2018-11-25 21:55:58.359 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_ALARM, value = 255 2018-11-25 21:55:58.361 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter processing NOTIFICATION 2018-11-25 21:55:58.362 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter NOTIFICATION event is 0, type OpenClosedType 2018-11-25 21:55:58.363 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1. 2018-11-25 21:55:58.364 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1b8a4b. 2018-11-25 21:55:58.365 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:58.366 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:55:58.367 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:55:58.369 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:55:58.443 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - ZWave discovery: Stop zwave:serial_zstick:15a7a49f3a6 2018-11-25 21:55:58.445 [DEBUG] [al.protocol.ZWaveInclusionController] - ZWave controller stopping inclusion at IncludeStart 2018-11-25 21:55:58.446 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Ending INCLUSION mode. 2018-11-25 21:55:58.447 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 542 to queue - size 1 2018-11-25 21:55:58.449 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:55:58.451 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 4A 05 9E 2B 2018-11-25 21:55:58.453 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 4A 05 9E 2B 2018-11-25 21:55:58.455 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT 2018-11-25 21:55:58.456 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 542: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 158 2018-11-25 21:55:58.461 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2018-11-25 21:55:58.463 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2018-11-25 21:55:58.464 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2018-11-25 21:55:58.465 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 542: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 158 2018-11-25 21:55:58.465 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK 2018-11-25 21:55:58.466 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:55:58.467 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2018-11-25 21:55:58.512 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 4A 9E 06 06 00 2C 2018-11-25 21:55:58.516 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=AddNodeToNetwork[74], type=Request[0], dest=6, callback=158, payload=9E 06 06 00 2018-11-25 21:55:58.517 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=AddNodeToNetwork[74], type=Request[0], dest=6, callback=158, payload=9E 06 06 00 2018-11-25 21:55:58.518 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 542: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 158 2018-11-25 21:55:58.519 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2018-11-25 21:55:58.520 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 542: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 158 2018-11-25 21:55:58.521 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 542: (Callback 158) 2018-11-25 21:55:58.522 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match! 2018-11-25 21:55:58.523 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 542: callback 158 2018-11-25 21:55:58.524 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=AddNodeToNetwork[74], type=Request[0], dest=6, callback=158, payload=9E 06 06 00 2018-11-25 21:55:58.525 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Add Node: Done. 2018-11-25 21:55:58.526 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 6: Device discovered 2018-11-25 21:55:58.530 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveInclusionEvent 2018-11-25 21:55:58.531 [DEBUG] [al.protocol.ZWaveInclusionController] - Inclusion event: Current state IncludeDone, new event IncludeDone 2018-11-25 21:55:58.532 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Ending INCLUSION mode. 2018-11-25 21:55:58.533 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 543 to queue - size 1 2018-11-25 21:55:58.534 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2018-11-25 21:55:58.535 [DEBUG] [al.protocol.ZWaveInclusionController] - ZWave controller end exclusion 2018-11-25 21:55:58.536 [DEBUG] [ve.internal.protocol.ZWaveController] - ZWaveController include done 2018-11-25 21:55:58.537 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 542: Advanced to DONE 2018-11-25 21:55:58.538 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Response processed after 82ms 2018-11-25 21:55:58.539 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: TID 542: Transaction completed 2018-11-25 21:55:58.539 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:542 DONE 2018-11-25 21:55:58.541 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:55:58.542 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:55:58.543 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 4A 05 00 B5 2018-11-25 21:55:58.544 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 4A 05 00 B5 2018-11-25 21:55:58.546 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT 2018-11-25 21:55:58.547 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 543: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 0 2018-11-25 21:55:58.551 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 10 06 0A 71 05 07 00 00 FF 07 00 00 00 7C 2018-11-25 21:55:58.554 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 00 00 FF 07 00 00 00 2018-11-25 21:55:58.556 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=16, payload=10 06 0A 71 05 07 00 00 FF 07 00 00 00 2018-11-25 21:55:58.556 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 18 2018-11-25 21:55:58.557 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 543: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 0 2018-11-25 21:55:58.557 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=CAN[4], dest=255, callback=0, payload= 2018-11-25 21:55:58.558 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:STATIC_END) 2018-11-25 21:55:58.559 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2018-11-25 21:55:58.560 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_ALARM 2018-11-25 21:55:58.561 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2018-11-25 21:55:58.561 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: NOTIFICATION report - 7 = 0, event=0, status=255, plen=0 2018-11-25 21:55:58.562 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: Alarm Type = BURGLAR (7) 2018-11-25 21:55:58.563 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2018-11-25 21:55:58.564 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_ALARM, value = 255 2018-11-25 21:55:58.565 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter processing NOTIFICATION 2018-11-25 21:55:58.566 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter NOTIFICATION event is 0, type OpenClosedType 2018-11-25 21:55:58.567 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1. 2018-11-25 21:55:58.568 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@d58abc. 2018-11-25 21:55:58.568 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2018-11-25 21:55:58.569 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2018-11-25 21:55:58.570 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=CAN[4], dest=255, callback=0, payload= 2018-11-25 21:55:58.571 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 543: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 0 2018-11-25 21:55:58.572 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Holdoff Timer started... 2018-11-25 21:55:58.573 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 543: Resetting transaction 2018-11-25 21:55:58.573 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:543 WAIT_REQUEST 2018-11-25 21:55:58.575 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 543 to queue - size 1 2018-11-25 21:55:58.575 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff true. 2018-11-25 21:55:58.576 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:55:58.577 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff true. 2018-11-25 21:55:58.823 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:55:58.824 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 4A 05 00 B5 2018-11-25 21:55:58.826 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 4A 05 00 B5 2018-11-25 21:55:58.827 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT 2018-11-25 21:55:58.828 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 543: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 0 2018-11-25 21:55:58.828 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2018-11-25 21:55:58.829 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2018-11-25 21:55:58.830 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2018-11-25 21:55:58.831 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 543: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 0 2018-11-25 21:55:58.832 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK 2018-11-25 21:55:58.832 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:55:58.833 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2018-11-25 21:55:59.743 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 06 0A 71 05 07 FF 00 FF 07 03 00 00 90 2018-11-25 21:55:59.746 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:59.747 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 0A 71 05 07 FF 00 FF 07 03 00 00 2018-11-25 21:55:59.749 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 543: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 0 2018-11-25 21:55:59.750 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:STATIC_END) 2018-11-25 21:55:59.751 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2018-11-25 21:55:59.752 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_ALARM 2018-11-25 21:55:59.752 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2018-11-25 21:55:59.753 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: NOTIFICATION report - 7 = 255, event=3, status=255, plen=0 2018-11-25 21:55:59.754 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: Alarm Type = BURGLAR (7) 2018-11-25 21:55:59.755 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2018-11-25 21:55:59.756 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_ALARM, value = 255 2018-11-25 21:55:59.757 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter processing NOTIFICATION 2018-11-25 21:55:59.758 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter NOTIFICATION event is 3, type OpenClosedType 2018-11-25 21:55:59.759 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1. 2018-11-25 21:55:59.760 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@9aa3a4. 2018-11-25 21:55:59.760 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2018-11-25 21:55:59.761 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2018-11-25 21:55:59.762 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:55:59.763 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2018-11-25 21:56:03.866 [DEBUG] [sactionManager$ZWaveTransactionTimer] - NODE 255: TID 543: Timeout at state WAIT_REQUEST. 3 retries remaining. 2018-11-25 21:56:03.867 [DEBUG] [sactionManager$ZWaveTransactionTimer] - TID 543: Transaction is current transaction, so clearing!!!!! 2018-11-25 21:56:03.868 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 543: Transaction CANCELLED 2018-11-25 21:56:03.869 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:543 CANCELLED 2018-11-25 21:56:03.870 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:56:05.071 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 06 0A 71 05 07 00 00 FF 07 00 00 00 6C 2018-11-25 21:56:05.075 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 0A 71 05 07 00 00 FF 07 00 00 00 2018-11-25 21:56:05.076 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 0A 71 05 07 00 00 FF 07 00 00 00 2018-11-25 21:56:05.077 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2018-11-25 21:56:05.078 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:STATIC_END) 2018-11-25 21:56:05.079 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_ALARM, endpoint 0 2018-11-25 21:56:05.080 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_ALARM 2018-11-25 21:56:05.080 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_ALARM V4 NOTIFICATION_REPORT 2018-11-25 21:56:05.081 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: NOTIFICATION report - 7 = 0, event=0, status=255, plen=0 2018-11-25 21:56:05.082 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 6: Alarm Type = BURGLAR (7) 2018-11-25 21:56:05.083 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveAlarmValueEvent 2018-11-25 21:56:05.084 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_ALARM, value = 255 2018-11-25 21:56:05.085 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter processing NOTIFICATION 2018-11-25 21:56:05.085 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 6: Alarm converter NOTIFICATION event is 0, type OpenClosedType 2018-11-25 21:56:05.086 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1. 2018-11-25 21:56:05.087 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@2dc82b. 2018-11-25 21:56:05.087 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:56:05.088 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:56:05.089 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:56:05.090 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:56:11.147 [INFO ] [clipse.smarthome.model.script.Logger] - System started has triggered in Automatisierung 2018-11-25 21:56:11.147 [INFO ] [clipse.smarthome.model.script.Logger] - System started has triggered in LoessleinEventLog 2018-11-25 21:56:11.150 [INFO ] [clipse.smarthome.model.script.Logger] - System started has triggered in Testrules 2018-11-25 21:56:11.153 [INFO ] [clipse.smarthome.model.script.Logger] - System started has triggered in Einstellungen 2018-11-25 21:56:11.155 [INFO ] [clipse.smarthome.model.script.Logger] - System started has triggered in SystemStarted - delayed-start 2018-11-25 21:56:11.234 [DEBUG] [org.openhab.binding.zwave ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=498, service.bundleid=237, service.scope=singleton} - org.openhab.binding.zwave 2018-11-25 21:56:11.168 [INFO ] [clipse.smarthome.model.script.Logger] - System started has triggered in SystemStarted 2018-11-25 21:56:11.814 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:15a7a49f3a6:node6. 2018-11-25 21:56:11.157 [ERROR] [org.quartz.core.JobRunShell ] - Job DEFAULT.2018-11-25T21:55:54.174+01:00: Proxy for org.eclipse.xtext.xbase.lib.Procedures$Procedure0: [ | { .send() logInfo(,) .cancel() .tsystemstartupTimer = } ] threw an unhandled Exception: java.lang.NullPointerException: cannot invoke method public abstract boolean org.eclipse.smarthome.model.script.actions.Timer.cancel() on null at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.invokeOperation(XbaseInterpreter.java:1071) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.invokeOperation(XbaseInterpreter.java:1061) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter._invokeFeature(XbaseInterpreter.java:1047) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.invokeFeature(XbaseInterpreter.java:992) ~[?:?] at org.eclipse.smarthome.model.script.interpreter.ScriptInterpreter.invokeFeature(ScriptInterpreter.java:151) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter._doEvaluate(XbaseInterpreter.java:772) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.doEvaluate(XbaseInterpreter.java:220) ~[?:?] at org.eclipse.smarthome.model.script.interpreter.ScriptInterpreter.doEvaluate(ScriptInterpreter.java:226) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.internalEvaluate(XbaseInterpreter.java:204) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter._doEvaluate(XbaseInterpreter.java:447) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.doEvaluate(XbaseInterpreter.java:228) ~[?:?] at org.eclipse.smarthome.model.script.interpreter.ScriptInterpreter.doEvaluate(ScriptInterpreter.java:226) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.internalEvaluate(XbaseInterpreter.java:204) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.evaluate(XbaseInterpreter.java:190) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.ClosureInvocationHandler.doInvoke(ClosureInvocationHandler.java:46) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.AbstractClosureInvocationHandler.invoke(AbstractClosureInvocationHandler.java:29) ~[?:?] at com.sun.proxy.$Proxy161.apply(Unknown Source) ~[?:?] at org.eclipse.smarthome.model.script.internal.actions.TimerExecutionJob.execute(TimerExecutionJob.java:49) ~[?:?] at org.quartz.core.JobRunShell.run(JobRunShell.java:202) [106:org.eclipse.smarthome.core.scheduler:0.10.0.201811171951] at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:573) [106:org.eclipse.smarthome.core.scheduler:0.10.0.201811171951] 2018-11-25 21:56:11.826 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Controller status changed to ONLINE. 2018-11-25 21:56:11.828 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Controller is ONLINE. Starting device initialisation. 2018-11-25 21:56:11.835 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Channel zwave:device:15a7a49f3a6:node6:alarm_tamper linked - polling started. 2018-11-25 21:56:11.836 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Channel zwave:device:15a7a49f3a6:node6:battery-level linked - polling started. 2018-11-25 21:56:11.833 [ERROR] [org.quartz.core.ErrorLogger ] - Job (DEFAULT.2018-11-25T21:55:54.174+01:00: Proxy for org.eclipse.xtext.xbase.lib.Procedures$Procedure0: [ | { .send() logInfo(,) .cancel() .tsystemstartupTimer = } ] threw an exception. org.quartz.SchedulerException: Job threw an unhandled exception. at org.quartz.core.JobRunShell.run(JobRunShell.java:213) [106:org.eclipse.smarthome.core.scheduler:0.10.0.201811171951] at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:573) [106:org.eclipse.smarthome.core.scheduler:0.10.0.201811171951] Caused by: java.lang.NullPointerException: cannot invoke method public abstract boolean org.eclipse.smarthome.model.script.actions.Timer.cancel() on null at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.invokeOperation(XbaseInterpreter.java:1071) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.invokeOperation(XbaseInterpreter.java:1061) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter._invokeFeature(XbaseInterpreter.java:1047) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.invokeFeature(XbaseInterpreter.java:992) ~[?:?] at org.eclipse.smarthome.model.script.interpreter.ScriptInterpreter.invokeFeature(ScriptInterpreter.java:151) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter._doEvaluate(XbaseInterpreter.java:772) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.doEvaluate(XbaseInterpreter.java:220) ~[?:?] at org.eclipse.smarthome.model.script.interpreter.ScriptInterpreter.doEvaluate(ScriptInterpreter.java:226) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.internalEvaluate(XbaseInterpreter.java:204) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter._doEvaluate(XbaseInterpreter.java:447) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.doEvaluate(XbaseInterpreter.java:228) ~[?:?] at org.eclipse.smarthome.model.script.interpreter.ScriptInterpreter.doEvaluate(ScriptInterpreter.java:226) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.internalEvaluate(XbaseInterpreter.java:204) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.XbaseInterpreter.evaluate(XbaseInterpreter.java:190) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.ClosureInvocationHandler.doInvoke(ClosureInvocationHandler.java:46) ~[?:?] at org.eclipse.xtext.xbase.interpreter.impl.AbstractClosureInvocationHandler.invoke(AbstractClosureInvocationHandler.java:29) ~[?:?] at com.sun.proxy.$Proxy161.apply(Unknown Source) ~[?:?] at org.eclipse.smarthome.model.script.internal.actions.TimerExecutionJob.execute(TimerExecutionJob.java:49) ~[?:?] at org.quartz.core.JobRunShell.run(JobRunShell.java:202) ~[?:?] ... 1 more 2018-11-25 21:56:11.834 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Channel zwave:device:15a7a49f3a6:node6:sensor_door linked - polling started. 2018-11-25 21:56:12.102 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Updating node properties. 2018-11-25 21:56:12.103 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Updating node properties. MAN=265 2018-11-25 21:56:12.104 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Updating node properties. MAN=265. SET. Was null 2018-11-25 21:56:12.105 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Properties synchronised 2018-11-25 21:56:12.218 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Update ASSOCIATION group_ZWaveAssociationGroup [index=1, name=null, profile1=null, profile2=null, associations=[node_1]]: Adding node_1 2018-11-25 21:56:12.219 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Configuration synchronised 2018-11-25 21:56:12.302 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 63: Polling... 2018-11-25 21:56:12.304 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 63: Polling zwave:device:15a7a49f3a6:node63:switch_binary 2018-11-25 21:56:12.306 [DEBUG] [converter.ZWaveBinarySwitchConverter] - NODE 63: Generating poll message for COMMAND_CLASS_SWITCH_BINARY, endpoint 0 2018-11-25 21:56:12.307 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 63: Creating new message for application command SWITCH_BINARY_GET 2018-11-25 21:56:12.309 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 63: SECURITY not supported 2018-11-25 21:56:12.311 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 63: Command Class COMMAND_CLASS_SWITCH_BINARY is NOT required to be secured 2018-11-25 21:56:12.313 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 63: Polling skipped for zwave:device:15a7a49f3a6:node63:switch_binary on COMMAND_CLASS_BASIC 2018-11-25 21:56:12.325 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 63: Polling zwave:device:15a7a49f3a6:node63:alarm_general 2018-11-25 21:56:12.326 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 63: Polling zwave:device:15a7a49f3a6:node63:battery-level 2018-11-25 21:56:12.329 [DEBUG] [rnal.converter.ZWaveBatteryConverter] - NODE 63: Generating poll message for COMMAND_CLASS_BATTERY endpoint 0 2018-11-25 21:56:12.331 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 63: SECURITY not supported 2018-11-25 21:56:12.332 [DEBUG] [ve.internal.protocol.ZWaveController] - Event listener added. 2018-11-25 21:56:12.334 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising Thing Node... 2018-11-25 21:56:12.335 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising cmd channel zwave:device:15a7a49f3a6:node6:sensor_door for OpenClosedType 2018-11-25 21:56:12.336 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising state channel zwave:device:15a7a49f3a6:node6:sensor_door for OpenClosedType 2018-11-25 21:56:12.338 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 63: Command Class COMMAND_CLASS_BATTERY is NOT required to be secured 2018-11-25 21:56:12.337 [ERROR] [nal.common.AbstractInvocationHandler] - An error occurred while calling method 'ThingHandler.initialize()' on 'org.openhab.binding.zwave.handler.ZWaveThingHandler@17a8199': 1 java.lang.ArrayIndexOutOfBoundsException: 1 at org.openhab.binding.zwave.handler.ZWaveThingHandler.initialiseNode(ZWaveThingHandler.java:226) ~[?:?] at org.openhab.binding.zwave.handler.ZWaveThingHandler.bridgeStatusChanged(ZWaveThingHandler.java:512) ~[?:?] at org.openhab.binding.zwave.handler.ZWaveThingHandler.initialize(ZWaveThingHandler.java:164) ~[?:?] at sun.reflect.GeneratedMethodAccessor73.invoke(Unknown Source) ~[?:?] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:?] at java.lang.reflect.Method.invoke(Method.java:498) ~[?:?] at org.eclipse.smarthome.core.internal.common.AbstractInvocationHandler.invokeDirect(AbstractInvocationHandler.java:153) [101:org.eclipse.smarthome.core:0.10.0.201811171951] at org.eclipse.smarthome.core.internal.common.Invocation.call(Invocation.java:53) [101:org.eclipse.smarthome.core:0.10.0.201811171951] at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:?] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?] at java.lang.Thread.run(Thread.java:748) [?:?] 2018-11-25 21:56:12.350 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: Bump transaction 544 priority from Get to Immediate 2018-11-25 21:56:12.351 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: Adding to device queue 2018-11-25 21:56:12.352 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: Added 544 to queue - size 41 2018-11-25 21:56:12.355 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:56:12.358 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 3F 02 25 02 25 A0 7A 2018-11-25 21:56:12.360 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 63: Sending REQUEST Message = 01 09 00 13 3F 02 25 02 25 A0 7A 2018-11-25 21:56:12.360 [ERROR] [core.thing.internal.ThingManagerImpl] - Exception occurred while initializing handler of thing 'zwave:device:15a7a49f3a6:node6': 1 java.lang.ArrayIndexOutOfBoundsException: 1 at org.openhab.binding.zwave.handler.ZWaveThingHandler.initialiseNode(ZWaveThingHandler.java:226) ~[?:?] at org.openhab.binding.zwave.handler.ZWaveThingHandler.bridgeStatusChanged(ZWaveThingHandler.java:512) ~[?:?] at org.openhab.binding.zwave.handler.ZWaveThingHandler.initialize(ZWaveThingHandler.java:164) ~[?:?] at sun.reflect.GeneratedMethodAccessor73.invoke(Unknown Source) ~[?:?] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:?] at java.lang.reflect.Method.invoke(Method.java:498) ~[?:?] at org.eclipse.smarthome.core.internal.common.AbstractInvocationHandler.invokeDirect(AbstractInvocationHandler.java:153) [101:org.eclipse.smarthome.core:0.10.0.201811171951] at org.eclipse.smarthome.core.internal.common.Invocation.call(Invocation.java:53) [101:org.eclipse.smarthome.core:0.10.0.201811171951] at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:?] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?] at java.lang.Thread.run(Thread.java:748) [?:?] 2018-11-25 21:56:12.373 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT 2018-11-25 21:56:12.375 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 544: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 160 2018-11-25 21:56:12.376 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: Bump transaction 545 priority from Get to Immediate 2018-11-25 21:56:12.376 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2018-11-25 21:56:12.377 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: Adding to device queue 2018-11-25 21:56:12.377 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2018-11-25 21:56:12.378 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: Added 545 to queue - size 41 2018-11-25 21:56:12.378 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2018-11-25 21:56:12.379 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2018-11-25 21:56:12.380 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 544: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 160 2018-11-25 21:56:12.380 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK 2018-11-25 21:56:12.381 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:56:12.381 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2018-11-25 21:56:12.382 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 2018-11-25 21:56:12.383 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2018-11-25 21:56:12.385 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2018-11-25 21:56:12.386 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 544: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 160 2018-11-25 21:56:12.386 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2018-11-25 21:56:12.388 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 544: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 160 2018-11-25 21:56:12.389 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2018-11-25 21:56:12.390 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 63: sentData successfully placed on stack. 2018-11-25 21:56:12.391 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 544: Advanced to WAIT_REQUEST 2018-11-25 21:56:12.392 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: TID 544: Transaction not completed 2018-11-25 21:56:12.392 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:56:12.393 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2018-11-25 21:56:13.663 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 A0 00 00 80 CB 2018-11-25 21:56:13.665 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=160, payload=A0 00 00 80 2018-11-25 21:56:13.667 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=160, payload=A0 00 00 80 2018-11-25 21:56:13.668 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 544: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 160 2018-11-25 21:56:13.669 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2018-11-25 21:56:13.670 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 544: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 160 2018-11-25 21:56:13.672 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 544: (Callback 160) 2018-11-25 21:56:13.672 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match! 2018-11-25 21:56:13.673 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 544: callback 160 2018-11-25 21:56:13.674 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=160, payload=A0 00 00 80 2018-11-25 21:56:13.675 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 63: SendData Request. CallBack ID = 160, Status = Transmission complete and ACK received(0) 2018-11-25 21:56:13.676 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 63: resetResendCount initComplete=true isDead=false 2018-11-25 21:56:13.676 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 3F 03 25 03 00 E8 2018-11-25 21:56:13.677 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 544: Advanced to WAIT_DATA 2018-11-25 21:56:13.677 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: TID 544: Transaction not completed 2018-11-25 21:56:13.678 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:56:13.679 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=63, callback=0, payload=00 3F 03 25 03 00 2018-11-25 21:56:13.679 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2018-11-25 21:56:13.680 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=63, callback=0, payload=00 3F 03 25 03 00 2018-11-25 21:56:13.681 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2018-11-25 21:56:13.681 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: Application Command Request (ALIVE:DONE) 2018-11-25 21:56:13.682 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 63: resetResendCount initComplete=true isDead=false 2018-11-25 21:56:13.683 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 63: Incoming command class COMMAND_CLASS_SWITCH_BINARY, endpoint 0 2018-11-25 21:56:13.684 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 63: SECURITY not supported 2018-11-25 21:56:13.684 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 63: Received COMMAND_CLASS_SWITCH_BINARY V1 SWITCH_BINARY_REPORT 2018-11-25 21:56:13.685 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 63: Switch Binary report, value = 0 2018-11-25 21:56:13.686 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 63: Got an event from Z-Wave network: ZWaveCommandClassValueEvent 2018-11-25 21:56:13.686 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 63: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SWITCH_BINARY, value = 0 2018-11-25 21:56:13.687 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 63: Updating channel state zwave:device:15a7a49f3a6:node63:switch_binary to OFF [OnOffType] 2018-11-25 21:56:13.689 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: Commands processed 1. 2018-11-25 21:56:13.690 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@345c77. 2018-11-25 21:56:13.691 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@345c77. 2018-11-25 21:56:13.692 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: notifyTransactionResponse TID:544 DONE 2018-11-25 21:56:13.693 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 63: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2018-11-25 21:56:13.694 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2018-11-25 21:56:13.694 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:56:13.695 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:56:13.696 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:56:13.698 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 3F 02 80 02 25 A1 DE 2018-11-25 21:56:13.721 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 63: Sending REQUEST Message = 01 09 00 13 3F 02 80 02 25 A1 DE 2018-11-25 21:56:13.723 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT 2018-11-25 21:56:13.724 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 545: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 161 2018-11-25 21:56:13.724 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2018-11-25 21:56:13.725 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2018-11-25 21:56:13.726 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2018-11-25 21:56:13.727 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 545: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 161 2018-11-25 21:56:13.728 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK 2018-11-25 21:56:13.729 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:56:13.730 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2018-11-25 21:56:13.731 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 2018-11-25 21:56:13.732 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2018-11-25 21:56:13.735 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2018-11-25 21:56:13.736 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 545: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 161 2018-11-25 21:56:13.737 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2018-11-25 21:56:13.738 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 545: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 161 2018-11-25 21:56:13.739 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2018-11-25 21:56:13.740 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 63: sentData successfully placed on stack. 2018-11-25 21:56:13.740 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 545: Advanced to WAIT_REQUEST 2018-11-25 21:56:13.741 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: TID 545: Transaction not completed 2018-11-25 21:56:13.742 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:56:13.742 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2018-11-25 21:56:13.752 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 A1 00 00 02 48 2018-11-25 21:56:13.754 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=161, payload=A1 00 00 02 2018-11-25 21:56:13.756 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=161, payload=A1 00 00 02 2018-11-25 21:56:13.757 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 545: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 161 2018-11-25 21:56:13.758 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2018-11-25 21:56:13.759 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 545: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 161 2018-11-25 21:56:13.759 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 545: (Callback 161) 2018-11-25 21:56:13.760 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match! 2018-11-25 21:56:13.761 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 545: callback 161 2018-11-25 21:56:13.762 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=161, payload=A1 00 00 02 2018-11-25 21:56:13.763 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 63: SendData Request. CallBack ID = 161, Status = Transmission complete and ACK received(0) 2018-11-25 21:56:13.764 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 63: resetResendCount initComplete=true isDead=false 2018-11-25 21:56:13.764 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 545: Advanced to WAIT_DATA 2018-11-25 21:56:13.837 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: TID 545: Transaction not completed 2018-11-25 21:56:13.837 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 3F 03 80 03 64 29 2018-11-25 21:56:13.839 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:56:13.842 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=63, callback=0, payload=00 3F 03 80 03 64 2018-11-25 21:56:13.843 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2018-11-25 21:56:13.844 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=63, callback=0, payload=00 3F 03 80 03 64 2018-11-25 21:56:13.845 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2018-11-25 21:56:13.846 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: Application Command Request (ALIVE:DONE) 2018-11-25 21:56:13.846 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 63: resetResendCount initComplete=true isDead=false 2018-11-25 21:56:13.847 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 63: Incoming command class COMMAND_CLASS_BATTERY, endpoint 0 2018-11-25 21:56:13.848 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 63: SECURITY not supported 2018-11-25 21:56:13.849 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 63: Received COMMAND_CLASS_BATTERY V1 BATTERY_REPORT 2018-11-25 21:56:13.850 [DEBUG] [ommandclass.ZWaveBatteryCommandClass] - NODE 63: Battery report value = 100 2018-11-25 21:56:13.851 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 63: Got an event from Z-Wave network: ZWaveCommandClassValueEvent 2018-11-25 21:56:13.853 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 63: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_BATTERY, value = 100 2018-11-25 21:56:13.854 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 63: Updating channel state zwave:device:15a7a49f3a6:node63:battery-level to 100 [DecimalType] 2018-11-25 21:56:13.856 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: Commands processed 1. 2018-11-25 21:56:13.857 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@2b367. 2018-11-25 21:56:13.858 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@2b367. 2018-11-25 21:56:13.859 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 63: notifyTransactionResponse TID:545 DONE 2018-11-25 21:56:13.860 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 63: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2018-11-25 21:56:13.860 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2018-11-25 21:56:13.861 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:56:13.862 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:56:13.862 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:56:13.922 [INFO ] [clipse.smarthome.model.script.Logger] - gMonitorLastUpdate received update from: SmokeSensor02_Battery: SmokeSensor02_LastUpdate 2018-11-25 21:56:13.924 [INFO ] [clipse.smarthome.model.script.Logger] - gMonitorLastUpdate ####################### 2018-11-25 21:56:14.945 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 4D 06 31 05 01 22 00 CD 66 2018-11-25 21:56:14.948 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=77, callback=0, payload=00 4D 06 31 05 01 22 00 CD 2018-11-25 21:56:14.949 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=77, callback=0, payload=00 4D 06 31 05 01 22 00 CD 2018-11-25 21:56:14.950 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null 2018-11-25 21:56:14.951 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 77: Application Command Request (ALIVE:REQUEST_NIF) 2018-11-25 21:56:14.952 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 77: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0 2018-11-25 21:56:14.953 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 77: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL 2018-11-25 21:56:14.953 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 77: Received COMMAND_CLASS_SENSOR_MULTILEVEL V5 SENSOR_MULTILEVEL_REPORT 2018-11-25 21:56:14.954 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 77: Sensor Type = Temperature(1), Scale = 0 2018-11-25 21:56:14.955 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 77: Sensor Value = 20.5 2018-11-25 21:56:14.956 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 77: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent 2018-11-25 21:56:14.957 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 77: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SENSOR_MULTILEVEL, value = 20.5 2018-11-25 21:56:14.958 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 77: Updating channel state zwave:device:15a7a49f3a6:node77:sensor_temperature to 20.5 °C [QuantityType] 2018-11-25 21:56:14.959 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 77: Commands processed 1. 2018-11-25 21:56:14.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 77: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1d2a440. 2018-11-25 21:56:14.961 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:56:14.961 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2018-11-25 21:56:14.962 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2018-11-25 21:56:14.963 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2018-11-25 21:57:06.602 [INFO ] [clipse.smarthome.model.script.Logger] - System started has triggered in LoessleinEventLog 2018-11-25 21:57:06.602 [INFO ] [clipse.smarthome.model.script.Logger] - System started has triggered in Testrules 2018-11-25 21:57:06.602 [INFO ] [clipse.smarthome.model.script.Logger] - System started has triggered in Einstellungen 2018-11-25 21:57:06.607 [INFO ] [clipse.smarthome.model.script.Logger] - System started has triggered in Automatisierung 2018-11-25 21:57:06.610 [INFO ] [clipse.smarthome.model.script.Logger] - System started has triggered in SystemStarted