I believe it is securely. I used the binding and HabMIN reports,
Attributes, Specific Class SPECIFIC_TYPE_SECURE_KEYPAD_DOOR_LOCK
I was a bit blurry eyed when I responded above. I see HABmin shows a green check mark for “Using Security” so I guess that means the inclusion was secure.
I have been spending a lot of time going through openhab.log for this device (NODE 27). There is a lot I don’t understand with Z-Wave but I found some interesting things. If I initiate a Lock Change (Lock or Unlock but Unlock in this case) I will see a burst that includes “alarm_raw to {“type”:“25”,“value”:“1”}” which means “Lock Un-Secured by Controller – Successful (Fully retracted)” Then the burst ends.
Then few seconds later another burst happens and includes “alarm_raw to {“type”:“21”,“value”:“0”}” which means " Lock Secured using Keyed cylinder or inside thumb-turn ". But nobody is at the lock to cause this and the lock remains Unlocked. One peculiarity is the “value” is 0 where as the documentation says for this message the “value” should be 1.
Also, a few lines before this I see:
ALARM report - 21 = 0 and
Alarm Type = WATER_QUALITY (21).
Why the heck is a lock reporting WATER_QUALITY ?
I have included the log below.
The first line at 2020-07-24 09:12:59.586 is the start of the sequence.
The alarm_raw type 25 is at time 09:13:02.559.
Then the WATER_QUALITY is at time 09:13:07.961. Over 5 seconds later.
Here is the log:
t
2020-07-24 09:12:59.586 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Command received zwave:device:fe40ab17:node27:lock_door --> OFF [OnOffType]
2020-07-24 09:12:59.588 [DEBUG] [mmandclass.ZWaveDoorLockCommandClass] - NODE 27: Creating new message for application command DOORLOCK_SET, value 0
2020-07-24 09:12:59.591 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: SECURITY required on COMMAND_CLASS_DOOR_LOCK
2020-07-24 09:12:59.593 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Command Class COMMAND_CLASS_DOOR_LOCK is required to be secured
2020-07-24 09:12:59.595 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Bump transaction 3073 priority from Get to Immediate
2020-07-24 09:12:59.597 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Adding to device queue
2020-07-24 09:12:59.600 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Added 3073 to queue - size 8
2020-07-24 09:12:59.605 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: isNonceAvailable = null
2020-07-24 09:12:59.615 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 27: Sending REQUEST Message = 01 09 00 13 1B 02 98 40 25 5E 5F
2020-07-24 09:12:59.627 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Polling initialised at 1800 seconds - start in 1500 milliseconds.
2020-07-24 09:12:59.706 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: sentData successfully placed on stack.
2020-07-24 09:12:59.714 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3074: Transaction not completed
2020-07-24 09:13:00.922 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: SendData Request. CallBack ID = 94, Status = Transmission complete and ACK received(0)
2020-07-24 09:13:00.924 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:00.928 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3074: Transaction not completed
2020-07-24 09:13:00.942 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Application Command Request (ALIVE:DONE)
2020-07-24 09:13:00.943 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:00.945 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2020-07-24 09:13:00.947 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: SECURITY check internal
2020-07-24 09:13:00.949 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 27: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_REPORT
2020-07-24 09:13:00.951 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: NONCE Received start…
2020-07-24 09:13:00.954 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: NONCE Received start null
2020-07-24 09:13:00.956 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: NONCE Received ZWaveNonce [nonceBytes=(4C 35 9A 89 B2 4A 34 7C ), timer=1094889, valid=true]
2020-07-24 09:13:00.958 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Commands processed 1.
2020-07-24 09:13:00.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@9442ce.
2020-07-24 09:13:00.962 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@9442ce.
2020-07-24 09:13:00.964 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: notifyTransactionResponse TID:3074 DONE
2020-07-24 09:13:00.967 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-07-24 09:13:00.984 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: SECURITY_TXD 62 01 00
2020-07-24 09:13:00.996 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 27: Sending REQUEST Message = 01 1E 00 13 1B 17 98 81 D1 50 30 82 C2 39 F5 7F 31 1C 48 75 4C 9D E9 78 49 AA F3 E1 49 25 5F 37
2020-07-24 09:13:01.034 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: sentData successfully placed on stack.
2020-07-24 09:13:01.038 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3073: Transaction not completed
2020-07-24 09:13:01.058 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: SendData Request. CallBack ID = 95, Status = Transmission complete and ACK received(0)
2020-07-24 09:13:01.059 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:01.064 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Response processed after 63ms
2020-07-24 09:13:01.066 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3073: Transaction completed
2020-07-24 09:13:01.068 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: notifyTransactionResponse TID:3073 DONE
2020-07-24 09:13:01.070 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-07-24 09:13:01.127 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Polling…
2020-07-24 09:13:01.129 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Polling zwave:device:fe40ab17:node27:lock_door
2020-07-24 09:13:01.131 [DEBUG] [nal.converter.ZWaveDoorLockConverter] - NODE 27: Generating poll message for COMMAND_CLASS_DOOR_LOCK endpoint 0
2020-07-24 09:13:01.136 [DEBUG] [mmandclass.ZWaveDoorLockCommandClass] - NODE 27: Creating new message for application command DOORLOCK_GET
2020-07-24 09:13:01.138 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: SECURITY required on COMMAND_CLASS_DOOR_LOCK
2020-07-24 09:13:01.140 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Command Class COMMAND_CLASS_DOOR_LOCK is required to be secured
2020-07-24 09:13:01.144 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Polling zwave:device:fe40ab17:node27:alarm_number
2020-07-24 09:13:01.146 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 27: Generating poll message for COMMAND_CLASS_ALARM, endpoint 0, alarm null, event null
2020-07-24 09:13:01.148 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 27: Creating new message for application command NOTIFICATION_GET V1
2020-07-24 09:13:01.150 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: SECURITY required on COMMAND_CLASS_ALARM
2020-07-24 09:13:01.154 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Command Class COMMAND_CLASS_ALARM is required to be secured
2020-07-24 09:13:01.156 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Polling zwave:device:fe40ab17:node27:alarm_raw
2020-07-24 09:13:01.158 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 27: Generating poll message for COMMAND_CLASS_ALARM, endpoint 0, alarm null, event null
2020-07-24 09:13:01.160 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 27: Creating new message for application command NOTIFICATION_GET V1
2020-07-24 09:13:01.162 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: SECURITY required on COMMAND_CLASS_ALARM
2020-07-24 09:13:01.164 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Command Class COMMAND_CLASS_ALARM is required to be secured
2020-07-24 09:13:01.166 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Bump transaction 3075 priority from Get to Immediate
2020-07-24 09:13:01.168 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Adding to device queue
2020-07-24 09:13:01.170 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Added 3075 to queue - size 8
2020-07-24 09:13:01.175 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: isNonceAvailable = null
2020-07-24 09:13:01.185 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 27: Sending REQUEST Message = 01 09 00 13 1B 02 98 40 25 60 61
2020-07-24 09:13:01.191 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Bump transaction 3077 priority from Config to Immediate
2020-07-24 09:13:01.193 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Adding to device queue
2020-07-24 09:13:01.198 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Added 3077 to queue - size 8
2020-07-24 09:13:01.203 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Bump transaction 3078 priority from Config to Immediate
2020-07-24 09:13:01.208 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Adding to device queue
2020-07-24 09:13:01.210 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Transaction already in queue - removed original
2020-07-24 09:13:01.213 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Added 3078 to queue - size 8
2020-07-24 09:13:01.228 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: sentData successfully placed on stack.
2020-07-24 09:13:01.234 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3076: Transaction not completed
2020-07-24 09:13:01.260 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: SendData Request. CallBack ID = 96, Status = Transmission complete and ACK received(0)
2020-07-24 09:13:01.261 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:01.265 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3076: Transaction not completed
2020-07-24 09:13:01.272 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Application Command Request (ALIVE:DONE)
2020-07-24 09:13:01.275 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:01.276 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2020-07-24 09:13:01.279 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: SECURITY check internal
2020-07-24 09:13:01.281 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 27: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_REPORT
2020-07-24 09:13:01.283 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: NONCE Received start…
2020-07-24 09:13:01.285 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: NONCE Received start null
2020-07-24 09:13:01.288 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: NONCE Received ZWaveNonce [nonceBytes=(47 35 79 94 AD 1E C4 94 ), timer=690100, valid=true]
2020-07-24 09:13:01.289 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Commands processed 1.
2020-07-24 09:13:01.292 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1e025bd.
2020-07-24 09:13:01.293 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1e025bd.
2020-07-24 09:13:01.295 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: notifyTransactionResponse TID:3076 DONE
2020-07-24 09:13:01.298 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-07-24 09:13:01.311 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: SECURITY_TXD 62 02
2020-07-24 09:13:01.319 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 27: Sending REQUEST Message = 01 1D 00 13 1B 16 98 81 14 64 5C 16 60 1D 9C 7C E7 12 ED 47 AD 66 38 30 CA E8 8F 17 25 61 20
2020-07-24 09:13:01.351 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: sentData successfully placed on stack.
2020-07-24 09:13:01.355 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3075: Transaction not completed
2020-07-24 09:13:01.385 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: SendData Request. CallBack ID = 97, Status = Transmission complete and ACK received(0)
2020-07-24 09:13:01.386 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:01.390 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3075: Transaction not completed
2020-07-24 09:13:01.967 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Application Command Request (ALIVE:DONE)
2020-07-24 09:13:01.968 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:01.970 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2020-07-24 09:13:01.972 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: SECURITY check internal
2020-07-24 09:13:01.974 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 27: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2020-07-24 09:13:01.977 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Added to secure queue - size 1
2020-07-24 09:13:01.979 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Commands processed 1.
2020-07-24 09:13:01.981 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@be9426.
2020-07-24 09:13:01.982 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Command NOT verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@be9426.
2020-07-24 09:13:02.003 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 27: Sending REQUEST Message = 01 11 00 13 1B 0A 98 80 58 FB 2E 6C 26 35 F6 AA 25 62 1D
2020-07-24 09:13:02.037 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: sentData successfully placed on stack.
2020-07-24 09:13:02.041 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3079: Transaction not completed
2020-07-24 09:13:02.067 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: SendData Request. CallBack ID = 98, Status = Transmission complete and ACK received(0)
2020-07-24 09:13:02.070 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:02.074 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Response processed after 66ms
2020-07-24 09:13:02.075 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3079: Transaction completed
2020-07-24 09:13:02.078 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: notifyTransactionResponse TID:3079 DONE
2020-07-24 09:13:02.080 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-07-24 09:13:02.087 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Application Command Request (ALIVE:DONE)
2020-07-24 09:13:02.089 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:02.091 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Decapsulating COMMAND_CLASS_SECURITY
2020-07-24 09:13:02.095 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: SECURITY_RXD 22 02 00
2020-07-24 09:13:02.098 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Incoming command class COMMAND_CLASS_APPLICATION_STATUS, endpoint 0
2020-07-24 09:13:02.100 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 27: Received COMMAND_CLASS_APPLICATION_STATUS V0 APPLICATION_REJECTED_REQUEST
2020-07-24 09:13:02.102 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Commands processed 1.
2020-07-24 09:13:02.104 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1c18a56.
2020-07-24 09:13:02.107 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Command NOT verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1c18a56.
2020-07-24 09:13:02.413 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Application Command Request (ALIVE:DONE)
2020-07-24 09:13:02.416 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:02.417 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2020-07-24 09:13:02.420 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: SECURITY check internal
2020-07-24 09:13:02.421 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 27: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2020-07-24 09:13:02.425 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Added to secure queue - size 1
2020-07-24 09:13:02.428 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Commands processed 1.
2020-07-24 09:13:02.429 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@14f2212.
2020-07-24 09:13:02.432 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Command NOT verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@14f2212.
2020-07-24 09:13:02.445 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 27: Sending REQUEST Message = 01 11 00 13 1B 0A 98 80 F9 EC F6 29 A2 32 7D 0A 25 63 9F
2020-07-24 09:13:02.477 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: sentData successfully placed on stack.
2020-07-24 09:13:02.481 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3080: Transaction not completed
2020-07-24 09:13:02.506 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: SendData Request. CallBack ID = 99, Status = Transmission complete and ACK received(0)
2020-07-24 09:13:02.509 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:02.514 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Response processed after 65ms
2020-07-24 09:13:02.516 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3080: Transaction completed
2020-07-24 09:13:02.518 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: notifyTransactionResponse TID:3080 DONE
2020-07-24 09:13:02.521 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-07-24 09:13:02.529 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Application Command Request (ALIVE:DONE)
2020-07-24 09:13:02.531 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:02.533 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Decapsulating COMMAND_CLASS_SECURITY
2020-07-24 09:13:02.536 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: SECURITY_RXD 71 05 19 01
2020-07-24 09:13:02.538 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Incoming command class COMMAND_CLASS_ALARM, endpoint 0
2020-07-24 09:13:02.540 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 27: Received COMMAND_CLASS_ALARM V1 NOTIFICATION_REPORT
2020-07-24 09:13:02.542 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 27: ALARM report - 25 = 1
2020-07-24 09:13:02.544 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 27: Alarm Type = null (25)
2020-07-24 09:13:02.546 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got an event from Z-Wave network: ZWaveAlarmValueEvent
2020-07-24 09:13:02.548 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_ALARM, value=1
2020-07-24 09:13:02.550 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 27: Alarm converter processing ALARM
2020-07-24 09:13:02.553 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Updating channel state zwave:device:fe40ab17:node27:alarm_number to 25 [DecimalType]
2020-07-24 09:13:02.557 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 27: Alarm converter processing ALARM
2020-07-24 09:13:02.559 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Updating channel state zwave:device:fe40ab17:node27:alarm_raw to {“type”:“25”,“value”:“1”} [StringType]
2020-07-24 09:13:02.564 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Commands processed 1.
2020-07-24 09:13:02.566 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@10a3b4b.
2020-07-24 09:13:02.569 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Command NOT verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@10a3b4b.
2020-07-24 09:13:06.391 [DEBUG] [sactionManager$ZWaveTransactionTimer] - NODE 27: TID 3075: Timeout at state WAIT_DATA. 3 retries remaining.
2020-07-24 09:13:06.396 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-07-24 09:13:06.399 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: notifyTransactionResponse TID:3075 CANCELLED
2020-07-24 09:13:06.404 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: isNonceAvailable = null
2020-07-24 09:13:06.413 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 27: Sending REQUEST Message = 01 09 00 13 1B 02 98 40 25 64 65
2020-07-24 09:13:06.452 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: sentData successfully placed on stack.
2020-07-24 09:13:06.456 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3081: Transaction not completed
2020-07-24 09:13:07.714 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: SendData Request. CallBack ID = 100, Status = Transmission complete and ACK received(0)
2020-07-24 09:13:07.716 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:07.719 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3081: Transaction not completed
2020-07-24 09:13:07.727 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Application Command Request (ALIVE:DONE)
2020-07-24 09:13:07.728 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:07.730 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2020-07-24 09:13:07.732 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: SECURITY check internal
2020-07-24 09:13:07.734 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 27: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_REPORT
2020-07-24 09:13:07.736 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: NONCE Received start…
2020-07-24 09:13:07.737 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: NONCE Received start null
2020-07-24 09:13:07.740 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: NONCE Received ZWaveNonce [nonceBytes=(B6 25 04 9C 34 6E DE F7 ), timer=628538, valid=true]
2020-07-24 09:13:07.742 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Commands processed 1.
2020-07-24 09:13:07.744 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@14988e8.
2020-07-24 09:13:07.745 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@14988e8.
2020-07-24 09:13:07.747 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: notifyTransactionResponse TID:3081 DONE
2020-07-24 09:13:07.749 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-07-24 09:13:07.763 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: SECURITY_TXD 71 04 15
2020-07-24 09:13:07.771 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 27: Sending REQUEST Message = 01 1E 00 13 1B 17 98 81 5A 03 CD AB 44 2A 1B 26 D8 39 75 B9 B6 94 43 67 5F 63 44 00 24 25 65 BC
2020-07-24 09:13:07.804 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: sentData successfully placed on stack.
2020-07-24 09:13:07.809 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3078: Transaction not completed
2020-07-24 09:13:07.832 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: SendData Request. CallBack ID = 101, Status = Transmission complete and ACK received(0)
2020-07-24 09:13:07.834 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:07.838 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3078: Transaction not completed
2020-07-24 09:13:07.843 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Application Command Request (ALIVE:DONE)
2020-07-24 09:13:07.845 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:07.846 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2020-07-24 09:13:07.848 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: SECURITY check internal
2020-07-24 09:13:07.849 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 27: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2020-07-24 09:13:07.853 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Added to secure queue - size 1
2020-07-24 09:13:07.855 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Commands processed 1.
2020-07-24 09:13:07.856 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@13222d.
2020-07-24 09:13:07.858 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Command NOT verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@13222d.
2020-07-24 09:13:07.869 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 27: Sending REQUEST Message = 01 11 00 13 1B 0A 98 80 09 71 9A 50 E2 BF 97 58 25 66 97
2020-07-24 09:13:07.895 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: sentData successfully placed on stack.
2020-07-24 09:13:07.898 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3082: Transaction not completed
2020-07-24 09:13:07.928 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 27: SendData Request. CallBack ID = 102, Status = Transmission complete and ACK received(0)
2020-07-24 09:13:07.929 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:07.934 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Response processed after 62ms
2020-07-24 09:13:07.936 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: TID 3082: Transaction completed
2020-07-24 09:13:07.937 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: notifyTransactionResponse TID:3082 DONE
2020-07-24 09:13:07.939 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-07-24 09:13:07.946 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Application Command Request (ALIVE:DONE)
2020-07-24 09:13:07.948 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: resetResendCount initComplete=true isDead=false
2020-07-24 09:13:07.950 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Decapsulating COMMAND_CLASS_SECURITY
2020-07-24 09:13:07.953 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 27: SECURITY_RXD 71 05 15 00
2020-07-24 09:13:07.956 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Incoming command class COMMAND_CLASS_ALARM, endpoint 0
2020-07-24 09:13:07.957 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 27: Received COMMAND_CLASS_ALARM V1 NOTIFICATION_REPORT
2020-07-24 09:13:07.960 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 27: ALARM report - 21 = 0
2020-07-24 09:13:07.961 [DEBUG] [.commandclass.ZWaveAlarmCommandClass] - NODE 27: Alarm Type = WATER_QUALITY (21)
2020-07-24 09:13:07.964 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got an event from Z-Wave network: ZWaveAlarmValueEvent
2020-07-24 09:13:07.965 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_ALARM, value=0
2020-07-24 09:13:07.968 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 27: Alarm converter processing ALARM
2020-07-24 09:13:07.970 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Updating channel state zwave:device:fe40ab17:node27:alarm_number to 21 [DecimalType]
2020-07-24 09:13:07.973 [DEBUG] [ternal.converter.ZWaveAlarmConverter] - NODE 27: Alarm converter processing ALARM
2020-07-24 09:13:07.976 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Updating channel state zwave:device:fe40ab17:node27:alarm_raw to {“type”:“21”,“value”:“0”} [StringType]
2020-07-24 09:13:07.980 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Commands processed 1.
2020-07-24 09:13:07.981 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@fcd50f.
2020-07-24 09:13:07.984 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@fcd50f.
2020-07-24 09:13:07.987 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: notifyTransactionResponse TID:3078 DONE
2020-07-24 09:13:07.998 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
@chris finds unfiltered logs are needed for troubleshooting. The log viewer should help the bleary eyes 
https://www.cd-jackson.com/index.php/openhab/zwave-log-viewer
Well, I started out using that but couldn’t find anything to help so I started using the viewer that has been added to http://192.168.1.115:9001/. That is where I found s lot more NODE 27 information.
Below is an unfiltered section from Chris’s log viewer.
RX REQ ApplicationCommandHandler SENSOR_MULTI_LEVEL_REPORT TEMPERATURE=42 0 /128
01 0C 00 04 08 05 06 31 05 01 2A 03 0C EC
10:50:47.806 5
RX REQ ApplicationCommandHandler SENSOR_MULTI_LEVEL_REPORT TEMPERATURE=42 0 /128
01 0C 00 04 00 05 06 31 05 01 2A 03 0C E4
10:50:47.824 5
STATE UPDATE zwave:device:fe40ab17:node5:sensor_temperature 78 °F [QuantityType]
10:50:47.861 5
STATE UPDATE zwave:device:fe40ab17:node5:sensor_temperature 78 °F [QuantityType]
11:12:08.845 5
RX REQ ApplicationCommandHandler SENSOR_MULTI_LEVEL_REPORT TEMPERATURE=42 0 /128
01 0C 00 04 08 05 06 31 05 01 2A 03 11 F1
11:12:08.871 5
RX REQ ApplicationCommandHandler SENSOR_MULTI_LEVEL_REPORT TEMPERATURE=42 0 /128
01 0C 00 04 00 05 06 31 05 01 2A 03 11 F9
11:12:08.892 5
STATE UPDATE zwave:device:fe40ab17:node5:sensor_temperature 78.5 °F [QuantityType]
11:12:08.940 5
STATE UPDATE zwave:device:fe40ab17:node5:sensor_temperature 78.5 °F [QuantityType]
11:13:01.180 27
TX REQ SendData 121 SECURITY_NONCE_GET ACK AUTO_ROUTE EXPLORE
01 09 00 13 1B 02 98 40 25 79 78
11:13:01.186
RX ACK 0 /128
06
11:13:01.208 27
RX RES SendData 121 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
11:13:02.440 27
RX REQ SendData 121 ACK RECEIVED from device in 1260ms 0 /128
01 07 00 13 79 00 00 7E EC
11:13:02.459 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_REPORT NONCE ID 89 0 /128
01 10 00 04 00 1B 0A 98 80 59 C2 33 79 62 5F BA F3 47
11:13:02.540 27
SECURE TXD DOOR_LOCK_GET
62 02
11:13:02.551 27
TX REQ SendData 122 SECURITY_ENCAP NONCE ID 89 ACK AUTO_ROUTE EXPLORE
01 1D 00 13 1B 16 98 81 96 CC DB 73 4F E2 9F 67 35 28 F7 59 D9 C3 EA 53 31 8E A2 1E 25 7A 0E
11:13:02.557
RX ACK 0 /128
06
11:13:02.565 27
RX RES SendData 122 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
11:13:02.589 27
RX REQ SendData 122 ACK RECEIVED from device in 38ms 0 /128
01 07 00 13 7A 00 00 02 93
11:13:02.628 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_GET 0 /128
01 08 00 04 00 1B 02 98 40 32
11:13:02.665 27
TX REQ SendData 123 SECURITY_NONCE_REPORT NONCE ID 51 ACK AUTO_ROUTE EXPLORE
01 11 00 13 1B 0A 98 80 33 8D 2D 02 66 8C 27 87 25 7B 71
11:13:02.671
RX ACK 0 /128
06
11:13:02.678 27
RX RES SendData 123 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
11:13:02.696 27
RX REQ SendData 123 ACK RECEIVED from device in 31ms 0 /128
01 07 00 13 7B 00 00 02 92
11:13:02.727 27
RX REQ ApplicationCommandHandler SECURITY_ENCAP NONCE ID 51 0 /128
01 21 00 04 00 1B 1B 98 81 A0 A5 07 57 30 2B D2 B8 0B 21 23 2B 6F C9 6C 1A 33 B7 47 D9 BD 21 6A D3 10 3A
11:13:02.758 27
SECURE RXD DOOR_LOCK_REPORT
62 03 00 00 02 FE FE
11:13:02.771 27
STATE UPDATE zwave:device:fe40ab17:node27:lock_door OFF [OnOffType]
11:13:02.809 27
TX REQ SendData 124 SECURITY_NONCE_GET ACK AUTO_ROUTE EXPLORE
01 09 00 13 1B 02 98 40 25 7C 7D
11:13:02.814
RX ACK 0 /128
06
11:13:02.822 27
RX RES SendData 124 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
11:13:02.839 27
RX REQ SendData 124 ACK RECEIVED from device in 30ms 0 /128
01 07 00 13 7C 00 00 03 94
11:13:02.854 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_REPORT NONCE ID 190 0 /128
01 10 00 04 00 1B 0A 98 80 BE 1C 8E 41 97 62 5D DF F8
11:13:02.908 27
SECURE TXD ALARM_GET
71 04 15
11:13:02.915 27
TX REQ SendData 125 SECURITY_ENCAP NONCE ID 190 ACK AUTO_ROUTE EXPLORE
01 1E 00 13 1B 17 98 81 36 60 F4 6C A9 98 13 38 73 7C AC AB BE 21 24 D0 A5 01 AB 72 05 25 7D 70
11:13:02.921
RX ACK 0 /128
06
11:13:02.928 27
RX RES SendData 125 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
11:13:02.951 27
RX REQ SendData 125 ACK RECEIVED from device in 36ms 0 /128
01 07 00 13 7D 00 00 03 95
11:13:02.966 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_GET 0 /128
01 08 00 04 00 1B 02 98 40 32
11:13:03.010 27
TX REQ SendData 126 SECURITY_NONCE_REPORT NONCE ID 10 ACK AUTO_ROUTE EXPLORE
01 11 00 13 1B 0A 98 80 0A 0B 62 AF B5 9F F2 89 25 7E 32
11:13:03.015
RX ACK 0 /128
06
11:13:03.022 27
RX RES SendData 126 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
11:13:03.041 27
RX REQ SendData 126 ACK RECEIVED from device in 31ms 0 /128
01 07 00 13 7E 00 00 02 97
11:13:03.067 27
RX REQ ApplicationCommandHandler SECURITY_ENCAP NONCE ID 10 0 /128
01 1E 00 04 00 1B 18 98 81 F8 06 3D B1 AB 3B 50 C4 05 8F C7 EB 5A 0A 19 65 94 A5 CF 61 61 AD 50
11:13:03.089 27
SECURE RXD ALARM_REPORT
71 05 15 00
11:13:03.101 27
STATE UPDATE zwave:device:fe40ab17:node27:alarm_number 21 [DecimalType]
11:13:03.107 27
STATE UPDATE zwave:device:fe40ab17:node27:alarm_raw {"type":"21","value":"0"} [StringType]
11:43:01.191 27
TX REQ SendData 127 SECURITY_NONCE_GET ACK AUTO_ROUTE EXPLORE
01 09 00 13 1B 02 98 40 25 7F 7E
11:43:01.197
RX ACK 0 /128
06
11:43:01.205 27
RX RES SendData 127 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
11:43:02.465 27
RX REQ SendData 127 ACK RECEIVED from device in 1274ms 0 /128
01 07 00 13 7F 00 00 7F EB
11:43:02.494 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_REPORT NONCE ID 163 0 /128
01 10 00 04 00 1B 0A 98 80 A3 B9 FF DC D6 36 37 86 8A
11:43:02.542 27
SECURE TXD DOOR_LOCK_GET
62 02
11:43:02.548 27
TX REQ SendData 128 SECURITY_ENCAP NONCE ID 163 ACK AUTO_ROUTE EXPLORE
01 1D 00 13 1B 16 98 81 EF 5C 1D 46 6D 23 12 86 26 98 96 A3 43 49 76 D0 5C 84 F1 42 25 80 3E
11:43:02.553
RX ACK 0 /128
06
11:43:02.560 27
RX RES SendData 128 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
11:43:02.582 27
RX REQ SendData 128 ACK RECEIVED from device in 34ms 0 /128
01 07 00 13 80 00 00 02 69
11:43:02.622 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_GET 0 /128
01 08 00 04 00 1B 02 98 40 32
11:43:02.666 27
TX REQ SendData 129 SECURITY_NONCE_REPORT NONCE ID 56 ACK AUTO_ROUTE EXPLORE
01 11 00 13 1B 0A 98 80 38 41 E8 DC 14 52 A1 6F 25 81 95
11:43:02.672
RX ACK 0 /128
06
11:43:02.678 27
RX RES SendData 129 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
11:43:02.698 27
RX REQ SendData 129 ACK RECEIVED from device in 32ms 0 /128
01 07 00 13 81 00 00 03 69
11:43:02.725 27
RX REQ ApplicationCommandHandler SECURITY_ENCAP NONCE ID 56 0 /128
01 21 00 04 00 1B 1B 98 81 1D 22 E5 B7 8B 65 31 73 DA 95 03 A0 26 EF 16 E9 38 FB 93 1C 57 D9 99 A0 20 03
11:43:02.746 27
SECURE RXD DOOR_LOCK_REPORT
62 03 00 00 02 FE FE
11:43:02.757 27
STATE UPDATE zwave:device:fe40ab17:node27:lock_door OFF [OnOffType]
11:43:02.788 27
TX REQ SendData 130 SECURITY_NONCE_GET ACK AUTO_ROUTE EXPLORE
01 09 00 13 1B 02 98 40 25 82 83
11:43:02.792
RX ACK 0 /128
06
11:43:02.799 27
RX RES SendData 130 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
11:43:02.817 27
RX REQ SendData 130 ACK RECEIVED from device in 29ms 0 /128
01 07 00 13 82 00 00 02 6B
11:43:02.831 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_REPORT NONCE ID 139 0 /128
01 10 00 04 00 1B 0A 98 80 8B 32 46 49 FD 4A 37 FF 2B
11:43:02.873 27
SECURE TXD ALARM_GET
71 04 15
11:43:02.878 27
TX REQ SendData 131 SECURITY_ENCAP NONCE ID 139 ACK AUTO_ROUTE EXPLORE
01 1E 00 13 1B 17 98 81 6B 1B 34 7E 16 76 61 EE A1 24 7E 9B 8B 61 8F A6 BF 17 A7 1F 42 25 83 65
11:43:02.884
RX ACK 0 /128
06
11:43:02.892 27
RX RES SendData 131 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
11:43:02.913 27
RX REQ SendData 131 ACK RECEIVED from device in 35ms 0 /128
01 07 00 13 83 00 00 02 6A
11:43:02.928 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_GET 0 /128
01 08 00 04 00 1B 02 98 40 32
11:43:02.972 27
TX REQ SendData 132 SECURITY_NONCE_REPORT NONCE ID 46 ACK AUTO_ROUTE EXPLORE
01 11 00 13 1B 0A 98 80 2E 8C D6 33 85 CE 78 A8 25 84 89
11:43:02.977
RX ACK 0 /128
06
11:43:02.985 27
RX RES SendData 132 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
11:43:03.004 27
RX REQ SendData 132 ACK RECEIVED from device in 32ms 0 /128
01 07 00 13 84 00 00 02 6D
11:43:03.028 27
RX REQ ApplicationCommandHandler SECURITY_ENCAP NONCE ID 46 0 /128
01 1E 00 04 00 1B 18 98 81 59 3F 57 C3 34 38 DE 5F 92 EC C5 52 2E 2E 55 94 60 B1 28 5A 0B F7 F7
11:43:03.050 27
SECURE RXD ALARM_REPORT
71 05 15 00
11:43:03.062 27
STATE UPDATE zwave:device:fe40ab17:node27:alarm_number 21 [DecimalType]
11:43:03.067 27
STATE UPDATE zwave:device:fe40ab17:node27:alarm_raw {"type":"21","value":"0"} [StringType]
12:13:01.185 27
TX REQ SendData 133 SECURITY_NONCE_GET ACK AUTO_ROUTE EXPLORE
01 09 00 13 1B 02 98 40 25 85 84
12:13:01.190
RX ACK 0 /128
06
12:13:01.200 27
RX RES SendData 133 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
12:13:02.461 27
RX REQ SendData 133 ACK RECEIVED from device in 1276ms 0 /128
01 07 00 13 85 00 00 7F 11
12:13:02.475 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_REPORT NONCE ID 18 0 /128
01 10 00 04 00 1B 0A 98 80 12 EF 1F 1C 78 3B B7 C8 20
12:13:02.548 27
SECURE TXD DOOR_LOCK_GET
62 02
12:13:02.560 27
TX REQ SendData 134 SECURITY_ENCAP NONCE ID 18 ACK AUTO_ROUTE EXPLORE
01 1D 00 13 1B 16 98 81 A8 97 3E C6 D1 FC 30 0D 7C 7C 16 12 76 90 61 1E DC 16 84 F0 25 86 B2
12:13:02.568
RX ACK 0 /128
06
12:13:02.576 27
RX RES SendData 134 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
12:13:02.602 27
RX REQ SendData 134 ACK RECEIVED from device in 42ms 0 /128
01 07 00 13 86 00 00 03 6E
12:13:02.638 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_GET 0 /128
01 08 00 04 00 1B 02 98 40 32
12:13:02.676 27
TX REQ SendData 135 SECURITY_NONCE_REPORT NONCE ID 168 ACK AUTO_ROUTE EXPLORE
01 11 00 13 1B 0A 98 80 A8 F8 65 3B 57 CD 2D 8D 25 87 62
12:13:02.683
RX ACK 0 /128
06
12:13:02.691 27
RX RES SendData 135 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
12:13:02.710 27
RX REQ SendData 135 ACK RECEIVED from device in 34ms 0 /128
01 07 00 13 87 00 00 02 6E
12:13:02.738 27
RX REQ ApplicationCommandHandler SECURITY_ENCAP NONCE ID 168 0 /128
01 21 00 04 00 1B 1B 98 81 4D A2 66 09 06 22 AE F7 92 92 4F DE 0A 45 E0 66 A8 1E AB 7E 46 14 E8 A0 6C 73
12:13:02.766 27
SECURE RXD DOOR_LOCK_REPORT
62 03 00 00 02 FE FE
12:13:02.782 27
STATE UPDATE zwave:device:fe40ab17:node27:lock_door OFF [OnOffType]
12:13:02.823 27
TX REQ SendData 136 SECURITY_NONCE_GET ACK AUTO_ROUTE EXPLORE
01 09 00 13 1B 02 98 40 25 88 89
12:13:02.827
RX ACK 0 /128
06
12:13:02.835 27
RX RES SendData 136 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
12:13:02.851 27
RX REQ SendData 136 ACK RECEIVED from device in 28ms 0 /128
01 07 00 13 88 00 00 03 60
12:13:02.866 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_REPORT NONCE ID 147 0 /128
01 10 00 04 00 1B 0A 98 80 93 68 9B 7E 6C 76 5F 52 EB
12:13:02.923 27
SECURE TXD ALARM_GET
71 04 15
12:13:02.930 27
TX REQ SendData 137 SECURITY_ENCAP NONCE ID 147 ACK AUTO_ROUTE EXPLORE
01 1E 00 13 1B 17 98 81 FB 4F 6B 7B 46 45 02 92 D3 84 31 19 93 A7 FA D1 EC 7E 11 C6 EE 25 89 B7
12:13:02.937
RX ACK 0 /128
06
12:13:02.948 27
RX RES SendData 137 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
12:13:02.966 27
RX REQ SendData 137 ACK RECEIVED from device in 36ms 0 /128
01 07 00 13 89 00 00 02 60
12:13:02.982 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_GET 0 /128
01 08 00 04 00 1B 02 98 40 32
12:13:03.018 27
TX REQ SendData 138 SECURITY_NONCE_REPORT NONCE ID 162 ACK AUTO_ROUTE EXPLORE
01 11 00 13 1B 0A 98 80 A2 25 C9 22 24 91 89 43 25 8A 48
12:13:03.022
RX ACK 0 /128
06
12:13:03.030 27
RX RES SendData 138 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
12:13:03.048 27
RX REQ SendData 138 ACK RECEIVED from device in 30ms 0 /128
01 07 00 13 8A 00 00 02 63
12:13:03.074 27
RX REQ ApplicationCommandHandler SECURITY_ENCAP NONCE ID 162 0 /128
01 1E 00 04 00 1B 18 98 81 45 0B F9 92 6B BE 95 36 94 15 27 F8 19 A2 BC C1 9E 6A E4 25 A5 1E BA
12:13:03.099 27
SECURE RXD ALARM_REPORT
71 05 15 00
12:13:03.114 27
STATE UPDATE zwave:device:fe40ab17:node27:alarm_number 21 [DecimalType]
12:13:03.119 27
STATE UPDATE zwave:device:fe40ab17:node27:alarm_raw {"type":"21","value":"0"} [StringType]
12:36:21.560 26
RX REQ ApplicationCommandHandler SECURITY_NONCE_GET 0 /128
01 08 00 04 00 1A 02 98 40 33
12:36:21.594 26
TX REQ SendData 139 SECURITY_NONCE_REPORT NONCE ID 142 ACK AUTO_ROUTE EXPLORE
01 11 00 13 1A 0A 98 80 8E F5 7C D8 C7 0E 5F 30 25 8B 22
12:36:21.600
RX ACK 0 /128
06
12:36:21.607 26
RX RES SendData 139 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
12:36:21.625 26
RX REQ SendData 139 ACK RECEIVED from device in 31ms 0 /128
01 07 00 13 8B 00 00 02 62
12:36:21.647 26
RX REQ ApplicationCommandHandler SECURITY_ENCAP NONCE ID 142 0 /128
01 1D 00 04 00 1A 17 98 81 B8 E8 98 38 98 B9 EB 86 7E 2C 73 46 8E 55 74 CC 3B 85 E7 7A 0A 63
12:36:21.665 26
SECURE RXD BATTERY_REPORT 92%
80 03 5C
12:43:01.172 27
TX REQ SendData 140 SECURITY_NONCE_GET ACK AUTO_ROUTE EXPLORE
01 09 00 13 1B 02 98 40 25 8C 8D
12:43:01.178
RX ACK 0 /128
06
12:43:01.192 27
RX RES SendData 140 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
12:43:02.416 27
RX REQ SendData 140 ACK RECEIVED from device in 1244ms 0 /128
01 07 00 13 8C 00 00 7C 1B
12:43:02.435 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_REPORT NONCE ID 82 0 /128
01 10 00 04 00 1B 0A 98 80 52 0E 2F BA 04 82 34 27 BE
12:43:02.502 27
SECURE TXD DOOR_LOCK_GET
62 02
12:43:02.509 27
TX REQ SendData 141 SECURITY_ENCAP NONCE ID 82 ACK AUTO_ROUTE EXPLORE
01 1D 00 13 1B 16 98 81 AD 7F BB CB 3B 1A 86 DB BF 63 53 52 6E 69 65 D6 03 6E 71 A8 25 8D 4E
12:43:02.515
RX ACK 0 /128
06
12:43:02.522 27
RX RES SendData 141 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
12:43:02.545 27
RX REQ SendData 141 ACK RECEIVED from device in 36ms 0 /128
01 07 00 13 8D 00 00 03 65
12:43:02.584 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_GET 0 /128
01 08 00 04 00 1B 02 98 40 32
12:43:02.620 27
TX REQ SendData 142 SECURITY_NONCE_REPORT NONCE ID 19 ACK AUTO_ROUTE EXPLORE
01 11 00 13 1B 0A 98 80 13 11 34 0D A4 A0 58 6A 25 8E 52
12:43:02.625
RX ACK 0 /128
06
12:43:02.632 27
RX RES SendData 142 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
12:43:02.650 27
RX REQ SendData 142 ACK RECEIVED from device in 30ms 0 /128
01 07 00 13 8E 00 00 02 67
12:43:02.677 27
RX REQ ApplicationCommandHandler SECURITY_ENCAP NONCE ID 19 0 /128
01 21 00 04 00 1B 1B 98 81 26 DE 1E 33 43 D6 9E 5F D4 E5 99 D9 7B 51 89 06 13 23 E9 6E 22 EB A1 19 2C 7C
12:43:02.697 27
SECURE RXD DOOR_LOCK_REPORT
62 03 00 00 02 FE FE
12:43:02.709 27
STATE UPDATE zwave:device:fe40ab17:node27:lock_door OFF [OnOffType]
12:43:02.739 27
TX REQ SendData 143 SECURITY_NONCE_GET ACK AUTO_ROUTE EXPLORE
01 09 00 13 1B 02 98 40 25 8F 8E
12:43:02.742
RX ACK 0 /128
06
12:43:02.749 27
RX RES SendData 143 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
12:43:02.766 27
RX REQ SendData 143 ACK RECEIVED from device in 27ms 0 /128
01 07 00 13 8F 00 00 02 66
12:43:02.780 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_REPORT NONCE ID 108 0 /128
01 10 00 04 00 1B 0A 98 80 6C D5 40 0F 33 9E F2 24 6F
12:43:02.826 27
SECURE TXD ALARM_GET
71 04 15
12:43:02.832 27
TX REQ SendData 144 SECURITY_ENCAP NONCE ID 108 ACK AUTO_ROUTE EXPLORE
01 1E 00 13 1B 17 98 81 F8 46 C0 E8 64 80 31 9A 47 10 70 01 6C 9B 3E 0D BE 4A 25 6D 8B 25 90 5E
12:43:02.837
RX ACK 0 /128
06
12:43:02.844 27
RX RES SendData 144 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
12:43:02.866 27
RX REQ SendData 144 ACK RECEIVED from device in 34ms 0 /128
01 07 00 13 90 00 00 03 78
12:43:02.881 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_GET 0 /128
01 08 00 04 00 1B 02 98 40 32
12:43:02.922 27
TX REQ SendData 145 SECURITY_NONCE_REPORT NONCE ID 165 ACK AUTO_ROUTE EXPLORE
01 11 00 13 1B 0A 98 80 A5 53 16 CA 85 E1 15 1F 25 91 04
12:43:02.926
RX ACK 0 /128
06
12:43:02.934 27
RX RES SendData 145 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
12:43:02.953 27
RX REQ SendData 145 ACK RECEIVED from device in 31ms 0 /128
01 07 00 13 91 00 00 02 78
12:43:02.979 27
RX REQ ApplicationCommandHandler SECURITY_ENCAP NONCE ID 165 0 /128
01 1E 00 04 00 1B 18 98 81 B4 82 60 ED AA CB CF 59 20 82 44 CB 9F A5 A1 0D 66 74 6F 32 29 BB D5
12:43:02.997 27
SECURE RXD ALARM_REPORT
71 05 15 00
12:43:03.009 27
STATE UPDATE zwave:device:fe40ab17:node27:alarm_number 21 [DecimalType]
12:43:03.014 27
STATE UPDATE zwave:device:fe40ab17:node27:alarm_raw {"type":"21","value":"0"} [StringType]
13:13:01.191 27
TX REQ SendData 146 SECURITY_NONCE_GET ACK AUTO_ROUTE EXPLORE
01 09 00 13 1B 02 98 40 25 92 93
13:13:01.196
RX ACK 0 /128
06
13:13:01.205 27
RX RES SendData 146 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
13:13:02.436 27
RX REQ SendData 146 ACK RECEIVED from device in 1245ms 0 /128
01 07 00 13 92 00 00 7C 05
13:13:02.450 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_REPORT NONCE ID 240 0 /128
01 10 00 04 00 1B 0A 98 80 F0 4B F8 63 57 30 06 5C FF
13:13:02.524 27
SECURE TXD DOOR_LOCK_GET
62 02
13:13:02.535 27
TX REQ SendData 147 SECURITY_ENCAP NONCE ID 240 ACK AUTO_ROUTE EXPLORE
01 1D 00 13 1B 16 98 81 CF AC D6 E8 30 E8 B2 50 BB 36 4B F0 54 61 3F 7F E3 DE 31 3F 25 93 44
13:13:02.543
RX ACK 0 /128
06
13:13:02.550 27
RX RES SendData 147 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
13:13:02.571 27
RX REQ SendData 147 ACK RECEIVED from device in 36ms 0 /128
01 07 00 13 93 00 00 03 7B
13:13:02.613 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_GET 0 /128
01 08 00 04 00 1B 02 98 40 32
13:13:02.650 27
TX REQ SendData 148 SECURITY_NONCE_REPORT NONCE ID 43 ACK AUTO_ROUTE EXPLORE
01 11 00 13 1B 0A 98 80 2B F8 1E E8 9B 0A C4 5A 25 94 6F
13:13:02.656
RX ACK 0 /128
06
13:13:02.665 27
RX RES SendData 148 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
13:13:02.692 27
RX REQ SendData 148 ACK RECEIVED from device in 42ms 0 /128
01 07 00 13 94 00 00 03 7C
13:13:02.710 27
RX REQ ApplicationCommandHandler SECURITY_ENCAP NONCE ID 43 0 /128
01 21 00 04 00 1B 1B 98 81 91 A6 7B 74 74 89 9D 6C 76 7B 13 97 E6 5A D3 FE 2B 78 83 0A 93 5A AC AB 68 93
13:13:02.755 27
SECURE RXD DOOR_LOCK_REPORT
62 03 00 00 02 FE FE
13:13:02.772 27
STATE UPDATE zwave:device:fe40ab17:node27:lock_door OFF [OnOffType]
13:13:02.810 27
TX REQ SendData 149 SECURITY_NONCE_GET ACK AUTO_ROUTE EXPLORE
01 09 00 13 1B 02 98 40 25 95 94
13:13:02.815
RX ACK 0 /128
06
13:13:02.822 27
RX RES SendData 149 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
13:13:02.838 27
RX REQ SendData 149 ACK RECEIVED from device in 28ms 0 /128
01 07 00 13 95 00 00 02 7C
13:13:02.853 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_REPORT NONCE ID 9 0 /128
01 10 00 04 00 1B 0A 98 80 09 AF BD 05 F7 1E DD 11 D9
13:13:02.919 27
SECURE TXD ALARM_GET
71 04 15
13:13:02.925 27
TX REQ SendData 150 SECURITY_ENCAP NONCE ID 9 ACK AUTO_ROUTE EXPLORE
01 1E 00 13 1B 17 98 81 23 CA 32 BF 0D FB 3B 01 C0 AD B0 2D 09 52 0D 62 F7 EA 9E F9 A7 25 96 E5
13:13:02.932
RX ACK 0 /128
06
13:13:02.939 27
RX RES SendData 150 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
13:13:02.960 27
RX REQ SendData 150 ACK RECEIVED from device in 35ms 0 /128
01 07 00 13 96 00 00 03 7E
13:13:02.975 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_GET 0 /128
01 08 00 04 00 1B 02 98 40 32
13:13:03.023 27
TX REQ SendData 151 SECURITY_NONCE_REPORT NONCE ID 191 ACK AUTO_ROUTE EXPLORE
01 11 00 13 1B 0A 98 80 BF AB 46 BF 10 2A 4C 80 25 97 5D
13:13:03.029
RX ACK 0 /128
06
13:13:03.036 27
RX RES SendData 151 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
13:13:03.055 27
RX REQ SendData 151 ACK RECEIVED from device in 32ms 0 /128
01 07 00 13 97 00 00 02 7E
13:13:03.079 27
RX REQ ApplicationCommandHandler SECURITY_ENCAP NONCE ID 191 0 /128
01 1E 00 04 00 1B 18 98 81 0A 56 EC 36 F5 24 36 11 34 DC 1A 63 60 BF 23 00 87 C6 68 B4 6A FE EB
13:13:03.100 27
SECURE RXD ALARM_REPORT
71 05 15 00
13:13:03.114 27
STATE UPDATE zwave:device:fe40ab17:node27:alarm_number 21 [DecimalType]
13:13:03.119 27
STATE UPDATE zwave:device:fe40ab17:node27:alarm_raw {"type":"21","value":"0"} [StringType]
13:43:01.248 27
TX REQ SendData 152 SECURITY_NONCE_GET ACK AUTO_ROUTE EXPLORE
01 09 00 13 1B 02 98 40 25 98 99
13:43:01.256
RX ACK 0 /128
06
13:43:01.283 27
RX RES SendData 152 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
13:43:02.540 27
RX REQ SendData 152 ACK RECEIVED from device in 1292ms 0 /128
01 07 00 13 98 00 00 81 F2
13:43:02.555 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_REPORT NONCE ID 71 0 /128
01 10 00 04 00 1B 0A 98 80 47 E7 06 5C 59 56 F0 BD 5A
13:43:02.632 27
SECURE TXD DOOR_LOCK_GET
62 02
13:43:02.644 27
TX REQ SendData 153 SECURITY_ENCAP NONCE ID 71 ACK AUTO_ROUTE EXPLORE
01 1D 00 13 1B 16 98 81 AB E1 24 A6 F3 CD 0C 20 42 98 2C 47 44 2F 9D 5B 0D 64 73 F3 25 99 76
13:43:02.652
RX ACK 0 /128
06
13:43:02.660 27
RX RES SendData 153 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
13:43:02.681 27
RX REQ SendData 153 ACK RECEIVED from device in 37ms 0 /128
01 07 00 13 99 00 00 03 71
13:43:02.720 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_GET 0 /128
01 08 00 04 00 1B 02 98 40 32
13:43:02.771 27
TX REQ SendData 154 SECURITY_NONCE_REPORT NONCE ID 49 ACK AUTO_ROUTE EXPLORE
01 11 00 13 1B 0A 98 80 31 82 4E 15 DF CD 0D 77 25 9A CB
13:43:02.777
RX ACK 0 /128
06
13:43:02.786 27
RX RES SendData 154 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
13:43:02.803 27
RX REQ SendData 154 ACK RECEIVED from device in 32ms 0 /128
01 07 00 13 9A 00 00 02 73
13:43:02.836 27
RX REQ ApplicationCommandHandler SECURITY_ENCAP NONCE ID 49 0 /128
01 21 00 04 00 1B 1B 98 81 FD D1 D7 C8 47 08 AD 79 37 EA BA FF BC E6 E3 E0 31 D1 48 CB F0 31 7E 7A 7B 77
13:43:02.879 27
SECURE RXD DOOR_LOCK_REPORT
62 03 00 00 02 FE FE
13:43:02.895 27
STATE UPDATE zwave:device:fe40ab17:node27:lock_door OFF [OnOffType]
13:43:02.935 27
TX REQ SendData 155 SECURITY_NONCE_GET ACK AUTO_ROUTE EXPLORE
01 09 00 13 1B 02 98 40 25 9B 9A
13:43:02.940
RX ACK 0 /128
06
13:43:02.947 27
RX RES SendData 155 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
13:43:02.964 27
RX REQ SendData 155 ACK RECEIVED from device in 29ms 0 /128
01 07 00 13 9B 00 00 02 72
13:43:02.978 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_REPORT NONCE ID 247 0 /128
01 10 00 04 00 1B 0A 98 80 F7 64 9A 82 A0 2B 9B FA 83
13:43:03.047 27
SECURE TXD ALARM_GET
71 04 15
13:43:03.054 27
TX REQ SendData 156 SECURITY_ENCAP NONCE ID 247 ACK AUTO_ROUTE EXPLORE
01 1E 00 13 1B 17 98 81 38 E0 36 0E 0C 15 ED 0C 22 DB 2D 12 F7 6D 95 96 35 F1 6C 86 7A 25 9C 4D
13:43:03.064
RX ACK 0 /128
06
13:43:03.069 27
RX RES SendData 156 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
13:43:03.091 27
RX REQ SendData 156 ACK RECEIVED from device in 37ms 0 /128
01 07 00 13 9C 00 00 03 74
13:43:03.105 27
RX REQ ApplicationCommandHandler SECURITY_NONCE_GET 0 /128
01 08 00 04 00 1B 02 98 40 32
13:43:03.160 27
TX REQ SendData 157 SECURITY_NONCE_REPORT NONCE ID 249 ACK AUTO_ROUTE EXPLORE
01 11 00 13 1B 0A 98 80 F9 8B C4 A1 14 1C 59 8A 25 9D 80
13:43:03.165
RX ACK 0 /128
06
13:43:03.171 27
RX RES SendData 157 ACCEPTED BY CONTROLLER 0 /128
01 04 01 13 01 E8
13:43:03.191 27
RX REQ SendData 157 ACK RECEIVED from device in 31ms 0 /128
01 07 00 13 9D 00 00 03 75
13:43:03.218 27
RX REQ ApplicationCommandHandler SECURITY_ENCAP NONCE ID 249 0 /128
01 1E 00 04 00 1B 18 98 81 F2 B5 E2 67 04 32 87 F9 2E 00 F9 81 7C F9 C4 DD 0C DB 5A 79 92 0D D4
13:43:03.283 27
SECURE RXD ALARM_REPORT
71 05 15 00
13:43:03.304 27
STATE UPDATE zwave:device:fe40ab17:node27:alarm_number 21 [DecimalType]
13:43:03.310 27
STATE UPDATE zwave:device:fe40ab17:node27:alarm_raw {"type":"21","value":"0"} [StringType]```Well I have been doing a lot of experimenting with this door lock and drudging through untold openhab.logs. I wish I could find a key to deciphering the log.
Anyhow, I have found that the “false” reports occur both right after a command to change and also as the result of polling which seems to happen every 30 minutes. For a few days the false report was {“type”:“21”,“value”:“0”}” which means " Lock Secured using Keyed cylinder or inside thumb-turn.
Today I rebooted my RPi and now the false reports are {“type”:“19”,“value”:“0”}=“Un-Secured by User 0 at Keypad”.
Nobody was near the keypad.
Interestingly when I was getting the {“type”:“21”,“value”:“0”} reports, I could always find the text:
"ALARM report - 21 = 0 and
Alarm Type = WATER_QUALITY (21)
where the “21” matches the type 21.
Today I am getting:
ALARM report - 19 = 0
Alarm Type = PEST_CONTROL (19)
where the “19” matches the type 19.
What does a door lock have to do with WATER_QUALITY or PEST_CONTROL?
I think the solution to my problem is to ignore the reports right after commanding a change and all the polling reports.
I have no idea how to do that. Any suggestions?
Here is the log via
“tail -f /var/log/openhab2/openhab.log /var/log/openhab2/events.log”
The command to change the lock is at 14:16:25.621
The PEST_CONTROL is at 14:16:34.007
The {“type”:“19”,“value”:“0”} is at 14:16:34.020
Oops, the file is longer then I can post here,.
I have uploaded it herenLog file
I have tried to use that viewer but it seems to be missing a lot of things. I am actually comparing it to the tale right now trying to correlate the two.
But I don’t see any “PEST_CONTROL” just for an example.
I am trying to find a way I can ignore the polling and the first transaction after the command to change.
I have attached a screen capture of Chris’s log. The {“type”.“25”,“value”.“1”} at time 15:22:55.665 is the one I need and it will get to the HABpanel display but then at 15:23:01.046 I get the {“type”:“22”,“value”.“0”} which overwrites the correct state. I need to find a way to detect that second {} and all subsequent ones (from polling) and stop them from updating the HABpanel display.
Either you have a very small network or that is a filtered log. @chris has said many times that a filtered log is useless for troubleshooting purposes.
These “raw” notifications are designed to be used in rules, so this is pretty easy. You need to create a virtual item - ie one that is not linked to a channel. You an then write a rule that receives these raw notifications, filters them as you like, and then updates the virtual item.
The following link might give you some ideas -:
1 Like
Bruce,
The log was unfiltered.
Almost everything in my house communicates in the 345MHz band. I bought this house that had an existing commercial security system (Vivint). They tried to rip me off at signup so I told them to stuff it and took it over myself. It took more than 9 months but now all the sensors, door, window, heat, smoke, glass break, all report to me. I decode the messages and pass it to OpenHAB.
There was a z-wave thermostat and door lock which are part of OpenHAB now but has these problems. I also installed another door lock and it has problems also which I am working on. And, I have two z-wave FirstAlert CO/Smoke detectors that are a real problem and are stand alone now.
It looks like Chris may have a solution for this lock problem.
1 Like
Sorry.
Chris is really our expert here. I just assist him as I am able. We are working on a replacement site for the database right now.
Sorry? Please no sorrys from you. You and Chris and all the others provide so much for this community is unbelievable.
1 Like
Then PLEASE start a new thread. Discussions of multiple devices in the same thread get confusing very quickly. Similar symptoms does not indicate the same underlying issue.
I believe his is the Z-Wave not Z-Wave plus model as well (he didn’t specify), I mentioned it only because these locks are confusing to identify and it sounds like he may not have been the original purchaser of the device. My device was identified as the same lock as his by OpenHAB.
I’ve withdrawn my post. Sorry about that! I’ll make my own topic some day when I get enough time to debug further, at least with my workaround in place the lock is usable.
You could have copied most of your posting.
As the OP, can I ask for a little pause on these lock issues? I am starting to believe that there are a number of locks out there with names like Black and Decker and Kwikset and various model numbers but they seem to pull up the same or similar devices from the data base. As if they use similar software with various hardware configurations. If the software isn’t the same they seem to have similar problems.
In my case when the lock is commanded to take an action it does (mechanically) and reports that it was successful. Then immediately or a few seconds later (sometimes as much as 12 seconds) another report comes that is bogus and describes an action that never happened. Also, if polling is running subsequent polls will give similar bogus actions.
shadowdognh has since removed his post describing exactly the same problem with his Kwikset 99100-014 deadbolt that I am having with my Black & Decker Touchpad Electronic Deadbolt (914TRL Touchpad Electronic Deadbolt).
shadowdognh what device does HABmin or PaperUI report for your lock?
Also, in addition to WATER_QUALITY and PEST_CONTROL alarm types, I am now getting GAS. It seems that if I reboot my RPi the alarm type changes and so does the bogus report (22 or 21 or 18 or 19)
Chris gave me a great link above and I am working through the example. It has provided me more understanding then hours of reading the docs. A picture is worth a thousand words.
I have not yet found a reliable key that I can use to discard the bogus reports but no doubt there is something. When I find it I will post it here.
1 Like
I think I have a solution for this problem that works except for one situation.
I have attached a screen capture of my cellphone screen.
The first row is for this lock. The second is for my Yale lock.
I will summarize the Problem because sometimes long threads lose context:
I started using the lock_door channel to report the state of the lock.
I discovered that if the lock changed because of a manual operation
like turning the lever, the lock_door channel is not updated.
So I tried the alarm_raw channel. It reports the correct state
but then a few seconds later (or for every polling action)
it reports a bogus state. The bogus alarm_raw seems to report as:
“Lock Secured at Keypad – Successful (Fully extended)”
but with no user number {“type”:“18”,“value”:“0”}.
The Solution:
If I used Alarm_Raw the wrong state can be displayed so I created a Virtual item like Chris recommended.
Then I can choose which alarm_raw reports to use.
Thus I will not update Virtual item if alarm_raw is {“type”:“18”,“value”:“0”}.
However {“type”:“18”,“value”:“0”} is a valid value for when the Lock
button on the keypad is pressed without a user ID.
So in that case the Virtual display will not be updated to show:
“Lock Secured at Keypad – Successful (Fully extended)”
This is the only case where the wrong state is displayed by the Virtual item.
If it is any consolation the door is locked when this happens.
If I could tell the difference between the bogus {“type”:“18”,“value”:“0”} and the valid one this problem could be corrected.
I just don’t have enough knowledge of the Z-Wave logs to solve this. I have included three image captures of the log when this is happening. With reference to the first image and time 19:30:10:569. That is when I pushed the Lock button of the keypad without entering a User ID. I believe the entire report ends at 19:30:10:694 where the {“type”:“18”,“value”:“0”} is reported. This is not the bogus report.
But I believe about 7 minutes later at 19:37:30:462 the bogus report starts. I don’t know what all those entries are telling us but at 19:37:32:307 I get the {“type”:“18”,“value”:“0”} which is a problem. (Note you might argue that this is a repeat of the last {“type”:“18”,“value”:“0”} but this sequence will come no matter what the last report was. If necessary I can provide other examples.)
I have included my items file below. I AM SORRY BUT I SEEM TO HAVE FORGOTTEN HOW TO PROPERLY FORMAT THIS. CHALK IT UP TO OLD AGE
THANK YOU BRUCE. BACKTICKS WHY COULDN’T I REMEMBER THAT?
// Door Lock to Garage: Black & Decker 914TRL but image shown as 910 in documents
Switch Garage_Lock_Door "G Lock State" <door> {channel="zwave:device:fe40ab17:node27:lock_door"}
String Garage_Alarm_Raw "G Alarm Raw type]" {channel="zwave:device:fe40ab17:node27:alarm_raw"}
Number Garage_Battery_Level "G Lock Battery [%d %%]" <battery> {channel="zwave:device:fe40ab17:node27:battery-level"}
String Garage_Alarm_Virtual "G Lock StateV "
//Door Lock to Porch: Yale YRD110
Switch Porch_Lock_Door "P Lock State" <door> {channel="zwave:device:fe40ab17:node26:lock_door"}
String Porch_Alarm_Raw "P Last Report [MAP(PorchLock.map):%s]" <alarm> {channel="zwave:device:fe40ab17:node26:alarm_raw"}
And my rules file below.
// I started using the lock_door switch to report the state of the lock.
// I discovered that if the lock changed because of a manual operation
// like turning the lever, the lock_door string is not updated.
// So I tried the alarm_raw string. It reports the correct state
// but then a few seconds after a controller command (or for every polling action)
// it reports a bogus state. The bogus alarm_raw seems report as:
// "Lock Secured at Keypad – Successful (Fully extended)"
// but with no user number {“type”:“18”,“value”:“0”}. If I used Alarm_Raw
// the wrong state can be displayed so I will create a Virtual item that
// I will not update if alarm_raw is {“type”:“18”,“value”:“0”}.
// However {“type”:“18”,“value”:“0”} is a valid value for when the Lock
// button on the keypad is pressed without a user ID.
// So in that case the Virtual display will be wrong. It will correct
// if another action is taken. And the door should be locked anyway.
when
Item Garage_Alarm_Raw changed
then
//Process the JSON from the raw alarm to get the Type and Value
var actionType = transform("JSONPATH", "$.type",triggeringItem.state.toString) // these SOBs are strings
var actionTypeValue = transform("JSONPATH", "$.value", triggeringItem.state.toString)
logDebug("RULE_SYSTEM", "Lock: Alarm events: TFormed State: {}, StateValue: {}", actionType, actionTypeValue)
if(actionTypeValue != "0"){
/* Alarm types and levels from the documentation
Alarm Type Alarm Level Notification Event
017 001 Lock Secured at Keypad – Bolt Jammed (Not fully extended)
018 000 or User-ID#* Lock Secured at Keypad – Successful (Fully extended)
019 User-ID#* Lock Un-Secured by User (User-ID) at Keypad
021 001 Lock Secured using Keyed cylinder or inside thumb-turn
022 001 Lock Un-Secured using Keyed cylinder or inside thumb-turn
023 001 Lock Secured by Controller – Bolt Jammed (Not fully extended)
024 001 Lock Secured by Controller – Successful (Fully extended)
025 001 Lock Un-Secured by Controller – Successful (Fully retracted)
026 001 Lock Auto Secured – Bolt Jammed (Not fully extended)
027 001 Lock Auto Secured – Successful (Fully extended)
032 001 All User Codes deleted from lock
033 User-ID#* User Code Removed (Not shown in the Device but discovered by experiment.)
112 User-ID#* New User Code (User-ID#) added to the lock
161 001 Failed User Code attempt at Keypad
162 User-ID#* Attempted access by user (User-ID#) outside of scheduled
167 001 Low battery level
168 001 Critical battery level
169 001 Battery level too low to operate lock
* User-ID# values: 001 to 030
Rule inspired by this but modified to work with our locks
https://community.openhab.org/t/zwave-yale-yrd220-lock/34180/5
*/
switch (actionType) {
//Locking actions
case "17": {
Garage_Alarm_Virtual.postUpdate("Lock Secured at Keypad by User # – Bolt Jammed (Not fully extended)")
logDebug("RULE_SYSTEM", "{} Lock Secured at Keypad – Bolt Jammed (Not fully extended)", "GarageLock")
}
case "18": {
Garage_Alarm_Virtual.postUpdate("Lock Secured at Keypad by User # " + actionTypeValue + " – Successful (Fully extended)")
logDebug("RULE_SYSTEM", "{} Lock Secured at Keypad by User [{}] – Successful (Fully extended)", "GarageLock", actionTypeValue)
}
case "19": {
Garage_Alarm_Virtual.postUpdate("Lock Un-Secured by User # " + actionTypeValue + " at Keypad" )
logDebug("RULE_SYSTEM", "{} Lock Un-Secured by User ({}) at Keypad", "GarageLock", actionTypeValue)
}
case "21": {
Garage_Alarm_Virtual.postUpdate("Lock Secured using Keyed cylinder or inside thumb-turn")
logDebug("RULE_SYSTEM", "{} Lock Secured using Keyed cylinder or inside thumb-turn", "GarageLock")
}
case "22": {
Garage_Alarm_Virtual.postUpdate("Lock Un-Secured using Keyed cylinder or inside thumb-turn")
logDebug("RULE_SYSTEM", "{} Lock Un-Secured using Keyed cylinder or inside thumb-turn", "GarageLock")
}
case "23": {
Garage_Alarm_Virtual.postUpdate("Lock Secured by Controller – Bolt Jammed (Not fully extended)")
logDebug("RULE_SYSTEM", "{} Lock Secured by Controller – Bolt Jammed (Not fully extended)", "GarageLock")
}
case "24": {
Garage_Alarm_Virtual.postUpdate("Lock Secured by Controller – Successful (Fully extended)")
logDebug("RULE_SYSTEM", "{} Lock Secured by Controller – Successful (Fully extended)", "GarageLock")
}
case "25": {
Garage_Alarm_Virtual.postUpdate("Lock Un-Secured by Controller – Successful (Fully retracted)")
logDebug("RULE_SYSTEM", "{} Lock Un-Secured by Controller – Successful (Fully retracted)", "GarageLock")
}
case "26": {
Garage_Alarm_Virtual.postUpdate("Lock Auto Secured – Bolt Jammed (Not fully extended)")
logDebug("RULE_SYSTEM", "{} Lock Auto Secured – Bolt Jammed (Not fully extended)", "GarageLock")
}
case "27": {
Garage_Alarm_Virtual.postUpdate("Lock Auto Secured – Successful (Fully extended)")
logDebug("RULE_SYSTEM", "{} Lock Auto Secured – Successful (Fully extended)", "GarageLock")
}
case "32": {
Garage_Alarm_Virtual.postUpdate ("All User Codes deleted from lock")
logDebug("RULE_SYSTEM", "All User Codes deleted from lock", "GarageLock")
}
case "33": {
Garage_Alarm_Virtual.postUpdate ("User Number " + actionTypeValue + " Removed")
logDebug("RULE_SYSTEM", "{} User Number " + actionTypeValue + " Removed", "GarageLock")
}
case "112": {
Garage_Alarm_Virtual.postUpdate ("User Number " + actionTypeValue + " Added")
logDebug("RULE_SYSTEM", "{} User Number " + actionTypeValue + " Added", "GarageLock")
}
case "161": {
Garage_Alarm_Virtual.postUpdate ("Failed User Code attempt at Keypad")
logDebug("RULE_SYSTEM", "{} Failed User Code attempt at Keypad", "GarageLock")
}
case "167": {
Garage_Alarm_Virtual.postUpdate ("Low battery level")
logDebug("RULE_SYSTEM", "{} Low battery level", "GarageLock")
}
case "168": {
Garage_Alarm_Virtual.postUpdate ("Critical battery level")
logDebug("RULE_SYSTEM", "{} Critical battery level", "GarageLock")
}
case "169": {
Garage_Alarm_Virtual.postUpdate ("Critical battery level")
logDebug("RULE_SYSTEM", "{} Critical battery level", "GarageLock")
}
default : {
Garage_Alarm_Virtual.postUpdate ("Unknown Alarm Type " +actionType + " Value " +actionTypeValue)
logDebug("RULE_SYSTEM", "{} Unknown Alarm Type " +actionType + " Value " +actionTypeValue, "GarageLock")
}
}
}
end
PLEASE fix that post using code fences if you wish any help.
How to use code fences - Tutorials & Examples - openHAB Community
I have clipped a note to my monitor to remind me how to do code fences.
Sorry.
1 Like