Hi,
as discussed here I’m still fighting with my Aeotec Z-Wave Stick and Fibaro Z-Wave switches.
- I have a small Z-Wave network with only 5 switches / wall plugs and 1 sensor (battery)
- I deleted all dead nodes with Domoticz
- When I put the stick in PC with Domoticz everything runs fine (no polling, quick response of switches, …)
- with the hint from @robmac I disable polling (set binding_cmdrepollperiod: 0) in each thing. (strange: in the thing-config UI the minimum value is 15, but in the code-config I set it to zero)
After restart of OH3 (runs on RPI4 with active usb hub for Aeotec Stick) it first runs without polling, but after switching on/off it starts polling again.
The log-file in debug mode looks like this:
2021-02-20 16:47:39.151 [DEBUG] [sactionManager$ZWaveTransactionTimer] - NODE 8: TID 34323: Timeout at state WAIT_RESPONSE. 3 retries remaining.
2021-02-20 16:47:39.153 [DEBUG] [sactionManager$ZWaveTransactionTimer] - Aborting Transaction!
2021-02-20 16:47:39.155 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 34323: Transaction ABORTED
2021-02-20 16:47:39.157 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA
2021-02-20 16:47:39.158 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA
2021-02-20 16:47:39.160 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-02-20 16:47:39.162 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-02-20 16:47:39.203 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2021-02-20 16:47:39.205 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2021-02-20 16:47:39.207 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2021-02-20 16:47:39.208 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 18
2021-02-20 16:47:39.209 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 34323: [ABORTED] priority=Set, requiresResponse=true, callback: 144
2021-02-20 16:47:39.210 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-02-20 16:47:39.211 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=CAN[4], dest=255, callback=0, payload=
2021-02-20 16:47:39.211 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 34323: [ABORTED] priority=Set, requiresResponse=true, callback: 144
2021-02-20 16:47:39.213 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2021-02-20 16:47:39.215 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 8: sentData successfully placed on stack.
2021-02-20 16:47:39.216 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: TID 34323: Transaction not completed
2021-02-20 16:47:39.218 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=CAN[4], dest=255, callback=0, payload=
2021-02-20 16:47:39.219 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 34323: [ABORTED] priority=Set, requiresResponse=true, callback: 144
2021-02-20 16:47:39.220 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Holdoff Timer started...
2021-02-20 16:47:39.222 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 34323: Resetting transaction
2021-02-20 16:47:39.224 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: notifyTransactionResponse TID:34323 ABORTED
2021-02-20 16:47:39.226 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: Adding to device queue
2021-02-20 16:47:39.227 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: Added 34323 to queue - size 22
2021-02-20 16:47:39.229 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff true.
2021-02-20 16:47:39.230 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-02-20 16:47:39.232 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff true.
2021-02-20 16:47:39.333 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 90 01 00 DB A1
2021-02-20 16:47:39.336 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=1, callback=144, payload=90 01 00 DB
2021-02-20 16:47:39.337 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=1, callback=144, payload=90 01 00 DB
2021-02-20 16:47:39.339 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-02-20 16:47:39.340 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0
2021-02-20 16:47:39.342 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: null
2021-02-20 16:47:39.343 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=1, callback=144, payload=90 01 00 DB
2021-02-20 16:47:39.345 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-02-20 16:47:39.346 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff true.
2021-02-20 16:47:39.472 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-02-20 16:47:39.475 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0E 00 13 08 07 60 0D 01 02 25 01 FF 25 90 ED
2021-02-20 16:47:39.478 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 8: Sending REQUEST Message = 01 0E 00 13 08 07 60 0D 01 02 25 01 FF 25 90 ED
2021-02-20 16:47:39.481 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-02-20 16:47:39.483 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-02-20 16:47:39.484 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 34323: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 144
2021-02-20 16:47:39.485 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-02-20 16:47:39.487 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-02-20 16:47:39.488 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 34323: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 144
2021-02-20 16:47:39.490 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-02-20 16:47:39.491 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-02-20 16:47:39.493 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-02-20 16:47:40.723 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 5: Polling...
2021-02-20 16:47:40.728 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 5: Polling deferred until initialisation complete
2021-02-20 16:47:41.488 [DEBUG] [sactionManager$ZWaveTransactionTimer] - NODE 8: TID 34323: Timeout at state WAIT_RESPONSE. 3 retries remaining.
2021-02-20 16:47:41.491 [DEBUG] [sactionManager$ZWaveTransactionTimer] - Aborting Transaction!
2021-02-20 16:47:41.492 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 34323: Transaction ABORTED
2021-02-20 16:47:41.494 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA
2021-02-20 16:47:41.496 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA
2021-02-20 16:47:41.498 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-02-20 16:47:41.501 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-02-20 16:47:41.541 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2021-02-20 16:47:41.543 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2021-02-20 16:47:41.546 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2021-02-20 16:47:41.546 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 18
2021-02-20 16:47:41.548 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 34323: [ABORTED] priority=Set, requiresResponse=true, callback: 144
2021-02-20 16:47:41.548 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=CAN[4], dest=255, callback=0, payload=
2021-02-20 16:47:41.549 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-02-20 16:47:41.551 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 34323: [ABORTED] priority=Set, requiresResponse=true, callback: 144
2021-02-20 16:47:41.552 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2021-02-20 16:47:41.554 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 8: sentData successfully placed on stack.
2021-02-20 16:47:41.555 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: TID 34323: Transaction not completed
2021-02-20 16:47:41.556 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=CAN[4], dest=255, callback=0, payload=
2021-02-20 16:47:41.558 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 34323: [ABORTED] priority=Set, requiresResponse=true, callback: 144
2021-02-20 16:47:41.559 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Holdoff Timer started...
2021-02-20 16:47:41.561 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 34323: Resetting transaction
2021-02-20 16:47:41.562 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: notifyTransactionResponse TID:34323 ABORTED
2021-02-20 16:47:41.564 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: Adding to device queue
2021-02-20 16:47:41.566 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: Added 34323 to queue - size 22
2021-02-20 16:47:41.567 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff true.
2021-02-20 16:47:41.569 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-02-20 16:47:41.571 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff true.
2021-02-20 16:47:41.642 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 90 01 00 D8 A2
2021-02-20 16:47:41.644 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=1, callback=144, payload=90 01 00 D8
2021-02-20 16:47:41.646 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=1, callback=144, payload=90 01 00 D8
2021-02-20 16:47:41.648 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-02-20 16:47:41.649 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 0
2021-02-20 16:47:41.651 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: null
2021-02-20 16:47:41.652 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=1, callback=144, payload=90 01 00 D8
2021-02-20 16:47:41.654 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-02-20 16:47:41.655 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff true.
2021-02-20 16:47:41.810 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-02-20 16:47:41.816 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0E 00 13 08 07 60 0D 01 02 25 01 FF 25 90 ED
2021-02-20 16:47:41.818 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 8: Sending REQUEST Message = 01 0E 00 13 08 07 60 0D 01 02 25 01 FF 25 90 ED
2021-02-20 16:47:41.819 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-02-20 16:47:41.821 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-02-20 16:47:41.822 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 34323: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 144
2021-02-20 16:47:41.823 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-02-20 16:47:41.824 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-02-20 16:47:41.826 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 34323: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 144
2021-02-20 16:47:41.827 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-02-20 16:47:41.828 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-02-20 16:47:41.830 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-02-20 16:47:43.778 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Polling...
2021-02-20 16:47:43.779 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Polling deferred until initialisation complete
2021-02-20 16:47:43.824 [DEBUG] [sactionManager$ZWaveTransactionTimer] - NODE 8: TID 34323: Timeout at state WAIT_RESPONSE. 3 retries remaining.
2021-02-20 16:47:43.826 [DEBUG] [sactionManager$ZWaveTransactionTimer] - Aborting Transaction!
2021-02-20 16:47:43.828 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 34323: Transaction ABORTED
2021-02-20 16:47:43.830 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 03 00 16 EA
2021-02-20 16:47:43.832 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 03 00 16 EA
2021-02-20 16:47:43.834 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-02-20 16:47:43.836 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-02-20 16:47:43.879 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2021-02-20 16:47:43.881 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2021-02-20 16:47:43.883 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 18
2021-02-20 16:47:43.884 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 1<>127 : Message: class=null[0], type=CAN[4], dest=255, callback=0, payload=
2021-02-20 16:47:43.886 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2021-02-20 16:47:43.887 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 34323: [ABORTED] priority=Set, requiresResponse=true, callback: 144
2021-02-20 16:47:43.889 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-02-20 16:47:43.891 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 34323: [ABORTED] priority=Set, requiresResponse=true, callback: 144
2021-02-20 16:47:43.894 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2021-02-20 16:47:43.896 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 8: sentData successfully placed on stack.
2021-02-20 16:47:43.898 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: TID 34323: Transaction not completed
2021-02-20 16:47:43.899 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=CAN[4], dest=255, callback=0, payload=
2021-02-20 16:47:43.901 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 34323: [ABORTED] priority=Set, requiresResponse=true, callback: 144
2021-02-20 16:47:43.903 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Holdoff Timer started...
2021-02-20 16:47:43.905 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 34323: Resetting transaction
2021-02-20 16:47:43.906 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: notifyTransactionResponse TID:34323 ABORTED
2021-02-20 16:47:43.910 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: Adding to device queue
2021-02-20 16:47:43.911 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: Added 34323 to queue - size 22
2021-02-20 16:47:43.913 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff true.
2021-02-20 16:47:43.915 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-02-20 16:47:43.916 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff true.
Any Idea?
Or do I really have to chance to another stick?