Koenkk / zigbee2mqtt

Zigbee 🐝 to MQTT bridge 🌉, get rid of your proprietary Zigbee bridges 🔨
https://www.zigbee2mqtt.io
GNU General Public License v3.0
11.79k stars 1.64k forks source link

Failed to interview '0x003c84fffee81528', device has not successfully been paired #15576

Closed NSimpsonsK closed 1 year ago

NSimpsonsK commented 1 year ago

What happened?

Hello, im trying to add a new Device, thats unsupported. Its the Bosch BSIR-EZ Außensirene: https://www.bosch-smarthome.com/de/de/produkte/geraete/aussensirene/

The device is trying to get interviewed but in the next step it left the network and tries to connect again.

I attached the log with herdsman debug logging

Im using aprox. 60 devices and all are working great. Battery is fully charged and im pairing it next to the base.

Does somebody have an idea why its behaving like that?

Thanks a lot in advance

What did you expect to happen?

No response

How to reproduce it (minimal and precise)

No response

Zigbee2MQTT version

1.28.4-1

Adapter firmware version

20221213.0

Adapter

ITead_Sonoff_Zigbee_3.0_USB_Dongle_Plus

Debug log

2022-12-16T00:47:43.552Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [] 2022-12-16T00:47:43.552Z zigbee-herdsman:adapter:zStack:znp:SREQ --> ZDO - nodeDescReq - {"dstaddr":2013,"nwkaddrofinterest":2013} 2022-12-16T00:47:43.553Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,4,37,2,221,7,221,7,35] 2022-12-16T00:47:43.571Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,101,2,0,102] 2022-12-16T00:47:43.571Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,101,2,0,102] 2022-12-16T00:47:43.572Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 5 - 2 - [0] - 102 2022-12-16T00:47:43.573Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- ZDO - nodeDescReq - {"status":0} 2022-12-16T00:47:43.574Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [] 2022-12-16T00:47:50.216Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,12,69,202,116,101,40,21,232,254,255,132,60,0,0,0,254] 2022-12-16T00:47:50.217Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,12,69,202,116,101,40,21,232,254,255,132,60,0,0,0,254] 2022-12-16T00:47:50.218Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 12 - 2 - 5 - 202 - [116,101,40,21,232,254,255,132,60,0,0,0] - 254 2022-12-16T00:47:50.219Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- ZDO - tcDeviceInd - {"nwkaddr":25972,"extaddr":"0x003c84fffee81528","parentaddr":0} 2022-12-16T00:47:50.220Z zigbee-herdsman:controller:log Device '0x003c84fffee81528' joined 2022-12-16T00:47:50.220Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [] 2022-12-16T00:47:50.221Z zigbee-herdsman:controller:log Device '0x003c84fffee81528' accepted by handler 2022-12-16T00:47:50.221Z zigbee-herdsman:controller:log Device '0x003c84fffee81528' is already in database with different networkAddress, updating networkAddress 2022-12-16T00:47:50.229Z zigbee-herdsman:controller:log Not interviewing '0x003c84fffee81528', completed 'false', in progress 'true' 2022-12-16T00:47:52.268Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,12,69,202,116,101,40,21,232,254,255,132,60,0,0,0,254] 2022-12-16T00:47:52.268Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,12,69,202,116,101,40,21,232,254,255,132,60,0,0,0,254] 2022-12-16T00:47:52.269Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 12 - 2 - 5 - 202 - [116,101,40,21,232,254,255,132,60,0,0,0] - 254 2022-12-16T00:47:52.269Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- ZDO - tcDeviceInd - {"nwkaddr":25972,"extaddr":"0x003c84fffee81528","parentaddr":0} 2022-12-16T00:47:52.269Z zigbee-herdsman:controller:log Device '0x003c84fffee81528' joined 2022-12-16T00:47:52.269Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [] 2022-12-16T00:47:52.269Z zigbee-herdsman:controller:log Device '0x003c84fffee81528' accepted by handler 2022-12-16T00:47:52.270Z zigbee-herdsman:controller:log Not interviewing '0x003c84fffee81528', completed 'false', in progress 'true' 2022-12-16T00:47:52.384Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,13,69,201,116,101,40,21,232,254,255,132,60,0,0,0,0,252] 2022-12-16T00:47:52.384Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,13,69,201,116,101,40,21,232,254,255,132,60,0,0,0,0,252] 2022-12-16T00:47:52.384Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 13 - 2 - 5 - 201 - [116,101,40,21,232,254,255,132,60,0,0,0,0] - 252 2022-12-16T00:47:52.385Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- ZDO - leaveInd - {"srcaddr":25972,"extaddr":"0x003c84fffee81528","request":0,"removechildren":0,"rejoin":0} 2022-12-16T00:47:52.386Z zigbee-herdsman:controller:log Device leave '0x003c84fffee81528' 2022-12-16T00:47:52.386Z zigbee-herdsman:controller:log Removing device from database '0x003c84fffee81528' Zigbee2MQTT:warn 2022-12-16 01:47:52: Device '0x003c84fffee81528' left the network Zigbee2MQTT:info 2022-12-16 01:47:52: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"friendly_name":"0x003c84fffee81528","ieee_address":"0x003c84fffee81528"},"type":"device_leave"}' Zigbee2MQTT:info 2022-12-16 01:47:52: MQTT publish: topic 'zigbee2mqtt/bridge/log', payload '{"message":"left_network","meta":{"friendly_name":"0x003c84fffee81528"},"type":"device_removed"}' 2022-12-16T00:47:52.835Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [] 2022-12-16T00:47:53.554Z zigbee-herdsman:adapter:zStack:adapter Node descriptor request for '49762' failed (Error: AREQ - ZDO - nodeDescRsp after 10000ms), retry 2022-12-16T00:47:53.555Z zigbee-herdsman:adapter:zStack:adapter Discovering route to 49762 2022-12-16T00:47:53.556Z zigbee-herdsman:adapter:zStack:znp:SREQ --> ZDO - extRouteDisc - {"dstAddr":49762,"options":0,"radius":30} 2022-12-16T00:47:53.557Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,4,37,69,98,194,0,30,218] 2022-12-16T00:47:53.569Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,101,69,0,33] 2022-12-16T00:47:53.569Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,101,69,0,33] 2022-12-16T00:47:53.570Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 5 - 69 - [0] - 33 2022-12-16T00:47:53.570Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- ZDO - extRouteDisc - {"status":0} 2022-12-16T00:47:53.571Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [] 2022-12-16T00:47:53.575Z zigbee-herdsman:adapter:zStack:adapter Node descriptor request for '2013' failed (Error: AREQ - ZDO - nodeDescRsp after 10000ms), retry 2022-12-16T00:47:53.575Z zigbee-herdsman:adapter:zStack:adapter Discovering route to 2013 2022-12-16T00:47:53.576Z zigbee-herdsman:adapter:zStack:znp:SREQ --> ZDO - extRouteDisc - {"dstAddr":2013,"options":0,"radius":30} 2022-12-16T00:47:53.577Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,4,37,69,221,7,0,30,160] 2022-12-16T00:47:53.582Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,101,69,0,33] 2022-12-16T00:47:53.583Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,101,69,0,33] 2022-12-16T00:47:53.583Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 5 - 69 - [0] - 33 2022-12-16T00:47:53.583Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- ZDO - extRouteDisc - {"status":0} 2022-12-16T00:47:53.584Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [] 2022-12-16T00:47:56.573Z zigbee-herdsman:adapter:zStack:znp:SREQ --> ZDO - nodeDescReq - {"dstaddr":49762,"nwkaddrofinterest":49762} 2022-12-16T00:47:56.573Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,4,37,2,98,194,98,194,35] 2022-12-16T00:47:56.585Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,101,2,0,102] 2022-12-16T00:47:56.585Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,101,2,0,102] 2022-12-16T00:47:56.585Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 5 - 2 - [0] - 102 2022-12-16T00:47:56.586Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- ZDO - nodeDescReq - {"status":0} 2022-12-16T00:47:56.586Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [] 2022-12-16T00:47:56.586Z zigbee-herdsman:adapter:zStack:znp:SREQ --> ZDO - nodeDescReq - {"dstaddr":2013,"nwkaddrofinterest":2013} 2022-12-16T00:47:56.587Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,4,37,2,221,7,221,7,35] 2022-12-16T00:47:56.593Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,101,2,0,102] 2022-12-16T00:47:56.593Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,101,2,0,102] 2022-12-16T00:47:56.593Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 5 - 2 - [0] - 102 2022-12-16T00:47:56.594Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- ZDO - nodeDescReq - {"status":0} 2022-12-16T00:47:56.594Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [] Zigbee2MQTT:info 2022-12-16 01:48:00: Device '0x003c84fffee81528' joined 2022-12-16T00:48:00.210Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,5,69,196,47,241,1,45,164,210,254,12,69,202,226,245,40,21,232,254,255,132,60,0,47,241,38,254,12,69,202,226,245,40,21,232,254,255,132,60,0,47,241,38] 2022-12-16T00:48:00.210Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,5,69,196,47,241,1,45,164,210,254,12,69,202,226,245,40,21,232,254,255,132,60,0,47,241,38,254,12,69,202,226,245,40,21,232,254,255,132,60,0,47,241,38] 2022-12-16T00:48:00.211Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 5 - 2 - 5 - 196 - [47,241,1,45,164] - 210 2022-12-16T00:48:00.211Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- ZDO - srcRtgInd - {"dstaddr":61743,"relaycount":1,"relaylist":[42029]} 2022-12-16T00:48:00.211Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,12,69,202,226,245,40,21,232,254,255,132,60,0,47,241,38,254,12,69,202,226,245,40,21,232,254,255,132,60,0,47,241,38] 2022-12-16T00:48:00.211Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 12 - 2 - 5 - 202 - [226,245,40,21,232,254,255,132,60,0,47,241] - 38 2022-12-16T00:48:00.211Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- ZDO - tcDeviceInd - {"nwkaddr":62946,"extaddr":"0x003c84fffee81528","parentaddr":61743} 2022-12-16T00:48:00.211Z zigbee-herdsman:controller:log Device '0x003c84fffee81528' joined 2022-12-16T00:48:00.212Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,12,69,202,226,245,40,21,232,254,255,132,60,0,47,241,38] 2022-12-16T00:48:00.212Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 12 - 2 - 5 - 202 - [226,245,40,21,232,254,255,132,60,0,47,241] - 38 2022-12-16T00:48:00.212Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- ZDO - tcDeviceInd - {"nwkaddr":62946,"extaddr":"0x003c84fffee81528","parentaddr":61743} 2022-12-16T00:48:00.212Z zigbee-herdsman:controller:log Device '0x003c84fffee81528' joined 2022-12-16T00:48:00.212Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [] 2022-12-16T00:48:00.212Z zigbee-herdsman:controller:log Device '0x003c84fffee81528' accepted by handler 2022-12-16T00:48:00.212Z zigbee-herdsman:controller:log Delete device '0x003c84fffee81528' joined, undeleting Zigbee2MQTT:info 2022-12-16 01:48:00: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"friendly_name":"0x003c84fffee81528","ieee_address":"0x003c84fffee81528"},"type":"device_joined"}' Zigbee2MQTT:info 2022-12-16 01:48:00: MQTT publish: topic 'zigbee2mqtt/bridge/log', payload '{"message":{"friendly_name":"0x003c84fffee81528"},"type":"device_connected"}' 2022-12-16T00:48:00.631Z zigbee-herdsman:controller:log Device '0x003c84fffee81528' is already in database with different networkAddress, updating networkAddress 2022-12-16T00:48:00.641Z zigbee-herdsman:controller:log Interview '0x003c84fffee81528' start Zigbee2MQTT:info 2022-12-16 01:48:00: Starting interview of '0x003c84fffee81528' Zigbee2MQTT:info 2022-12-16 01:48:01: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"friendly_name":"0x003c84fffee81528","ieee_address":"0x003c84fffee81528","status":"started"},"type":"device_interview"}' Zigbee2MQTT:info 2022-12-16 01:48:01: MQTT publish: topic 'zigbee2mqtt/bridge/log', payload '{"message":"interview_started","meta":{"friendly_name":"0x003c84fffee81528"},"type":"pairing"}' 2022-12-16T00:48:01.027Z zigbee-herdsman:controller:device:log Interview - start device '0x003c84fffee81528' 2022-12-16T00:48:01.027Z zigbee-herdsman:adapter:zStack:znp:SREQ --> ZDO - nodeDescReq - {"dstaddr":62946,"nwkaddrofinterest":62946} 2022-12-16T00:48:01.028Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,4,37,2,226,245,226,245,35] 2022-12-16T00:48:01.029Z zigbee-herdsman:controller:log Device '0x003c84fffee81528' accepted by handler 2022-12-16T00:48:01.029Z zigbee-herdsman:controller:log Not interviewing '0x003c84fffee81528', completed 'false', in progress 'true' 2022-12-16T00:48:01.058Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,101,2,0,102] 2022-12-16T00:48:01.058Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,101,2,0,102] 2022-12-16T00:48:01.058Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 5 - 2 - [0] - 102 2022-12-16T00:48:01.059Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- ZDO - nodeDescReq - {"status":0} 2022-12-16T00:48:01.060Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []

danieledwardgeorgehitchcock commented 1 year ago

See Koenkk/zigbee2mqtt#13520

github-actions[bot] commented 1 year ago

This issue is stale because it has been open 30 days with no activity. Remove stale label or comment or this will be closed in 7 days