dresden-elektronik / deconz-rest-plugin

deCONZ REST-API plugin to control ZigBee devices
BSD 3-Clause "New" or "Revised" License
1.9k stars 503 forks source link

Unable to add 4 button sunrichter/NAMRON AS switch 4512719 #7925

Closed olemr closed 2 months ago

olemr commented 2 months ago

Does the issue really belong here?

Is there already an existing issue for this?

Describe the bug

As described in https://forum.phoscon.de/t/namron-4512719-no-longer-able-to-add/5066 Was directed here. Got logs now.

Steps to reproduce the behavior

  1. Factory resetting the 4512719 switch
  2. Start an Add new switch search in Phoscon
  3. Start add procedure on the 4512719
  4. The Add fails.

Expected behavior

I expected the switch to be added as it did in the past. Not sure when it was broken.

Screenshots

Screenshots in forum: https://forum.phoscon.de/t/namron-4512719-no-longer-able-to-add/5066

Environment

deCONZ Logs

15:09:01:134 MAC Poll 0x02 0x6470, life time: 4294967295 sec, dev timeout: 4294967295 sec 15:09:01:470 Beacon src: 0xBB69 ch: 25 updateId: 1 15:09:01:486 Beacon src: 0xB706 ch: 25 updateId: 1 15:09:01:486 Beacon src: 0xFF8D ch: 25 updateId: 1 15:09:01:487 Beacon src: 0x87FA ch: 25 updateId: 1 15:09:01:487 Beacon src: 0x7E37 ch: 25 updateId: 1 15:09:01:487 Beacon src: 0x1788 ch: 25 updateId: 1 15:09:01:487 Beacon src: 0xC780 ch: 25 updateId: 1 15:09:01:502 Beacon src: 0x2EE5 ch: 25 updateId: 1 15:09:01:502 Beacon src: 0x7968 ch: 25 updateId: 1 15:09:01:503 Beacon src: 0xF91F ch: 25 updateId: 1 15:09:01:503 Beacon src: 0x1B14 ch: 25 updateId: 1 15:09:01:503 Beacon src: 0x67F5 ch: 25 updateId: 1 15:09:01:503 Beacon src: 0x782E ch: 25 updateId: 1 15:09:01:518 Beacon src: 0x2989 ch: 25 updateId: 1 15:09:01:518 Beacon src: 0xD079 ch: 25 updateId: 1 15:09:01:518 Beacon src: 0xC387 ch: 25 updateId: 1 15:09:01:519 Beacon src: 0x3395 ch: 25 updateId: 1 15:09:01:534 Beacon src: 0x67A3 ch: 25 updateId: 1 15:09:01:534 Beacon src: 0x1B8D ch: 25 updateId: 1 15:09:01:535 Beacon src: 0xAEE0 ch: 25 updateId: 1 15:09:01:550 Beacon src: 0xF440 ch: 25 updateId: 1 15:09:01:550 Beacon src: 0xF867 ch: 25 updateId: 1 15:09:01:566 Beacon src: 0xFEE7 ch: 25 updateId: 1 15:09:01:566 Beacon src: 0xDB48 ch: 25 updateId: 1 15:09:01:566 Beacon src: 0xB196 ch: 25 updateId: 1 15:09:01:567 Mgmt_Lqi_req zdpSeq: 220 to 0x000B57FFFEEFC30E start index 3 15:09:01:582 Beacon src: 0xC20A ch: 25 updateId: 1 15:09:01:582 Beacon src: 0xD8E3 ch: 25 updateId: 1 15:09:01:583 Beacon src: 0x1D31 ch: 25 updateId: 1 15:09:01:583 Beacon src: 0x6AE5 ch: 25 updateId: 1 15:09:01:583 Beacon src: 0xD804 ch: 25 updateId: 1 15:09:01:598 Beacon src: 0x48C6 ch: 25 updateId: 1 15:09:01:598 Beacon src: 0x7231 ch: 25 updateId: 1 15:09:01:599 Beacon src: 0xB654 ch: 25 updateId: 1 15:09:01:678 ZDP 0x000B57FFFEEFC30E cluster: 0x8031 status = 0x00 -> SUCCESS 15:09:01:678 ZDP Mgmt_Lqi_rsp zdpSeq: 220 from 0x000B57FFFEEFC30E total: 16, startIndex: 3, listCount: 3 15:09:01:678 * neighbor: 0x000D6FFFFEFC04D7 (0x48C6), LQI: 170, relation: 0x02, depth: 15, rxOnWHenIdle: 1 15:09:01:679 ZDP add 0x000D6FFFFEFC04D7, nwk: 0x48C6 to discover queue 15:09:01:679 * neighbor: 0x385CFBFFFE848F01 (0x782E), LQI: 179, relation: 0x02, depth: 15, rxOnWHenIdle: 1 15:09:01:679 ZDP add 0x385CFBFFFE848F01, nwk: 0x782E to discover queue 15:09:01:680 * neighbor: 0x0017880108E6E821 (0x7968), LQI: 214, relation: 0x02, depth: 15, rxOnWHenIdle: 1 15:09:01:680 ZDP add 0x0017880108E6E821, nwk: 0x7968 to discover queue 15:09:01:726 Beacon src: 0x2F55 ch: 25 updateId: 1 15:09:01:742 Beacon src: 0xB196 ch: 25 updateId: 1 15:09:01:742 Beacon src: 0x3395 ch: 25 updateId: 1 15:09:01:742 Beacon src: 0xC387 ch: 25 updateId: 1 15:09:01:743 Beacon src: 0xB706 ch: 25 updateId: 1 15:09:01:743 Beacon src: 0x87FA ch: 25 updateId: 1 15:09:01:758 Beacon src: 0xBB69 ch: 25 updateId: 1 15:09:01:758 Beacon src: 0x050D ch: 25 updateId: 1 15:09:01:758 Beacon src: 0x612F ch: 25 updateId: 1 15:09:01:759 Beacon src: 0x1B14 ch: 25 updateId: 1 15:09:01:774 Beacon src: 0x2EE5 ch: 25 updateId: 1 15:09:01:774 Beacon src: 0xC780 ch: 25 updateId: 1 15:09:01:774 Beacon src: 0x6AE5 ch: 25 updateId: 1 15:09:01:775 Beacon src: 0xD804 ch: 25 updateId: 1 15:09:01:775 Beacon src: 0x7968 ch: 25 updateId: 1 15:09:01:775 Beacon src: 0xF440 ch: 25 updateId: 1 15:09:01:775 Beacon src: 0xA6CD ch: 25 updateId: 1 15:09:01:790 Beacon src: 0x67F5 ch: 25 updateId: 1 15:09:01:790 Beacon src: 0x782E ch: 25 updateId: 1 15:09:01:791 Beacon src: 0xF867 ch: 25 updateId: 1 15:09:01:806 Beacon src: 0xB792 ch: 25 updateId: 1 15:09:01:806 Beacon src: 0xFEE7 ch: 25 updateId: 1 15:09:01:807 Beacon src: 0x67A3 ch: 25 updateId: 1 15:09:01:807 Beacon src: 0x1B8D ch: 25 updateId: 1 15:09:01:822 Beacon src: 0x48C6 ch: 25 updateId: 1 15:09:01:822 Beacon src: 0x7CD7 ch: 25 updateId: 1 15:09:01:822 Beacon src: 0xD079 ch: 25 updateId: 1 15:09:01:823 Beacon src: 0xAEE0 ch: 25 updateId: 1 15:09:01:838 Beacon src: 0xDB48 ch: 25 updateId: 1 15:09:01:838 Beacon src: 0xD8E3 ch: 25 updateId: 1 15:09:02:365 APS-DATA.indication from unknown node 0x842E14FFFE90135F 15:09:02:366 ZDP device announce: 0x842E14FFFE90135F, 0x27D2, 0x80 15:09:02:366 ZDP add 0x842E14FFFE90135F, nwk: 0x27D2 to discover queue 15:09:02:367 CTRL create node 0x842E14FFFE90135F, nwk: 0x27D2 15:09:02:373 device announce 0x842E14FFFE90135F (0x27D2) mac capabilities 0x80 15:09:02:374 set fast probe address to 0x842E14FFFE90135F (0x27D2) 15:09:02:374 FP indication 0x0000 / 0x0013 (0x842E14FFFE90135F / 0x27D2) 15:09:02:375 ... (0x842E14FFFE90135F / 0x27D2) 15:09:02:375 device announce 0x842E14FFFE90135F (0x27D2) mac capabilities 0x80 15:09:02:375 DEV Tick.Join: event/device.anounce 15:09:02:375 DEV Tick: fast poll 0x842E14FFFE90135F, mac capabilities: 0x80 15:09:02:384 ZDP get node descriptor for 0x27D2 15:09:02:526 skip device discovery while end devices is added 15:09:03:006 skip device discovery while end devices is added 15:09:03:277 [1] get node descriptor for 0x842e14fffe90135f 15:09:03:278 ZDP get node descriptor for 0x27D2 15:09:03:437 APS-DATA.request id: 74 -> finish [4] 15:09:03:438 ZDP 0x842E14FFFE90135F cluster: 0x8002 status = 0x00 -> SUCCESS 15:09:03:438 ZDP Node_Descriptor_rsp 0x842E14FFFE90135F - 0x27D2 15:09:03:438 DB pushZdpDescriptorDb() 15:09:03:439 DB UPDATE device_descriptors SET data = x'0240802412525200002c520000', timestamp = 1726319343 WHERE device_id = (SELECT id FROM devices WHERE mac = '84:2e:14:ff:fe:90:13:5f') AND endpoint = 0 AND type = 2 15:09:03:440 DB INSERT INTO device_descriptors (device_id, endpoint, type, data, timestamp) SELECT id, 0, 2, x'0240802412525200002c520000', 1726319343 FROM devices WHERE mac = '84:2e:14:ff:fe:90:13:5f' 15:09:03:445 FP indication 0x0000 / 0x8002 (0x842E14FFFE90135F / 0x27D2) 15:09:03:445 ... (0x842E14FFFE90135F / 0x27D2) 15:09:03:445 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) cluster 0x8002 15:09:03:446 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) clear timeout on cluster 0x8002 15:09:03:446 DEV ZDP node descriptor verified: 0x842E14FFFE90135F 15:09:03:446 ZDP get active endpoints for 0x27D2 15:09:03:454 [2] get active endpoints for 0x842e14fffe90135f 15:09:03:455 ZDP get active endpoints for 0x27D2 15:09:03:486 skip device discovery while end devices is added 15:09:03:966 skip device discovery while end devices is added 15:09:04:413 ZDP 0x842E14FFFE90135F cluster: 0x8005 status = 0x00 -> SUCCESS 15:09:04:414 ZDP active ep response for 0x842E14FFFE90135F 15:09:04:415 ep: 0x01 15:09:04:416 ep: 0x02 15:09:04:417 FP indication 0x0000 / 0x8005 (0x842E14FFFE90135F / 0x27D2) 15:09:04:418 ... (0x842E14FFFE90135F / 0x27D2) 15:09:04:418 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) cluster 0x8005 15:09:04:419 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) clear timeout on cluster 0x8005 15:09:04:420 DEV ZDP node descriptor verified: 0x842E14FFFE90135F 15:09:04:421 DEV ZDP active endpoints verified: 0x842E14FFFE90135F 15:09:04:421 ZDP get simple descriptor 0x01 for 0x27D2 15:09:04:437 [3] get simple descriptor 0x01 for 0x842e14fffe90135f 15:09:04:438 ZDP get simple descriptor 0x01 for 0x27D2 15:09:04:447 skip device discovery while end devices is added 15:09:04:463 ZDP 0x842E14FFFE90135F cluster: 0x8005 status = 0x00 -> SUCCESS 15:09:04:465 ZDP active ep response for 0x842E14FFFE90135F 15:09:04:465 ep: 0x01 15:09:04:466 ep: 0x02 15:09:04:467 FP indication 0x0000 / 0x8005 (0x842E14FFFE90135F / 0x27D2) 15:09:04:468 ... (0x842E14FFFE90135F / 0x27D2) 15:09:04:469 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) cluster 0x8005 15:09:04:478 wait response fastEnddeviceProbe() 0x842E14FFFE90135F, elapsed 38 ms 15:09:04:509 ZDP 0x842E14FFFE90135F cluster: 0x8005 status = 0x00 -> SUCCESS 15:09:04:510 ZDP active ep response for 0x842E14FFFE90135F 15:09:04:510 ep: 0x01 15:09:04:510 ep: 0x02 15:09:04:510 FP indication 0x0000 / 0x8005 (0x842E14FFFE90135F / 0x27D2) 15:09:04:511 ... (0x842E14FFFE90135F / 0x27D2) 15:09:04:511 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) cluster 0x8005 15:09:04:517 wait response fastEnddeviceProbe() 0x842E14FFFE90135F, elapsed 78 ms 15:09:04:926 skip device discovery while end devices is added 15:09:05:373 FP indication 0x0104 / 0x0001 (0x842E14FFFE90135F / 0x27D2) 15:09:05:374 ... (0x842E14FFFE90135F / 0x27D2) 15:09:05:374 ZCL attribute report 0x842E14FFFE90135F for cluster: 0x0001, ep: 0x01, frame control: 0x08, mfcode: 0x0000 15:09:05:374 payload: 21002057 15:09:05:406 skip device discovery while end devices is added 15:09:05:517 ZDP 0x842E14FFFE90135F cluster: 0x8004 status = 0x00 -> SUCCESS 15:09:05:517 ZDP Simple_Descriptor_rsp 0x842E14FFFE90135F - 0x27D2 15:09:05:518 copy Power Configuration cluster data 15:09:05:520 DB pushZdpDescriptorDb() 15:09:05:521 DB UPDATE device_descriptors SET data = x'01040101000004000001000300050b0803000400050006000800190000030010', timestamp = 1726319345 WHERE device_id = (SELECT id FROM devices WHERE mac = '84:2e:14:ff:fe:90:13:5f') AND endpoint = 1 AND type = 4 15:09:05:522 DB INSERT INTO device_descriptors (device_id, endpoint, type, data, timestamp) SELECT id, 1, 4, x'01040101000004000001000300050b0803000400050006000800190000030010', 1726319345 FROM devices WHERE mac = '84:2e:14:ff:fe:90:13:5f' 15:09:05:526 FP indication 0x0000 / 0x8004 (0x842E14FFFE90135F / 0x27D2) 15:09:05:527 ... (0x842E14FFFE90135F / 0x27D2) 15:09:05:527 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) cluster 0x8004 15:09:05:527 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) clear timeout on cluster 0x8004 15:09:05:528 DEV ZDP node descriptor verified: 0x842E14FFFE90135F 15:09:05:528 DEV ZDP active endpoints verified: 0x842E14FFFE90135F 15:09:05:529 ZDP get simple descriptor 0x02 for 0x27D2 15:09:05:538 [3] get simple descriptor 0x02 for 0x842e14fffe90135f 15:09:05:539 ZDP get simple descriptor 0x02 for 0x27D2 15:09:05:581 ZDP 0x842E14FFFE90135F cluster: 0x8004 status = 0x00 -> SUCCESS 15:09:05:581 ZDP Simple_Descriptor_rsp 0x842E14FFFE90135F - 0x27D2 15:09:05:582 DB pushZdpDescriptorDb() 15:09:05:583 FP indication 0x0000 / 0x8004 (0x842E14FFFE90135F / 0x27D2) 15:09:05:583 ... (0x842E14FFFE90135F / 0x27D2) 15:09:05:584 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) cluster 0x8004 15:09:05:584 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) clear timeout on cluster 0x8004 15:09:05:584 DEV ZDP node descriptor verified: 0x842E14FFFE90135F 15:09:05:584 DEV ZDP active endpoints verified: 0x842E14FFFE90135F 15:09:05:585 ZDP get simple descriptor 0x02 for 0x27D2 15:09:05:590 [3] get simple descriptor 0x02 for 0x842e14fffe90135f 15:09:05:590 ZDP get simple descriptor 0x02 for 0x27D2 15:09:05:644 ZDP 0x842E14FFFE90135F cluster: 0x8004 status = 0x00 -> SUCCESS 15:09:05:645 ZDP Simple_Descriptor_rsp 0x842E14FFFE90135F - 0x27D2 15:09:05:646 DB pushZdpDescriptorDb() 15:09:05:647 FP indication 0x0000 / 0x8004 (0x842E14FFFE90135F / 0x27D2) 15:09:05:647 ... (0x842E14FFFE90135F / 0x27D2) 15:09:05:647 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) cluster 0x8004 15:09:05:648 DEV ZDP node descriptor verified: 0x842E14FFFE90135F 15:09:05:648 DEV ZDP active endpoints verified: 0x842E14FFFE90135F 15:09:05:648 ZDP get simple descriptor 0x02 for 0x27D2 15:09:05:653 [3] get simple descriptor 0x02 for 0x842e14fffe90135f 15:09:05:654 ZDP get simple descriptor 0x02 for 0x27D2 15:09:05:886 skip device discovery while end devices is added 15:09:06:172 MAC Poll 0x02 0x6470, life time: 4294967295 sec, dev timeout: 4294967295 sec 15:09:06:366 skip device discovery while end devices is added 15:09:06:444 ZDP 0x842E14FFFE90135F cluster: 0x8004 status = 0x00 -> SUCCESS 15:09:06:445 ZDP Simple_Descriptor_rsp 0x842E14FFFE90135F - 0x27D2 15:09:06:449 DB pushZdpDescriptorDb() 15:09:06:450 DB UPDATE device_descriptors SET data = x'02040101000004000001000300050b0803000400050006000800190000030010', timestamp = 1726319346 WHERE device_id = (SELECT id FROM devices WHERE mac = '84:2e:14:ff:fe:90:13:5f') AND endpoint = 2 AND type = 4 15:09:06:451 DB INSERT INTO device_descriptors (device_id, endpoint, type, data, timestamp) SELECT id, 2, 4, x'02040101000004000001000300050b0803000400050006000800190000030010', 1726319346 FROM devices WHERE mac = '84:2e:14:ff:fe:90:13:5f' 15:09:06:455 FP indication 0x0000 / 0x8004 (0x842E14FFFE90135F / 0x27D2) 15:09:06:455 ... (0x842E14FFFE90135F / 0x27D2) 15:09:06:456 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) cluster 0x8004 15:09:06:456 DEV ZDP node descriptor verified: 0x842E14FFFE90135F 15:09:06:456 DEV ZDP active endpoints verified: 0x842E14FFFE90135F 15:09:06:457 DEV ZDP simple descriptors verified: 0x842E14FFFE90135F 15:09:06:457 ZCL read attr 0x842E14FFFE90135F, ep: 0x01, cl: 0x0000, attr: 0x0004, mfcode: 0x0000, aps.id: 106, zcl.seq: 43 15:09:06:467 [4.1] Get manufacturer code 15:09:06:524 ZDP 0x842E14FFFE90135F cluster: 0x8004 status = 0x00 -> SUCCESS 15:09:06:525 ZDP Simple_Descriptor_rsp 0x842E14FFFE90135F - 0x27D2 15:09:06:526 DB pushZdpDescriptorDb() 15:09:06:527 FP indication 0x0000 / 0x8004 (0x842E14FFFE90135F / 0x27D2) 15:09:06:527 ... (0x842E14FFFE90135F / 0x27D2) 15:09:06:527 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) cluster 0x8004 15:09:06:534 [4.1] Get manufacturer code 15:09:06:588 ZDP 0x842E14FFFE90135F cluster: 0x8004 status = 0x00 -> SUCCESS 15:09:06:589 ZDP Simple_Descriptor_rsp 0x842E14FFFE90135F - 0x27D2 15:09:06:590 DB pushZdpDescriptorDb() 15:09:06:591 FP indication 0x0000 / 0x8004 (0x842E14FFFE90135F / 0x27D2) 15:09:06:591 ... (0x842E14FFFE90135F / 0x27D2) 15:09:06:591 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) cluster 0x8004 15:09:06:597 [4.1] Get manufacturer code 15:09:06:652 ZDP 0x842E14FFFE90135F cluster: 0x8004 status = 0x00 -> SUCCESS 15:09:06:653 ZDP Simple_Descriptor_rsp 0x842E14FFFE90135F - 0x27D2 15:09:06:654 DB pushZdpDescriptorDb() 15:09:06:655 FP indication 0x0000 / 0x8004 (0x842E14FFFE90135F / 0x27D2) 15:09:06:655 ... (0x842E14FFFE90135F / 0x27D2) 15:09:06:655 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) cluster 0x8004 15:09:06:661 [4.1] Get manufacturer code 15:09:06:749 08:6b:d7:ff:fe:37:06:74-01/state/bri expression: Item.val = Attr.val --> 165 15:09:06:750 ZCL attribute report 0x086BD7FFFE370674 for cluster: 0x0008, ep: 0x01, frame control: 0x38, mfcode: 0x0000 15:09:06:750 payload: 000020a5 15:09:06:750 Websocket 192.168.1.6:34664 send message: {"attr":{"id":"24","lastannounced":null,"lastseen":"2024-09-14T13:09Z","manufacturername":"IKEA of Sweden","modelid":"TRADFRI bulb E14 W op/ch 400lm","name":"Bokhylle 2","productid":"LED1649C5E14EU","swversion":"2.3.086","type":"Dimmable light","uniqueid":"08:6b:d7:ff:fe:37:06:74-01"},"e":"changed","id":"24","r":"lights","t":"event","uniqueid":"08:6b:d7:ff:fe:37:06:74-01"} (ret = -6726016) 15:09:06:751 Websocket 192.168.1.5:59137 send message: {"attr":{"id":"24","lastannounced":null,"lastseen":"2024-09-14T13:09Z","manufacturername":"IKEA of Sweden","modelid":"TRADFRI bulb E14 W op/ch 400lm","name":"Bokhylle 2","productid":"LED1649C5E14EU","swversion":"2.3.086","type":"Dimmable light","uniqueid":"08:6b:d7:ff:fe:37:06:74-01"},"e":"changed","id":"24","r":"lights","t":"event","uniqueid":"08:6b:d7:ff:fe:37:06:74-01"} (ret = -6726016) 15:09:06:846 skip device discovery while end devices is added 15:09:07:326 skip device discovery while end devices is added 15:09:07:436 ZCL got data for node=0x27D2, cl=0x0000, at=0x0004, mfc=0x0000, status=0x00, type=0x42 15:09:07:437 84:2e:14:ff:fe:90:13:5f/attr/manufacturername expression: Item.val = Attr.val --> NAMRON AS 15:09:07:438 FP indication 0x0104 / 0x0000 (0x842E14FFFE90135F / 0x27D2) 15:09:07:438 ... (0x842E14FFFE90135F / 0x27D2) 15:09:07:438 DEV received attr/manufacturername: 0x842E14FFFE90135F 15:09:07:439 DEV ZDP node descriptor verified: 0x842E14FFFE90135F 15:09:07:439 DEV ZDP active endpoints verified: 0x842E14FFFE90135F 15:09:07:439 DEV ZDP simple descriptors verified: 0x842E14FFFE90135F 15:09:07:439 ZCL read attr 0x842E14FFFE90135F, ep: 0x01, cl: 0x0000, attr: 0x0005, mfcode: 0x0000, aps.id: 120, zcl.seq: 48 15:09:07:444 [4.1] Get model ID 15:09:07:806 skip device discovery while end devices is added 15:09:08:286 skip device discovery while end devices is added 15:09:08:460 ZCL got data for node=0x27D2, cl=0x0000, at=0x0005, mfc=0x0000, status=0x00, type=0x42 15:09:08:461 84:2e:14:ff:fe:90:13:5f/attr/modelid expression: Item.val = Attr.val --> 4512719 15:09:08:462 FP indication 0x0104 / 0x0000 (0x842E14FFFE90135F / 0x27D2) 15:09:08:462 ... (0x842E14FFFE90135F / 0x27D2) 15:09:08:463 DEV received attr/modelid: 0x842E14FFFE90135F 15:09:08:463 DEV ZDP node descriptor verified: 0x842E14FFFE90135F 15:09:08:463 DEV ZDP active endpoints verified: 0x842E14FFFE90135F 15:09:08:464 DEV ZDP simple descriptors verified: 0x842E14FFFE90135F 15:09:08:464 DEV modelId: 4512719, 0x842E14FFFE90135F 15:09:08:464 DEV no DDF for 0x842E14FFFE90135F, modelId: 4512719 15:09:08:465 DEV create on-the-fly DDF for 0x842E14FFFE90135F 15:09:08:465 DEV enter passive state 0x842E14FFFE90135F 15:09:08:766 skip device discovery while end devices is added 15:09:09:246 skip device discovery while end devices is added 15:09:09:726 skip device discovery while end devices is added 15:09:09:979 Daylight now: solarNoon, status: 170, daylight: 1, dark: 0 15:09:10:206 skip device discovery while end devices is added 15:09:10:685 skip device discovery while end devices is added 15:09:11:166 skip device discovery while end devices is added 15:09:11:195 MAC Poll 0x02 0x6470, life time: 4294967295 sec, dev timeout: 4294967295 sec 15:09:11:646 skip device discovery while end devices is added 15:09:12:126 skip device discovery while end devices is added 15:09:12:363 FP indication 0x0104 / 0x0006 (0x842E14FFFE90135F / 0x27D2) 15:09:12:364 ... (0x842E14FFFE90135F / 0x27D2) 15:09:12:606 skip device discovery while end devices is added 15:09:13:086 skip device discovery while end devices is added 15:09:13:467 ZDP 0x842E14FFFE90135F cluster: 0x8002 status = 0x00 -> SUCCESS 15:09:13:468 ZDP Node_Descriptor_rsp 0x842E14FFFE90135F - 0x27D2 15:09:13:469 DB pushZdpDescriptorDb() 15:09:13:470 FP indication 0x0000 / 0x8002 (0x842E14FFFE90135F / 0x27D2) 15:09:13:471 ... (0x842E14FFFE90135F / 0x27D2) 15:09:13:472 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) cluster 0x8002 15:09:13:566 skip device discovery while end devices is added 15:09:14:046 skip device discovery while end devices is added 15:09:14:474 ZDP 0x842E14FFFE90135F cluster: 0x8005 status = 0x00 -> SUCCESS 15:09:14:476 ZDP active ep response for 0x842E14FFFE90135F 15:09:14:476 ep: 0x01 15:09:14:477 ep: 0x02 15:09:14:478 FP indication 0x0000 / 0x8005 (0x842E14FFFE90135F / 0x27D2) 15:09:14:479 ... (0x842E14FFFE90135F / 0x27D2) 15:09:14:479 ZDP indication search sensors 0x842E14FFFE90135F (0x27D2) cluster 0x8005 15:09:14:526 skip device discovery while end devices is added 15:09:15:006 skip device discovery while end devices is added 15:09:15:486 skip device discovery while end devices is added 15:09:15:965 skip device discovery while end devices is added 15:09:16:009 CTRL db store gui node 84:2e:14:ff:fe:90:13:5f 15:09:16:018 saved node state in 0 ms 15:09:16:019 sync() in 0 ms 15:09:16:202 MAC Poll 0x02 0x6470, life time: 4294967295 sec, dev timeout: 4294967295 sec 15:09:16:446 skip device discovery while end devices is added 15:09:16:926 skip device discovery while end devices is added 15:09:17:406 skip device discovery while end devices is added 15:09:17:658 cc:cc:cc:ff:fe:02:94:a2-01/state/lift expression: Item.val = Attr.val; --> 0 15:09:17:659 cc:cc:cc:ff:fe:02:94:a2-01/state/open expression: Item.val = Attr.val < 100 --> true 15:09:17:659 [INFO] - No button map for: FYRTUR block-out roller blind, unicast to: 0x0000, endpoint: 0x01, cluster: WINDOW_COVERING (0x0102), command: 0x0A, payload: 08002000, zclSeq: 81 15:09:17:660 ZCL attribute report 0xCCCCCCFFFE0294A2 for cluster: 0x0102, ep: 0x01, frame control: 0x38, mfcode: 0x0000 15:09:17:660 payload: 08002000 15:09:17:661 Websocket 192.168.1.6:34664 send message: {"attr":{"id":"37","lastannounced":null,"lastseen":"2024-09-14T13:09Z","manufacturername":"IKEA of Sweden","modelid":"FYRTUR block-out roller blind","name":"Fyrtur Soverom 37","productid":"E1757-140","swversion":"2.3.088","type":"Window covering device","uniqueid":"cc:cc:cc:ff:fe:02:94:a2-01"},"e":"changed","id":"37","r":"lights","t":"event","uniqueid":"cc:cc:cc:ff:fe:02:94:a2-01"} (ret = -6726016) 15:09:17:661 Websocket 192.168.1.5:59137 send message: {"attr":{"id":"37","lastannounced":null,"lastseen":"2024-09-14T13:09Z","manufacturername":"IKEA of Sweden","modelid":"FYRTUR block-out roller blind","name":"Fyrtur Soverom 37","productid":"E1757-140","swversion":"2.3.088","type":"Window covering device","uniqueid":"cc:cc:cc:ff:fe:02:94:a2-01"},"e":"changed","id":"37","r":"lights","t":"event","uniqueid":"cc:cc:cc:ff:fe:02:94:a2-01"} (ret = -6726016) 15:09:17:663 Websocket 192.168.1.6:34664 send message: {"attr":{"id":"31","lastannounced":null,"lastseen":"2024-09-14T13:09Z","manufacturername":"IKEA of Sweden","mode":1,"modelid":"FYRTUR block-out roller blind","name":"Battery 31","productid":"E1757-140","swversion":"2.3.088","type":"ZHABattery","uniqueid":"cc:cc:cc:ff:fe:02:94:a2-01-0001"},"e":"changed","id":"31","r":"sensors","t":"event","uniqueid":"cc:cc:cc:ff:fe:02:94:a2-01-0001"} (ret = -6724480) 15:09:17:664 Websocket 192.168.1.5:59137 send message: {"attr":{"id":"31","lastannounced":null,"lastseen":"2024-09-14T13:09Z","manufacturername":"IKEA of Sweden","mode":1,"modelid":"FYRTUR block-out roller blind","name":"Battery 31","productid":"E1757-140","swversion":"2.3.088","type":"ZHABattery","uniqueid":"cc:cc:cc:ff:fe:02:94:a2-01-0001"},"e":"changed","id":"31","r":"sensors","t":"event","uniqueid":"cc:cc:cc:ff:fe:02:94:a2-01-0001"} (ret = -6724480) 15:09:17:886 skip device discovery while end devices is added 15:09:18:366 skip device discovery while end devices is added 15:09:18:846 skip device discovery while end devices is added 15:09:19:326 skip device discovery while end devices is added 15:09:19:805 skip device discovery while end devices is added 15:09:19:978 Daylight now: solarNoon, status: 170, daylight: 1, dark: 0 15:09:20:286 skip device discovery while end devices is added 15:09:20:765 skip device discovery while end devices is added 15:09:21:240 MAC Poll 0x02 0x6470, life time: 4294967295 sec, dev timeout: 4294967295 sec 15:09:21:334 skip device discovery while end devices is added 15:09:21:814 skip device discovery while end devices is added 15:09:22:382 skip device discovery while end devices is added 15:09:22:862 skip device discovery while end devices is added 15:09:22:978 sql exec SELECT conf FROM zbconf ORDER BY rowid desc limit 1 15:09:22:979 Wait 12s till query finished 15:09:23:016 Websocket 192.168.1.6:34664 send message: {"attr":{"id":"39","lastannounced":null,"lastseen":"2024-09-14T13:09Z","manufacturername":"NAMRON AS","mode":1,"modelid":"4512703","name":"4512703 Switch 39","swversion":"2.7.6_r22","type":"ZHASwitch","uniqueid":"60:a4:23:ff:fe:28:31:1c-01-0006"},"e":"changed","id":"39","r":"sensors","t":"event","uniqueid":"60:a4:23:ff:fe:28:31:1c-01-0006"} (ret = -6724480) 15:09:23:017 Websocket 192.168.1.5:59137 send message: {"attr":{"id":"39","lastannounced":null,"lastseen":"2024-09-14T13:09Z","manufacturername":"NAMRON AS","mode":1,"modelid":"4512703","name":"4512703 Switch 39","swversion":"2.7.6_r22","type":"ZHASwitch","uniqueid":"60:a4:23:ff:fe:28:31:1c-01-0006"},"e":"changed","id":"39","r":"sensors","t":"event","uniqueid":"60:a4:23:ff:fe:28:31:1c-01-0006"} (ret = -6724480) 15:09:23:342 skip device discovery while end devices is added 15:09:23:822 skip device discovery while end devices is added 15:09:23:979 Wait 11s till query finished 15:09:24:302 skip device discovery while end devices is added 15:09:24:781 skip device discovery while end devices is added 15:09:24:978 Wait 10s till query finished 15:09:25:262 skip device discovery while end devices is added 15:09:25:742 skip device discovery while end devices is added 15:09:25:980 CTRL db store gui node 84:2e:14:ff:fe:90:13:5f 15:09:25:985 saved node state in 0 ms 15:09:25:986 sync() in 0 ms 15:09:25:986 Wait 9s till query finished 15:09:26:222 skip device discovery while end devices is added 15:09:26:263 MAC Poll 0x02 0x6470, life time: 4294967295 sec, dev timeout: 4294967295 sec 15:09:26:702 skip device discovery while end devices is added 15:09:27:002 Wait 7s till query finished 15:09:27:182 skip device discovery while end devices is added 15:09:27:662 skip device discovery while end devices is added 15:09:27:978 Wait 7s till query finished 15:09:28:054 FP indication 0x0104 / 0x0006 (0x842E14FFFE90135F / 0x27D2) 15:09:28:055 ... (0x842E14FFFE90135F / 0x27D2) 15:09:28:142 skip device discovery while end devices is added 15:09:28:622 skip device discovery while end devices is added 15:09:28:978 Wait 6s till query finished 15:09:29:102 skip device discovery while end devices is added 15:09:29:582 skip device discovery while end devices is added 15:09:29:978 Daylight now: solarNoon, status: 170, daylight: 1, dark: 0 15:09:29:979 Wait 5s till query finished 15:09:30:062 skip device discovery while end devices is added 15:09:30:542 skip device discovery while end devices is added 15:09:30:983 Wait 4s till query finished 15:09:31:022 skip device discovery while end devices is added 15:09:31:269 MAC Poll 0x02 0x6470, life time: 4294967295 sec, dev timeout: 4294967295 sec 15:09:31:501 skip device discovery while end devices is added 15:09:31:845 0xD0CF5EFFFEEEE3E3: update ZCL value 0x01/0x0300/0x0008 after 0 s 15:09:31:846 ZCL attribute report 0xD0CF5EFFFEEEE3E3 for cluster: 0x0300, ep: 0x01, frame control: 0x38, mfcode: 0x0000 15:09:31:846 payload: 08003001 15:09:31:847 Websocket 192.168.1.6:34664 send message: {"attr":{"colorcapabilities":16,"ctmax":454,"ctmin":250,"id":"52","lastannounced":"2023-06-23T09:05:59Z","lastseen":"2024-09-14T13:09Z","manufacturername":"IKEA of Sweden","modelid":"FLOALT panel WS 30x90","name":"Floalt 30x90 Oppe 52","swversion":"2.3.087","type":"Color temperature light","uniqueid":"d0:cf:5e:ff:fe:ee:e3:e3-01"},"e":"changed","id":"52","r":"lights","t":"event","uniqueid":"d0:cf:5e:ff:fe:ee:e3:e3-01"} (ret = -6726016) 15:09:31:848 Websocket 192.168.1.5:59137 send message: {"attr":{"colorcapabilities":16,"ctmax":454,"ctmin":250,"id":"52","lastannounced":"2023-06-23T09:05:59Z","lastseen":"2024-09-14T13:09Z","manufacturername":"IKEA of Sweden","modelid":"FLOALT panel WS 30x90","name":"Floalt 30x90 Oppe 52","swversion":"2.3.087","type":"Color temperature light","uniqueid":"d0:cf:5e:ff:fe:ee:e3:e3-01"},"e":"changed","id":"52","r":"lights","t":"event","uniqueid":"d0:cf:5e:ff:fe:ee:e3:e3-01"} (ret = -6726016) 15:09:31:896 0xD0CF5EFFFEEEE3E3: update ZCL value 0x01/0x0300/0x0007 after 0 s 15:09:31:897 ZCL attribute report 0xD0CF5EFFFEEEE3E3 for cluster: 0x0300, ep: 0x01, frame control: 0x38, mfcode: 0x0000 15:09:31:897 payload: 0700217201 15:09:31:995 Wait 3s till query finished 15:09:31:999 DEV Binding enter /devices/0x588E81FFFE2B5B21 15:09:32:078 skip device discovery while end devices is added 15:09:32:558 skip device discovery while end devices is added 15:09:32:978 Wait 2s till query finished 15:09:33:038 skip device discovery while end devices is added 15:09:33:518 skip device discovery while end devices is added 15:09:33:979 Wait 1s till query finished 15:09:33:997 skip device discovery while end devices is added 15:09:34:478 skip device discovery while end devices is added 15:09:35:045 skip device discovery while end devices is added 15:09:35:526 skip device discovery while end devices is added 15:09:36:006 skip device discovery while end devices is added 15:09:36:292 MAC Poll 0x02 0x6470, life time: 4294967295 sec, dev timeout: 4294967295 sec 15:09:36:296 Websocket 192.168.1.6:34664 send message: {"attr":{"id":"28","lastannounced":null,"lastseen":"2024-09-14T13:09Z","manufacturername":"Philips","mode":1,"modelid":"SML002","name":"HUE outdoor","productname":"Hue outdoor motion sensor","swversion":"6.1.0.25261","type":"ZHAPresence","uniqueid":"00:17:88:01:06:47:c7:1f-02-0406"},"e":"changed","id":"28","r":"sensors","t":"event","uniqueid":"00:17:88:01:06:47:c7:1f-02-0406"} (ret = -6723648) 15:09:36:297 Websocket 192.168.1.5:59137 send message: {"attr":{"id":"28","lastannounced":null,"lastseen":"2024-09-14T13:09Z","manufacturername":"Philips","mode":1,"modelid":"SML002","name":"HUE outdoor","productname":"Hue outdoor motion sensor","swversion":"6.1.0.25261","type":"ZHAPresence","uniqueid":"00:17:88:01:06:47:c7:1f-02-0406"},"e":"changed","id":"28","r":"sensors","t":"event","uniqueid":"00:17:88:01:06:47:c7:1f-02-0406"} (ret = -6723648) 15:09:36:299 Websocket 192.168.1.6:34664 send message: {"attr":{"id":"30","lastannounced":null,"lastseen":"2024-09-14T13:09Z","manufacturername":"Philips","mode":1,"modelid":"SML002","name":"HUE outdoor","productname":"Hue outdoor light sensor","swversion":"6.1.0.25261","type":"ZHALightLevel","uniqueid":"00:17:88:01:06:47:c7:1f-02-0400"},"e":"changed","id":"30","r":"sensors","t":"event","uniqueid":"00:17:88:01:06:47:c7:1f-02-0400"} (ret = -6723648) 15:09:36:300 Websocket 192.168.1.5:59137 send message: {"attr":{"id":"30","lastannounced":null,"lastseen":"2024-09-14T13:09Z","manufacturername":"Philips","mode":1,"modelid":"SML002","name":"HUE outdoor","productname":"Hue outdoor light sensor","swversion":"6.1.0.25261","type":"ZHALightLevel","uniqueid":"00:17:88:01:06:47:c7:1f-02-0400"},"e":"changed","id":"30","r":"sensors","t":"event","uniqueid":"00:17:88:01:06:47:c7:1f-02-0400"} (ret = -6723648) 15:09:36:301 Websocket 192.168.1.6:34664 send message: {"attr":{"id":"29","lastannounced":null,"lastseen":"2024-09-14T13:09Z","manufacturername":"Philips","mode":1,"modelid":"SML002","name":"HUE outdoor","productname":"Hue outdoor temp. sensor","swversion":"6.1.0.25261","type":"ZHATemperature","uniqueid":"00:17:88:01:06:47:c7:1f-02-0402"},"e":"changed","id":"29","r":"sensors","t":"event","uniqueid":"00:17:88:01:06:47:c7:1f-02-0402"} (ret = -6723648) 15:09:36:302 Websocket 192.168.1.5:59137 send message: {"attr":{"id":"29","lastannounced":null,"lastseen":"2024-09-14T13:09Z","manufacturername":"Philips","mode":1,"modelid":"SML002","name":"HUE outdoor","productname":"Hue outdoor temp. sensor","swversion":"6.1.0.25261","type":"ZHATemperature","uniqueid":"00:17:88:01:06:47:c7:1f-02-0402"},"e":"changed","id":"29","r":"sensors","t":"event","uniqueid":"00:17:88:01:06:47:c7:1f-02-0402"} (ret = -6723648) 15:09:36:486 skip device discovery while end devices is added

Additional context

From the log: 3489: 15:09:08:464 DEV modelId: 4512719, 0x842E14FFFE90135F 3490: 15:09:08:464 DEV no DDF for 0x842E14FFFE90135F, modelId: 4512719 3491: 15:09:08:465 DEV create on-the-fly DDF for 0x842E14FFFE90135F 3492: 15:09:08:465 DEV enter passive state 0x842E14FFFE90135F

pi@rpi4stavern:/usr/share/deCONZ/devices/sunricher $ ll 4b* -rw-r--r-- 1 root root 2978 Sep 14 15:16 4button_switch.json

pi@rpi4stavern:/usr/share/deCONZ/devices/sunricher $ cat 4button_switch.json { "schema": "devcap1.schema.json", "uuid": "d835ceb3-dc5c-4f8a-80cc-84f5d3900319", "manufacturername": [ "EcoDim", "EcoDim", "Sunricher", "NAMRON AS", "NAMRON AS", "ROBB smarrt", "ROBB smarrt" ], "modelid": [ "ED-10012", "ED-10013", "ZG2833K4_EU06", "4512719", "4512729", "ROB_200-008", "ROB_200-008-0" ], "matchexpr": "R.endpoints.length === 2", "vendor": "Sunricher", "product": "4 button wall switch", "sleeper": true, "status": "Gold", "subdevices": [ { "type": "$TYPE_SWITCH", "restapi": "/sensors", "uuid": ["$address.ext", "0x01", "0x0006"], "fingerprint": { "profile": "0x0104", "device": "0x0001", "endpoint": "0x01", "in": [ "0x0000", "0x0001", "0x1000" ], "out": [ "0x0005", "0x0006", "0x0008" ] }, "meta": {"group.endpoints": [1, 2] }, "items": [ { "name": "attr/id" }, { "name": "attr/lastannounced" }, { "name": "attr/lastseen" }, { "name": "attr/manufacturername" }, { "name": "attr/modelid" }, { "name": "attr/name" }, { "name": "attr/swversion" }, { "name": "attr/type" }, { "name": "attr/uniqueid" }, { "name": "config/battery", "parse": {"at": "0x0021", "cl": "0x0001", "ep": 1, "eval": "Item.val = Attr.val"}, "read": {"fn": "zcl:attr", "ep": 1, "cl": "0x0001", "at": "0x0021"}, "refresh.interval": 4000, "awake": true }, { "name": "config/group", "default": "auto,auto" }, { "name": "config/on" }, { "name": "config/reachable" }, { "name": "state/buttonevent", "awake": true }, { "name": "state/lastupdated" } ] } ], "bindings": [ { "bind": "unicast", "src.ep": 1, "cl": "0x0001", "report": [ { "at": "0x0021", "dt": "0x20", "min": 60, "max": 3600, "change": "0x00000001" } ] }, { "bind": "groupcast", "config.group": 0, "src.ep": 1, "cl": "0x0006" }, { "bind": "groupcast", "config.group": 0, "src.ep": 1, "cl": "0x0008" }, { "bind": "groupcast", "config.group": 1, "src.ep": 2, "cl": "0x0006" }, { "bind": "groupcast", "config.group": 1, "src.ep": 2, "cl": "0x0008" } ] }

Tried adding NAMRON AS with 2 spaces as hinted to in forum. No joy.

SwoopX commented 2 months ago

Hi,

thanks for raising your matter here and sharing some valuable logs. However, it looks as I stand right with my initial assumption on the manufacturer name, so this is not a bug. Therefore, I'll close this issue.

Feel free to directly raise a PR to have that modelID/manufacturername combination covered as well in the future, no need for another device support request.

grafik

olemr commented 2 months ago

@SwoopX what should that PR contain? Do I have to clone, build and test a fix myself and then include that fix in a PR? Never done this before ...

olemr commented 2 months ago

Also please note, that this is not a new switch. It used to work fine a few years back, probably pre DDF ..

SwoopX commented 2 months ago

You just need to add modelid and manufacturer to a fitting DDF like here: https://github.com/dresden-elektronik/deconz-rest-plugin/pull/7889/files

That's it already

olemr commented 2 months ago

In the original sunrichter/4button_switch.json that looks like this:

  "manufacturername": [
    "EcoDim",
    "EcoDim",
    "Sunricher",
    "NAMRON AS",
    "NAMRON AS",
    "ROBB smarrt",
    "ROBB smarrt"
  ], 

I tried adding

  "manufacturername": [
    "EcoDim",
    "EcoDim",
    "Sunricher",
    "NAMRON AS",
    "NAMRON AS",
    "NAMRON  AS",
    "NAMRON  AS",
    "ROBB smarrt",
    "ROBB smarrt"
  ],

But that did not help. I'm confused by the double entries there.

Perhaps try:

  "manufacturername": [
    "EcoDim",
    "EcoDim",
    "Sunricher",
    "NAMRON AS",
    "NAMRON  AS",
    "ROBB smarrt",
    "ROBB smarrt"
  ],

?

olemr commented 2 months ago

@SwoopX Sorry for mentioning. I don't think the DDF is picked up at all: (tried my Perhaps try in my latest post, but still no joy) 3489: 15:09:08:464 DEV modelId: 4512719, 0x842E14FFFE90135F 3490: 15:09:08:464 DEV no DDF for 0x842E14FFFE90135F, modelId: 4512719 3491: 15:09:08:465 DEV create on-the-fly DDF for 0x842E14FFFE90135F 3492: 15:09:08:465 DEV enter passive state 0x842E14FFFE90135F

How can we check the content of this on-the-fly DDF? Or better still, how to get it to pick up the DDF?

olemr commented 2 months ago

image

olemr commented 2 months ago

Think I just understood the mapping between manufacturername and modelid, but it looks ok?

  "manufacturername": [
    "EcoDim",
    "EcoDim",
    "Sunricher",
    "NAMRON AS",
    "NAMRON  AS",
    "ROBB smarrt",
    "ROBB smarrt"
  ],
  "modelid": [
    "ED-10012",
    "ED-10013",
    "ZG2833K4_EU06",
    "4512719",
    "4512729",
    "ROB_200-008",
    "ROB_200-008-0"
  ],
SwoopX commented 2 months ago

I'm sorry, but you're not thoroughly looking at the provided example and what I've written. You must add manufacturer and modelID, you were (at least initially) adding just the manufacturer. Both values are a json array and the index values at a certain position represent a touple, a valid model/manufacturer combination.

You later on removed the working combination for the 4512719 and replaced the manufacturer at that position with yours. That would mean, everybody else having that combination cannot pair the device anymore. Therefroe, please add your combination at the end.

The legacy code which made the pairing work back in the days has already been removed in favor of leveraging more defined DDFs.