Hi All,
I have an issue with my z-wave in home assistant. When I restart home assistant and z-wave is configuring it goes through all the nodes, but stops at one. From the OZW log I can see that the controller and this node is spamming the entire z-wave network to that extent that other messages gets a huge (2-3min) delay to go through. If I then cut the power to this node (aeotec dimmer 2) the z-wave network is able to complete configuring and everything works as normal, I can then power the node again and it still works. Any ideas or tips on how this can be fixed except removing the node?
Rpi with hassbian 0.79.3
Aeon z-stick
Node 29: Aeotec Dimmer 2
This is just a small part of the log, but it continues in much the same manner:
> 2018-10-24 15:58:38.080 Detail, Node029, Query Stage Complete (CacheLoad)
> 2018-10-24 15:58:38.080 Detail, Node029, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Associations live=1
> 2018-10-24 15:58:38.080 Detail, Node029, QueryStage_Associations
> 2018-10-24 15:58:38.080 Info, Node029, Number of association groups reported for node 29 is 2.
> 2018-10-24 15:58:38.080 Info, Node029, Get Associations for group 1 of node 29
> 2018-10-24 15:58:38.080 Detail, Node029, Queuing (Send) AssociationCmd_Get (Node=29): 0x01, 0x0a, 0x00, 0x13, 0x1d, 0x03, 0x85, 0x02, 0x01, 0x25, 0x71, 0x2a
> 2018-10-24 15:58:38.080 Detail, Node029, Queuing (Query) Query Stage Complete (Associations)
> 2018-10-24 15:58:38.080 Detail,
> 2018-10-24 15:58:38.081 Info, Node029, Sending (Send) message (Callback ID=0x71, Expected Reply=0x04) - AssociationCmd_Get (Node=29): 0x01, 0x0a, 0x00, 0x13, 0x1d, 0x03, 0x85, 0x02, 0x01, 0x25, 0x71, 0x2a
> 2018-10-24 15:58:38.089 Detail, Node029, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
> 2018-10-24 15:58:38.089 Detail, Node029, ZW_SEND_DATA delivered to Z-Wave stack
> 2018-10-24 15:58:38.107 Detail, Node029, Received: 0x01, 0x07, 0x00, 0x13, 0x71, 0x00, 0x00, 0x03, 0x99
> 2018-10-24 15:58:38.107 Detail, Node029, ZW_SEND_DATA Request with callback ID 0x71 received (expected 0x71)
> 2018-10-24 15:58:38.107 Info, Node029, Request RTT 26 Average Request RTT 129
> 2018-10-24 15:58:38.107 Detail, Expected callbackId was received
> 2018-10-24 15:58:38.305 Detail, Node029, Received: 0x01, 0x0c, 0x00, 0x04, 0x10, 0x1d, 0x06, 0x85, 0x03, 0x01, 0x05, 0x00, 0x01, 0x7f
> 2018-10-24 15:58:38.305 Detail,
> 2018-10-24 15:58:38.305 Info, Node029, Response RTT 224 Average Response RTT 224
> 2018-10-24 15:58:38.305 Info, Node029, Received Association report from node 29, group 1, containing 1 associations
> 2018-10-24 15:58:38.305 Info, Node029, The group contains:
> 2018-10-24 15:58:38.305 Info, Node029, Node 1
> 2018-10-24 15:58:38.305 Info, Node029, Get Associations for group 2 of node 29
> 2018-10-24 15:58:38.306 Detail, Node029, Queuing (Send) AssociationCmd_Get (Node=29): 0x01, 0x0a, 0x00, 0x13, 0x1d, 0x03, 0x85, 0x02, 0x02, 0x25, 0x72, 0x2a
> 2018-10-24 15:58:38.306 Detail, Node029, Expected reply and command class was received
> 2018-10-24 15:58:38.306 Detail, Node029, Message transaction complete
> 2018-10-24 15:58:38.306 Detail,
> 2018-10-24 15:58:38.306 Detail, Node029, Removing current message
> 2018-10-24 15:58:38.306 Detail,
> 2018-10-24 15:58:38.306 Info, Node029, Sending (Send) message (Callback ID=0x72, Expected Reply=0x04) - AssociationCmd_Get (Node=29): 0x01, 0x0a, 0x00, 0x13, 0x1d, 0x03, 0x85, 0x02, 0x02, 0x25, 0x72, 0x2a
> 2018-10-24 15:58:38.315 Detail, Node029, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
> 2018-10-24 15:58:38.316 Detail, Node029, ZW_SEND_DATA delivered to Z-Wave stack
> 2018-10-24 15:58:38.377 Detail, Node029, Received: 0x01, 0x07, 0x00, 0x13, 0x72, 0x00, 0x00, 0x07, 0x9e
> 2018-10-24 15:58:38.377 Detail, Node029, ZW_SEND_DATA Request with callback ID 0x72 received (expected 0x72)
> 2018-10-24 15:58:38.377 Info, Node029, Request RTT 70 Average Request RTT 99
> 2018-10-24 15:58:38.377 Detail, Expected callbackId was received
> 2018-10-24 15:58:38.427 Detail, Node029, Received: 0x01, 0x0c, 0x00, 0x04, 0x00, 0x1d, 0x06, 0x85, 0x03, 0x01, 0x05, 0x00, 0x01, 0x6f
> 2018-10-24 15:58:38.427 Detail,
> 2018-10-24 15:58:38.427 Info, Node029, Response RTT 120 Average Response RTT 172
> 2018-10-24 15:58:38.427 Info, Node029, Received Association report from node 29, group 1, containing 1 associations
> 2018-10-24 15:58:38.428 Info, Node029, The group contains:
> 2018-10-24 15:58:38.428 Info, Node029, Node 1
> 2018-10-24 15:58:38.428 Info, Node029, Get Associations for group 2 of node 29
> 2018-10-24 15:58:38.428 Detail, Node029, Queuing (Send) AssociationCmd_Get (Node=29): 0x01, 0x0a, 0x00, 0x13, 0x1d, 0x03, 0x85, 0x02, 0x02, 0x25, 0x73, 0x2b
> 2018-10-24 15:58:38.428 Detail, Node029, Expected reply and command class was received
> 2018-10-24 15:58:38.428 Detail, Node029, Message transaction complete
> 2018-10-24 15:58:38.428 Detail,
> 2018-10-24 15:58:38.428 Detail, Node029, Removing current message
> 2018-10-24 15:58:38.428 Detail,
> 2018-10-24 15:58:38.428 Info, Node029, Sending (Send) message (Callback ID=0x73, Expected Reply=0x04) - AssociationCmd_Get (Node=29): 0x01, 0x0a, 0x00, 0x13, 0x1d, 0x03, 0x85, 0x02, 0x02, 0x25, 0x73, 0x2b
> 2018-10-24 15:58:38.438 Detail, Node029, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
> 2018-10-24 15:58:38.438 Detail, Node029, ZW_SEND_DATA delivered to Z-Wave stack
> 2018-10-24 15:58:38.488 Detail, Node029, Received: 0x01, 0x0c, 0x00, 0x04, 0x10, 0x1d, 0x06, 0x85, 0x03, 0x01, 0x05, 0x00, 0x01, 0x7f
> 2018-10-24 15:58:38.488 Detail,