-
-
Notifications
You must be signed in to change notification settings - Fork 1.8k
Description
What happened?
I have a setup with several Popp-TRVs (identical to Danfoss Ally TRVs), lots of Aqara sensors and two routers, all connected to a Sonoff USB Dongle 3.0 Plus. I run Home Assistant and have automations that send temperatures measured by the Aqara sensors to the external_measured_room_sensor endpoint of the TRVs.
Everything runs smoothly for some time - until the TRVs stop reacting to any command sent to them. They still report their states without any issue, it's just that I cannot send any command to them any more. Most notably this ONLY happens to TRVs which are connected directly to the coordinator, never if connected to a router.
Looking at the devices tab shows recent "Last seen" values. I highlighted "Thermostat Badezimmer Fenster" as that's the one that's unresponsive (did an initial re-pairing of all devices this morning):
Looking at the map gives me a clear sign that this TRV will not react to my commands anymore. LQI is shown as 0 here, while the previous picture showed LQI 72:
I tried Z2M versions 1.27.0 and 1.26.0. The Sonoff dongle was on ZStack 20220219, now upgraded to dev branch 20220726. I resetted and repaired all devices numerous times, even changed to position of the coordinator to the other side of the house. Nothing helps, it's always the devices connected to the coordinator that stop reacting after some hours, at max one or two days. Only way to make them react again for some time is to take the batteries in and out.
I completely reinstalled Z2M 1.27.0 and connected all devices to the coordinator directly. The result is the same - after some hours the first TRVs become unresponsive but happily send their states.
In the debug log can see some "data confirm errors" which might give a clue.
What did you expect to happen?
I expect the devices always react to the commands I send to them and not become unresponsive.
How to reproduce it (minimal and precise)
Just setup the TRVs, make sure they are connected to the coordinator, and wait some hours.
Zigbee2MQTT version
1.27.0
Adapter firmware version
20220219 and dev 20220726
Adapter
Sonoff USB Dongle 3.0 plus
Debug log
2022-08-09T22:17:35.975Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,100,1,0,100]
2022-08-09T22:17:35.975Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 4 - 1 - [0] - 100
2022-08-09T22:17:35.975Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- AF - dataRequest - {"status":0}
2022-08-09T22:17:35.975Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-08-09T22:17:37.682Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,3,68,128,205,1,13,6]
2022-08-09T22:17:37.682Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,3,68,128,205,1,13,6]
2022-08-09T22:17:37.684Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 3 - 2 - 4 - 128 - [205,1,13] - 6
2022-08-09T22:17:37.684Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - dataConfirm - {"status":205,"endpoint":1,"transid":13}
2022-08-09T22:17:37.684Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-08-09T22:17:37.685Z zigbee-herdsman:adapter:zStack:adapter Data confirm error (0xb4e3f9fffedf0571:10453,205,2)
2022-08-09T22:17:37.685Z zigbee-herdsman:adapter:zStack:adapter Request network address of '0xb4e3f9fffedf0571'
2022-08-09T22:17:37.686Z zigbee-herdsman:adapter:zStack:znp:SREQ --> ZDO - nwkAddrReq - {"ieeeaddr":"0xb4e3f9fffedf0571","reqtype":0,"startindex":0}
2022-08-09T22:17:37.686Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,10,37,0,113,5,223,254,255,249,227,180,0,0,43]
2022-08-09T22:17:37.701Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,101,0,0,100]
2022-08-09T22:17:37.701Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,101,0,0,100]
2022-08-09T22:17:37.701Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 5 - 0 - [0] - 100
2022-08-09T22:17:37.701Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- ZDO - nwkAddrReq - {"status":0}
2022-08-09T22:17:37.701Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-08-09T22:17:40.813Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,23,68,129,0,0,32,0,113,235,1,242,0,87,0,126,88,7,0,0,3,9,96,0,113,235,29,0]
2022-08-09T22:17:40.814Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,23,68,129,0,0,32,0,113,235,1,242,0,87,0,126,88,7,0,0,3,9,96,0,113,235,29,0]
2022-08-09T22:17:40.814Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 23 - 2 - 4 - 129 - [0,0,32,0,113,235,1,242,0,87,0,126,88,7,0,0,3,9,96,0,113,235,29] - 0
2022-08-09T22:17:40.815Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - incomingMsg - {"groupid":0,"clusterid":32,"srcaddr":60273,"srcendpoint":1,"dstendpoint":242,"wasbroadcast":0,"linkquality":87,"securityuse":0,"timestamp":481406,"transseqnumber":0,"len":3,"data":{"type":"Buffer","data":[9,96,0]}}
2022-08-09T22:17:40.816Z zigbee-herdsman:controller:log Received 'zcl' data '{"frame":{"Header":{"frameControl":{"frameType":1,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":96,"manufacturerCode":null,"commandIdentifier":0},"Payload":{},"Command":{"ID":0,"parameters":[],"name":"checkin"}},"address":60273,"endpoint":1,"linkquality":87,"groupID":0,"wasBroadcast":false,"destinationEndpoint":242}'
2022-08-09T22:17:40.818Z zigbee-herdsman:controller:device:log check-in from 0x0c4314fffe45317c: declining fast-poll
2022-08-09T22:17:40.818Z zigbee-herdsman:controller:endpoint Command 0x0c4314fffe45317c/1 genPollCtrl.checkinRsp({"startFastPolling":false,"fastPollTimeout":0}, {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":false,"direction":0,"srcEndpoint":null,"reservedBits":0,"manufacturerCode":null,"transactionSequenceNumber":null,"writeUndiv":false})
2022-08-09T22:17:40.818Z zigbee-herdsman:adapter:zStack:adapter sendZclFrameToEndpointInternal 0x0c4314fffe45317c:60273/1 (0,0,2)
2022-08-09T22:17:40.819Z zigbee-herdsman:adapter:zStack:znp:SREQ --> AF - dataRequest - {"dstaddr":60273,"destendpoint":1,"srcendpoint":1,"clusterid":32,"transid":14,"options":0,"radius":30,"len":6,"data":{"type":"Buffer","data":[1,6,0,0,0,0]}}
2022-08-09T22:17:40.819Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,16,36,1,113,235,1,1,32,0,14,0,30,6,1,6,0,0,0,0,158]
2022-08-09T22:17:40.819Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-08-09T22:17:40.835Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,100,1,0,100]
2022-08-09T22:17:40.835Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,100,1,0,100]
2022-08-09T22:17:40.835Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 4 - 1 - [0] - 100
2022-08-09T22:17:40.836Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- AF - dataRequest - {"status":0}
2022-08-09T22:17:40.836Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-08-09T22:17:41.170Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,3,68,128,233,1,14,33]
2022-08-09T22:17:41.170Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,3,68,128,233,1,14,33]
2022-08-09T22:17:41.170Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 3 - 2 - 4 - 128 - [233,1,14] - 33
2022-08-09T22:17:41.170Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - dataConfirm - {"status":233,"endpoint":1,"transid":14}
2022-08-09T22:17:41.170Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-08-09T22:17:41.171Z zigbee-herdsman:adapter:zStack:adapter Data confirm error (0x0c4314fffe45317c:60273,233,0)
2022-08-09T22:17:41.171Z zigbee-herdsman:adapter:zStack:adapter Wait 2000ms
2022-08-09T22:17:43.173Z zigbee-herdsman:adapter:zStack:adapter sendZclFrameToEndpointInternal 0x0c4314fffe45317c:60273/1 (0,1,2)
2022-08-09T22:17:43.173Z zigbee-herdsman:adapter:zStack:znp:SREQ --> AF - dataRequest - {"dstaddr":60273,"destendpoint":1,"srcendpoint":1,"clusterid":32,"transid":15,"options":0,"radius":30,"len":6,"data":{"type":"Buffer","data":[1,6,0,0,0,0]}}
2022-08-09T22:17:43.174Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,16,36,1,113,235,1,1,32,0,15,0,30,6,1,6,0,0,0,0,159]
2022-08-09T22:17:43.190Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,100,1,0,100]
2022-08-09T22:17:43.190Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,100,1,0,100]
2022-08-09T22:17:43.190Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 4 - 1 - [0] - 100
2022-08-09T22:17:43.190Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- AF - dataRequest - {"status":0}
2022-08-09T22:17:43.190Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-08-09T22:17:43.414Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,3,68,128,233,1,15,32]
2022-08-09T22:17:43.414Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,3,68,128,233,1,15,32]
2022-08-09T22:17:43.414Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 3 - 2 - 4 - 128 - [233,1,15] - 32
2022-08-09T22:17:43.414Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - dataConfirm - {"status":233,"endpoint":1,"transid":15}
2022-08-09T22:17:43.414Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-08-09T22:17:43.415Z zigbee-herdsman:adapter:zStack:adapter Data confirm error (0x0c4314fffe45317c:60273,233,1)
2022-08-09T22:17:43.415Z zigbee-herdsman:adapter:zStack:adapter Discovering route to 60273
2022-08-09T22:17:43.416Z zigbee-herdsman:adapter:zStack:znp:SREQ --> ZDO - extRouteDisc - {"dstAddr":60273,"options":0,"radius":30}
2022-08-09T22:17:43.416Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,4,37,69,113,235,0,30,224]
2022-08-09T22:17:43.430Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,101,69,0,33]
2022-08-09T22:17:43.431Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,101,69,0,33]
2022-08-09T22:17:43.431Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 5 - 69 - [0] - 33
2022-08-09T22:17:43.431Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- ZDO - extRouteDisc - {"status":0}
2022-08-09T22:17:43.431Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-08-09T22:17:46.433Z zigbee-herdsman:adapter:zStack:adapter sendZclFrameToEndpointInternal 0x0c4314fffe45317c:60273/1 (0,2,2)
2022-08-09T22:17:46.433Z zigbee-herdsman:adapter:zStack:znp:SREQ --> AF - dataRequest - {"dstaddr":60273,"destendpoint":1,"srcendpoint":1,"clusterid":32,"transid":16,"options":0,"radius":30,"len":6,"data":{"type":"Buffer","data":[1,6,0,0,0,0]}}
2022-08-09T22:17:46.433Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,16,36,1,113,235,1,1,32,0,16,0,30,6,1,6,0,0,0,0,128]
2022-08-09T22:17:46.450Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,100,1,0,100]
2022-08-09T22:17:46.450Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,100,1,0,100]
2022-08-09T22:17:46.450Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 4 - 1 - [0] - 100
2022-08-09T22:17:46.451Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- AF - dataRequest - {"status":0}
2022-08-09T22:17:46.451Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-08-09T22:17:46.674Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,3,68,128,233,1,16,63]
2022-08-09T22:17:46.675Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,3,68,128,233,1,16,63]
2022-08-09T22:17:46.675Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 3 - 2 - 4 - 128 - [233,1,16] - 63
2022-08-09T22:17:46.675Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - dataConfirm - {"status":233,"endpoint":1,"transid":16}
2022-08-09T22:17:46.675Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-08-09T22:17:46.675Z zigbee-herdsman:adapter:zStack:adapter Data confirm error (0x0c4314fffe45317c:60273,233,2)
2022-08-09T22:17:46.675Z zigbee-herdsman:adapter:zStack:adapter Request network address of '0x0c4314fffe45317c'
2022-08-09T22:17:46.675Z zigbee-herdsman:adapter:zStack:znp:SREQ --> ZDO - nwkAddrReq - {"ieeeaddr":"0x0c4314fffe45317c","reqtype":0,"startindex":0}
2022-08-09T22:17:46.676Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,10,37,0,124,49,69,254,255,20,67,12,0,0,125]
2022-08-09T22:17:46.682Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,101,0,0,100]
2022-08-09T22:17:46.682Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,101,0,0,100]
2022-08-09T22:17:46.682Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 5 - 0 - [0] - 100
2022-08-09T22:17:46.682Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- ZDO - nwkAddrReq - {"status":0}
2022-08-09T22:17:46.683Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-08-09T22:17:47.703Z zigbee-herdsman:adapter:zStack:adapter sendZclFrameToEndpointInternal 0xb4e3f9fffedf0571:10453/1 (0,3,2)
2022-08-09T22:17:47.704Z zigbee-herdsman:adapter:zStack:znp:SREQ --> AF - dataRequest - {"dstaddr":10453,"destendpoint":1,"srcendpoint":1,"clusterid":32,"transid":17,"options":0,"radius":30,"len":6,"data":{"type":"Buffer","data":[1,5,0,0,0,0]}}
2022-08-09T22:17:47.704Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,16,36,1,213,40,1,1,32,0,17,0,30,6,1,5,0,0,0,0,229]
2022-08-09T22:17:47.720Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,100,1,0,100]
2022-08-09T22:17:47.721Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,100,1,0,100]
2022-08-09T22:17:47.721Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 4 - 1 - [0] - 100
2022-08-09T22:17:47.721Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- AF - dataRequest - {"status":0}
2022-08-09T22:17:47.721Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-08-09T22:17:49.165Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,3,68,128,205,1,17,26]
2022-08-09T22:17:49.165Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,3,68,128,205,1,17,26]
2022-08-09T22:17:49.165Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 3 - 2 - 4 - 128 - [205,1,17] - 26
2022-08-09T22:17:49.165Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - dataConfirm - {"status":205,"endpoint":1,"transid":17}
2022-08-09T22:17:49.165Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-08-09T22:17:49.165Z zigbee-herdsman:adapter:zStack:adapter Data confirm error (0xb4e3f9fffedf0571:10453,205,3)
2022-08-09T22:17:49.166Z zigbee-herdsman:adapter:zStack:adapter Wait 2000ms