Zwave FGMS001 - Motion/Tamper Alarm suddenly stopped working

Celaeno1 · March 10, 2019, 3:08pm

Hello Folks,

Im on Windows 10, 32 bit, JAVA: jdk1.8.0_161, 2.5.0-SNAPSHOT, Build #1486

316 │ Active   │  80 │ 2.5.0.201901020757     │ ZWave Binding

.

I’m nearly desperated. 2 of 3 Fibaro FGMS001 stopped working.

Temperature, Illuminance and Battery are running. Motion Alarm, Tamper Alarm are NOT running anymore!

I bought them abot 1.5 years ago at the same day.

They are all the same:

I compared ALL settings, they 3 are all the same configured.

They were running until End of January 2019 /Mid February 2019. I didn’ t change anything!!!

I have three items:

FibEye1_Motion_S (=node 3)<–NOT OK
FibEye2_Motion_S (=node 11)<–NOT OK
FibEye3_Motion_S (=node 9)<–STILL RUNNING

Here the logs (FibEye1_Motion_S, FibEye2_Motion_S) , that they were running:

Zeile 128335 - 2019-01-23 19:47:53.904 [GroupItemStateChangedEvent] - Motion1 changed from ON to OFF through <FibEye1_Motion_S>
Zeile 128366 - 2019-01-23 19:50:35.943 [vent.ItemStateChangedEvent] - <FibEye1_Motion_S> changed from OFF to ON
Zeile 128367 - 2019-01-23 19:50:35.945 [GroupItemStateChangedEvent] - Motion1 changed from OFF to ON through <FibEye1_Motion_S>
Zeile 128386 - 2019-01-23 19:51:06.196 [vent.ItemStateChangedEvent] - <FibEye1_Motion_S> changed from ON to OFF
Zeile 128432 - 2019-01-23 19:52:56.922 [vent.ItemStateChangedEvent] - <FibEye1_Motion_S> changed from OFF to ON
Zeile 128453 - 2019-01-23 19:53:27.428 [vent.ItemStateChangedEvent] - <FibEye1_Motion_S> changed from ON to OFF
Zeile 128454 - 2019-01-23 19:53:27.429 [GroupItemStateChangedEvent] - Motion1 changed from ON to OFF through <FibEye1_Motion_S>
Zeile 128484 - 2019-01-23 19:55:57.851 [vent.ItemStateChangedEvent] - <FibEye1_Motion_S> changed from OFF to ON
Zeile 128485 - 2019-01-23 19:55:57.852 [GroupItemStateChangedEvent] - Motion1 changed from OFF to ON through <FibEye1_Motion_S>
Zeile 128506 - 2019-01-23 19:56:49.729 [vent.ItemStateChangedEvent] - <FibEye1_Motion_S> changed from ON to OFF
Zeile 128507 - 2019-01-23 19:56:49.731 [GroupItemStateChangedEvent] - Motion1 changed from ON to OFF through <FibEye1_Motion_S>
Zeile 128583 - 2019-01-23 20:04:24.350 [vent.ItemStateChangedEvent] - <FibEye1_Motion_S> changed from OFF to ON
Zeile 128584 - 2019-01-23 20:04:24.352 [GroupItemStateChangedEvent] - Motion1 changed from OFF to ON through <FibEye1_Motion_S>

Zeile 18681 - 2019-01-25 18:08:45.864 [vent.ItemStateChangedEvent] - <FibEye1_Motion_S> changed from ON to OFF
Zeile 18682 - 2019-01-25 18:08:45.866 [GroupItemStateChangedEvent] - Motion1 changed from ON to OFF through <FibEye1_Motion_S>

Zeile 58151 - 2019-02-05 20:28:46.847 [vent.ItemStateChangedEvent] - <FibEye1_Motion_S> changed from NULL to OFF
Zeile 82322 - 2019-02-07 18:33:04.976 [vent.ItemStateChangedEvent] - <FibEye1_Motion_S> changed from OFF to ON
Zeile 82323 - 2019-02-07 18:33:04.978 [GroupItemStateChangedEvent] - Motion1 changed from OFF to ON through <FibEye1_Motion_S>

Zeile 82011 - 2019-02-07 18:08:44.660 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from OFF to ON
Zeile 82012 - 2019-02-07 18:08:44.662 [GroupItemStateChangedEvent] - Motion1 changed from OFF to ON through <FibEye2_Motion_S>
Zeile 82033 - 2019-02-07 18:09:33.803 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from ON to OFF
Zeile 82142 - 2019-02-07 18:15:07.869 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from OFF to ON
Zeile 82143 - 2019-02-07 18:15:07.871 [GroupItemStateChangedEvent] - Motion1 changed from OFF to ON through <FibEye2_Motion_S>
Zeile 82152 - 2019-02-07 18:16:05.244 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from ON to OFF
Zeile 82153 - 2019-02-07 18:16:05.246 [GroupItemStateChangedEvent] - Motion1 changed from ON to OFF through <FibEye2_Motion_S>
Zeile 82199 - 2019-02-07 18:19:51.353 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from OFF to ON
Zeile 82200 - 2019-02-07 18:19:51.355 [GroupItemStateChangedEvent] - Motion1 changed from OFF to ON through <FibEye2_Motion_S>
Zeile 82206 - 2019-02-07 18:20:36.865 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from ON to OFF
Zeile 82207 - 2019-02-07 18:20:36.867 [GroupItemStateChangedEvent] - Motion1 changed from ON to OFF through <FibEye2_Motion_S>
Zeile 83817 - 2019-02-07 20:26:22.666 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from OFF to ON
Zeile 83829 - 2019-02-07 20:26:53.172 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from ON to OFF

Zeile 109453 - 2019-02-09 18:36:59.105 [vent.ItemStateChangedEvent] - <FibEye1_Motion_S> changed from ON to OFF
Zeile 109454 - 2019-02-09 18:36:59.107 [GroupItemStateChangedEvent] - Motion1 changed from ON to OFF through <FibEye1_Motion_S>

Zeile 109464 - 2019-02-09 18:37:17.543 [GroupItemStateChangedEvent] - Motion1 changed from OFF to ON through <FibEye2_Motion_S>
Zeile 109468 - 2019-02-09 18:37:48.543 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from ON to OFF
Zeile 109469 - 2019-02-09 18:37:48.544 [GroupItemStateChangedEvent] - Motion1 changed from ON to OFF through <FibEye2_Motion_S>
Zeile 109903 - 2019-02-09 19:17:52.132 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from OFF to ON
Zeile 109923 - 2019-02-09 19:18:29.817 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from ON to OFF
Zeile 109924 - 2019-02-09 19:18:29.819 [GroupItemStateChangedEvent] - Motion1 changed from ON to OFF through <FibEye2_Motion_S>
Zeile 109939 - 2019-02-09 19:18:39.745 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from OFF to ON
Zeile 109940 - 2019-02-09 19:18:39.747 [GroupItemStateChangedEvent] - Motion1 changed from OFF to ON through <FibEye2_Motion_S>

Zeile 71923 - 2019-02-16 20:35:27.230 [vent.ItemStateChangedEvent] - <FibEye1_Motion_S> changed from NULL to ON
Zeile 91792 - 2019-02-18 08:33:32.182 [vent.ItemStateChangedEvent] - <FibEye1_Motion_S> changed from ON to OFF
Zeile 91793 - 2019-02-18 08:33:32.184 [GroupItemStateChangedEvent] - Motion1 changed from ON to OFF through <FibEye1_Motion_S>

Zeile 126842 - 2019-02-20 19:02:03.684 [GroupItemStateChangedEvent] - Motion1 changed from OFF to ON through <FibEye2_Motion_S>
Zeile 139473 - 2019-02-21 19:10:04.205 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from ON to OFF
Zeile 139474 - 2019-02-21 19:10:04.207 [GroupItemStateChangedEvent] - Motion1 changed from ON to OFF through <FibEye2_Motion_S>

Zeile 64872 - 2019-02-26 17:45:55.493 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from OFF to ON
Zeile 79291 - 2019-02-27 17:52:22.713 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from ON to OFF

Zeile 133949 - 2019-03-03 10:21:58.957 [vent.ItemStateChangedEvent] - <FibEye2_Motion_S> changed from NULL to OFF
Zeile 133950 - 2019-03-03 10:21:58.960 [GroupItemStateChangedEvent] - Motion1 changed from NULL to OFF through <FibEye2_Motion_S>

As you can see the frequency of motion detection decreases. After 2019-03-03 no more log entries of BOTH.

I tried the following:

I had a Backup of 20.01.2019. I reused this. No success.
I excluded one (=node 11) of the two from controller. Did a factory reset.
Included it again (= now node 13) --> NO success!

When I set:log DEBUG org.openhab.binding.zwave --> If I force motion or tamper alarm (node 3 or node 13 (former node 11)) --> NO entries in logfile !!

Celaeno1 · March 10, 2019, 3:10pm

Only when I wake them up: here node 11 (now node 13)

2019-03-10 10:50:13.069 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: WakeupTimerTask 0 Messages waiting, state DONE
2019-03-10 10:50:13.071 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: No more messages, go back to sleep
2019-03-10 10:50:13.074 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 11: Creating new message for application command WAKE_UP_NO_MORE_INFORMATION
2019-03-10 10:50:13.076 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: SECURITY not supported
2019-03-10 10:50:13.079 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Command Class COMMAND_CLASS_WAKE_UP is NOT required to be secured
2019-03-10 10:50:13.081 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@1a08969
2019-03-10 10:50:13.086 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Bump transaction 648 priority from Immediate to Immediate
2019-03-10 10:50:13.089 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Adding to device queue
2019-03-10 10:50:13.091 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Added 648 to queue - size 2
2019-03-10 10:50:13.094 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-03-10 10:50:13.097 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0B 02 84 08 25 56 13 
2019-03-10 10:50:13.100 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 11: Sending REQUEST Message = 01 09 00 13 0B 02 84 08 25 56 13 
2019-03-10 10:50:13.103 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2019-03-10 10:50:13.105 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2019-03-10 10:50:13.106 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 648: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 86
2019-03-10 10:50:13.109 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-03-10 10:50:13.112 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-03-10 10:50:13.114 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2019-03-10 10:50:13.115 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 648: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 86
2019-03-10 10:50:13.118 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-03-10 10:50:13.119 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2019-03-10 10:50:13.123 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-03-10 10:50:13.127 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 648: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 86
2019-03-10 10:50:13.129 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-03-10 10:50:13.132 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 648: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 86
2019-03-10 10:50:13.136 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-03-10 10:50:13.140 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 11: sentData successfully placed on stack.
2019-03-10 10:50:13.143 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 648: Advanced to WAIT_REQUEST
2019-03-10 10:50:13.146 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: TID 648: Transaction not completed
2019-03-10 10:50:13.150 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-03-10 10:50:13.153 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-03-10 10:50:13.157 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 56 00 00 05 B8 
2019-03-10 10:50:13.161 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=86, payload=56 00 00 05 
2019-03-10 10:50:13.165 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=86, payload=56 00 00 05 
2019-03-10 10:50:13.169 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 648: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 86
2019-03-10 10:50:13.172 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-03-10 10:50:13.175 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 648: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 86
2019-03-10 10:50:13.179 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 648: (Callback 86)
2019-03-10 10:50:13.182 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2019-03-10 10:50:13.185 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 648: callback 86
2019-03-10 10:50:13.189 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=86, payload=56 00 00 05 
2019-03-10 10:50:13.192 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 11: SendData Request. CallBack ID = 86, Status = Transmission complete and ACK received(0)
2019-03-10 10:50:13.194 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: resetResendCount initComplete=true isDead=false
2019-03-10 10:50:13.197 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 648: Transaction COMPLETED
2019-03-10 10:50:13.202 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Response processed after 96ms
2019-03-10 10:50:13.205 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: TID 648: Transaction completed
2019-03-10 10:50:13.208 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: notifyTransactionResponse TID:648 DONE
2019-03-10 10:50:13.212 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 11: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2019-03-10 10:50:13.213 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 648: Transaction event listener: DONE: DONE -> 
2019-03-10 10:50:13.216 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-03-10 10:50:13.218 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Went to sleep COMPLETE
2019-03-10 10:50:13.219 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-03-10 10:50:14.784 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C C9 
2019-03-10 10:50:14.789 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
2019-03-10 10:50:14.792 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
2019-03-10 10:50:14.794 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-03-10 10:50:14.796 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0
2019-03-10 10:50:14.799 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: null
2019-03-10 10:50:14.802 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
2019-03-10 10:50:14.804 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 11: Application update request. Node information received. Transaction null
2019-03-10 10:50:14.806 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: resetResendCount initComplete=true isDead=false
2019-03-10 10:50:14.809 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 11: Application update - no transaction.
2019-03-10 10:50:14.811 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-03-10 10:50:14.814 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-03-10 10:50:15.062 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Is awake with 0 messages in the queue
2019-03-10 10:50:15.065 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Start sleep timer at 1000ms
2019-03-10 10:50:15.067 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 11: Got an event from Z-Wave network: ZWaveNodeStatusEvent
2019-03-10 10:50:15.077 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 11: Node Status event - Node is AWAKE
2019-03-10 10:50:15.568 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: WakeupTimerTask 0 Messages waiting, state DONE
2019-03-10 10:50:16.068 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: WakeupTimerTask 0 Messages waiting, state DONE
2019-03-10 10:50:16.070 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: No more messages, go back to sleep
2019-03-10 10:50:16.073 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 11: Creating new message for application command WAKE_UP_NO_MORE_INFORMATION
2019-03-10 10:50:16.075 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: SECURITY not supported
2019-03-10 10:50:16.078 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Command Class COMMAND_CLASS_WAKE_UP is NOT required to be secured
2019-03-10 10:50:16.081 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@9103bf
2019-03-10 10:50:16.084 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Bump transaction 649 priority from Immediate to Immediate
2019-03-10 10:50:16.087 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Adding to device queue
2019-03-10 10:50:16.090 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Added 649 to queue - size 2
2019-03-10 10:50:16.092 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-03-10 10:50:16.095 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0B 02 84 08 25 57 12 
2019-03-10 10:50:16.098 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 11: Sending REQUEST Message = 01 09 00 13 0B 02 84 08 25 57 12 
2019-03-10 10:50:16.101 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2019-03-10 10:50:16.102 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2019-03-10 10:50:16.104 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 649: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 87
2019-03-10 10:50:16.107 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-03-10 10:50:16.111 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-03-10 10:50:16.112 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2019-03-10 10:50:16.113 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 649: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 87
2019-03-10 10:50:16.115 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-03-10 10:50:16.116 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2019-03-10 10:50:16.120 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-03-10 10:50:16.122 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 649: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 87
2019-03-10 10:50:16.125 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-03-10 10:50:16.128 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 649: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 87
2019-03-10 10:50:16.131 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-03-10 10:50:16.135 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 11: sentData successfully placed on stack.
2019-03-10 10:50:16.139 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 649: Advanced to WAIT_REQUEST
2019-03-10 10:50:16.142 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: TID 649: Transaction not completed
2019-03-10 10:50:16.144 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-03-10 10:50:16.147 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-03-10 10:50:16.155 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 57 00 00 05 B9 
2019-03-10 10:50:16.159 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=87, payload=57 00 00 05 
2019-03-10 10:50:16.162 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=87, payload=57 00 00 05 
2019-03-10 10:50:16.167 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 649: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 87
2019-03-10 10:50:16.170 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-03-10 10:50:16.173 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 649: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 87
2019-03-10 10:50:16.175 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 649: (Callback 87)
2019-03-10 10:50:16.178 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2019-03-10 10:50:16.180 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 649: callback 87
2019-03-10 10:50:16.185 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=87, payload=57 00 00 05 
2019-03-10 10:50:16.189 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 11: SendData Request. CallBack ID = 87, Status = Transmission complete and ACK received(0)
2019-03-10 10:50:16.193 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: resetResendCount initComplete=true isDead=false
2019-03-10 10:50:16.197 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 649: Transaction COMPLETED
2019-03-10 10:50:16.209 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Response processed after 106ms
2019-03-10 10:50:16.212 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: TID 649: Transaction completed
2019-03-10 10:50:16.217 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: notifyTransactionResponse TID:649 DONE
2019-03-10 10:50:16.223 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 649: Transaction event listener: DONE: DONE -> 
2019-03-10 10:50:16.227 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Went to sleep COMPLETE
2019-03-10 10:50:16.222 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 11: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2019-03-10 10:50:16.237 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-03-10 10:50:16.241 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-03-10 10:50:17.804 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C C9 
2019-03-10 10:50:17.809 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
2019-03-10 10:50:17.813 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
2019-03-10 10:50:17.815 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-03-10 10:50:17.818 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0
2019-03-10 10:50:17.820 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: null
2019-03-10 10:50:17.823 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
2019-03-10 10:50:17.826 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 11: Application update request. Node information received. Transaction null
2019-03-10 10:50:17.829 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: resetResendCount initComplete=true isDead=false
2019-03-10 10:50:17.832 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 11: Application update - no transaction.
2019-03-10 10:50:17.834 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-03-10 10:50:17.837 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-03-10 10:50:18.085 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Is awake with 0 messages in the queue
2019-03-10 10:50:18.088 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Start sleep timer at 1000ms
2019-03-10 10:50:18.090 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 11: Got an event from Z-Wave network: ZWaveNodeStatusEvent
2019-03-10 10:50:18.099 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 11: Node Status event - Node is AWAKE
2019-03-10 10:50:18.590 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: WakeupTimerTask 0 Messages waiting, state DONE
2019-03-10 10:50:19.090 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: WakeupTimerTask 0 Messages waiting, state DONE
2019-03-10 10:50:19.093 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: No more messages, go back to sleep
2019-03-10 10:50:19.095 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 11: Creating new message for application command WAKE_UP_NO_MORE_INFORMATION
2019-03-10 10:50:19.098 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: SECURITY not supported
2019-03-10 10:50:19.102 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Command Class COMMAND_CLASS_WAKE_UP is NOT required to be secured
2019-03-10 10:50:19.108 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@7acc5f
2019-03-10 10:50:19.110 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Bump transaction 650 priority from Immediate to Immediate
2019-03-10 10:50:19.113 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Adding to device queue
2019-03-10 10:50:19.115 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Added 650 to queue - size 2
2019-03-10 10:50:19.118 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-03-10 10:50:19.121 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0B 02 84 08 25 58 1D 
2019-03-10 10:50:19.126 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 11: Sending REQUEST Message = 01 09 00 13 0B 02 84 08 25 58 1D 
2019-03-10 10:50:19.129 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2019-03-10 10:50:19.130 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2019-03-10 10:50:19.132 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 650: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 88
2019-03-10 10:50:19.133 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-03-10 10:50:19.137 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-03-10 10:50:19.138 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2019-03-10 10:50:19.140 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 650: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 88
2019-03-10 10:50:19.144 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-03-10 10:50:19.145 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2019-03-10 10:50:19.150 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-03-10 10:50:19.156 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 650: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 88
2019-03-10 10:50:19.159 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-03-10 10:50:19.161 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 650: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 88
2019-03-10 10:50:19.164 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-03-10 10:50:19.166 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 11: sentData successfully placed on stack.
2019-03-10 10:50:19.170 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 650: Advanced to WAIT_REQUEST
2019-03-10 10:50:19.173 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: TID 650: Transaction not completed
2019-03-10 10:50:19.177 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-03-10 10:50:19.183 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 58 00 00 05 B6 
2019-03-10 10:50:19.181 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-03-10 10:50:19.190 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=88, payload=58 00 00 05 
2019-03-10 10:50:19.193 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=88, payload=58 00 00 05 
2019-03-10 10:50:19.196 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 650: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 88
2019-03-10 10:50:19.199 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-03-10 10:50:19.203 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 650: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 88
2019-03-10 10:50:19.206 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 650: (Callback 88)
2019-03-10 10:50:19.212 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2019-03-10 10:50:19.216 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 650: callback 88
2019-03-10 10:50:19.220 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=88, payload=58 00 00 05 
2019-03-10 10:50:19.223 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 11: SendData Request. CallBack ID = 88, Status = Transmission complete and ACK received(0)
2019-03-10 10:50:19.226 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: resetResendCount initComplete=true isDead=false
2019-03-10 10:50:19.229 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 650: Transaction COMPLETED
2019-03-10 10:50:19.233 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Response processed after 101ms
2019-03-10 10:50:19.237 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: TID 650: Transaction completed
2019-03-10 10:50:19.241 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: notifyTransactionResponse TID:650 DONE
2019-03-10 10:50:19.246 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 11: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2019-03-10 10:50:19.251 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-03-10 10:50:19.252 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 650: Transaction event listener: DONE: DONE -> 
2019-03-10 10:50:19.255 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-03-10 10:50:19.256 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Went to sleep COMPLETE
2019-03-10 10:50:20.751 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C C9 
2019-03-10 10:50:20.756 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
2019-03-10 10:50:20.759 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
2019-03-10 10:50:20.762 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-03-10 10:50:20.763 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0
2019-03-10 10:50:20.766 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: null
2019-03-10 10:50:20.769 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
2019-03-10 10:50:20.771 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 11: Application update request. Node information received. Transaction null
2019-03-10 10:50:20.774 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: resetResendCount initComplete=true isDead=false
2019-03-10 10:50:20.776 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 11: Application update - no transaction.
2019-03-10 10:50:20.780 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-03-10 10:50:20.783 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-03-10 10:50:21.035 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Is awake with 0 messages in the queue
2019-03-10 10:50:21.038 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Start sleep timer at 1000ms
2019-03-10 10:50:21.040 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 11: Got an event from Z-Wave network: ZWaveNodeStatusEvent
2019-03-10 10:50:21.050 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 11: Node Status event - Node is AWAKE
2019-03-10 10:50:21.540 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: WakeupTimerTask 0 Messages waiting, state DONE
2019-03-10 10:50:22.040 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: WakeupTimerTask 0 Messages waiting, state DONE
2019-03-10 10:50:22.042 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: No more messages, go back to sleep
2019-03-10 10:50:22.045 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 11: Creating new message for application command WAKE_UP_NO_MORE_INFORMATION
2019-03-10 10:50:22.047 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: SECURITY not supported
2019-03-10 10:50:22.050 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Command Class COMMAND_CLASS_WAKE_UP is NOT required to be secured
2019-03-10 10:50:22.052 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@10855dc
2019-03-10 10:50:22.057 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Bump transaction 651 priority from Immediate to Immediate
2019-03-10 10:50:22.060 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Adding to device queue
2019-03-10 10:50:22.062 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Added 651 to queue - size 2
2019-03-10 10:50:22.065 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-03-10 10:50:22.067 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0B 02 84 08 25 59 1C 
2019-03-10 10:50:22.071 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 11: Sending REQUEST Message = 01 09 00 13 0B 02 84 08 25 59 1C 
2019-03-10 10:50:22.075 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2019-03-10 10:50:22.077 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2019-03-10 10:50:22.079 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 651: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 89
2019-03-10 10:50:22.080 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-03-10 10:50:22.083 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-03-10 10:50:22.084 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2019-03-10 10:50:22.086 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 651: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 89
2019-03-10 10:50:22.088 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-03-10 10:50:22.088 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2019-03-10 10:50:22.092 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-03-10 10:50:22.096 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 651: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 89
2019-03-10 10:50:22.099 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-03-10 10:50:22.102 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 651: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 89
2019-03-10 10:50:22.106 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-03-10 10:50:22.109 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 11: sentData successfully placed on stack.
2019-03-10 10:50:22.112 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 651: Advanced to WAIT_REQUEST
2019-03-10 10:50:22.114 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: TID 651: Transaction not completed
2019-03-10 10:50:22.116 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-03-10 10:50:22.119 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-03-10 10:50:22.130 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 59 00 00 05 B7 
2019-03-10 10:50:22.135 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=89, payload=59 00 00 05 
2019-03-10 10:50:22.139 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=89, payload=59 00 00 05 
2019-03-10 10:50:22.142 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 651: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 89
2019-03-10 10:50:22.145 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-03-10 10:50:22.147 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 651: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 89
2019-03-10 10:50:22.150 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 651: (Callback 89)
2019-03-10 10:50:22.153 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2019-03-10 10:50:22.156 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 651: callback 89
2019-03-10 10:50:22.159 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=89, payload=59 00 00 05 
2019-03-10 10:50:22.162 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 11: SendData Request. CallBack ID = 89, Status = Transmission complete and ACK received(0)
2019-03-10 10:50:22.166 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: resetResendCount initComplete=true isDead=false
2019-03-10 10:50:22.171 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 651: Transaction COMPLETED
2019-03-10 10:50:22.175 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Response processed after 96ms
2019-03-10 10:50:22.178 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: TID 651: Transaction completed
2019-03-10 10:50:22.180 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: notifyTransactionResponse TID:651 DONE
2019-03-10 10:50:22.184 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 11: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2019-03-10 10:50:22.185 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 651: Transaction event listener: DONE: DONE -> 
2019-03-10 10:50:22.188 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-03-10 10:50:22.191 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Went to sleep COMPLETE

Celaeno1 · March 10, 2019, 3:11pm

    2019-03-10 10:50:22.192 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
    2019-03-10 10:50:23.731 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C C9 
    2019-03-10 10:50:23.735 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
    2019-03-10 10:50:23.738 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
    2019-03-10 10:50:23.741 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
    2019-03-10 10:50:23.743 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0
    2019-03-10 10:50:23.745 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: null
    2019-03-10 10:50:23.748 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
    2019-03-10 10:50:23.750 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 11: Application update request. Node information received. Transaction null
    2019-03-10 10:50:23.753 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: resetResendCount initComplete=true isDead=false
    2019-03-10 10:50:23.755 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 11: Application update - no transaction.
    2019-03-10 10:50:23.758 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
    2019-03-10 10:50:23.760 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
    2019-03-10 10:50:24.009 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Is awake with 0 messages in the queue
    2019-03-10 10:50:24.011 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Start sleep timer at 1000ms
    2019-03-10 10:50:24.014 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 11: Got an event from Z-Wave network: ZWaveNodeStatusEvent
    2019-03-10 10:50:24.023 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 11: Node Status event - Node is AWAKE
    2019-03-10 10:50:24.514 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: WakeupTimerTask 0 Messages waiting, state DONE
    2019-03-10 10:50:25.015 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: WakeupTimerTask 0 Messages waiting, state DONE
    2019-03-10 10:50:25.017 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: No more messages, go back to sleep
    2019-03-10 10:50:25.020 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 11: Creating new message for application command WAKE_UP_NO_MORE_INFORMATION
    2019-03-10 10:50:25.023 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: SECURITY not supported
    2019-03-10 10:50:25.025 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Command Class COMMAND_CLASS_WAKE_UP is NOT required to be secured
    2019-03-10 10:50:25.030 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@ae6c55
    2019-03-10 10:50:25.033 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Bump transaction 652 priority from Immediate to Immediate
    2019-03-10 10:50:25.036 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Adding to device queue
    2019-03-10 10:50:25.039 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Added 652 to queue - size 2
    2019-03-10 10:50:25.043 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
    2019-03-10 10:50:25.047 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0B 02 84 08 25 5A 1F 
    2019-03-10 10:50:25.050 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 11: Sending REQUEST Message = 01 09 00 13 0B 02 84 08 25 5A 1F 
    2019-03-10 10:50:25.054 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
    2019-03-10 10:50:25.055 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
    2019-03-10 10:50:25.057 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 652: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 90
    2019-03-10 10:50:25.059 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
    2019-03-10 10:50:25.062 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
    2019-03-10 10:50:25.063 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
    2019-03-10 10:50:25.065 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 652: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 90
    2019-03-10 10:50:25.067 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
    2019-03-10 10:50:25.068 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
    2019-03-10 10:50:25.073 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
    2019-03-10 10:50:25.079 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 652: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 90
    2019-03-10 10:50:25.082 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
    2019-03-10 10:50:25.085 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 652: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 90
    2019-03-10 10:50:25.088 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
    2019-03-10 10:50:25.091 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 11: sentData successfully placed on stack.
    2019-03-10 10:50:25.094 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 652: Advanced to WAIT_REQUEST
    2019-03-10 10:50:25.096 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: TID 652: Transaction not completed
    2019-03-10 10:50:25.099 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
    2019-03-10 10:50:25.103 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
    2019-03-10 10:50:25.110 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 5A 00 00 05 B4 
    2019-03-10 10:50:25.114 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=90, payload=5A 00 00 05 
    2019-03-10 10:50:25.117 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=90, payload=5A 00 00 05 
    2019-03-10 10:50:25.121 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 652: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 90
    2019-03-10 10:50:25.124 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
    2019-03-10 10:50:25.127 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 652: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 90
    2019-03-10 10:50:25.129 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 652: (Callback 90)
    2019-03-10 10:50:25.132 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
    2019-03-10 10:50:25.135 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 652: callback 90
    2019-03-10 10:50:25.140 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=90, payload=5A 00 00 05 
    2019-03-10 10:50:25.146 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 11: SendData Request. CallBack ID = 90, Status = Transmission complete and ACK received(0)
    2019-03-10 10:50:25.149 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: resetResendCount initComplete=true isDead=false
    2019-03-10 10:50:25.153 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 652: Transaction COMPLETED
    2019-03-10 10:50:25.156 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Response processed after 98ms
    2019-03-10 10:50:25.158 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: TID 652: Transaction completed
    2019-03-10 10:50:25.161 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: notifyTransactionResponse TID:652 DONE
    2019-03-10 10:50:25.166 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 11: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
    2019-03-10 10:50:25.172 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
    2019-03-10 10:50:25.172 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 652: Transaction event listener: DONE: DONE -> 
    2019-03-10 10:50:25.176 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
    2019-03-10 10:50:25.180 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Went to sleep COMPLETE
    2019-03-10 10:50:26.681 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C C9 
    2019-03-10 10:50:26.685 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
    2019-03-10 10:50:26.688 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
    2019-03-10 10:50:26.691 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
    2019-03-10 10:50:26.693 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0
    2019-03-10 10:50:26.695 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: null
    2019-03-10 10:50:26.698 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
    2019-03-10 10:50:26.701 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 11: Application update request. Node information received. Transaction null
    2019-03-10 10:50:26.703 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: resetResendCount initComplete=true isDead=false
    2019-03-10 10:50:26.705 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 11: Application update - no transaction.
    2019-03-10 10:50:26.708 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
    2019-03-10 10:50:26.710 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
    2019-03-10 10:50:26.958 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Is awake with 0 messages in the queue
    2019-03-10 10:50:26.961 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Start sleep timer at 1000ms
    2019-03-10 10:50:26.963 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 11: Got an event from Z-Wave network: ZWaveNodeStatusEvent
    2019-03-10 10:50:26.971 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 11: Node Status event - Node is AWAKE
    2019-03-10 10:50:27.463 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: WakeupTimerTask 0 Messages waiting, state DONE
    2019-03-10 10:50:27.964 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: WakeupTimerTask 0 Messages waiting, state DONE
    2019-03-10 10:50:27.966 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: No more messages, go back to sleep
    2019-03-10 10:50:27.968 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 11: Creating new message for application command WAKE_UP_NO_MORE_INFORMATION
    2019-03-10 10:50:27.971 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: SECURITY not supported
    2019-03-10 10:50:27.973 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Command Class COMMAND_CLASS_WAKE_UP is NOT required to be secured
    2019-03-10 10:50:27.976 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@6e0184
    2019-03-10 10:50:27.981 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Bump transaction 653 priority from Immediate to Immediate
    2019-03-10 10:50:27.984 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Adding to device queue
    2019-03-10 10:50:27.986 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Added 653 to queue - size 2
    2019-03-10 10:50:27.989 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
    2019-03-10 10:50:27.992 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0B 02 84 08 25 5B 1E 
    2019-03-10 10:50:27.997 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 11: Sending REQUEST Message = 01 09 00 13 0B 02 84 08 25 5B 1E 
    2019-03-10 10:50:28.002 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
    2019-03-10 10:50:28.004 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
    2019-03-10 10:50:28.005 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 653: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 91
    2019-03-10 10:50:28.007 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
    2019-03-10 10:50:28.010 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
    2019-03-10 10:50:28.011 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
    2019-03-10 10:50:28.013 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 653: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 91
    2019-03-10 10:50:28.015 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
    2019-03-10 10:50:28.016 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
    2019-03-10 10:50:28.020 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
    2019-03-10 10:50:28.022 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 653: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 91
    2019-03-10 10:50:28.026 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
    2019-03-10 10:50:28.031 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 653: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 91
    2019-03-10 10:50:28.035 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
    2019-03-10 10:50:28.037 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 11: sentData successfully placed on stack.
    2019-03-10 10:50:28.040 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 653: Advanced to WAIT_REQUEST
    2019-03-10 10:50:28.042 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: TID 653: Transaction not completed
    2019-03-10 10:50:28.045 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
    2019-03-10 10:50:28.048 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
    2019-03-10 10:50:28.057 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 5B 00 00 05 B5 
    2019-03-10 10:50:28.063 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=91, payload=5B 00 00 05 
    2019-03-10 10:50:28.070 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=91, payload=5B 00 00 05 
    2019-03-10 10:50:28.073 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 653: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 91
    2019-03-10 10:50:28.075 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
    2019-03-10 10:50:28.078 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 653: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 91
    2019-03-10 10:50:28.080 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 653: (Callback 91)
    2019-03-10 10:50:28.083 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
    2019-03-10 10:50:28.086 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 653: callback 91
    2019-03-10 10:50:28.089 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=91, payload=5B 00 00 05 
    2019-03-10 10:50:28.092 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 11: SendData Request. CallBack ID = 91, Status = Transmission complete and ACK received(0)
    2019-03-10 10:50:28.095 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: resetResendCount initComplete=true isDead=false
    2019-03-10 10:50:28.098 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 653: Transaction COMPLETED
    2019-03-10 10:50:28.101 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Response processed after 96ms
    2019-03-10 10:50:28.106 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: TID 653: Transaction completed
    2019-03-10 10:50:28.114 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: notifyTransactionResponse TID:653 DONE
    2019-03-10 10:50:28.121 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 11: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
    2019-03-10 10:50:28.126 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
    2019-03-10 10:50:28.125 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 653: Transaction event listener: DONE: DONE -> 
    2019-03-10 10:50:28.132 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Went to sleep COMPLETE
    2019-03-10 10:50:28.131 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
    2019-03-10 10:50:29.556 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 15 00 49 84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C C9 
    2019-03-10 10:50:29.561 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
    2019-03-10 10:50:29.564 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
    2019-03-10 10:50:29.566 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
    2019-03-10 10:50:29.568 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0
    2019-03-10 10:50:29.571 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: null
    2019-03-10 10:50:29.574 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=ApplicationUpdate[73], type=Request[0], dest=11, callback=132, payload=84 0B 0F 04 20 01 30 84 85 80 8F 56 72 86 70 8E 31 9C 
    2019-03-10 10:50:29.577 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 11: Application update request. Node information received. Transaction null
    2019-03-10 10:50:29.579 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: resetResendCount initComplete=true isDead=false
    2019-03-10 10:50:29.581 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 11: Application update - no transaction.
    2019-03-10 10:50:29.584 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
    2019-03-10 10:50:29.588 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
    2019-03-10 10:50:29.835 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Is awake with 0 messages in the queue
    2019-03-10 10:50:29.838 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Start sleep timer at 1000ms
    2019-03-10 10:50:29.840 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 11: Got an event from Z-Wave network: ZWaveNodeStatusEvent
    2019-03-10 10:50:29.849 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 11: Node Status event - Node is AWAKE
    2019-03-10 10:50:30.340 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: WakeupTimerTask 0 Messages waiting, state DONE
    2019-03-10 10:50:30.841 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: WakeupTimerTask 0 Messages waiting, state DONE
    2019-03-10 10:50:30.843 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: No more messages, go back to sleep
    2019-03-10 10:50:30.846 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 11: Creating new message for application command WAKE_UP_NO_MORE_INFORMATION
    2019-03-10 10:50:30.848 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: SECURITY not supported
    2019-03-10 10:50:30.851 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Command Class COMMAND_CLASS_WAKE_UP is NOT required to be secured
    2019-03-10 10:50:30.853 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@603ee2
    2019-03-10 10:50:30.858 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Bump transaction 654 priority from Immediate to Immediate
    2019-03-10 10:50:30.860 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Adding to device queue
    2019-03-10 10:50:30.863 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Added 654 to queue - size 2
    2019-03-10 10:50:30.865 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
    2019-03-10 10:50:30.869 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0B 02 84 08 25 5C 19 
    2019-03-10 10:50:30.874 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 11: Sending REQUEST Message = 01 09 00 13 0B 02 84 08 25 5C 19 
    2019-03-10 10:50:30.876 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
    2019-03-10 10:50:30.878 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
    2019-03-10 10:50:30.879 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 654: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 92
    2019-03-10 10:50:30.882 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
    2019-03-10 10:50:30.886 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
    2019-03-10 10:50:30.888 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
    2019-03-10 10:50:30.890 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 654: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 92
    2019-03-10 10:50:30.892 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
    2019-03-10 10:50:30.893 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
    2019-03-10 10:50:30.897 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
    2019-03-10 10:50:30.900 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 654: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 92
    2019-03-10 10:50:30.905 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
    2019-03-10 10:50:30.908 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 654: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 92
    2019-03-10 10:50:30.911 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
    2019-03-10 10:50:30.914 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 11: sentData successfully placed on stack.
    2019-03-10 10:50:30.917 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 654: Advanced to WAIT_REQUEST
    2019-03-10 10:50:30.920 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: TID 654: Transaction not completed
    2019-03-10 10:50:30.922 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
    2019-03-10 10:50:30.925 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
    2019-03-10 10:50:31.168 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 5C 00 00 1D AA 
    2019-03-10 10:50:31.171 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=92, payload=5C 00 00 1D 
    2019-03-10 10:50:31.174 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=92, payload=5C 00 00 1D 
    2019-03-10 10:50:31.177 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 654: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 92
    2019-03-10 10:50:31.179 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
    2019-03-10 10:50:31.181 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 654: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 92
    2019-03-10 10:50:31.183 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 654: (Callback 92)
    2019-03-10 10:50:31.186 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
    2019-03-10 10:50:31.188 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 654: callback 92
    2019-03-10 10:50:31.190 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=92, payload=5C 00 00 1D 
    2019-03-10 10:50:31.193 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 11: SendData Request. CallBack ID = 92, Status = Transmission complete and ACK received(0)
    2019-03-10 10:50:31.195 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: resetResendCount initComplete=true isDead=false
    2019-03-10 10:50:31.198 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 654: Transaction COMPLETED
    2019-03-10 10:50:31.201 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: Response processed after 322ms
    2019-03-10 10:50:31.204 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: TID 654: Transaction completed
    2019-03-10 10:50:31.206 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: notifyTransactionResponse TID:654 DONE
    2019-03-10 10:50:31.209 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 11: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
    2019-03-10 10:50:31.210 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 654: Transaction event listener: DONE: DONE -> 
    2019-03-10 10:50:31.212 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
    2019-03-10 10:50:31.214 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 11: Went to sleep COMPLETE
    2019-03-10 10:50:31.215 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

.

And here from node 9: THIS IS STILL RUNNING!

    2019-03-10 10:41:20.722 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 09 03 30 03 00 CB 
    2019-03-10 10:41:20.726 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 03 30 03 00 
    2019-03-10 10:41:20.729 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 03 30 03 00 
    2019-03-10 10:41:20.730 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
    2019-03-10 10:41:20.732 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Application Command Request (ALIVE:DONE)
    2019-03-10 10:41:20.734 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: resetResendCount initComplete=true isDead=false
    2019-03-10 10:41:20.736 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Incoming command class COMMAND_CLASS_SENSOR_BINARY, endpoint 0
    2019-03-10 10:41:20.737 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY not supported
    2019-03-10 10:41:20.739 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Received COMMAND_CLASS_SENSOR_BINARY V1 SENSOR_BINARY_REPORT
    2019-03-10 10:41:20.741 [DEBUG] [dclass.ZWaveBinarySensorCommandClass] - NODE 9: Sensor Binary report, type=Unknown, value=0
    2019-03-10 10:41:20.743 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveBinarySensorValueEvent
    2019-03-10 10:41:20.746 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SENSOR_BINARY, value = 0
    2019-03-10 10:41:20.747 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Updating channel state zwave:device:f7e29c6d:node9:alarm_motion to OFF [OnOffType]
    2019-03-10 10:41:20.750 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Commands processed 1.
    2019-03-10 10:41:20.752 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1bbaffe.
    2019-03-10 10:41:20.754 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
    2019-03-10 10:41:20.756 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
    2019-03-10 10:41:20.758 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
    2019-03-10 10:41:20.762 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

.
.
Maybe they are out of order?

Thankful for any help!

Alex

kanji · March 10, 2019, 8:32pm

Hi Alex,

just try with a fresh batterie. It solved the problem for me instantly.

Kind regards
Clemens

Celaeno1 · March 10, 2019, 9:34pm

@kanji

Thank you for the hint.

I wonder why the battery states are still remaining 81% and 100%? Was it the same at yours?

I’ll give it a try!

Alex

Celaeno1 · March 11, 2019, 11:13am

@kanji

Inside are the following batteries:

Are they really empty after 18 month? I could not believe!

Has someone else the same experience?

kanji · March 11, 2019, 11:23am

@Celaeno1 Try with the batterie from the still working one.

Celaeno1 · March 11, 2019, 11:47am

@kanji OK, I’ll try this evening!

khakzoy · March 11, 2019, 12:00pm

I have the same unit. My battery was empty in a month. Had the wrong settings.

For me the unit does not give actual battery status. Re-added one of them and battery went from 100% to 0%. New battery and it was up and running again. I threw them out and replaced them with an aeotec multisensor. Those units can be powered by an outlet, I gave up on zwave and battery powered.

Celaeno1 · March 11, 2019, 3:07pm

Have researched the internet and read a lot about the FGMS001. The battery life is according to the manufacturer up to 3 years. Other online stores write in the product description up to 2 years. Various forums report from one month over 3 months up to 1.5 years, depending on the settings. Mine are on DEFAULT settings. A long-term test (published in internet) showed 40% rest of charge after 12 months. I will now change the batteries, let’s see how long these battery charges will last and whether the motion alarm now works again.

P.S: I wonder why the battery states are still remaining 81% and 100%? How do I get the correct values?

jag · March 11, 2019, 3:56pm

My FGMS001 does not send motion events, if it’s added with PaperUI.
I do have to add FGMS001 using Habmin.

I understand yours stopped working, suddenly. But if you are deleting and adding them back, try using Habmin. If you do any updates on the FGMD001 using PaperUI, you could also make it not sending motion events anymore.

Celaeno1 · March 11, 2019, 4:11pm

Initially I used PaperUI to include FGMS001 (1.5 years ago) . Then I NEVER changed any setting! Now after 1.5 years I excluded it through Habmin and included it with PaperUI again. Maybe that’s the problem?

jag · March 11, 2019, 5:48pm

I would have tried to include it using Habmin again.

Celaeno1 · March 11, 2019, 11:17pm

@jag @kanji @khakzoy

I had success. I bought 1 new battery. Put it into FibEye2 (=node13) . Same problem. Woke it up about 25-30 times. Same problem. Changed the thing name a little bit with Habmin. Woke it up about 10 times again. FibEye2 (=node13) (Motion Alarm/Tamper Alarm) is running again!

Thanks to all!

But I’m going to observe this the next few days.

P.S. FibEye1 is still not running (with old battery, have no new one). Will try it in the reverse order. But not tonight.

Andrew_Rowe · March 12, 2019, 2:14am

I feel the same way about zigbee motion sensors. They all died after 4-5 months. Bought some zwave stuff, hoping for better… we’ll see

Celaeno1 · March 12, 2019, 9:07pm

@khakzoy @Andrew_Rowe @jag @kanji

There are new findings. Have not inserted a new battery into FibEye1. And now comes the successful step: just change the name of the thing with HABMIN and save it. (DO NEVER USE PaperUI for this!!). Then waken the device 10-20 times. That’s all. Motion alarm and Tamper alarm are working again.

Andrew_Rowe · March 13, 2019, 2:39am

The plot thickens… I’m interested in this because this is one of several of the zwave sensors I purchased to test with openHAB. I had great results with zigbee motion sensors until they ran out of batteries about 4-5 months in. Here is thread where Alex recommends this sensor

I also played dickens getting the little bugger to work… here is that thread

Celaeno1 · March 13, 2019, 4:22am

@Andrew_Rowe
I can only repeat myself. I would recommend this motion detector again at any time. When I bought them about 18 to 20 months ago, these (= firmware version 2.7, type 0800:1001) could be integrated into zwave and openhab without the slightest problems. Then they ran very reliable until about mid-February. In the meantime I had updated several times openhab and the z-wave binding completely has also been changed. What exactly happened with the two faulty sensors, unfortunately I can not understand. It was the configuration with PaperUI instead of using Habmin. I do not want to denounce either the device’s manufacturer or the device itself. There probably went something wrong with using PaperUI. There are many other versions of this sensor on the market with different firmware or type / IDs (0800:2001, 0800:3001, 0800:4001, 0800:6001, 0801:1001, 0801:1002, 0801:2001, 0801:2002, 0801:3001, 0801:3002, 0801:4001, 8800:3001). I don’t know why some types causes more problems, but it seems like.