OH 2.3 S1273, Z-Wave v 2.3.0.201805072038
I have also 2 nodes which appear as failed but something strange is happening at the same time (I think… not 100% sure)… OH2 is still getting info from them and updates the states of the items…
some log entries:
2018-05-11 17:42:04.987 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.987 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
more complete log
2018-05-11 17:42:04.951 [DEBUG] [rialmessage.IsFailedNodeMessageClass] - NODE 10: Requesting IsFailedNode status from controller.
2018-05-11 17:42:04.952 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@6398d665
2018-05-11 17:42:04.953 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Adding to controller queue
2018-05-11 17:42:04.954 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added to queue - size 1
2018-05-11 17:42:04.955 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start
2018-05-11 17:42:04.956 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 8: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.956 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: Node not awake!
2018-05-11 17:42:04.957 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.958 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.959 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.961 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.962 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.963 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.964 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.964 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.964 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.965 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.965 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.965 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.966 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.966 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.966 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.967 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.967 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.967 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.968 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.968 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.968 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.969 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.969 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.969 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.970 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.970 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.970 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.971 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.971 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.971 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.972 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.972 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.973 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.973 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.973 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.974 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.974 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.974 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.975 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.975 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.975 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.976 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.976 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.976 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.976 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.976 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.976 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.976 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.977 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.977 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.977 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.977 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.977 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.977 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.978 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.978 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.978 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.978 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.978 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.978 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.979 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.979 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.979 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.979 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.979 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.979 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.980 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.980 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.980 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.980 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.980 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.980 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.980 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.981 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.981 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.981 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.981 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.981 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.981 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.981 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.982 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.982 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.982 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.982 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.982 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.982 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.982 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.982 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.983 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.983 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.983 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.983 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.983 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.983 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.983 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.984 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.984 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.984 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.984 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.984 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.984 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.984 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.985 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.985 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.985 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.985 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.985 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.985 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.985 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.986 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.986 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.986 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.986 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.986 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.986 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.986 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.987 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.987 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.987 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.987 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:04.987 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!
2018-05-11 17:42:04.987 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction from controllerQueue
2018-05-11 17:42:04.988 [DEBUG] [nal.protocol.ZWaveTransactionManager] - getTransactionToSend 6
2018-05-11 17:42:04.988 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Creating empty message of class = IsFailedNodeID (0x62), type = Request
2018-05-11 17:42:04.988 [TRACE] [wave.internal.protocol.SerialMessage] - Calculated checksum = -109
2018-05-11 17:42:04.988 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 00 62 0A 93
2018-05-11 17:42:04.988 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 04 00 62 0A 93
2018-05-11 17:42:04.989 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2018-05-11 17:42:04.989 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 526: Transaction Start type IsFailedNodeID
2018-05-11 17:42:04.989 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 526: [WAIT_RESPONSE] requiresResponse=true callback: 0
2018-05-11 17:42:04.989 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: expected cmd class: null
2018-05-11 17:42:04.990 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: expected cmd: null
2018-05-11 17:42:04.990 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage Transactions outstanding: 1
2018-05-11 17:42:04.990 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Start transaction timer to Fri May 11 17:42:06 EEST 2018 - 2000ms
2018-05-11 17:42:04.990 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage lastTransaction: TID 526: [WAIT_RESPONSE] requiresResponse=true callback: 0
2018-05-11 17:42:04.991 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2018-05-11 17:42:04.991 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Creating new SerialMessage from buffer = 06
2018-05-11 17:42:04.991 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-05-11 17:42:04.992 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage past lock Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-05-11 17:42:04.992 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Received SOF
2018-05-11 17:42:04.992 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 62 01 99
2018-05-11 17:42:04.993 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Creating new SerialMessage from buffer = 01 04 01 62 01 99
2018-05-11 17:42:04.993 [TRACE] [wave.internal.protocol.SerialMessage] - Calculated checksum = -103
2018-05-11 17:42:04.993 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-05-11 17:42:04.993 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Checksum matched
2018-05-11 17:42:04.993 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 526: [WAIT_RESPONSE] requiresResponse=true callback: 0
2018-05-11 17:42:04.993 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2018-05-11 17:42:04.993 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-05-11 17:42:04.994 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start
2018-05-11 17:42:04.993 [TRACE] [wave.internal.protocol.SerialMessage] - NODE 255: Message payload = 01
2018-05-11 17:42:04.994 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Message is valid, sending ACK
2018-05-11 17:42:04.994 [TRACE] [WaveSerialHandler$ZWaveReceiveThread] - Response SENT 6
2018-05-11 17:42:04.994 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=IsFailedNodeID[98], type=Response[1], dest=255, callback=0, payload=01
2018-05-11 17:42:04.994 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage past lock Message: class=IsFailedNodeID[98], type=Response[1], dest=255, callback=0, payload=01
2018-05-11 17:42:04.994 [DEBUG] [nal.protocol.ZWaveTransactionManager] - STOP transaction timer
2018-05-11 17:42:04.995 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Start transaction timer to Fri May 11 17:42:06 EEST 2018 - 1995ms
2018-05-11 17:42:04.997 [DEBUG] [rialmessage.IsFailedNodeMessageClass] - NODE 2: Requesting IsFailedNode status from controller.
2018-05-11 17:42:04.997 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@15413f3a
2018-05-11 17:42:04.997 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Adding to controller queue
2018-05-11 17:42:04.997 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added to queue - size 1
2018-05-11 17:42:04.998 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start
2018-05-11 17:42:04.998 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction lastTransaction outstanding...
2018-05-11 17:42:04.998 [DEBUG] [nal.protocol.ZWaveTransactionManager] - STOP transaction timer
2018-05-11 17:42:04.998 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Start transaction timer to Fri May 11 17:42:06 EEST 2018 - 1992ms
2018-05-11 17:42:04.999 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction lastTransaction outstanding...
2018-05-11 17:42:04.999 [DEBUG] [nal.protocol.ZWaveTransactionManager] - STOP transaction timer
2018-05-11 17:42:05.000 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Start transaction timer to Fri May 11 17:42:06 EEST 2018 - 1990ms
2018-05-11 17:42:05.000 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=IsFailedNodeID[98], type=Response[1], dest=255, callback=0, payload=01
2018-05-11 17:42:05.000 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 526: [WAIT_RESPONSE] requiresResponse=true callback: 0
2018-05-11 17:42:05.000 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-05-11 17:42:05.001 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 526: [WAIT_RESPONSE] requiresResponse=true callback: 0
2018-05-11 17:42:05.001 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=IsFailedNodeID[98], type=Response[1], dest=255, callback=0, payload=01
2018-05-11 17:42:05.001 [TRACE] [ve.internal.protocol.ZWaveController] - Incoming Message type = RESPONSE
2018-05-11 17:42:05.001 [DEBUG] [rialmessage.IsFailedNodeMessageClass] - NODE 10: Is currently marked as failed by the controller!
2018-05-11 17:42:05.002 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 526: Transaction COMPLETED
2018-05-11 17:42:05.002 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 526: TransactionAdvance ST: DONE
2018-05-11 17:42:05.002 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 526: TransactionAdvance WT: null {}
2018-05-11 17:42:05.002 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 526: TransactionAdvance RX: Message: class=IsFailedNodeID[98], type=Response[1], dest=255, callback=0, payload=01
2018-05-11 17:42:05.002 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 526: TransactionAdvance TO: DONE
2018-05-11 17:42:05.003 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Response processed after 14ms
2018-05-11 17:42:05.003 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: TID 526: Transaction completed
2018-05-11 17:42:05.003 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:526 DONE
2018-05-11 17:42:05.005 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2018-05-11 17:42:05.005 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 526: Transaction event listener: DONE: DONE ->
2018-05-11 17:42:05.005 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: -- To notify -- COMPLETE
2018-05-11 17:42:05.005 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ********* Transaction Response Complete -- 526 --
2018-05-11 17:42:05.005 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-05-11 17:42:05.006 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 10: Node Init response (0) org.openhab.binding.zwave.internal.protocol.ZWaveTransactionResponse@3eca82e7
2018-05-11 17:42:05.006 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start
2018-05-11 17:42:05.006 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 10: Node Init transaction completed with response COMPLETE
2018-05-11 17:42:05.007 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 8: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:05.007 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: Node not awake!
2018-05-11 17:42:05.007 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: listening == false, frequentlyListening == false, awake == false
2018-05-11 17:42:05.007 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Node not awake!