Cannot add NAMRON AS/4512703 8 button switch

[olemr]

Does the issue really belong here?

• I definitively want to report a bug within deCONZ or its REST-API

Is there already an existing issue for this?

• I have searched the existing issues and there is none for the bug at hand

Describe the bug

Seems like the DDF is not picked up and add fails.
Not a single DDF reference in the log
Device defined here: /usr/share/deCONZ/devices/sunricher/8button_switch.json
My :~/.local/share/dresden-elektronik/deCONZ/devices is empty
Tried numerous deconz restarts, Conbee replugs, node deletes and adding retries ...

Steps to reproduce the behavior

Start adding the switch. GUI times out.

Expected behavior

Add successful.

Screenshots

Environment

• Host system: Raspberry Pi
• Running method: Raspbian
• Firmware version: 26400500
• deCONZ version 2.28.1
• Device: ConBee I
• Do you use an USB extension cable: yes
• Is there any other USB or serial devices connected to the host system? no

deCONZ Logs

16:40:12:615 Beacon src: 0x050D ch: 25 updateId: 1
16:40:12:617 Beacon src: 0xB706 ch: 25 updateId: 1
16:40:12:618 Beacon src: 0xBB69 ch: 25 updateId: 1
16:40:12:632 Beacon src: 0xC780 ch: 25 updateId: 1
16:40:12:633 Beacon src: 0x1B14 ch: 25 updateId: 1
16:40:12:634 Beacon src: 0xFF8D ch: 25 updateId: 1
16:40:12:634 Beacon src: 0x1788 ch: 25 updateId: 1
16:40:12:635 Beacon src: 0xD5ED ch: 25 updateId: 1
16:40:12:636 Beacon src: 0xD804 ch: 25 updateId: 1
16:40:12:637 Beacon src: 0xF440 ch: 25 updateId: 1
16:40:12:647 Beacon src: 0x7E37 ch: 25 updateId: 1
16:40:12:649 Beacon src: 0xC20A ch: 25 updateId: 1
16:40:12:649 Beacon src: 0xF867 ch: 25 updateId: 1
16:40:12:650 Beacon src: 0x48C6 ch: 25 updateId: 1
16:40:12:656 APS-DATA.request id: 183, addrmode: 0x03, addr: 0x00178801040482BF, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
16:40:12:657 asdu (length: 2): 1F0A
16:40:12:663 Beacon src: 0xB792 ch: 25 updateId: 1
16:40:12:664 Beacon src: 0x67A3 ch: 25 updateId: 1
16:40:12:665 Beacon src: 0x67F5 ch: 25 updateId: 1
16:40:12:695 Beacon src: 0xD8E3 ch: 25 updateId: 1
16:40:12:711 Beacon src: 0x782E ch: 25 updateId: 1
16:40:12:712 Beacon src: 0xA6CD ch: 25 updateId: 1
16:40:12:713 Beacon src: 0x6AE5 ch: 25 updateId: 1
16:40:12:713 Beacon src: 0xDB48 ch: 25 updateId: 1
16:40:12:714 Beacon src: 0x7231 ch: 25 updateId: 1
16:40:12:727 Beacon src: 0x25CB ch: 25 updateId: 1
16:40:12:728 Beacon src: 0xB196 ch: 25 updateId: 1
16:40:12:743 APS-DATA.confirm id: 183, status: 0x00 SUCCESS
16:40:12:759 Beacon src: 0x1B14 ch: 25 updateId: 1
16:40:12:791 APS-DATA.indication srcAddr: 0x612F, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 215, rssi: -64
16:40:12:792 asdu: 1f00140a02852c02ffff2e2100343723feff570b003172350102c1852c02ffff2e210094c72e0601881700141b350102b7
16:40:12:792 APS-DATA.indication request id: 183 -> finished
16:40:12:793 APS-DATA.request id: 183 erase from queue
16:40:12:807 Beacon src: 0x7E37 ch: 25 updateId: 1
16:40:12:808 Beacon src: 0xBB69 ch: 25 updateId: 1
16:40:12:808 Beacon src: 0xF91F ch: 25 updateId: 1
16:40:12:808 Beacon src: 0xD079 ch: 25 updateId: 1
16:40:12:809 Beacon src: 0x2EE5 ch: 25 updateId: 1
16:40:12:809 Beacon src: 0x67F5 ch: 25 updateId: 1
16:40:12:809 Beacon src: 0xD804 ch: 25 updateId: 1
16:40:12:809 Beacon src: 0xC387 ch: 25 updateId: 1
16:40:12:810 Beacon src: 0xF440 ch: 25 updateId: 1
16:40:12:810 Beacon src: 0x6AE5 ch: 25 updateId: 1
16:40:12:810 Beacon src: 0xDB48 ch: 25 updateId: 1
16:40:12:810 Beacon src: 0xC20A ch: 25 updateId: 1
16:40:12:823 Beacon src: 0x48C6 ch: 25 updateId: 1
16:40:12:824 Beacon src: 0x782E ch: 25 updateId: 1
16:40:12:824 Beacon src: 0xF867 ch: 25 updateId: 1
16:40:12:824 Beacon src: 0x1D31 ch: 25 updateId: 1
16:40:12:839 Beacon src: 0x25CB ch: 25 updateId: 1
16:40:12:840 Beacon src: 0xB196 ch: 25 updateId: 1
16:40:12:855 Beacon src: 0xA6CD ch: 25 updateId: 1
16:40:12:856 Beacon src: 0x1B8D ch: 25 updateId: 1
16:40:12:856 Beacon src: 0xB792 ch: 25 updateId: 1
16:40:12:856 Beacon src: 0x3395 ch: 25 updateId: 1
16:40:13:383 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x0013, lqi: 143, rssi: -73
16:40:13:384 asdu: aa80036de240feff27718480
16:40:13:384 APS-DATA.indication from unknown node 0x847127FFFE40E26D
16:40:13:385 CTRL create node 0x847127FFFE40E26D, nwk: 0x0380
16:40:13:393 device announce 0x847127FFFE40E26D (0x0380) mac capabilities 0x80
16:40:13:393 set fast probe address to 0x847127FFFE40E26D (0x0380)
16:40:13:394 FP indication 0x0000 / 0x0013 (0x847127FFFE40E26D / 0x0380)
16:40:13:394 ... (0x847127FFFE40E26D / 0x0380)
16:40:13:394 device announce 0x847127FFFE40E26D (0x0380) mac capabilities 0x80
16:40:13:394 DEV Tick.Join: event/device.anounce
16:40:13:395 DEV Tick: fast poll 0x847127FFFE40E26D, mac capabilities: 0x80
16:40:13:402 ZDP get node descriptor for 0x0380
16:40:13:403 APS-DATA.request id: 189, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0002, ep: 0x00 -> 0x00 queue: 0 len: 3 tx.options 0x00
16:40:13:403 asdu (length: 3): 268003
16:40:14:312 [1] get node descriptor for 0x847127fffe40e26d
16:40:14:313 ZDP get node descriptor for 0x0380
16:40:14:313 APS-DATA.request id: 194, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0002, ep: 0x00 -> 0x00 queue: 1 len: 3 tx.options 0x00
16:40:14:314 asdu (length: 3): 278003
16:40:14:375 APS-DATA.confirm id: 194, status: 0x00 SUCCESS
16:40:14:535 APS-DATA.indication srcAddr: 0xB792, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -31
16:40:14:535 asdu: 38060a00001001
16:40:14:536 DJS evaluate()
16:40:14:536 DJS_GetAttributeValue
16:40:14:537 DJS_SetItemVal: state/on --> 1
16:40:14:537 DJS result true, memory peak: 4288 bytes, freed: 3459
16:40:14:537 08:6b:d7:ff:fe:02:14:a6-01/state/on expression: Item.val = Attr.val --> true
16:40:14:538 ZCL attribute report 0x086BD7FFFE0214A6 for cluster: 0x0006, ep: 0x01, frame control: 0x38, mfcode: 0x0000
16:40:14:538 payload: 00001001
16:40:15:398 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8002, lqi: 255, rssi: -46
16:40:15:399 asdu: 270080030240802412525200002c520000
16:40:15:400 DB pushZdpDescriptorDb()
16:40:15:400 DB UPDATE device_descriptors SET data = x'0240802412525200002c520000', timestamp = 1727534415 WHERE device_id = (SELECT id FROM devices WHERE mac = '84:71:27:ff:fe:40:e2:6d') AND endpoint = 0 AND type = 2
16:40:15:401 DB INSERT INTO device_descriptors (device_id, endpoint, type, data, timestamp) SELECT id, 0, 2, x'0240802412525200002c520000', 1727534415 FROM devices WHERE mac = '84:71:27:ff:fe:40:e2:6d'
16:40:15:405 APS-DATA.request id: 201, addrmode: 0x02, addr: 0x0380, profile: 0x0000, cluster: 0x0005, ep: 0x00 -> 0x00 queue: 2 len: 3 tx.options 0x00
16:40:15:406 asdu (length: 3): B18003
16:40:15:406 FP indication 0x0000 / 0x8002 (0x847127FFFE40E26D / 0x0380)
16:40:15:407 ... (0x847127FFFE40E26D / 0x0380)
16:40:15:407 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8002
16:40:15:407 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) clear timeout on cluster 0x8002
16:40:15:407 DEV ZDP node descriptor verified: 0x847127FFFE40E26D
16:40:15:408 ZDP get active endpoints for 0x0380
16:40:15:408 APS-DATA.request id: 202, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0005, ep: 0x00 -> 0x00 queue: 3 len: 3 tx.options 0x00
16:40:15:409 asdu (length: 3): 288003
16:40:15:409 Delay APS request id: 202 to 0x0380, profile: 0x0000 cluster: 0x0005 node already has busy 2
16:40:15:409 Delay APS request id: 202 to 0x0380, profile: 0x0000 cluster: 0x0005 node already has busy 2
16:40:15:419 Delay APS request id: 202 to 0x0380, profile: 0x0000 cluster: 0x0005 node already has busy 2
16:40:15:420 Delay APS request id: 202 to 0x0380, profile: 0x0000 cluster: 0x0005 node already has busy 2
16:40:15:421 Delay APS request id: 202 to 0x0380, profile: 0x0000 cluster: 0x0005 node already has busy 2
16:40:15:421 [2] get active endpoints for 0x847127fffe40e26d
16:40:15:421 ZDP get active endpoints for 0x0380
16:40:15:422 APS-DATA.request id: 204, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0005, ep: 0x00 -> 0x00 queue: 4 len: 3 tx.options 0x00
16:40:15:422 asdu (length: 3): 298003
16:40:15:422 Delay APS request id: 202 to 0x0380, profile: 0x0000 cluster: 0x0005 node already has busy 2
16:40:15:423 Delay APS request id: 204 to 0x0380, profile: 0x0000 cluster: 0x0005 node already has busy 2
16:40:15:446 Delay APS request id: 202 to 0x0380, profile: 0x0000 cluster: 0x0005 node already has busy 2
16:40:15:447 Delay APS request id: 204 to 0x0380, profile: 0x0000 cluster: 0x0005 node already has busy 2
16:40:15:456 aps request id: 194 finished, erase from queue
16:40:15:463 APS-DATA.confirm id: 201, status: 0x00 SUCCESS
16:40:15:465 Delay APS request id: 204 to 0x0380, profile: 0x0000 cluster: 0x0005 node already has busy 2
16:40:15:466 Delay APS request id: 204 to 0x0380, profile: 0x0000 cluster: 0x0005 node already has busy 2
16:40:15:469 Delay APS request id: 204 to 0x0380, profile: 0x0000 cluster: 0x0005 node already has busy 2
16:40:15:494 Delay APS request id: 204 to 0x0380, profile: 0x0000 cluster: 0x0005 node already has busy 2
16:40:15:510 APS-DATA.confirm id: 202, status: 0x00 SUCCESS
16:40:15:574 APS-DATA.confirm id: 204, status: 0x00 SUCCESS
16:40:16:358 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0001, lqi: 151, rssi: -72
16:40:16:359 asdu: 08430a21002064
16:40:16:360 FP indication 0x0104 / 0x0001 (0x847127FFFE40E26D / 0x0380)
16:40:16:360 ... (0x847127FFFE40E26D / 0x0380)
16:40:16:361 ZCL attribute report 0x847127FFFE40E26D for cluster: 0x0001, ep: 0x01, frame control: 0x08, mfcode: 0x0000
16:40:16:361 payload: 21002064
16:40:16:361 APS-DATA.request id: 209, addrmode: 0x02, addr: 0x0380, profile: 0x0104, cluster: 0x0001, ep: 0x01 -> 0x01 queue: 4 len: 5 tx.options 0x04
16:40:16:362 asdu (length: 5): 10430B0A00
16:40:16:422 APS-DATA.confirm id: 209, status: 0x00 SUCCESS
16:40:16:423 APS-DATA.confirm request id: 209 -> erase from queue
16:40:16:486 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8005, lqi: 255, rssi: -46
16:40:16:487 asdu: 280080030401020304
16:40:16:487 APS-DATA.request id: 209 erase from queue
16:40:16:488 FP indication 0x0000 / 0x8005 (0x847127FFFE40E26D / 0x0380)
16:40:16:488 ... (0x847127FFFE40E26D / 0x0380)
16:40:16:488 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8005
16:40:16:489 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) clear timeout on cluster 0x8005
16:40:16:489 DEV ZDP node descriptor verified: 0x847127FFFE40E26D
16:40:16:489 DEV ZDP active endpoints verified: 0x847127FFFE40E26D
16:40:16:490 ZDP get simple descriptor 0x01 for 0x0380
16:40:16:490 APS-DATA.request id: 212, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 4 len: 4 tx.options 0x00
16:40:16:490 asdu (length: 4): 2A800301
16:40:16:498 [3] get simple descriptor 0x01 for 0x847127fffe40e26d
16:40:16:499 ZDP get simple descriptor 0x01 for 0x0380
16:40:16:499 APS-DATA.request id: 213, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 5 len: 4 tx.options 0x00
16:40:16:500 asdu (length: 4): 2B800301
16:40:16:500 Delay APS request id: 213 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:16:501 aps request id: 202 finished, erase from queue
16:40:16:505 Delay APS request id: 213 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:16:538 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8005, lqi: 255, rssi: -46
16:40:16:539 asdu: 290080030401020304
16:40:16:539 FP indication 0x0000 / 0x8005 (0x847127FFFE40E26D / 0x0380)
16:40:16:540 ... (0x847127FFFE40E26D / 0x0380)
16:40:16:540 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8005
16:40:16:540 Delay APS request id: 213 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:16:544 Delay APS request id: 213 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:16:547 wait response fastEnddeviceProbe() 0x847127FFFE40E26D, elapsed 46 ms
16:40:16:577 aps request id: 204 finished, erase from queue
16:40:16:582 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8005, lqi: 255, rssi: -46
16:40:16:583 asdu: b10080030401020304
16:40:16:583 APS-DATA.indication request id: 201 -> finished
16:40:16:583 APS-DATA.request id: 201 erase from queue
16:40:16:584 FP indication 0x0000 / 0x8005 (0x847127FFFE40E26D / 0x0380)
16:40:16:584 ... (0x847127FFFE40E26D / 0x0380)
16:40:16:584 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8005
16:40:16:585 Delay APS request id: 213 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:16:585 APS-DATA.confirm id: 212, status: 0x00 SUCCESS
16:40:16:590 wait response fastEnddeviceProbe() 0x847127FFFE40E26D, elapsed 89 ms
16:40:16:646 APS-DATA.confirm id: 213, status: 0x00 SUCCESS
16:40:17:446 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 255, rssi: -46
16:40:17:446 asdu: 2a0080032201040101000105000001000300050b00100803000400050006000800190000030010
16:40:17:447 APS-DATA.indication request id: 212 -> finished
16:40:17:447 APS-DATA.request id: 212 erase from queue
16:40:17:448 copy Power Configuration cluster data
16:40:17:450 DB pushZdpDescriptorDb()
16:40:17:451 DB UPDATE device_descriptors SET data = x'01040101000105000001000300050b00100803000400050006000800190000030010', timestamp = 1727534417 WHERE device_id = (SELECT id FROM devices WHERE mac = '84:71:27:ff:fe:40:e2:6d') AND endpoint = 1 AND type = 4
16:40:17:451 DB INSERT INTO device_descriptors (device_id, endpoint, type, data, timestamp) SELECT id, 1, 4, x'01040101000105000001000300050b00100803000400050006000800190000030010', 1727534417 FROM devices WHERE mac = '84:71:27:ff:fe:40:e2:6d'
16:40:17:460 FP indication 0x0000 / 0x8004 (0x847127FFFE40E26D / 0x0380)
16:40:17:460 ... (0x847127FFFE40E26D / 0x0380)
16:40:17:461 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8004
16:40:17:461 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) clear timeout on cluster 0x8004
16:40:17:461 DEV ZDP node descriptor verified: 0x847127FFFE40E26D
16:40:17:461 DEV ZDP active endpoints verified: 0x847127FFFE40E26D
16:40:17:462 ZDP get simple descriptor 0x02 for 0x0380
16:40:17:462 APS-DATA.request id: 221, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 2 len: 4 tx.options 0x00
16:40:17:462 asdu (length: 4): 2C800302
16:40:17:473 [3] get simple descriptor 0x02 for 0x847127fffe40e26d
16:40:17:474 ZDP get simple descriptor 0x02 for 0x0380
16:40:17:474 APS-DATA.request id: 222, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 3 len: 4 tx.options 0x00
16:40:17:475 asdu (length: 4): 2D800302
16:40:17:475 Delay APS request id: 222 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:17:479 Delay APS request id: 222 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:17:526 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 255, rssi: -46
16:40:17:526 asdu: 2b0080032201040101000105000001000300050b00100803000400050006000800190000030010
16:40:17:527 APS-DATA.indication request id: 213 -> finished
16:40:17:527 APS-DATA.request id: 213 erase from queue
16:40:17:528 DB pushZdpDescriptorDb()
16:40:17:529 FP indication 0x0000 / 0x8004 (0x847127FFFE40E26D / 0x0380)
16:40:17:529 ... (0x847127FFFE40E26D / 0x0380)
16:40:17:529 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8004
16:40:17:530 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) clear timeout on cluster 0x8004
16:40:17:530 DEV ZDP node descriptor verified: 0x847127FFFE40E26D
16:40:17:530 DEV ZDP active endpoints verified: 0x847127FFFE40E26D
16:40:17:531 ZDP get simple descriptor 0x02 for 0x0380
16:40:17:531 APS-DATA.request id: 224, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 3 len: 4 tx.options 0x00
16:40:17:531 asdu (length: 4): 2E800302
16:40:17:532 Delay APS request id: 222 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:17:532 Delay APS request id: 224 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:17:532 Delay APS request id: 222 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:17:533 Delay APS request id: 224 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:17:540 [3] get simple descriptor 0x02 for 0x847127fffe40e26d
16:40:17:541 ZDP get simple descriptor 0x02 for 0x0380
16:40:17:541 reject aps request to enddevice node queue is full (4)
16:40:17:545 Delay APS request id: 222 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:17:546 Delay APS request id: 224 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:17:558 APS-DATA.confirm id: 221, status: 0x00 SUCCESS
16:40:17:561 Delay APS request id: 224 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:17:562 Delay APS request id: 224 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:17:570 Delay APS request id: 224 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:17:590 Delay APS request id: 224 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:17:606 APS-DATA.confirm id: 222, status: 0x00 SUCCESS
16:40:17:654 APS-DATA.confirm id: 224, status: 0x00 SUCCESS
16:40:18:405 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 255, rssi: -46
16:40:18:407 asdu: 2c0080032202040101000105000001000300050b00100803000400050006000800190000030010
16:40:18:407 APS-DATA.indication request id: 221 -> finished
16:40:18:408 APS-DATA.request id: 221 erase from queue
16:40:18:418 DB pushZdpDescriptorDb()
16:40:18:419 DB UPDATE device_descriptors SET data = x'02040101000105000001000300050b00100803000400050006000800190000030010', timestamp = 1727534418 WHERE device_id = (SELECT id FROM devices WHERE mac = '84:71:27:ff:fe:40:e2:6d') AND endpoint = 2 AND type = 4
16:40:18:421 DB INSERT INTO device_descriptors (device_id, endpoint, type, data, timestamp) SELECT id, 2, 4, x'02040101000105000001000300050b00100803000400050006000800190000030010', 1727534418 FROM devices WHERE mac = '84:71:27:ff:fe:40:e2:6d'
16:40:18:428 FP indication 0x0000 / 0x8004 (0x847127FFFE40E26D / 0x0380)
16:40:18:430 ... (0x847127FFFE40E26D / 0x0380)
16:40:18:430 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8004
16:40:18:431 DEV ZDP node descriptor verified: 0x847127FFFE40E26D
16:40:18:432 DEV ZDP active endpoints verified: 0x847127FFFE40E26D
16:40:18:433 ZDP get simple descriptor 0x03 for 0x0380
16:40:18:433 APS-DATA.request id: 230, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 3 len: 4 tx.options 0x00
16:40:18:434 asdu (length: 4): 30800303
16:40:18:455 Daylight now: solarNoon, status: 170, daylight: 1, dark: 0
16:40:18:457 [3] get simple descriptor 0x03 for 0x847127fffe40e26d
16:40:18:458 ZDP get simple descriptor 0x03 for 0x0380
16:40:18:459 APS-DATA.request id: 232, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 4 len: 4 tx.options 0x00
16:40:18:460 asdu (length: 4): 31800303
16:40:18:461 Delay APS request id: 232 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:465 Delay APS request id: 232 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:501 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 255, rssi: -46
16:40:18:502 asdu: 2d0080032202040101000105000001000300050b00100803000400050006000800190000030010
16:40:18:502 APS-DATA.indication request id: 222 -> finished
16:40:18:503 APS-DATA.request id: 222 erase from queue
16:40:18:504 DB pushZdpDescriptorDb()
16:40:18:505 FP indication 0x0000 / 0x8004 (0x847127FFFE40E26D / 0x0380)
16:40:18:505 ... (0x847127FFFE40E26D / 0x0380)
16:40:18:505 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8004
16:40:18:506 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) clear timeout on cluster 0x8004
16:40:18:506 DEV ZDP node descriptor verified: 0x847127FFFE40E26D
16:40:18:506 DEV ZDP active endpoints verified: 0x847127FFFE40E26D
16:40:18:507 ZDP get simple descriptor 0x03 for 0x0380
16:40:18:507 APS-DATA.request id: 234, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 4 len: 4 tx.options 0x00
16:40:18:507 asdu (length: 4): 32800303
16:40:18:508 Delay APS request id: 232 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:508 Delay APS request id: 234 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:508 Delay APS request id: 232 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:509 Delay APS request id: 234 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:516 Delay APS request id: 232 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:517 Delay APS request id: 234 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:518 [3] get simple descriptor 0x03 for 0x847127fffe40e26d
16:40:18:518 ZDP get simple descriptor 0x03 for 0x0380
16:40:18:518 reject aps request to enddevice node queue is full (4)
16:40:18:549 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 255, rssi: -46
16:40:18:550 asdu: 2e0080032202040101000105000001000300050b00100803000400050006000800190000030010
16:40:18:550 APS-DATA.indication request id: 224 -> finished
16:40:18:551 APS-DATA.request id: 224 erase from queue
16:40:18:552 DB pushZdpDescriptorDb()
16:40:18:552 FP indication 0x0000 / 0x8004 (0x847127FFFE40E26D / 0x0380)
16:40:18:553 ... (0x847127FFFE40E26D / 0x0380)
16:40:18:553 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8004
16:40:18:553 DEV ZDP node descriptor verified: 0x847127FFFE40E26D
16:40:18:554 DEV ZDP active endpoints verified: 0x847127FFFE40E26D
16:40:18:554 ZDP get simple descriptor 0x03 for 0x0380
16:40:18:554 reject aps request to enddevice node queue is full (4)
16:40:18:555 Delay APS request id: 232 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:555 Delay APS request id: 234 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:561 [3] get simple descriptor 0x03 for 0x847127fffe40e26d
16:40:18:562 ZDP get simple descriptor 0x03 for 0x0380
16:40:18:562 reject aps request to enddevice node queue is full (4)
16:40:18:565 Delay APS request id: 232 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:566 Delay APS request id: 234 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:567 APS-DATA.confirm id: 230, status: 0x00 SUCCESS
16:40:18:570 Delay APS request id: 234 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:571 Delay APS request id: 234 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:613 Delay APS request id: 234 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:616 Delay APS request id: 234 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:18:629 APS-DATA.confirm id: 232, status: 0x00 SUCCESS
16:40:18:677 APS-DATA.confirm id: 234, status: 0x00 SUCCESS
16:40:18:932 DEV ZDP node descriptor verified: 0x847127FFFE40E26D
16:40:18:932 DEV ZDP active endpoints verified: 0x847127FFFE40E26D
16:40:18:933 ZDP get simple descriptor 0x03 for 0x0380
16:40:18:933 APS-DATA.request id: 241, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 4 len: 4 tx.options 0x00
16:40:18:933 asdu (length: 4): 36800303
16:40:18:981 APS-DATA.confirm id: 241, status: 0x00 SUCCESS
16:40:19:404 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 255, rssi: -46
16:40:19:405 asdu: 310080032203040101000105000001000300050b00100803000400050006000800190000030010
16:40:19:411 DB pushZdpDescriptorDb()
16:40:19:412 DB UPDATE device_descriptors SET data = x'03040101000105000001000300050b00100803000400050006000800190000030010', timestamp = 1727534419 WHERE device_id = (SELECT id FROM devices WHERE mac = '84:71:27:ff:fe:40:e2:6d') AND endpoint = 3 AND type = 4
16:40:19:413 DB INSERT INTO device_descriptors (device_id, endpoint, type, data, timestamp) SELECT id, 3, 4, x'03040101000105000001000300050b00100803000400050006000800190000030010', 1727534419 FROM devices WHERE mac = '84:71:27:ff:fe:40:e2:6d'
16:40:19:417 FP indication 0x0000 / 0x8004 (0x847127FFFE40E26D / 0x0380)
16:40:19:418 ... (0x847127FFFE40E26D / 0x0380)
16:40:19:418 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8004
16:40:19:419 DEV ZDP node descriptor verified: 0x847127FFFE40E26D
16:40:19:419 DEV ZDP active endpoints verified: 0x847127FFFE40E26D
16:40:19:419 ZDP get simple descriptor 0x04 for 0x0380
16:40:19:420 APS-DATA.request id: 244, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 5 len: 4 tx.options 0x00
16:40:19:420 asdu (length: 4): 37800304
16:40:19:431 [3] get simple descriptor 0x04 for 0x847127fffe40e26d
16:40:19:432 ZDP get simple descriptor 0x04 for 0x0380
16:40:19:432 APS-DATA.request id: 246, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 6 len: 4 tx.options 0x00
16:40:19:433 asdu (length: 4): 38800304
16:40:19:433 Delay APS request id: 246 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:456 aps request id: 232 finished, erase from queue
16:40:19:493 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 255, rssi: -46
16:40:19:494 asdu: 320080032203040101000105000001000300050b00100803000400050006000800190000030010
16:40:19:495 DB pushZdpDescriptorDb()
16:40:19:496 FP indication 0x0000 / 0x8004 (0x847127FFFE40E26D / 0x0380)
16:40:19:496 ... (0x847127FFFE40E26D / 0x0380)
16:40:19:496 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8004
16:40:19:497 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) clear timeout on cluster 0x8004
16:40:19:497 DEV ZDP node descriptor verified: 0x847127FFFE40E26D
16:40:19:497 DEV ZDP active endpoints verified: 0x847127FFFE40E26D
16:40:19:498 ZDP get simple descriptor 0x04 for 0x0380
16:40:19:498 APS-DATA.request id: 248, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 6 len: 4 tx.options 0x00
16:40:19:498 asdu (length: 4): 39800304
16:40:19:499 Delay APS request id: 246 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:499 Delay APS request id: 248 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:499 Delay APS request id: 246 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:499 Delay APS request id: 248 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:506 [3] get simple descriptor 0x04 for 0x847127fffe40e26d
16:40:19:507 ZDP get simple descriptor 0x04 for 0x0380
16:40:19:507 reject aps request to enddevice node queue is full (4)
16:40:19:511 APS-DATA.confirm id: 244, status: 0x00 SUCCESS
16:40:19:517 Delay APS request id: 248 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:536 aps request id: 234 finished, erase from queue
16:40:19:573 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 255, rssi: -46
16:40:19:574 asdu: 300080032203040101000105000001000300050b00100803000400050006000800190000030010
16:40:19:574 APS-DATA.indication request id: 230 -> finished
16:40:19:574 APS-DATA.request id: 230 erase from queue
16:40:19:575 DB pushZdpDescriptorDb()
16:40:19:576 FP indication 0x0000 / 0x8004 (0x847127FFFE40E26D / 0x0380)
16:40:19:577 ... (0x847127FFFE40E26D / 0x0380)
16:40:19:577 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8004
16:40:19:577 DEV ZDP node descriptor verified: 0x847127FFFE40E26D
16:40:19:577 DEV ZDP active endpoints verified: 0x847127FFFE40E26D
16:40:19:578 ZDP get simple descriptor 0x04 for 0x0380
16:40:19:578 APS-DATA.request id: 251, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 5 len: 4 tx.options 0x00
16:40:19:578 asdu (length: 4): 3B800304
16:40:19:579 Delay APS request id: 248 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:579 Delay APS request id: 251 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:579 Delay APS request id: 248 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:580 Delay APS request id: 251 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:587 Delay APS request id: 248 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:587 Delay APS request id: 251 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:588 Delay APS request id: 248 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:588 Delay APS request id: 251 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:589 [3] get simple descriptor 0x04 for 0x847127fffe40e26d
16:40:19:589 ZDP get simple descriptor 0x04 for 0x0380
16:40:19:590 reject aps request to enddevice node queue is full (4)
16:40:19:621 APS-DATA.confirm id: 246, status: 0x00 SUCCESS
16:40:19:637 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 255, rssi: -46
16:40:19:638 asdu: 360080032203040101000105000001000300050b00100803000400050006000800190000030010
16:40:19:638 APS-DATA.indication request id: 241 -> finished
16:40:19:638 APS-DATA.request id: 241 erase from queue
16:40:19:639 DB pushZdpDescriptorDb()
16:40:19:640 FP indication 0x0000 / 0x8004 (0x847127FFFE40E26D / 0x0380)
16:40:19:641 ... (0x847127FFFE40E26D / 0x0380)
16:40:19:641 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8004
16:40:19:641 DEV ZDP node descriptor verified: 0x847127FFFE40E26D
16:40:19:642 DEV ZDP active endpoints verified: 0x847127FFFE40E26D
16:40:19:642 ZDP get simple descriptor 0x04 for 0x0380
16:40:19:642 APS-DATA.request id: 254, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0000, cluster: 0x0004, ep: 0x00 -> 0x00 queue: 5 len: 4 tx.options 0x00
16:40:19:643 asdu (length: 4): 3D800304
16:40:19:643 Delay APS request id: 251 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:643 Delay APS request id: 254 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:644 Delay APS request id: 251 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:644 Delay APS request id: 254 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:651 Delay APS request id: 251 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:652 Delay APS request id: 254 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:652 Delay APS request id: 251 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:653 Delay APS request id: 254 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:653 Delay APS request id: 251 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:654 Delay APS request id: 254 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:654 [3] get simple descriptor 0x04 for 0x847127fffe40e26d
16:40:19:654 ZDP get simple descriptor 0x04 for 0x0380
16:40:19:655 reject aps request to enddevice node queue is full (4)
16:40:19:685 Delay APS request id: 251 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:686 Delay APS request id: 254 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:701 APS-DATA.confirm id: 248, status: 0x00 SUCCESS
16:40:19:704 Delay APS request id: 254 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:704 Delay APS request id: 254 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:707 Delay APS request id: 254 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:733 Delay APS request id: 254 to 0x0380, profile: 0x0000 cluster: 0x0004 node already has busy 2
16:40:19:749 APS-DATA.confirm id: 251, status: 0x00 SUCCESS
16:40:19:797 APS-DATA.confirm id: 254, status: 0x00 SUCCESS
16:40:20:437 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 255, rssi: -46
16:40:20:437 asdu: 380080032204040101000105000001000300050b00100803000400050006000800190000030010
16:40:20:445 DB pushZdpDescriptorDb()
16:40:20:446 DB UPDATE device_descriptors SET data = x'04040101000105000001000300050b00100803000400050006000800190000030010', timestamp = 1727534420 WHERE device_id = (SELECT id FROM devices WHERE mac = '84:71:27:ff:fe:40:e2:6d') AND endpoint = 4 AND type = 4
16:40:20:446 DB INSERT INTO device_descriptors (device_id, endpoint, type, data, timestamp) SELECT id, 4, 4, x'04040101000105000001000300050b00100803000400050006000800190000030010', 1727534420 FROM devices WHERE mac = '84:71:27:ff:fe:40:e2:6d'
16:40:20:452 FP indication 0x0000 / 0x8004 (0x847127FFFE40E26D / 0x0380)
16:40:20:452 ... (0x847127FFFE40E26D / 0x0380)
16:40:20:453 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8004
16:40:20:453 DEV ZDP node descriptor verified: 0x847127FFFE40E26D
16:40:20:453 DEV ZDP active endpoints verified: 0x847127FFFE40E26D
16:40:20:453 DEV ZDP simple descriptors verified: 0x847127FFFE40E26D
16:40:20:454 APS-DATA.request id: 4, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0104, cluster: 0x0000, ep: 0x01 -> 0x01 queue: 6 len: 5 tx.options 0x00
16:40:20:454 asdu (length: 5): 10B2000400
16:40:20:466 [4.1] Get manufacturer code
16:40:20:497 aps request id: 246 finished, erase from queue
16:40:20:517 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 255, rssi: -46
16:40:20:517 asdu: 390080032204040101000105000001000300050b00100803000400050006000800190000030010
16:40:20:518 DB pushZdpDescriptorDb()
16:40:20:519 FP indication 0x0000 / 0x8004 (0x847127FFFE40E26D / 0x0380)
16:40:20:520 ... (0x847127FFFE40E26D / 0x0380)
16:40:20:520 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8004
16:40:20:526 [4.1] Get manufacturer code
16:40:20:565 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 255, rssi: -46
16:40:20:565 asdu: 3b0080032204040101000105000001000300050b00100803000400050006000800190000030010
16:40:20:566 APS-DATA.request id: 248 erase from queue
16:40:20:567 DB pushZdpDescriptorDb()
16:40:20:568 FP indication 0x0000 / 0x8004 (0x847127FFFE40E26D / 0x0380)
16:40:20:568 ... (0x847127FFFE40E26D / 0x0380)
16:40:20:568 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8004
16:40:20:575 [4.1] Get manufacturer code
16:40:20:578 aps request id: 251 finished, erase from queue
16:40:20:581 APS-DATA.confirm id: 4, status: 0x00 SUCCESS
16:40:20:581 APS-DATA.confirm request id: 4 -> erase from queue
16:40:20:613 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8004, lqi: 255, rssi: -46
16:40:20:613 asdu: 3d0080032204040101000105000001000300050b00100803000400050006000800190000030010
16:40:20:614 APS-DATA.request id: 4 erase from queue
16:40:20:615 DB pushZdpDescriptorDb()
16:40:20:615 FP indication 0x0000 / 0x8004 (0x847127FFFE40E26D / 0x0380)
16:40:20:616 ... (0x847127FFFE40E26D / 0x0380)
16:40:20:616 ZDP indication search sensors 0x847127FFFE40E26D (0x0380) cluster 0x8004
16:40:20:623 [4.1] Get manufacturer code
16:40:20:657 aps request id: 254 finished, erase from queue
16:40:20:964 APS-DATA.indication srcAddr: 0x67A3, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -58
16:40:20:965 asdu: 387c0a00001001
16:40:20:966 DJS evaluate()
16:40:20:966 DJS_GetAttributeValue
16:40:20:967 DJS_SetItemVal: state/on --> 1
16:40:20:967 DJS result true, memory peak: 4288 bytes, freed: 3459
16:40:20:967 00:0b:57:ff:fe:ef:bb:4a-01/state/on expression: Item.val = Attr.val --> true
16:40:20:967 ZCL attribute report 0x000B57FFFEEFBB4A for cluster: 0x0006, ep: 0x01, frame control: 0x38, mfcode: 0x0000
16:40:20:968 payload: 00001001
16:40:20:969 Websocket 192.168.1.5:58830 send message: {"attr":{"colorcapabilities":16,"ctmax":454,"ctmin":250,"id":"13","lastannounced":null,"lastseen":"2024-09-28T14:40Z","manufacturername":"IKEA of Sweden","modelid":"TRADFRI bulb E27 WS opal 980lm","name":"Trumpet1-1","productid":"LED1545G12E27EU","swversion":"2.3.087","type":"Color temperature light","uniqueid":"00:0b:57:ff:fe:ef:bb:4a-01"},"e":"changed","id":"13","r":"lights","t":"event","uniqueid":"00:0b:57:ff:fe:ef:bb:4a-01"} (ret = -6376384)
16:40:20:969 Websocket 192.168.1.6:44698 send message: {"attr":{"colorcapabilities":16,"ctmax":454,"ctmin":250,"id":"13","lastannounced":null,"lastseen":"2024-09-28T14:40Z","manufacturername":"IKEA of Sweden","modelid":"TRADFRI bulb E27 WS opal 980lm","name":"Trumpet1-1","productid":"LED1545G12E27EU","swversion":"2.3.087","type":"Color temperature light","uniqueid":"00:0b:57:ff:fe:ef:bb:4a-01"},"e":"changed","id":"13","r":"lights","t":"event","uniqueid":"00:0b:57:ff:fe:ef:bb:4a-01"} (ret = -6376384)
16:40:21:012 APS-DATA.indication srcAddr: 0x1D31, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -48
16:40:21:013 asdu: 380b0a00001001
16:40:21:014 DJS evaluate()
16:40:21:015 DJS_GetAttributeValue
16:40:21:015 DJS_SetItemVal: state/on --> 1
16:40:21:015 DJS result true, memory peak: 4288 bytes, freed: 3459
16:40:21:015 90:fd:9f:ff:fe:07:b8:33-01/state/on expression: Item.val = Attr.val --> true
16:40:21:016 ZCL attribute report 0x90FD9FFFFE07B833 for cluster: 0x0006, ep: 0x01, frame control: 0x38, mfcode: 0x0000
16:40:21:016 payload: 00001001
16:40:21:017 Websocket 192.168.1.5:58830 send message: {"attr":{"colorcapabilities":16,"ctmax":454,"ctmin":250,"id":"15","lastannounced":null,"lastseen":"2024-09-28T14:40Z","manufacturername":"IKEA of Sweden","modelid":"TRADFRI bulb E27 WS opal 980lm","name":"Trumpet1-3","productid":"LED1545G12E27EU","swversion":"2.3.087","type":"Color temperature light","uniqueid":"90:fd:9f:ff:fe:07:b8:33-01"},"e":"changed","id":"15","r":"lights","t":"event","uniqueid":"90:fd:9f:ff:fe:07:b8:33-01"} (ret = -6376384)
16:40:21:018 Websocket 192.168.1.6:44698 send message: {"attr":{"colorcapabilities":16,"ctmax":454,"ctmin":250,"id":"15","lastannounced":null,"lastseen":"2024-09-28T14:40Z","manufacturername":"IKEA of Sweden","modelid":"TRADFRI bulb E27 WS opal 980lm","name":"Trumpet1-3","productid":"LED1545G12E27EU","swversion":"2.3.087","type":"Color temperature light","uniqueid":"90:fd:9f:ff:fe:07:b8:33-01"},"e":"changed","id":"15","r":"lights","t":"event","uniqueid":"90:fd:9f:ff:fe:07:b8:33-01"} (ret = -6376384)
16:40:21:060 APS-DATA.indication srcAddr: 0xA6CD, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -47
16:40:21:061 asdu: 38730a00001001
16:40:21:062 DJS evaluate()
16:40:21:063 DJS_GetAttributeValue
16:40:21:063 DJS_SetItemVal: state/on --> 1
16:40:21:063 DJS result true, memory peak: 4288 bytes, freed: 3459
16:40:21:064 90:fd:9f:ff:fe:08:3d:b1-01/state/on expression: Item.val = Attr.val --> true
16:40:21:064 ZCL attribute report 0x90FD9FFFFE083DB1 for cluster: 0x0006, ep: 0x01, frame control: 0x38, mfcode: 0x0000
16:40:21:064 payload: 00001001
16:40:21:065 Websocket 192.168.1.5:58830 send message: {"attr":{"colorcapabilities":16,"ctmax":454,"ctmin":250,"id":"14","lastannounced":null,"lastseen":"2024-09-28T14:40Z","manufacturername":"IKEA of Sweden","modelid":"TRADFRI bulb E27 WS opal 980lm","name":"Trumpet1-2","productid":"LED1545G12E27EU","swversion":"2.3.087","type":"Color temperature light","uniqueid":"90:fd:9f:ff:fe:08:3d:b1-01"},"e":"changed","id":"14","r":"lights","t":"event","uniqueid":"90:fd:9f:ff:fe:08:3d:b1-01"} (ret = -6376384)
16:40:21:066 Websocket 192.168.1.6:44698 send message: {"attr":{"colorcapabilities":16,"ctmax":454,"ctmin":250,"id":"14","lastannounced":null,"lastseen":"2024-09-28T14:40Z","manufacturername":"IKEA of Sweden","modelid":"TRADFRI bulb E27 WS opal 980lm","name":"Trumpet1-2","productid":"LED1545G12E27EU","swversion":"2.3.087","type":"Color temperature light","uniqueid":"90:fd:9f:ff:fe:08:3d:b1-01"},"e":"changed","id":"14","r":"lights","t":"event","uniqueid":"90:fd:9f:ff:fe:08:3d:b1-01"} (ret = -6376384)
16:40:21:380 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0000, lqi: 255, rssi: -46
16:40:21:381 asdu: 08b20104000042094e414d524f4e204153
16:40:21:382 DJS evaluate()
16:40:21:382 DJS_GetAttributeValue
16:40:21:383 DJS_SetItemVal: attr/manufacturername --> NAMRON AS
16:40:21:383 DJS result NAMRON AS, memory peak: 4342 bytes, freed: 3459
16:40:21:383 84:71:27:ff:fe:40:e2:6d/attr/manufacturername expression: Item.val = Attr.val --> NAMRON AS
16:40:21:384 FP indication 0x0104 / 0x0000 (0x847127FFFE40E26D / 0x0380)
16:40:21:384 ... (0x847127FFFE40E26D / 0x0380)
16:40:21:384 DEV received attr/manufacturername: 0x847127FFFE40E26D
16:40:21:385 DEV ZDP node descriptor verified: 0x847127FFFE40E26D
16:40:21:385 DEV ZDP active endpoints verified: 0x847127FFFE40E26D
16:40:21:385 DEV ZDP simple descriptors verified: 0x847127FFFE40E26D
16:40:21:385 APS-DATA.request id: 19, addrmode: 0x03, addr: 0x847127FFFE40E26D, profile: 0x0104, cluster: 0x0000, ep: 0x01 -> 0x01 queue: 2 len: 5 tx.options 0x00
16:40:21:386 asdu (length: 5): 10B7000500
16:40:21:386 APS-DATA.request id: 20, addrmode: 0x02, addr: 0x0380, profile: 0x0104, cluster: 0x0000, ep: 0x01 -> 0x01 queue: 3 len: 5 tx.options 0x04
16:40:21:386 asdu (length: 5): 10B20B0100
16:40:21:395 [4.1] Get model ID
16:40:21:477 APS-DATA.confirm id: 19, status: 0x00 SUCCESS
16:40:21:477 APS-DATA.confirm request id: 19 -> erase from queue
16:40:21:492 APS-DATA.confirm id: 20, status: 0x00 SUCCESS
16:40:21:493 APS-DATA.confirm request id: 20 -> erase from queue
16:40:21:536 aps request id: 19 finished, erase from queue
16:40:21:616 aps request id: 20 finished, erase from queue
16:40:22:404 APS-DATA.indication srcAddr: 0x0380, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0000, lqi: 255, rssi: -46
16:40:22:405 asdu: 08b701050000420734353132373033
16:40:22:405 DJS evaluate()
16:40:22:406 DJS_GetAttributeValue
16:40:22:406 DJS_SetItemVal: attr/modelid --> 4512703
16:40:22:406 DJS result 4512703, memory peak: 4340 bytes, freed: 3459
16:40:22:407 84:71:27:ff:fe:40:e2:6d/attr/modelid expression: Item.val = Attr.val --> 4512703
16:40:22:407 FP indication 0x0104 / 0x0000 (0x847127FFFE40E26D / 0x0380)

Additional context

A similar switch added a year ago works fine, but no DDF mark on the icon.

[SwoopX]

Could you please try amending the respective entry for the model to use your manufacturername, so that is is all capital letters? There was a recent fix which should have restored case insensitivity on the manufacturername, but maybe it does not work as expected.

However, before you do that, please make sure to delete that device with a right click -> delete node and try to pair it again if it was previously paired and working .

[olemr]

Could you please try amending the respective entry for the model to use your manufacturername, so that is is all capital letters?

I'm not sure which entry and where you mean here?

Ah, got it ... in /usr/share/deCONZ/devices/sunricher/8button_switch.json

Will try in a few hours ...

[olemr]

That did the trick!
It would be helpful if the DDF/DEV log entries were a bit more talkative as to which DDF .json file it was picking up, and the result of the file parsing.
Do you want me to make a PR for the uppercase entries, or du you want to hunt down the case insensitivity yourself? (Beyond me ..)

[SwoopX]

Hi,

Many thanks for checking and sharing feedback. Actually, I'd tend to take this as a confirmation of a bug, that case insensitivity is not given.

Regardless, good that it works out for you right now.

[olemr]

@SwoopX did a fix make it to 2.29.0?
Didn't find it in the Changelog ...

[SwoopX]

Thanks for following up. No, I'm afraid that has drowned a bit. I'll make a quick bug report later, so this matter is not disguised anymore and close/reference this issue.

In the meantime, you may update the version to your liking but if you do, do not forget to make the necessary amendments for the affected device.

[SwoopX]

Closing in favor of #7965