Unable to pair Aqara WSDCGQ11LM

cypres422 · May 9, 2022, 4:43pm

I’m trying to pair my first zigbee devices using Conbee II USB stick.
Here is my setup:

RPI 4B 8G, POE HAT and booting from SSD.
Home Assistant OS: 2022.5.3 (Latest)
HA Supervisor: 2022.05.0
Conbee 2 SW: 2.15.3
Conbee 2 FW: 26720700
Integration: deCONZ 6.13.0. using hostname “core-deconz” instead of ip.
Using a 12 inches USB 3.0 cable extender, plugged into a USB2.0 port on the RPI
4x Aqara Temp/Humidity sensors: WSDCGQ11LM

I tried with and without the extension cable and always the same result. No device discovered.
During the 3m discovery time, I started by putting a sensor in pairing mode, then quickly press the set button every ~5 sec… no results.
I found one similar topic that fixes by itself while looking at the logs… It doesn’t work for me…

Mimiix · May 9, 2022, 5:19pm

Hi

Can you share some logs while pairing? In #deconz you can find out how to make logs.

cypres422 · May 9, 2022, 5:44pm

Here is the first 90 seconds of my last attemp

12:18:27:998 New websocket 127.0.0.1:57182 (state: 3) 
12:18:28:217 APS-DATA.request id: 81, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:18:28:218 	asdu (length: 2): 4b00
12:18:28:238 APS-DATA.confirm id: 81, status: 0x00 SUCCESS
12:18:28:239 APS-DATA.confirm request id: 81 -> confirmed, timeout 961766
12:18:28:277 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 0, rssi: 0
12:18:28:278 	asdu: 4b00000000
12:18:28:278 APS-DATA.indication request id: 81 -> finished
12:18:28:278 APS-DATA.request id: 81 erase from queue
12:18:28:279 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:18:30:013 Websocket disconnected 127.0.0.1:57182, state: 0, close-code: 1000, reason: 
12:18:30:617 APS-DATA.request id: 92, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:18:30:619 	asdu (length: 2): 4c00
12:18:30:640 APS-DATA.confirm id: 92, status: 0x00 SUCCESS
12:18:30:640 APS-DATA.confirm request id: 92 -> confirmed, timeout 964167
12:18:30:674 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:18:30:674 	asdu: 4c00000000
12:18:30:675 APS-DATA.indication request id: 92 -> finished
12:18:30:675 APS-DATA.request id: 92 erase from queue
12:18:30:675 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:18:31:106 New websocket 127.0.0.1:57198 (state: 3) 
12:18:33:017 APS-DATA.request id: 104, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:18:33:018 	asdu (length: 2): 4d00
12:18:33:037 APS-DATA.confirm id: 104, status: 0x00 SUCCESS
12:18:33:038 APS-DATA.confirm request id: 104 -> confirmed, timeout 966566
12:18:33:077 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:18:33:078 	asdu: 4d00000000
12:18:33:078 APS-DATA.indication request id: 104 -> finished
12:18:33:078 APS-DATA.request id: 104 erase from queue
12:18:33:078 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:18:35:417 APS-DATA.request id: 115, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:18:35:419 	asdu (length: 2): 4e00
12:18:35:438 APS-DATA.confirm id: 115, status: 0x00 SUCCESS
12:18:35:439 APS-DATA.confirm request id: 115 -> confirmed, timeout 968967
12:18:35:479 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:18:35:480 	asdu: 4e00000000
12:18:35:480 APS-DATA.indication request id: 115 -> finished
12:18:35:480 APS-DATA.request id: 115 erase from queue
12:18:35:481 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:18:36:454 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:18:36:455 APS-DATA.request id: 121, addrmode: 0x02, addr: 0xfffc, profile: 0x0000, cluster: 0x0036, ep: 0x00 -> 0x00 queue: 0 len: 3 tx.options 0x00
12:18:36:456 	asdu (length: 3): 004101
12:18:36:457 send permit join, duration: 65
12:18:36:458 APS-DATA.request id: 122, addrmode: 0x02, addr: 0xfffc, profile: 0xA1E0, cluster: 0x0021, ep: 0xF2 -> 0xF2 queue: 1 len: 6 tx.options 0x00
12:18:36:459 	asdu (length: 6): 1900020b2800
12:18:36:582 APS-DATA.confirm id: 121, status: 0xE1 
12:18:36:623 APS-DATA.confirm id: 122, status: 0xE1 
12:18:37:817 APS-DATA.request id: 129, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:18:37:819 	asdu (length: 2): 4f00
12:18:37:840 APS-DATA.confirm id: 129, status: 0x00 SUCCESS
12:18:37:841 APS-DATA.confirm request id: 129 -> confirmed, timeout 971367
12:18:37:879 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:18:37:879 	asdu: 4f00000000
12:18:37:879 APS-DATA.indication request id: 129 -> finished
12:18:37:880 APS-DATA.request id: 129 erase from queue
12:18:37:880 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:18:40:217 APS-DATA.request id: 141, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:18:40:219 	asdu (length: 2): 5000
12:18:40:238 APS-DATA.confirm id: 141, status: 0x00 SUCCESS
12:18:40:239 APS-DATA.confirm request id: 141 -> confirmed, timeout 973767
12:18:40:276 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:18:40:277 	asdu: 5000000000
12:18:40:277 APS-DATA.indication request id: 141 -> finished
12:18:40:278 APS-DATA.request id: 141 erase from queue
12:18:40:279 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:18:40:291 Websocket 127.0.0.1:57136 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-09T16:18Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
12:18:40:292 Websocket 127.0.0.1:57198 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-09T16:18Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
12:18:42:617 APS-DATA.request id: 152, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:18:42:619 	asdu (length: 2): 5100
12:18:42:641 APS-DATA.confirm id: 152, status: 0x00 SUCCESS
12:18:42:642 APS-DATA.confirm request id: 152 -> confirmed, timeout 976167
12:18:42:680 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:18:42:682 	asdu: 5100000000
12:18:42:682 APS-DATA.indication request id: 152 -> finished
12:18:42:683 APS-DATA.request id: 152 erase from queue
12:18:42:684 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:18:45:017 APS-DATA.request id: 164, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:18:45:018 	asdu (length: 2): 5200
12:18:45:036 APS-DATA.confirm id: 164, status: 0x00 SUCCESS
12:18:45:037 APS-DATA.confirm request id: 164 -> confirmed, timeout 978566
12:18:45:077 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:18:45:077 	asdu: 5200000000
12:18:45:078 APS-DATA.indication request id: 164 -> finished
12:18:45:078 APS-DATA.request id: 164 erase from queue
12:18:45:078 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:18:46:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:18:47:417 APS-DATA.request id: 175, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:18:47:419 	asdu (length: 2): 5300
12:18:47:439 APS-DATA.confirm id: 175, status: 0x00 SUCCESS
12:18:47:440 APS-DATA.confirm request id: 175 -> confirmed, timeout 980967
12:18:47:481 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:18:47:482 	asdu: 5300000000
12:18:47:482 APS-DATA.indication request id: 175 -> finished
12:18:47:482 APS-DATA.request id: 175 erase from queue
12:18:47:483 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:18:49:817 APS-DATA.request id: 187, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:18:49:818 	asdu (length: 2): 5400
12:18:49:840 APS-DATA.confirm id: 187, status: 0x00 SUCCESS
12:18:49:841 APS-DATA.confirm request id: 187 -> confirmed, timeout 983366
12:18:49:877 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:18:49:878 	asdu: 5400000000
12:18:49:878 APS-DATA.indication request id: 187 -> finished
12:18:49:879 APS-DATA.request id: 187 erase from queue
12:18:49:879 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:18:52:217 APS-DATA.request id: 199, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:18:52:217 	asdu (length: 2): 5500
12:18:52:234 APS-DATA.confirm id: 199, status: 0x00 SUCCESS
12:18:52:235 APS-DATA.confirm request id: 199 -> confirmed, timeout 985765
12:18:52:274 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:18:52:274 	asdu: 5500000000
12:18:52:275 APS-DATA.indication request id: 199 -> finished
12:18:52:275 APS-DATA.request id: 199 erase from queue
12:18:52:275 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:18:54:617 APS-DATA.request id: 210, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:18:54:618 	asdu (length: 2): 5600
12:18:54:638 APS-DATA.confirm id: 210, status: 0x00 SUCCESS
12:18:54:639 APS-DATA.confirm request id: 210 -> confirmed, timeout 988166
12:18:54:675 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:18:54:676 	asdu: 5600000000
12:18:54:676 APS-DATA.indication request id: 210 -> finished
12:18:54:676 APS-DATA.request id: 210 erase from queue
12:18:54:676 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:18:55:453 Idle timer triggered
12:18:56:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:18:57:017 APS-DATA.request id: 222, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:18:57:018 	asdu (length: 2): 5700
12:18:57:038 APS-DATA.confirm id: 222, status: 0x00 SUCCESS
12:18:57:039 APS-DATA.confirm request id: 222 -> confirmed, timeout 990567
12:18:57:076 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:18:57:077 	asdu: 5700000000
12:18:57:077 APS-DATA.indication request id: 222 -> finished
12:18:57:078 APS-DATA.request id: 222 erase from queue
12:18:57:078 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:18:59:417 APS-DATA.request id: 233, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:18:59:418 	asdu (length: 2): 5800
12:18:59:438 APS-DATA.confirm id: 233, status: 0x00 SUCCESS
12:18:59:439 APS-DATA.confirm request id: 233 -> confirmed, timeout 992966
12:18:59:478 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:18:59:478 	asdu: 5800000000
12:18:59:479 APS-DATA.indication request id: 233 -> finished
12:18:59:479 APS-DATA.request id: 233 erase from queue
12:18:59:479 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:01:818 APS-DATA.request id: 245, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:01:819 	asdu (length: 2): 5900
12:19:01:841 APS-DATA.confirm id: 245, status: 0x00 SUCCESS
12:19:01:842 APS-DATA.confirm request id: 245 -> confirmed, timeout 995367
12:19:01:877 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:01:878 	asdu: 5900000000
12:19:01:878 APS-DATA.indication request id: 245 -> finished
12:19:01:878 APS-DATA.request id: 245 erase from queue
12:19:01:879 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:04:217 APS-DATA.request id: 1, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:04:218 	asdu (length: 2): 5a00
12:19:04:238 APS-DATA.confirm id: 1, status: 0x00 SUCCESS
12:19:04:239 APS-DATA.confirm request id: 1 -> confirmed, timeout 997766
12:19:04:276 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:04:277 	asdu: 5a00000000
12:19:04:278 APS-DATA.indication request id: 1 -> finished
12:19:04:278 APS-DATA.request id: 1 erase from queue
12:19:04:278 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:06:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:19:06:617 APS-DATA.request id: 12, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:06:618 	asdu (length: 2): 5b00
12:19:06:638 APS-DATA.confirm id: 12, status: 0x00 SUCCESS
12:19:06:638 APS-DATA.confirm request id: 12 -> confirmed, timeout 1000166
12:19:06:676 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:06:676 	asdu: 5b00000000
12:19:06:677 APS-DATA.indication request id: 12 -> finished
12:19:06:677 APS-DATA.request id: 12 erase from queue
12:19:06:677 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:09:017 APS-DATA.request id: 24, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:09:018 	asdu (length: 2): 5c00
12:19:09:038 APS-DATA.confirm id: 24, status: 0x00 SUCCESS
12:19:09:039 APS-DATA.confirm request id: 24 -> confirmed, timeout 1002566
12:19:09:077 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:09:078 	asdu: 5c00000000
12:19:09:078 APS-DATA.indication request id: 24 -> finished
12:19:09:078 APS-DATA.request id: 24 erase from queue
12:19:09:078 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:11:417 APS-DATA.request id: 35, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:11:418 	asdu (length: 2): 5d00
12:19:11:439 APS-DATA.confirm id: 35, status: 0x00 SUCCESS
12:19:11:440 APS-DATA.confirm request id: 35 -> confirmed, timeout 1004966
12:19:11:477 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:11:478 	asdu: 5d00000000
12:19:11:478 APS-DATA.indication request id: 35 -> finished
12:19:11:479 APS-DATA.request id: 35 erase from queue
12:19:11:479 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:13:817 APS-DATA.request id: 47, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:13:818 	asdu (length: 2): 5e00
12:19:13:837 APS-DATA.confirm id: 47, status: 0x00 SUCCESS
12:19:13:838 APS-DATA.confirm request id: 47 -> confirmed, timeout 1007365
12:19:13:873 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:13:874 	asdu: 5e00000000
12:19:13:874 APS-DATA.indication request id: 47 -> finished
12:19:13:875 APS-DATA.request id: 47 erase from queue
12:19:13:875 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:16:217 APS-DATA.request id: 59, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:16:218 	asdu (length: 2): 5f00
12:19:16:239 APS-DATA.confirm id: 59, status: 0x00 SUCCESS
12:19:16:240 APS-DATA.confirm request id: 59 -> confirmed, timeout 1009766
12:19:16:279 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:16:280 	asdu: 5f00000000
12:19:16:280 APS-DATA.indication request id: 59 -> finished
12:19:16:280 APS-DATA.request id: 59 erase from queue
12:19:16:281 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:16:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:19:18:617 APS-DATA.request id: 70, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:18:619 	asdu (length: 2): 6000
12:19:18:638 APS-DATA.confirm id: 70, status: 0x00 SUCCESS
12:19:18:639 APS-DATA.confirm request id: 70 -> confirmed, timeout 1012167
12:19:18:675 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:18:676 	asdu: 6000000000
12:19:18:676 APS-DATA.indication request id: 70 -> finished
12:19:18:677 APS-DATA.request id: 70 erase from queue
12:19:18:677 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:21:017 APS-DATA.request id: 82, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:21:019 	asdu (length: 2): 6100
12:19:21:039 APS-DATA.confirm id: 82, status: 0x00 SUCCESS
12:19:21:040 APS-DATA.confirm request id: 82 -> confirmed, timeout 1014567
12:19:21:079 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:21:080 	asdu: 6100000000
12:19:21:080 APS-DATA.indication request id: 82 -> finished
12:19:21:080 APS-DATA.request id: 82 erase from queue
12:19:21:080 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:23:417 APS-DATA.request id: 93, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:23:418 	asdu (length: 2): 6200
12:19:23:435 APS-DATA.confirm id: 93, status: 0x00 SUCCESS
12:19:23:436 APS-DATA.confirm request id: 93 -> confirmed, timeout 1016966
12:19:23:473 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:23:474 	asdu: 6200000000
12:19:23:474 APS-DATA.indication request id: 93 -> finished
12:19:23:474 APS-DATA.request id: 93 erase from queue
12:19:23:474 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:25:453 Idle timer triggered
12:19:25:817 APS-DATA.request id: 105, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:25:818 	asdu (length: 2): 6300
12:19:25:837 APS-DATA.confirm id: 105, status: 0x00 SUCCESS
12:19:25:838 APS-DATA.confirm request id: 105 -> confirmed, timeout 1019366
12:19:25:875 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:25:876 	asdu: 6300000000
12:19:25:876 APS-DATA.indication request id: 105 -> finished
12:19:25:877 APS-DATA.request id: 105 erase from queue
12:19:25:877 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:26:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:19:26:470 Master: read param with arg 0x19
12:19:26:525 Device TTL 2578 s flags: 0x7
12:19:28:217 APS-DATA.request id: 117, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:28:218 	asdu (length: 2): 6400
12:19:28:241 APS-DATA.confirm id: 117, status: 0x00 SUCCESS
12:19:28:241 APS-DATA.confirm request id: 117 -> confirmed, timeout 1021766
12:19:28:274 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:28:274 	asdu: 6400000000
12:19:28:275 APS-DATA.indication request id: 117 -> finished
12:19:28:275 APS-DATA.request id: 117 erase from queue
12:19:28:275 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:30:617 APS-DATA.request id: 128, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:30:618 	asdu (length: 2): 6500
12:19:30:639 APS-DATA.confirm id: 128, status: 0x00 SUCCESS
12:19:30:640 APS-DATA.confirm request id: 128 -> confirmed, timeout 1024166
12:19:30:675 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:30:676 	asdu: 6500000000
12:19:30:676 APS-DATA.indication request id: 128 -> finished
12:19:30:676 APS-DATA.request id: 128 erase from queue
12:19:30:677 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:33:017 APS-DATA.request id: 140, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:33:018 	asdu (length: 2): 6600
12:19:33:038 APS-DATA.confirm id: 140, status: 0x00 SUCCESS
12:19:33:039 APS-DATA.confirm request id: 140 -> confirmed, timeout 1026566
12:19:33:075 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:33:076 	asdu: 6600000000
12:19:33:076 APS-DATA.indication request id: 140 -> finished
12:19:33:077 APS-DATA.request id: 140 erase from queue
12:19:33:077 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:35:417 APS-DATA.request id: 151, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:35:419 	asdu (length: 2): 6700
12:19:35:440 APS-DATA.confirm id: 151, status: 0x00 SUCCESS
12:19:35:440 APS-DATA.confirm request id: 151 -> confirmed, timeout 1028967
12:19:35:475 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:35:475 	asdu: 6700000000
12:19:35:476 APS-DATA.indication request id: 151 -> finished
12:19:35:476 APS-DATA.request id: 151 erase from queue
12:19:35:476 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:36:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:19:37:453 APS-DATA.request id: 161, addrmode: 0x02, addr: 0xfffc, profile: 0x0000, cluster: 0x0036, ep: 0x00 -> 0x00 queue: 0 len: 3 tx.options 0x00
12:19:37:455 	asdu (length: 3): 014101
12:19:37:455 send permit join, duration: 65
12:19:37:456 APS-DATA.request id: 162, addrmode: 0x02, addr: 0xfffc, profile: 0xA1E0, cluster: 0x0021, ep: 0xF2 -> 0xF2 queue: 1 len: 6 tx.options 0x00
12:19:37:457 	asdu (length: 6): 1901020b2800
12:19:37:575 APS-DATA.confirm id: 162, status: 0xE1 
12:19:37:620 APS-DATA.confirm id: 161, status: 0xE1 
12:19:37:817 APS-DATA.request id: 165, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:37:818 	asdu (length: 2): 6800
12:19:37:838 APS-DATA.confirm id: 165, status: 0x00 SUCCESS
12:19:37:839 APS-DATA.confirm request id: 165 -> confirmed, timeout 1031366
12:19:37:877 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:37:878 	asdu: 6800000000
12:19:37:878 APS-DATA.indication request id: 165 -> finished
12:19:37:878 APS-DATA.request id: 165 erase from queue
12:19:37:878 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:40:217 APS-DATA.request id: 177, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:40:218 	asdu (length: 2): 6900
12:19:40:238 APS-DATA.confirm id: 177, status: 0x00 SUCCESS
12:19:40:239 APS-DATA.confirm request id: 177 -> confirmed, timeout 1033766
12:19:40:276 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:40:277 	asdu: 6900000000
12:19:40:278 APS-DATA.indication request id: 177 -> finished
12:19:40:278 APS-DATA.request id: 177 erase from queue
12:19:40:279 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:40:291 Websocket 127.0.0.1:57136 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-09T16:19Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
12:19:40:293 Websocket 127.0.0.1:57198 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-09T16:19Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
12:19:42:454 GW firmware version: 0x26720700
12:19:42:455 GW firmware version is up to date: 0x26720700
12:19:42:617 APS-DATA.request id: 188, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:42:618 	asdu (length: 2): 6a00
12:19:42:637 APS-DATA.confirm id: 188, status: 0x00 SUCCESS
12:19:42:638 APS-DATA.confirm request id: 188 -> confirmed, timeout 1036166
12:19:42:677 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:42:677 	asdu: 6a00000000
12:19:42:678 APS-DATA.indication request id: 188 -> finished
12:19:42:678 APS-DATA.request id: 188 erase from queue
12:19:42:678 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:45:017 APS-DATA.request id: 200, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:45:019 	asdu (length: 2): 6b00
12:19:45:039 APS-DATA.confirm id: 200, status: 0x00 SUCCESS
12:19:45:040 APS-DATA.confirm request id: 200 -> confirmed, timeout 1038567
12:19:45:081 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:45:082 	asdu: 6b00000000
12:19:45:082 APS-DATA.indication request id: 200 -> finished
12:19:45:082 APS-DATA.request id: 200 erase from queue
12:19:45:083 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:46:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:19:47:417 APS-DATA.request id: 211, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:47:418 	asdu (length: 2): 6c00
12:19:47:438 APS-DATA.confirm id: 211, status: 0x00 SUCCESS
12:19:47:439 APS-DATA.confirm request id: 211 -> confirmed, timeout 1040966
12:19:47:479 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:47:480 	asdu: 6c00000000
12:19:47:480 APS-DATA.indication request id: 211 -> finished
12:19:47:480 APS-DATA.request id: 211 erase from queue
12:19:47:481 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:49:817 APS-DATA.request id: 223, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:49:818 	asdu (length: 2): 6d00
12:19:49:841 APS-DATA.confirm id: 223, status: 0x00 SUCCESS
12:19:49:841 APS-DATA.confirm request id: 223 -> confirmed, timeout 1043367
12:19:49:873 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:49:874 	asdu: 6d00000000
12:19:49:874 APS-DATA.indication request id: 223 -> finished
12:19:49:875 APS-DATA.request id: 223 erase from queue
12:19:49:875 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:52:217 APS-DATA.request id: 235, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:52:218 	asdu (length: 2): 6e00
12:19:52:238 APS-DATA.confirm id: 235, status: 0x00 SUCCESS
12:19:52:239 APS-DATA.confirm request id: 235 -> confirmed, timeout 1045766
12:19:52:275 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:52:276 	asdu: 6e00000000
12:19:52:276 APS-DATA.indication request id: 235 -> finished
12:19:52:276 APS-DATA.request id: 235 erase from queue
12:19:52:276 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:54:617 APS-DATA.request id: 246, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:54:618 	asdu (length: 2): 6f00
12:19:54:638 APS-DATA.confirm id: 246, status: 0x00 SUCCESS
12:19:54:639 APS-DATA.confirm request id: 246 -> confirmed, timeout 1048166
12:19:54:674 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:54:676 	asdu: 6f00000000
12:19:54:676 APS-DATA.indication request id: 246 -> finished
12:19:54:677 APS-DATA.request id: 246 erase from queue
12:19:54:677 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:55:454 sql exec SELECT conf FROM zbconf ORDER BY rowid desc limit 1
12:19:55:455 Idle timer triggered
12:19:56:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:19:57:017 APS-DATA.request id: 2, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:57:019 	asdu (length: 2): 7000
12:19:57:038 APS-DATA.confirm id: 2, status: 0x00 SUCCESS
12:19:57:039 APS-DATA.confirm request id: 2 -> confirmed, timeout 1050567
12:19:57:076 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:57:076 	asdu: 7000000000
12:19:57:077 APS-DATA.indication request id: 2 -> finished
12:19:57:077 APS-DATA.request id: 2 erase from queue
12:19:57:077 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:19:59:417 APS-DATA.request id: 13, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:19:59:418 	asdu (length: 2): 7100
12:19:59:438 APS-DATA.confirm id: 13, status: 0x00 SUCCESS
12:19:59:439 APS-DATA.confirm request id: 13 -> confirmed, timeout 1052966
12:19:59:477 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:19:59:477 	asdu: 7100000000
12:19:59:478 APS-DATA.indication request id: 13 -> finished
12:19:59:478 APS-DATA.request id: 13 erase from queue
12:19:59:478 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000

cypres422 · May 9, 2022, 6:05pm

Next 90 sec

12:20:01:817 APS-DATA.request id: 25, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:01:818 	asdu (length: 2): 7200
12:20:01:837 APS-DATA.confirm id: 25, status: 0x00 SUCCESS
12:20:01:838 APS-DATA.confirm request id: 25 -> confirmed, timeout 1055366
12:20:01:878 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:01:879 	asdu: 7200000000
12:20:01:879 APS-DATA.indication request id: 25 -> finished
12:20:01:879 APS-DATA.request id: 25 erase from queue
12:20:01:880 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:04:217 APS-DATA.request id: 37, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:04:219 	asdu (length: 2): 7300
12:20:04:239 APS-DATA.confirm id: 37, status: 0x00 SUCCESS
12:20:04:240 APS-DATA.confirm request id: 37 -> confirmed, timeout 1057766
12:20:04:276 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:04:277 	asdu: 7300000000
12:20:04:278 APS-DATA.indication request id: 37 -> finished
12:20:04:278 APS-DATA.request id: 37 erase from queue
12:20:04:278 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:06:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:20:06:617 APS-DATA.request id: 48, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:06:619 	asdu (length: 2): 7400
12:20:06:638 APS-DATA.confirm id: 48, status: 0x00 SUCCESS
12:20:06:638 APS-DATA.confirm request id: 48 -> confirmed, timeout 1060167
12:20:06:678 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:06:678 	asdu: 7400000000
12:20:06:679 APS-DATA.indication request id: 48 -> finished
12:20:06:679 APS-DATA.request id: 48 erase from queue
12:20:06:679 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:09:017 APS-DATA.request id: 60, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:09:018 	asdu (length: 2): 7500
12:20:09:037 APS-DATA.confirm id: 60, status: 0x00 SUCCESS
12:20:09:038 APS-DATA.confirm request id: 60 -> confirmed, timeout 1062566
12:20:09:075 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:09:076 	asdu: 7500000000
12:20:09:076 APS-DATA.indication request id: 60 -> finished
12:20:09:076 APS-DATA.request id: 60 erase from queue
12:20:09:077 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:11:417 APS-DATA.request id: 71, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:11:418 	asdu (length: 2): 7600
12:20:11:439 APS-DATA.confirm id: 71, status: 0x00 SUCCESS
12:20:11:440 APS-DATA.confirm request id: 71 -> confirmed, timeout 1064966
12:20:11:477 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:11:478 	asdu: 7600000000
12:20:11:478 APS-DATA.indication request id: 71 -> finished
12:20:11:478 APS-DATA.request id: 71 erase from queue
12:20:11:479 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:13:817 APS-DATA.request id: 83, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:13:818 	asdu (length: 2): 7700
12:20:13:838 APS-DATA.confirm id: 83, status: 0x00 SUCCESS
12:20:13:839 APS-DATA.confirm request id: 83 -> confirmed, timeout 1067366
12:20:13:880 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:13:880 	asdu: 7700000000
12:20:13:881 APS-DATA.indication request id: 83 -> finished
12:20:13:881 APS-DATA.request id: 83 erase from queue
12:20:13:881 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:16:217 APS-DATA.request id: 95, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:16:218 	asdu (length: 2): 7800
12:20:16:239 APS-DATA.confirm id: 95, status: 0x00 SUCCESS
12:20:16:240 APS-DATA.confirm request id: 95 -> confirmed, timeout 1069766
12:20:16:279 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:16:280 	asdu: 7800000000
12:20:16:281 APS-DATA.indication request id: 95 -> finished
12:20:16:281 APS-DATA.request id: 95 erase from queue
12:20:16:281 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:16:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:20:18:617 APS-DATA.request id: 106, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:18:619 	asdu (length: 2): 7900
12:20:18:639 APS-DATA.confirm id: 106, status: 0x00 SUCCESS
12:20:18:640 APS-DATA.confirm request id: 106 -> confirmed, timeout 1072167
12:20:18:677 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:18:678 	asdu: 7900000000
12:20:18:678 APS-DATA.indication request id: 106 -> finished
12:20:18:679 APS-DATA.request id: 106 erase from queue
12:20:18:679 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:21:017 APS-DATA.request id: 118, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:21:019 	asdu (length: 2): 7a00
12:20:21:039 APS-DATA.confirm id: 118, status: 0x00 SUCCESS
12:20:21:039 APS-DATA.confirm request id: 118 -> confirmed, timeout 1074567
12:20:21:077 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:21:077 	asdu: 7a00000000
12:20:21:077 APS-DATA.indication request id: 118 -> finished
12:20:21:078 APS-DATA.request id: 118 erase from queue
12:20:21:078 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:23:417 APS-DATA.request id: 129, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:23:418 	asdu (length: 2): 7b00
12:20:23:441 APS-DATA.confirm id: 129, status: 0x00 SUCCESS
12:20:23:441 APS-DATA.confirm request id: 129 -> confirmed, timeout 1076966
12:20:23:478 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:23:479 	asdu: 7b00000000
12:20:23:479 APS-DATA.indication request id: 129 -> finished
12:20:23:479 APS-DATA.request id: 129 erase from queue
12:20:23:479 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:25:453 Idle timer triggered
12:20:25:817 APS-DATA.request id: 141, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:25:818 	asdu (length: 2): 7c00
12:20:25:833 APS-DATA.confirm id: 141, status: 0x00 SUCCESS
12:20:25:834 APS-DATA.confirm request id: 141 -> confirmed, timeout 1079367
12:20:25:841 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:25:842 	asdu: 7c00000000
12:20:25:842 APS-DATA.indication request id: 141 -> finished
12:20:25:843 APS-DATA.request id: 141 erase from queue
12:20:25:843 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:26:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:20:26:469 Master: read param with arg 0x19
12:20:26:530 Device TTL 2518 s flags: 0x7
12:20:28:217 APS-DATA.request id: 153, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:28:218 	asdu (length: 2): 7d00
12:20:28:236 APS-DATA.confirm id: 153, status: 0x00 SUCCESS
12:20:28:237 APS-DATA.confirm request id: 153 -> confirmed, timeout 1081766
12:20:28:275 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:28:276 	asdu: 7d00000000
12:20:28:276 APS-DATA.indication request id: 153 -> finished
12:20:28:277 APS-DATA.request id: 153 erase from queue
12:20:28:277 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:30:617 APS-DATA.request id: 164, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:30:619 	asdu (length: 2): 7e00
12:20:30:638 APS-DATA.confirm id: 164, status: 0x00 SUCCESS
12:20:30:638 APS-DATA.confirm request id: 164 -> confirmed, timeout 1084167
12:20:30:678 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:30:679 	asdu: 7e00000000
12:20:30:679 APS-DATA.indication request id: 164 -> finished
12:20:30:679 APS-DATA.request id: 164 erase from queue
12:20:30:679 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:33:017 APS-DATA.request id: 176, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:33:018 	asdu (length: 2): 7f00
12:20:33:038 APS-DATA.confirm id: 176, status: 0x00 SUCCESS
12:20:33:039 APS-DATA.confirm request id: 176 -> confirmed, timeout 1086566
12:20:33:080 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:33:081 	asdu: 7f00000000
12:20:33:081 APS-DATA.indication request id: 176 -> finished
12:20:33:081 APS-DATA.request id: 176 erase from queue
12:20:33:082 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:35:417 APS-DATA.request id: 187, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:35:418 	asdu (length: 2): 8000
12:20:35:436 APS-DATA.confirm id: 187, status: 0x00 SUCCESS
12:20:35:441 APS-DATA.confirm request id: 187 -> confirmed, timeout 1088966
12:20:35:477 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:35:477 	asdu: 8000000000
12:20:35:478 APS-DATA.indication request id: 187 -> finished
12:20:35:478 APS-DATA.request id: 187 erase from queue
12:20:35:478 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:36:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:20:37:817 APS-DATA.request id: 199, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:37:818 	asdu (length: 2): 8100
12:20:37:837 APS-DATA.confirm id: 199, status: 0x00 SUCCESS
12:20:37:838 APS-DATA.confirm request id: 199 -> confirmed, timeout 1091366
12:20:37:876 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:37:876 	asdu: 8100000000
12:20:37:877 APS-DATA.indication request id: 199 -> finished
12:20:37:877 APS-DATA.request id: 199 erase from queue
12:20:37:877 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:38:453 APS-DATA.request id: 203, addrmode: 0x02, addr: 0xfffc, profile: 0x0000, cluster: 0x0036, ep: 0x00 -> 0x00 queue: 0 len: 3 tx.options 0x00
12:20:38:455 	asdu (length: 3): 023901
12:20:38:455 send permit join, duration: 57
12:20:38:456 APS-DATA.request id: 204, addrmode: 0x02, addr: 0xfffc, profile: 0xA1E0, cluster: 0x0021, ep: 0xF2 -> 0xF2 queue: 1 len: 6 tx.options 0x00
12:20:38:457 	asdu (length: 6): 1902020b2800
12:20:38:571 APS-DATA.confirm id: 203, status: 0xE1 
12:20:38:617 APS-DATA.confirm id: 204, status: 0xE1 
12:20:40:217 APS-DATA.request id: 213, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:40:218 	asdu (length: 2): 8200
12:20:40:240 APS-DATA.confirm id: 213, status: 0x00 SUCCESS
12:20:40:241 APS-DATA.confirm request id: 213 -> confirmed, timeout 1093766
12:20:40:273 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:40:274 	asdu: 8200000000
12:20:40:275 APS-DATA.indication request id: 213 -> finished
12:20:40:275 APS-DATA.request id: 213 erase from queue
12:20:40:275 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:42:617 APS-DATA.request id: 224, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:42:619 	asdu (length: 2): 8300
12:20:42:641 APS-DATA.confirm id: 224, status: 0x00 SUCCESS
12:20:42:641 APS-DATA.confirm request id: 224 -> confirmed, timeout 1096167
12:20:42:677 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:42:678 	asdu: 8300000000
12:20:42:678 APS-DATA.indication request id: 224 -> finished
12:20:42:679 APS-DATA.request id: 224 erase from queue
12:20:42:679 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:42:688 Websocket 127.0.0.1:57136 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-09T16:20Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
12:20:42:690 Websocket 127.0.0.1:57198 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-09T16:20Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
12:20:45:017 APS-DATA.request id: 236, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:45:018 	asdu (length: 2): 8400
12:20:45:043 APS-DATA.confirm id: 236, status: 0x00 SUCCESS
12:20:45:043 APS-DATA.confirm request id: 236 -> confirmed, timeout 1098566
12:20:45:083 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:45:083 	asdu: 8400000000
12:20:45:084 APS-DATA.indication request id: 236 -> finished
12:20:45:084 APS-DATA.request id: 236 erase from queue
12:20:45:084 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:46:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:20:47:417 APS-DATA.request id: 247, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:47:418 	asdu (length: 2): 8500
12:20:47:439 APS-DATA.confirm id: 247, status: 0x00 SUCCESS
12:20:47:440 APS-DATA.confirm request id: 247 -> confirmed, timeout 1100966
12:20:47:479 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:47:480 	asdu: 8500000000
12:20:47:481 APS-DATA.indication request id: 247 -> finished
12:20:47:481 APS-DATA.request id: 247 erase from queue
12:20:47:481 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:49:817 APS-DATA.request id: 3, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:49:819 	asdu (length: 2): 8600
12:20:49:841 APS-DATA.confirm id: 3, status: 0x00 SUCCESS
12:20:49:841 APS-DATA.confirm request id: 3 -> confirmed, timeout 1103367
12:20:49:878 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:49:878 	asdu: 8600000000
12:20:49:879 APS-DATA.indication request id: 3 -> finished
12:20:49:879 APS-DATA.request id: 3 erase from queue
12:20:49:879 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:52:217 APS-DATA.request id: 15, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:52:219 	asdu (length: 2): 8700
12:20:52:241 APS-DATA.confirm id: 15, status: 0x00 SUCCESS
12:20:52:241 APS-DATA.confirm request id: 15 -> confirmed, timeout 1105767
12:20:52:278 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:52:278 	asdu: 8700000000
12:20:52:278 APS-DATA.indication request id: 15 -> finished
12:20:52:279 APS-DATA.request id: 15 erase from queue
12:20:52:279 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:54:617 APS-DATA.request id: 26, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:54:619 	asdu (length: 2): 8800
12:20:54:642 APS-DATA.confirm id: 26, status: 0x00 SUCCESS
12:20:54:643 APS-DATA.confirm request id: 26 -> confirmed, timeout 1108167
12:20:54:675 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:54:675 	asdu: 8800000000
12:20:54:676 APS-DATA.indication request id: 26 -> finished
12:20:54:676 APS-DATA.request id: 26 erase from queue
12:20:54:677 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:55:453 Idle timer triggered
12:20:56:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:20:57:017 APS-DATA.request id: 38, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:57:019 	asdu (length: 2): 8900
12:20:57:038 APS-DATA.confirm id: 38, status: 0x00 SUCCESS
12:20:57:039 APS-DATA.confirm request id: 38 -> confirmed, timeout 1110567
12:20:57:075 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:57:076 	asdu: 8900000000
12:20:57:077 APS-DATA.indication request id: 38 -> finished
12:20:57:077 APS-DATA.request id: 38 erase from queue
12:20:57:078 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:20:59:417 APS-DATA.request id: 49, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:20:59:418 	asdu (length: 2): 8a00
12:20:59:438 APS-DATA.confirm id: 49, status: 0x00 SUCCESS
12:20:59:439 APS-DATA.confirm request id: 49 -> confirmed, timeout 1112966
12:20:59:477 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:20:59:478 	asdu: 8a00000000
12:20:59:479 APS-DATA.indication request id: 49 -> finished
12:20:59:479 APS-DATA.request id: 49 erase from queue
12:20:59:479 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:21:01:817 APS-DATA.request id: 61, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:21:01:819 	asdu (length: 2): 8b00
12:21:01:839 APS-DATA.confirm id: 61, status: 0x00 SUCCESS
12:21:01:840 APS-DATA.confirm request id: 61 -> confirmed, timeout 1115367
12:21:01:878 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:21:01:879 	asdu: 8b00000000
12:21:01:879 APS-DATA.indication request id: 61 -> finished
12:21:01:879 APS-DATA.request id: 61 erase from queue
12:21:01:879 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:21:04:217 APS-DATA.request id: 73, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:21:04:218 	asdu (length: 2): 8c00
12:21:04:238 APS-DATA.confirm id: 73, status: 0x00 SUCCESS
12:21:04:239 APS-DATA.confirm request id: 73 -> confirmed, timeout 1117767
12:21:04:277 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:21:04:278 	asdu: 8c00000000
12:21:04:278 APS-DATA.indication request id: 73 -> finished
12:21:04:279 APS-DATA.request id: 73 erase from queue
12:21:04:279 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:21:06:454 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:21:06:618 APS-DATA.request id: 84, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:21:06:619 	asdu (length: 2): 8d00
12:21:06:637 APS-DATA.confirm id: 84, status: 0x00 SUCCESS
12:21:06:638 APS-DATA.confirm request id: 84 -> confirmed, timeout 1120167
12:21:06:675 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:21:06:676 	asdu: 8d00000000
12:21:06:677 APS-DATA.indication request id: 84 -> finished
12:21:06:677 APS-DATA.request id: 84 erase from queue
12:21:06:677 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:21:09:017 APS-DATA.request id: 96, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:21:09:018 	asdu (length: 2): 8e00
12:21:09:038 APS-DATA.confirm id: 96, status: 0x00 SUCCESS
12:21:09:039 APS-DATA.confirm request id: 96 -> confirmed, timeout 1122566
12:21:09:077 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:21:09:078 	asdu: 8e00000000
12:21:09:078 APS-DATA.indication request id: 96 -> finished
12:21:09:078 APS-DATA.request id: 96 erase from queue
12:21:09:079 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:21:11:417 APS-DATA.request id: 107, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:21:11:418 	asdu (length: 2): 8f00
12:21:11:440 APS-DATA.confirm id: 107, status: 0x00 SUCCESS
12:21:11:441 APS-DATA.confirm request id: 107 -> confirmed, timeout 1124966
12:21:11:473 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:21:11:474 	asdu: 8f00000000
12:21:11:474 APS-DATA.indication request id: 107 -> finished
12:21:11:475 APS-DATA.request id: 107 erase from queue
12:21:11:475 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:21:13:817 APS-DATA.request id: 119, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:21:13:818 	asdu (length: 2): 9000
12:21:13:838 APS-DATA.confirm id: 119, status: 0x00 SUCCESS
12:21:13:839 APS-DATA.confirm request id: 119 -> confirmed, timeout 1127366
12:21:13:874 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:21:13:875 	asdu: 9000000000
12:21:13:876 APS-DATA.indication request id: 119 -> finished
12:21:13:876 APS-DATA.request id: 119 erase from queue
12:21:13:876 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:21:16:216 APS-DATA.request id: 131, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:21:16:217 	asdu (length: 2): 9100
12:21:16:236 APS-DATA.confirm id: 131, status: 0x00 SUCCESS
12:21:16:237 APS-DATA.confirm request id: 131 -> confirmed, timeout 1129765
12:21:16:273 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:21:16:273 	asdu: 9100000000
12:21:16:274 APS-DATA.indication request id: 131 -> finished
12:21:16:274 APS-DATA.request id: 131 erase from queue
12:21:16:274 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:21:16:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:21:18:617 APS-DATA.request id: 142, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:21:18:618 	asdu (length: 2): 9200
12:21:18:637 APS-DATA.confirm id: 142, status: 0x00 SUCCESS
12:21:18:638 APS-DATA.confirm request id: 142 -> confirmed, timeout 1132166
12:21:18:675 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:21:18:676 	asdu: 9200000000
12:21:18:676 APS-DATA.indication request id: 142 -> finished
12:21:18:676 APS-DATA.request id: 142 erase from queue
12:21:18:677 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:21:21:017 APS-DATA.request id: 154, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:21:21:019 	asdu (length: 2): 9300
12:21:21:041 APS-DATA.confirm id: 154, status: 0x00 SUCCESS
12:21:21:042 APS-DATA.confirm request id: 154 -> confirmed, timeout 1134567
12:21:21:077 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:21:21:078 	asdu: 9300000000
12:21:21:078 APS-DATA.indication request id: 154 -> finished
12:21:21:079 APS-DATA.request id: 154 erase from queue
12:21:21:079 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:21:23:417 APS-DATA.request id: 165, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:21:23:418 	asdu (length: 2): 9400
12:21:23:440 APS-DATA.confirm id: 165, status: 0x00 SUCCESS
12:21:23:441 APS-DATA.confirm request id: 165 -> confirmed, timeout 1136966
12:21:23:477 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:21:23:477 	asdu: 9400000000
12:21:23:478 APS-DATA.indication request id: 165 -> finished
12:21:23:478 APS-DATA.request id: 165 erase from queue
12:21:23:478 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:21:25:453 sql exec SELECT conf FROM zbconf ORDER BY rowid desc limit 1
12:21:25:455 Idle timer triggered
12:21:25:817 APS-DATA.request id: 177, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:21:25:818 	asdu (length: 2): 9500
12:21:25:840 APS-DATA.confirm id: 177, status: 0x00 SUCCESS
12:21:25:841 APS-DATA.confirm request id: 177 -> confirmed, timeout 1139366
12:21:25:876 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:21:25:877 	asdu: 9500000000
12:21:25:877 APS-DATA.indication request id: 177 -> finished
12:21:25:877 APS-DATA.request id: 177 erase from queue
12:21:25:878 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
12:21:26:453 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
12:21:26:471 Master: read param with arg 0x19
12:21:26:526 Device TTL 2458 s flags: 0x7
12:21:28:217 APS-DATA.request id: 189, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
12:21:28:218 	asdu (length: 2): 9600
12:21:28:238 APS-DATA.confirm id: 189, status: 0x00 SUCCESS
12:21:28:239 APS-DATA.confirm request id: 189 -> confirmed, timeout 1141766
12:21:28:280 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
12:21:28:281 	asdu: 9600000000
12:21:28:281 APS-DATA.indication request id: 189 -> finished
12:21:28:282 APS-DATA.request id: 189 erase from queue
12:21:28:282 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000

cypres422 · May 9, 2022, 6:58pm

I checked the RF spectrum for the 2.4 Ghz wifi and I tried channel 11 instead of 15 (default), still no success.

cypres422 · May 10, 2022, 1:13pm

This is the log (part 1) for a new test without the PoE+ HAT and using the official power supply.
Conbee 2 directly plugged into a USB 2.0 port

09:04:00:412 APS-DATA.request id: 190, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:00:413 	asdu (length: 2): d900
09:04:00:434 APS-DATA.confirm id: 190, status: 0x00 SUCCESS
09:04:00:435 APS-DATA.confirm request id: 190 -> confirmed, timeout 1244974
09:04:00:471 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:00:472 	asdu: d900000000
09:04:00:472 APS-DATA.indication request id: 190 -> finished
09:04:00:473 APS-DATA.request id: 190 erase from queue
09:04:00:473 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:02:812 APS-DATA.request id: 202, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:02:813 	asdu (length: 2): da00
09:04:02:836 APS-DATA.confirm id: 202, status: 0x00 SUCCESS
09:04:02:837 APS-DATA.confirm request id: 202 -> confirmed, timeout 1247374
09:04:02:871 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:02:871 	asdu: da00000000
09:04:02:872 APS-DATA.indication request id: 202 -> finished
09:04:02:872 APS-DATA.request id: 202 erase from queue
09:04:02:872 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:05:212 APS-DATA.request id: 214, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:05:213 	asdu (length: 2): db00
09:04:05:234 APS-DATA.confirm id: 214, status: 0x00 SUCCESS
09:04:05:235 APS-DATA.confirm request id: 214 -> confirmed, timeout 1249774
09:04:05:273 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:05:274 	asdu: db00000000
09:04:05:274 APS-DATA.indication request id: 214 -> finished
09:04:05:274 APS-DATA.request id: 214 erase from queue
09:04:05:275 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:05:940 APS-DATA.request id: 218, addrmode: 0x02, addr: 0xfffc, profile: 0x0000, cluster: 0x0036, ep: 0x00 -> 0x00 queue: 0 len: 3 tx.options 0x00
09:04:05:941 	asdu (length: 3): 004101
09:04:05:942 send permit join, duration: 65
09:04:05:943 APS-DATA.request id: 219, addrmode: 0x02, addr: 0xfffc, profile: 0xA1E0, cluster: 0x0021, ep: 0xF2 -> 0xF2 queue: 1 len: 6 tx.options 0x00
09:04:05:944 	asdu (length: 6): 1900020b2800
09:04:06:069 APS-DATA.confirm id: 219, status: 0xE1 
09:04:06:100 APS-DATA.confirm id: 218, status: 0xE1 
09:04:07:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:04:07:612 APS-DATA.request id: 227, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:07:613 	asdu (length: 2): dc00
09:04:07:633 APS-DATA.confirm id: 227, status: 0x00 SUCCESS
09:04:07:634 APS-DATA.confirm request id: 227 -> confirmed, timeout 1252174
09:04:07:670 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:07:671 	asdu: dc00000000
09:04:07:671 APS-DATA.indication request id: 227 -> finished
09:04:07:672 APS-DATA.request id: 227 erase from queue
09:04:07:672 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:10:012 APS-DATA.request id: 239, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:10:013 	asdu (length: 2): dd00
09:04:10:033 APS-DATA.confirm id: 239, status: 0x00 SUCCESS
09:04:10:033 APS-DATA.confirm request id: 239 -> confirmed, timeout 1254574
09:04:10:070 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:10:070 	asdu: dd00000000
09:04:10:070 APS-DATA.indication request id: 239 -> finished
09:04:10:071 APS-DATA.request id: 239 erase from queue
09:04:10:071 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:12:412 APS-DATA.request id: 250, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:12:414 	asdu (length: 2): de00
09:04:12:436 APS-DATA.confirm id: 250, status: 0x00 SUCCESS
09:04:12:437 APS-DATA.confirm request id: 250 -> confirmed, timeout 1256975
09:04:12:472 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:12:472 	asdu: de00000000
09:04:12:473 APS-DATA.indication request id: 250 -> finished
09:04:12:473 APS-DATA.request id: 250 erase from queue
09:04:12:473 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:14:812 APS-DATA.request id: 6, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:14:813 	asdu (length: 2): df00
09:04:14:833 APS-DATA.confirm id: 6, status: 0x00 SUCCESS
09:04:14:834 APS-DATA.confirm request id: 6 -> confirmed, timeout 1259374
09:04:14:873 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:14:874 	asdu: df00000000
09:04:14:875 APS-DATA.indication request id: 6 -> finished
09:04:14:875 APS-DATA.request id: 6 erase from queue
09:04:14:876 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:16:940 sql exec SELECT conf FROM zbconf ORDER BY rowid desc limit 1
09:04:16:942 Idle timer triggered
09:04:17:212 APS-DATA.request id: 18, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:17:214 	asdu (length: 2): e000
09:04:17:233 APS-DATA.confirm id: 18, status: 0x00 SUCCESS
09:04:17:234 APS-DATA.confirm request id: 18 -> confirmed, timeout 1261775
09:04:17:272 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:17:272 	asdu: e000000000
09:04:17:273 APS-DATA.indication request id: 18 -> finished
09:04:17:273 APS-DATA.request id: 18 erase from queue
09:04:17:273 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:17:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:04:17:457 Master: read param with arg 0x19
09:04:17:523 Device TTL 3036 s flags: 0x7
09:04:19:612 APS-DATA.request id: 29, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:19:613 	asdu (length: 2): e100
09:04:19:633 APS-DATA.confirm id: 29, status: 0x00 SUCCESS
09:04:19:633 APS-DATA.confirm request id: 29 -> confirmed, timeout 1264174
09:04:19:671 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:19:672 	asdu: e100000000
09:04:19:672 APS-DATA.indication request id: 29 -> finished
09:04:19:672 APS-DATA.request id: 29 erase from queue
09:04:19:672 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:22:012 APS-DATA.request id: 41, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:22:014 	asdu (length: 2): e200
09:04:22:034 APS-DATA.confirm id: 41, status: 0x00 SUCCESS
09:04:22:035 APS-DATA.confirm request id: 41 -> confirmed, timeout 1266575
09:04:22:074 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:22:075 	asdu: e200000000
09:04:22:075 APS-DATA.indication request id: 41 -> finished
09:04:22:075 APS-DATA.request id: 41 erase from queue
09:04:22:076 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:24:412 APS-DATA.request id: 52, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:24:413 	asdu (length: 2): e300
09:04:24:436 APS-DATA.confirm id: 52, status: 0x00 SUCCESS
09:04:24:436 APS-DATA.confirm request id: 52 -> confirmed, timeout 1268974
09:04:24:472 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:24:473 	asdu: e300000000
09:04:24:473 APS-DATA.indication request id: 52 -> finished
09:04:24:474 APS-DATA.request id: 52 erase from queue
09:04:24:474 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:26:812 APS-DATA.request id: 64, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:26:813 	asdu (length: 2): e400
09:04:26:833 APS-DATA.confirm id: 64, status: 0x00 SUCCESS
09:04:26:834 APS-DATA.confirm request id: 64 -> confirmed, timeout 1271374
09:04:26:871 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:26:871 	asdu: e400000000
09:04:26:872 APS-DATA.indication request id: 64 -> finished
09:04:26:872 APS-DATA.request id: 64 erase from queue
09:04:26:872 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:27:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:04:29:212 APS-DATA.request id: 76, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:29:213 	asdu (length: 2): e500
09:04:29:234 APS-DATA.confirm id: 76, status: 0x00 SUCCESS
09:04:29:235 APS-DATA.confirm request id: 76 -> confirmed, timeout 1273774
09:04:29:270 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:29:271 	asdu: e500000000
09:04:29:271 APS-DATA.indication request id: 76 -> finished
09:04:29:271 APS-DATA.request id: 76 erase from queue
09:04:29:272 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:31:612 APS-DATA.request id: 87, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:31:613 	asdu (length: 2): e600
09:04:31:632 APS-DATA.confirm id: 87, status: 0x00 SUCCESS
09:04:31:633 APS-DATA.confirm request id: 87 -> confirmed, timeout 1276174
09:04:31:669 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:31:670 	asdu: e600000000
09:04:31:670 APS-DATA.indication request id: 87 -> finished
09:04:31:671 APS-DATA.request id: 87 erase from queue
09:04:31:671 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:34:012 APS-DATA.request id: 99, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:34:013 	asdu (length: 2): e700
09:04:34:033 APS-DATA.confirm id: 99, status: 0x00 SUCCESS
09:04:34:034 APS-DATA.confirm request id: 99 -> confirmed, timeout 1278574
09:04:34:071 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:34:071 	asdu: e700000000
09:04:34:072 APS-DATA.indication request id: 99 -> finished
09:04:34:072 APS-DATA.request id: 99 erase from queue
09:04:34:072 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:34:082 Websocket 172.30.32.1:60828 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-10T13:04Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
09:04:34:083 Websocket 127.0.0.1:48426 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-10T13:04Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
09:04:36:412 APS-DATA.request id: 110, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:36:414 	asdu (length: 2): e800
09:04:36:435 APS-DATA.confirm id: 110, status: 0x00 SUCCESS
09:04:36:436 APS-DATA.confirm request id: 110 -> confirmed, timeout 1280975
09:04:36:474 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:36:475 	asdu: e800000000
09:04:36:476 APS-DATA.indication request id: 110 -> finished
09:04:36:476 APS-DATA.request id: 110 erase from queue
09:04:36:477 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:37:441 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:04:38:812 APS-DATA.request id: 122, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:38:814 	asdu (length: 2): e900
09:04:38:834 APS-DATA.confirm id: 122, status: 0x00 SUCCESS
09:04:38:835 APS-DATA.confirm request id: 122 -> confirmed, timeout 1283375
09:04:38:872 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:38:873 	asdu: e900000000
09:04:38:873 APS-DATA.indication request id: 122 -> finished
09:04:38:873 APS-DATA.request id: 122 erase from queue
09:04:38:874 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:41:212 APS-DATA.request id: 134, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:41:213 	asdu (length: 2): ea00
09:04:41:232 APS-DATA.confirm id: 134, status: 0x00 SUCCESS
09:04:41:232 APS-DATA.confirm request id: 134 -> confirmed, timeout 1285774
09:04:41:273 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:41:273 	asdu: ea00000000
09:04:41:274 APS-DATA.indication request id: 134 -> finished
09:04:41:274 APS-DATA.request id: 134 erase from queue
09:04:41:274 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:43:612 APS-DATA.request id: 145, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:43:613 	asdu (length: 2): eb00
09:04:43:633 APS-DATA.confirm id: 145, status: 0x00 SUCCESS
09:04:43:634 APS-DATA.confirm request id: 145 -> confirmed, timeout 1288174
09:04:43:676 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:43:677 	asdu: eb00000000
09:04:43:677 APS-DATA.indication request id: 145 -> finished
09:04:43:678 APS-DATA.request id: 145 erase from queue
09:04:43:678 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:46:012 APS-DATA.request id: 157, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:46:013 	asdu (length: 2): ec00
09:04:46:034 APS-DATA.confirm id: 157, status: 0x00 SUCCESS
09:04:46:035 APS-DATA.confirm request id: 157 -> confirmed, timeout 1290574
09:04:46:077 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:46:078 	asdu: ec00000000
09:04:46:078 APS-DATA.indication request id: 157 -> finished
09:04:46:079 APS-DATA.request id: 157 erase from queue
09:04:46:079 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:46:941 Idle timer triggered
09:04:47:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:04:48:412 APS-DATA.request id: 168, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:48:413 	asdu (length: 2): ed00
09:04:48:433 APS-DATA.confirm id: 168, status: 0x00 SUCCESS
09:04:48:433 APS-DATA.confirm request id: 168 -> confirmed, timeout 1292974
09:04:48:473 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:48:473 	asdu: ed00000000
09:04:48:473 APS-DATA.indication request id: 168 -> finished
09:04:48:474 APS-DATA.request id: 168 erase from queue
09:04:48:474 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:50:812 APS-DATA.request id: 180, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:50:813 	asdu (length: 2): ee00
09:04:50:833 APS-DATA.confirm id: 180, status: 0x00 SUCCESS
09:04:50:834 APS-DATA.confirm request id: 180 -> confirmed, timeout 1295374
09:04:50:870 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:50:871 	asdu: ee00000000
09:04:50:871 APS-DATA.indication request id: 180 -> finished
09:04:50:871 APS-DATA.request id: 180 erase from queue
09:04:50:871 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:53:212 APS-DATA.request id: 192, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:53:214 	asdu (length: 2): ef00
09:04:53:233 APS-DATA.confirm id: 192, status: 0x00 SUCCESS
09:04:53:234 APS-DATA.confirm request id: 192 -> confirmed, timeout 1297775
09:04:53:272 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:53:273 	asdu: ef00000000
09:04:53:273 APS-DATA.indication request id: 192 -> finished
09:04:53:273 APS-DATA.request id: 192 erase from queue
09:04:53:274 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:55:612 APS-DATA.request id: 203, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:55:613 	asdu (length: 2): f000
09:04:55:636 APS-DATA.confirm id: 203, status: 0x00 SUCCESS
09:04:55:637 APS-DATA.confirm request id: 203 -> confirmed, timeout 1300174
09:04:55:668 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:55:669 	asdu: f000000000
09:04:55:670 APS-DATA.indication request id: 203 -> finished
09:04:55:670 APS-DATA.request id: 203 erase from queue
09:04:55:670 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:04:57:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:04:58:012 APS-DATA.request id: 215, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:04:58:013 	asdu (length: 2): f100
09:04:58:033 APS-DATA.confirm id: 215, status: 0x00 SUCCESS
09:04:58:034 APS-DATA.confirm request id: 215 -> confirmed, timeout 1302574
09:04:58:071 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:04:58:072 	asdu: f100000000
09:04:58:072 APS-DATA.indication request id: 215 -> finished
09:04:58:072 APS-DATA.request id: 215 erase from queue
09:04:58:073 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:00:412 APS-DATA.request id: 226, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:00:413 	asdu (length: 2): f200
09:05:00:432 APS-DATA.confirm id: 226, status: 0x00 SUCCESS
09:05:00:433 APS-DATA.confirm request id: 226 -> confirmed, timeout 1304974
09:05:00:470 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:00:471 	asdu: f200000000
09:05:00:471 APS-DATA.indication request id: 226 -> finished
09:05:00:471 APS-DATA.request id: 226 erase from queue
09:05:00:472 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:02:812 APS-DATA.request id: 238, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:02:813 	asdu (length: 2): f300
09:05:02:832 APS-DATA.confirm id: 238, status: 0x00 SUCCESS
09:05:02:833 APS-DATA.confirm request id: 238 -> confirmed, timeout 1307374
09:05:02:873 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:02:873 	asdu: f300000000
09:05:02:874 APS-DATA.indication request id: 238 -> finished
09:05:02:874 APS-DATA.request id: 238 erase from queue
09:05:02:874 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:05:212 APS-DATA.request id: 250, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:05:213 	asdu (length: 2): f400
09:05:05:232 APS-DATA.confirm id: 250, status: 0x00 SUCCESS
09:05:05:232 APS-DATA.confirm request id: 250 -> confirmed, timeout 1309774
09:05:05:268 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:05:269 	asdu: f400000000
09:05:05:269 APS-DATA.indication request id: 250 -> finished
09:05:05:269 APS-DATA.request id: 250 erase from queue
09:05:05:270 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:06:941 APS-DATA.request id: 2, addrmode: 0x02, addr: 0xfffc, profile: 0x0000, cluster: 0x0036, ep: 0x00 -> 0x00 queue: 0 len: 3 tx.options 0x00
09:05:06:942 	asdu (length: 3): 014101
09:05:06:942 send permit join, duration: 65
09:05:06:943 APS-DATA.request id: 3, addrmode: 0x02, addr: 0xfffc, profile: 0xA1E0, cluster: 0x0021, ep: 0xF2 -> 0xF2 queue: 1 len: 6 tx.options 0x00
09:05:06:944 	asdu (length: 6): 1901020b2800
09:05:07:069 APS-DATA.confirm id: 2, status: 0xE1 
09:05:07:110 APS-DATA.confirm id: 3, status: 0xE1 
09:05:07:441 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:05:07:612 APS-DATA.request id: 7, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:07:613 	asdu (length: 2): f500
09:05:07:633 APS-DATA.confirm id: 7, status: 0x00 SUCCESS
09:05:07:634 APS-DATA.confirm request id: 7 -> confirmed, timeout 1312174
09:05:07:671 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:07:672 	asdu: f500000000
09:05:07:673 APS-DATA.indication request id: 7 -> finished
09:05:07:673 APS-DATA.request id: 7 erase from queue
09:05:07:673 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:10:012 APS-DATA.request id: 19, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:10:014 	asdu (length: 2): f600
09:05:10:032 APS-DATA.confirm id: 19, status: 0x00 SUCCESS
09:05:10:032 APS-DATA.confirm request id: 19 -> confirmed, timeout 1314575
09:05:10:069 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:10:070 	asdu: f600000000
09:05:10:071 APS-DATA.indication request id: 19 -> finished
09:05:10:071 APS-DATA.request id: 19 erase from queue
09:05:10:071 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:12:413 APS-DATA.request id: 30, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:12:414 	asdu (length: 2): f700
09:05:12:435 APS-DATA.confirm id: 30, status: 0x00 SUCCESS
09:05:12:435 APS-DATA.confirm request id: 30 -> confirmed, timeout 1316975
09:05:12:469 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:12:469 	asdu: f700000000
09:05:12:470 APS-DATA.indication request id: 30 -> finished
09:05:12:470 APS-DATA.request id: 30 erase from queue
09:05:12:470 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:14:812 APS-DATA.request id: 42, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:14:813 	asdu (length: 2): f800
09:05:14:834 APS-DATA.confirm id: 42, status: 0x00 SUCCESS
09:05:14:835 APS-DATA.confirm request id: 42 -> confirmed, timeout 1319375
09:05:14:871 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:14:872 	asdu: f800000000
09:05:14:872 APS-DATA.indication request id: 42 -> finished
09:05:14:872 APS-DATA.request id: 42 erase from queue
09:05:14:873 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:16:940 Idle timer triggered
09:05:17:212 APS-DATA.request id: 54, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:17:214 	asdu (length: 2): f900
09:05:17:232 APS-DATA.confirm id: 54, status: 0x00 SUCCESS
09:05:17:233 APS-DATA.confirm request id: 54 -> confirmed, timeout 1321775
09:05:17:271 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:17:272 	asdu: f900000000
09:05:17:272 APS-DATA.indication request id: 54 -> finished
09:05:17:273 APS-DATA.request id: 54 erase from queue
09:05:17:273 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:17:442 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:05:17:457 Master: read param with arg 0x19
09:05:17:514 Device TTL 2976 s flags: 0x7
09:05:19:612 APS-DATA.request id: 65, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:19:613 	asdu (length: 2): fa00
09:05:19:633 APS-DATA.confirm id: 65, status: 0x00 SUCCESS
09:05:19:634 APS-DATA.confirm request id: 65 -> confirmed, timeout 1324174
09:05:19:672 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:19:672 	asdu: fa00000000
09:05:19:673 APS-DATA.indication request id: 65 -> finished
09:05:19:673 APS-DATA.request id: 65 erase from queue
09:05:19:673 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:22:012 APS-DATA.request id: 77, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:22:013 	asdu (length: 2): fb00
09:05:22:033 APS-DATA.confirm id: 77, status: 0x00 SUCCESS
09:05:22:034 APS-DATA.confirm request id: 77 -> confirmed, timeout 1326574
09:05:22:075 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:22:076 	asdu: fb00000000
09:05:22:076 APS-DATA.indication request id: 77 -> finished
09:05:22:076 APS-DATA.request id: 77 erase from queue
09:05:22:077 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:24:412 APS-DATA.request id: 88, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:24:413 	asdu (length: 2): fc00
09:05:24:432 APS-DATA.confirm id: 88, status: 0x00 SUCCESS
09:05:24:433 APS-DATA.confirm request id: 88 -> confirmed, timeout 1328975
09:05:24:479 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:24:480 	asdu: fc00000000
09:05:24:480 APS-DATA.indication request id: 88 -> finished
09:05:24:481 APS-DATA.request id: 88 erase from queue
09:05:24:481 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:26:812 APS-DATA.request id: 100, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:26:813 	asdu (length: 2): fd00
09:05:26:833 APS-DATA.confirm id: 100, status: 0x00 SUCCESS
09:05:26:834 APS-DATA.confirm request id: 100 -> confirmed, timeout 1331374
09:05:26:874 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:26:874 	asdu: fd00000000
09:05:26:875 APS-DATA.indication request id: 100 -> finished
09:05:26:875 APS-DATA.request id: 100 erase from queue
09:05:26:875 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:27:442 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:05:29:212 APS-DATA.request id: 112, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:29:213 	asdu (length: 2): fe00
09:05:29:232 APS-DATA.confirm id: 112, status: 0x00 SUCCESS
09:05:29:233 APS-DATA.confirm request id: 112 -> confirmed, timeout 1333774
09:05:29:270 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:29:271 	asdu: fe00000000
09:05:29:271 APS-DATA.indication request id: 112 -> finished
09:05:29:271 APS-DATA.request id: 112 erase from queue
09:05:29:272 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000

cypres422 · May 10, 2022, 1:13pm

part 2.

09:05:31:613 APS-DATA.request id: 123, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:31:614 	asdu (length: 2): ff00
09:05:31:632 APS-DATA.confirm id: 123, status: 0x00 SUCCESS
09:05:31:633 APS-DATA.confirm request id: 123 -> confirmed, timeout 1336175
09:05:31:669 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:31:670 	asdu: ff00000000
09:05:31:670 APS-DATA.indication request id: 123 -> finished
09:05:31:670 APS-DATA.request id: 123 erase from queue
09:05:31:671 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:34:012 APS-DATA.request id: 135, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:34:013 	asdu (length: 2): 0000
09:05:34:036 APS-DATA.confirm id: 135, status: 0x00 SUCCESS
09:05:34:037 APS-DATA.confirm request id: 135 -> confirmed, timeout 1338574
09:05:34:071 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:34:072 	asdu: 0000000000
09:05:34:072 APS-DATA.indication request id: 135 -> finished
09:05:34:072 APS-DATA.request id: 135 erase from queue
09:05:34:072 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:34:082 Websocket 172.30.32.1:60828 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-10T13:05Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
09:05:34:083 Websocket 127.0.0.1:48426 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-10T13:05Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
09:05:36:412 APS-DATA.request id: 146, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:36:414 	asdu (length: 2): 0100
09:05:36:433 APS-DATA.confirm id: 146, status: 0x00 SUCCESS
09:05:36:434 APS-DATA.confirm request id: 146 -> confirmed, timeout 1340975
09:05:36:472 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:36:473 	asdu: 0100000000
09:05:36:473 APS-DATA.indication request id: 146 -> finished
09:05:36:473 APS-DATA.request id: 146 erase from queue
09:05:36:473 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:37:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:05:38:812 APS-DATA.request id: 158, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:38:814 	asdu (length: 2): 0200
09:05:38:833 APS-DATA.confirm id: 158, status: 0x00 SUCCESS
09:05:38:834 APS-DATA.confirm request id: 158 -> confirmed, timeout 1343375
09:05:38:873 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:38:874 	asdu: 0200000000
09:05:38:874 APS-DATA.indication request id: 158 -> finished
09:05:38:874 APS-DATA.request id: 158 erase from queue
09:05:38:875 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:41:212 APS-DATA.request id: 170, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:41:213 	asdu (length: 2): 0300
09:05:41:234 APS-DATA.confirm id: 170, status: 0x00 SUCCESS
09:05:41:234 APS-DATA.confirm request id: 170 -> confirmed, timeout 1345774
09:05:41:273 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:41:273 	asdu: 0300000000
09:05:41:273 APS-DATA.indication request id: 170 -> finished
09:05:41:274 APS-DATA.request id: 170 erase from queue
09:05:41:274 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:43:612 APS-DATA.request id: 181, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:43:614 	asdu (length: 2): 0400
09:05:43:634 APS-DATA.confirm id: 181, status: 0x00 SUCCESS
09:05:43:635 APS-DATA.confirm request id: 181 -> confirmed, timeout 1348175
09:05:43:672 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:43:673 	asdu: 0400000000
09:05:43:673 APS-DATA.indication request id: 181 -> finished
09:05:43:673 APS-DATA.request id: 181 erase from queue
09:05:43:674 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:46:012 APS-DATA.request id: 193, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:46:013 	asdu (length: 2): 0500
09:05:46:032 APS-DATA.confirm id: 193, status: 0x00 SUCCESS
09:05:46:033 APS-DATA.confirm request id: 193 -> confirmed, timeout 1350574
09:05:46:071 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:46:072 	asdu: 0500000000
09:05:46:072 APS-DATA.indication request id: 193 -> finished
09:05:46:072 APS-DATA.request id: 193 erase from queue
09:05:46:073 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:46:941 sql exec SELECT conf FROM zbconf ORDER BY rowid desc limit 1
09:05:46:942 Idle timer triggered
09:05:47:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:05:48:412 APS-DATA.request id: 204, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:48:413 	asdu (length: 2): 0600
09:05:48:432 APS-DATA.confirm id: 204, status: 0x00 SUCCESS
09:05:48:433 APS-DATA.confirm request id: 204 -> confirmed, timeout 1352974
09:05:48:477 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:48:478 	asdu: 0600000000
09:05:48:479 APS-DATA.indication request id: 204 -> finished
09:05:48:479 APS-DATA.request id: 204 erase from queue
09:05:48:480 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:50:812 APS-DATA.request id: 216, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:50:814 	asdu (length: 2): 0700
09:05:50:835 APS-DATA.confirm id: 216, status: 0x00 SUCCESS
09:05:50:836 APS-DATA.confirm request id: 216 -> confirmed, timeout 1355375
09:05:50:872 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:50:873 	asdu: 0700000000
09:05:50:873 APS-DATA.indication request id: 216 -> finished
09:05:50:873 APS-DATA.request id: 216 erase from queue
09:05:50:874 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:53:212 APS-DATA.request id: 228, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:53:213 	asdu (length: 2): 0800
09:05:53:232 APS-DATA.confirm id: 228, status: 0x00 SUCCESS
09:05:53:233 APS-DATA.confirm request id: 228 -> confirmed, timeout 1357774
09:05:53:267 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:53:268 	asdu: 0800000000
09:05:53:269 APS-DATA.indication request id: 228 -> finished
09:05:53:269 APS-DATA.request id: 228 erase from queue
09:05:53:269 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:55:612 APS-DATA.request id: 239, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:55:613 	asdu (length: 2): 0900
09:05:55:632 APS-DATA.confirm id: 239, status: 0x00 SUCCESS
09:05:55:633 APS-DATA.confirm request id: 239 -> confirmed, timeout 1360174
09:05:55:672 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:55:672 	asdu: 0900000000
09:05:55:673 APS-DATA.indication request id: 239 -> finished
09:05:55:673 APS-DATA.request id: 239 erase from queue
09:05:55:673 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:05:57:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:05:58:012 APS-DATA.request id: 251, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:05:58:013 	asdu (length: 2): 0a00
09:05:58:036 APS-DATA.confirm id: 251, status: 0x00 SUCCESS
09:05:58:036 APS-DATA.confirm request id: 251 -> confirmed, timeout 1362574
09:05:58:077 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:05:58:078 	asdu: 0a00000000
09:05:58:078 APS-DATA.indication request id: 251 -> finished
09:05:58:079 APS-DATA.request id: 251 erase from queue
09:05:58:079 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:00:412 APS-DATA.request id: 6, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:00:413 	asdu (length: 2): 0b00
09:06:00:432 APS-DATA.confirm id: 6, status: 0x00 SUCCESS
09:06:00:433 APS-DATA.confirm request id: 6 -> confirmed, timeout 1364974
09:06:00:469 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:00:470 	asdu: 0b00000000
09:06:00:470 APS-DATA.indication request id: 6 -> finished
09:06:00:470 APS-DATA.request id: 6 erase from queue
09:06:00:471 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:02:812 APS-DATA.request id: 18, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:02:813 	asdu (length: 2): 0c00
09:06:02:833 APS-DATA.confirm id: 18, status: 0x00 SUCCESS
09:06:02:833 APS-DATA.confirm request id: 18 -> confirmed, timeout 1367374
09:06:02:872 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:02:873 	asdu: 0c00000000
09:06:02:874 APS-DATA.indication request id: 18 -> finished
09:06:02:874 APS-DATA.request id: 18 erase from queue
09:06:02:874 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:05:212 APS-DATA.request id: 30, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:05:213 	asdu (length: 2): 0d00
09:06:05:230 APS-DATA.confirm id: 30, status: 0x00 SUCCESS
09:06:05:231 APS-DATA.confirm request id: 30 -> confirmed, timeout 1369774
09:06:05:269 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:05:270 	asdu: 0d00000000
09:06:05:270 APS-DATA.indication request id: 30 -> finished
09:06:05:270 APS-DATA.request id: 30 erase from queue
09:06:05:271 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:07:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:06:07:612 APS-DATA.request id: 41, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:07:613 	asdu (length: 2): 0e00
09:06:07:629 APS-DATA.confirm id: 41, status: 0x00 SUCCESS
09:06:07:630 APS-DATA.confirm request id: 41 -> confirmed, timeout 1372174
09:06:07:665 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:07:666 	asdu: 0e00000000
09:06:07:666 APS-DATA.indication request id: 41 -> finished
09:06:07:666 APS-DATA.request id: 41 erase from queue
09:06:07:667 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:07:940 APS-DATA.request id: 44, addrmode: 0x02, addr: 0xfffc, profile: 0x0000, cluster: 0x0036, ep: 0x00 -> 0x00 queue: 0 len: 3 tx.options 0x00
09:06:07:942 	asdu (length: 3): 023901
09:06:07:943 send permit join, duration: 57
09:06:07:943 APS-DATA.request id: 45, addrmode: 0x02, addr: 0xfffc, profile: 0xA1E0, cluster: 0x0021, ep: 0xF2 -> 0xF2 queue: 1 len: 6 tx.options 0x00
09:06:07:944 	asdu (length: 6): 1902020b2800
09:06:08:100 APS-DATA.confirm id: 44, status: 0xE1 
09:06:08:108 APS-DATA.confirm id: 45, status: 0xE1 
09:06:10:012 APS-DATA.request id: 55, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:10:013 	asdu (length: 2): 0f00
09:06:10:034 APS-DATA.confirm id: 55, status: 0x00 SUCCESS
09:06:10:034 APS-DATA.confirm request id: 55 -> confirmed, timeout 1374574
09:06:10:071 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:10:072 	asdu: 0f00000000
09:06:10:072 APS-DATA.indication request id: 55 -> finished
09:06:10:072 APS-DATA.request id: 55 erase from queue
09:06:10:072 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:12:412 APS-DATA.request id: 66, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:12:413 	asdu (length: 2): 1000
09:06:12:432 APS-DATA.confirm id: 66, status: 0x00 SUCCESS
09:06:12:433 APS-DATA.confirm request id: 66 -> confirmed, timeout 1376974
09:06:12:470 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:12:471 	asdu: 1000000000
09:06:12:471 APS-DATA.indication request id: 66 -> finished
09:06:12:471 APS-DATA.request id: 66 erase from queue
09:06:12:471 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:14:812 APS-DATA.request id: 78, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:14:813 	asdu (length: 2): 1100
09:06:14:833 APS-DATA.confirm id: 78, status: 0x00 SUCCESS
09:06:14:834 APS-DATA.confirm request id: 78 -> confirmed, timeout 1379374
09:06:14:872 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:14:873 	asdu: 1100000000
09:06:14:874 APS-DATA.indication request id: 78 -> finished
09:06:14:875 APS-DATA.request id: 78 erase from queue
09:06:14:875 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:16:940 Idle timer triggered
09:06:17:212 APS-DATA.request id: 90, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:17:213 	asdu (length: 2): 1200
09:06:17:236 APS-DATA.confirm id: 90, status: 0x00 SUCCESS
09:06:17:236 APS-DATA.confirm request id: 90 -> confirmed, timeout 1381774
09:06:17:269 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:17:269 	asdu: 1200000000
09:06:17:270 APS-DATA.indication request id: 90 -> finished
09:06:17:270 APS-DATA.request id: 90 erase from queue
09:06:17:270 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:17:442 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:06:17:459 Master: read param with arg 0x19
09:06:17:516 Device TTL 2916 s flags: 0x7
09:06:19:612 APS-DATA.request id: 101, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:19:613 	asdu (length: 2): 1300
09:06:19:631 APS-DATA.confirm id: 101, status: 0x00 SUCCESS
09:06:19:632 APS-DATA.confirm request id: 101 -> confirmed, timeout 1384174
09:06:19:668 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:19:669 	asdu: 1300000000
09:06:19:669 APS-DATA.indication request id: 101 -> finished
09:06:19:670 APS-DATA.request id: 101 erase from queue
09:06:19:670 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:22:013 APS-DATA.request id: 113, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:22:014 	asdu (length: 2): 1400
09:06:22:035 APS-DATA.confirm id: 113, status: 0x00 SUCCESS
09:06:22:036 APS-DATA.confirm request id: 113 -> confirmed, timeout 1386575
09:06:22:072 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:22:073 	asdu: 1400000000
09:06:22:073 APS-DATA.indication request id: 113 -> finished
09:06:22:073 APS-DATA.request id: 113 erase from queue
09:06:22:074 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:24:412 APS-DATA.request id: 124, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:24:414 	asdu (length: 2): 1500
09:06:24:434 APS-DATA.confirm id: 124, status: 0x00 SUCCESS
09:06:24:435 APS-DATA.confirm request id: 124 -> confirmed, timeout 1388975
09:06:24:469 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:24:470 	asdu: 1500000000
09:06:24:470 APS-DATA.indication request id: 124 -> finished
09:06:24:471 APS-DATA.request id: 124 erase from queue
09:06:24:471 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:26:812 APS-DATA.request id: 136, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:26:814 	asdu (length: 2): 1600
09:06:26:836 APS-DATA.confirm id: 136, status: 0x00 SUCCESS
09:06:26:837 APS-DATA.confirm request id: 136 -> confirmed, timeout 1391375
09:06:26:871 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:26:871 	asdu: 1600000000
09:06:26:872 APS-DATA.indication request id: 136 -> finished
09:06:26:872 APS-DATA.request id: 136 erase from queue
09:06:26:872 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:27:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:06:29:212 APS-DATA.request id: 148, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:29:213 	asdu (length: 2): 1700
09:06:29:233 APS-DATA.confirm id: 148, status: 0x00 SUCCESS
09:06:29:234 APS-DATA.confirm request id: 148 -> confirmed, timeout 1393774
09:06:29:273 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:29:274 	asdu: 1700000000
09:06:29:274 APS-DATA.indication request id: 148 -> finished
09:06:29:275 APS-DATA.request id: 148 erase from queue
09:06:29:275 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:31:612 APS-DATA.request id: 159, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:31:613 	asdu (length: 2): 1800
09:06:31:634 APS-DATA.confirm id: 159, status: 0x00 SUCCESS
09:06:31:636 APS-DATA.confirm request id: 159 -> confirmed, timeout 1396174
09:06:31:671 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:31:671 	asdu: 1800000000
09:06:31:672 APS-DATA.indication request id: 159 -> finished
09:06:31:672 APS-DATA.request id: 159 erase from queue
09:06:31:672 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:34:012 APS-DATA.request id: 171, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:34:014 	asdu (length: 2): 1900
09:06:34:033 APS-DATA.confirm id: 171, status: 0x00 SUCCESS
09:06:34:033 APS-DATA.confirm request id: 171 -> confirmed, timeout 1398575
09:06:34:072 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:34:072 	asdu: 1900000000
09:06:34:073 APS-DATA.indication request id: 171 -> finished
09:06:34:073 APS-DATA.request id: 171 erase from queue
09:06:34:073 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:34:082 Websocket 172.30.32.1:60828 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-10T13:06Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
09:06:34:084 Websocket 127.0.0.1:48426 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-10T13:06Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
09:06:36:412 APS-DATA.request id: 182, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:36:414 	asdu (length: 2): 1a00
09:06:36:434 APS-DATA.confirm id: 182, status: 0x00 SUCCESS
09:06:36:435 APS-DATA.confirm request id: 182 -> confirmed, timeout 1400975
09:06:36:473 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:36:474 	asdu: 1a00000000
09:06:36:474 APS-DATA.indication request id: 182 -> finished
09:06:36:474 APS-DATA.request id: 182 erase from queue
09:06:36:474 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:37:441 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:06:38:812 APS-DATA.request id: 194, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:38:813 	asdu (length: 2): 1b00
09:06:38:832 APS-DATA.confirm id: 194, status: 0x00 SUCCESS
09:06:38:832 APS-DATA.confirm request id: 194 -> confirmed, timeout 1403374
09:06:38:870 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:38:871 	asdu: 1b00000000
09:06:38:871 APS-DATA.indication request id: 194 -> finished
09:06:38:872 APS-DATA.request id: 194 erase from queue
09:06:38:872 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:41:212 APS-DATA.request id: 206, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:41:214 	asdu (length: 2): 1c00
09:06:41:236 APS-DATA.confirm id: 206, status: 0x00 SUCCESS
09:06:41:237 APS-DATA.confirm request id: 206 -> confirmed, timeout 1405775
09:06:41:274 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:41:274 	asdu: 1c00000000
09:06:41:275 APS-DATA.indication request id: 206 -> finished
09:06:41:275 APS-DATA.request id: 206 erase from queue
09:06:41:275 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:43:612 APS-DATA.request id: 217, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:43:614 	asdu (length: 2): 1d00
09:06:43:632 APS-DATA.confirm id: 217, status: 0x00 SUCCESS
09:06:43:633 APS-DATA.confirm request id: 217 -> confirmed, timeout 1408175
09:06:43:674 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:43:675 	asdu: 1d00000000
09:06:43:675 APS-DATA.indication request id: 217 -> finished
09:06:43:675 APS-DATA.request id: 217 erase from queue
09:06:43:676 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:46:012 APS-DATA.request id: 229, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:46:013 	asdu (length: 2): 1e00
09:06:46:030 APS-DATA.confirm id: 229, status: 0x00 SUCCESS
09:06:46:031 APS-DATA.confirm request id: 229 -> confirmed, timeout 1410574
09:06:46:068 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:46:069 	asdu: 1e00000000
09:06:46:069 APS-DATA.indication request id: 229 -> finished
09:06:46:070 APS-DATA.request id: 229 erase from queue
09:06:46:070 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:46:940 Idle timer triggered
09:06:47:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:06:48:412 APS-DATA.request id: 240, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:48:413 	asdu (length: 2): 1f00
09:06:48:431 APS-DATA.confirm id: 240, status: 0x00 SUCCESS
09:06:48:432 APS-DATA.confirm request id: 240 -> confirmed, timeout 1412974
09:06:48:468 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:48:468 	asdu: 1f00000000
09:06:48:469 APS-DATA.indication request id: 240 -> finished
09:06:48:469 APS-DATA.request id: 240 erase from queue
09:06:48:469 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:50:812 APS-DATA.request id: 252, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:50:813 	asdu (length: 2): 2000
09:06:50:832 APS-DATA.confirm id: 252, status: 0x00 SUCCESS
09:06:50:833 APS-DATA.confirm request id: 252 -> confirmed, timeout 1415374
09:06:50:869 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:50:870 	asdu: 2000000000
09:06:50:870 APS-DATA.indication request id: 252 -> finished
09:06:50:870 APS-DATA.request id: 252 erase from queue
09:06:50:871 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:53:212 APS-DATA.request id: 8, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:53:214 	asdu (length: 2): 2100
09:06:53:234 APS-DATA.confirm id: 8, status: 0x00 SUCCESS
09:06:53:235 APS-DATA.confirm request id: 8 -> confirmed, timeout 1417775
09:06:53:269 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:53:270 	asdu: 2100000000
09:06:53:270 APS-DATA.indication request id: 8 -> finished
09:06:53:271 APS-DATA.request id: 8 erase from queue
09:06:53:271 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:55:612 APS-DATA.request id: 19, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:55:613 	asdu (length: 2): 2200
09:06:55:636 APS-DATA.confirm id: 19, status: 0x00 SUCCESS
09:06:55:636 APS-DATA.confirm request id: 19 -> confirmed, timeout 1420174
09:06:55:669 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:55:670 	asdu: 2200000000
09:06:55:670 APS-DATA.indication request id: 19 -> finished
09:06:55:670 APS-DATA.request id: 19 erase from queue
09:06:55:670 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:06:57:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
09:06:58:012 APS-DATA.request id: 31, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:06:58:013 	asdu (length: 2): 2300
09:06:58:032 APS-DATA.confirm id: 31, status: 0x00 SUCCESS
09:06:58:033 APS-DATA.confirm request id: 31 -> confirmed, timeout 1422574
09:06:58:076 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:06:58:077 	asdu: 2300000000
09:06:58:077 APS-DATA.indication request id: 31 -> finished
09:06:58:078 APS-DATA.request id: 31 erase from queue
09:06:58:078 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:07:00:412 APS-DATA.request id: 42, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:07:00:413 	asdu (length: 2): 2400
09:07:00:434 APS-DATA.confirm id: 42, status: 0x00 SUCCESS
09:07:00:435 APS-DATA.confirm request id: 42 -> confirmed, timeout 1424974
09:07:00:477 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:07:00:478 	asdu: 2400000000
09:07:00:478 APS-DATA.indication request id: 42 -> finished
09:07:00:479 APS-DATA.request id: 42 erase from queue
09:07:00:479 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:07:02:812 APS-DATA.request id: 54, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
09:07:02:814 	asdu (length: 2): 2500
09:07:02:836 APS-DATA.confirm id: 54, status: 0x00 SUCCESS
09:07:02:837 APS-DATA.confirm request id: 54 -> confirmed, timeout 1427375
09:07:02:870 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
09:07:02:871 	asdu: 2500000000
09:07:02:871 APS-DATA.indication request id: 54 -> finished
09:07:02:871 APS-DATA.request id: 54 erase from queue
09:07:02:871 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
09:07:03:940 APS-DATA.request id: 60, addrmode: 0x02, addr: 0xfffc, profile: 0x0000, cluster: 0x0036, ep: 0x00 -> 0x00 queue: 0 len: 3 tx.options 0x00
09:07:03:942 	asdu (length: 3): 030001
09:07:03:942 send permit join, duration: 0
09:07:03:962 Search sensors done
09:07:04:096 APS-DATA.confirm id: 60, status: 0xE1

cypres422 · May 10, 2022, 1:16pm

This is the log (part 1) for a new test without the PoE+ HAT and using the official power supply.
Still using a USB3.0 extension cable plugged into a USB 2.0 port

08:49:00:324 APS-DATA.request id: 50, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:00:326 	asdu (length: 2): 7400
08:49:00:344 APS-DATA.confirm id: 50, status: 0x00 SUCCESS
08:49:00:345 APS-DATA.confirm request id: 50 -> confirmed, timeout 344887
08:49:00:381 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:00:381 	asdu: 7400000000
08:49:00:382 APS-DATA.indication request id: 50 -> finished
08:49:00:382 APS-DATA.request id: 50 erase from queue
08:49:00:382 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:02:724 APS-DATA.request id: 62, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:02:726 	asdu (length: 2): 7500
08:49:02:747 APS-DATA.confirm id: 62, status: 0x00 SUCCESS
08:49:02:748 APS-DATA.confirm request id: 62 -> confirmed, timeout 347287
08:49:02:783 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:02:784 	asdu: 7500000000
08:49:02:784 APS-DATA.indication request id: 62 -> finished
08:49:02:784 APS-DATA.request id: 62 erase from queue
08:49:02:784 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:03:440 APS-DATA.request id: 66, addrmode: 0x02, addr: 0xfffc, profile: 0x0000, cluster: 0x0036, ep: 0x00 -> 0x00 queue: 0 len: 3 tx.options 0x00
08:49:03:441 	asdu (length: 3): 044101
08:49:03:442 send permit join, duration: 65
08:49:03:443 APS-DATA.request id: 67, addrmode: 0x02, addr: 0xfffc, profile: 0xA1E0, cluster: 0x0021, ep: 0xF2 -> 0xF2 queue: 1 len: 6 tx.options 0x00
08:49:03:444 	asdu (length: 6): 1903020b2800
08:49:03:562 APS-DATA.confirm id: 66, status: 0xE1 
08:49:03:641 APS-DATA.confirm id: 67, status: 0xE1 
08:49:05:124 APS-DATA.request id: 75, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:05:125 	asdu (length: 2): 7600
08:49:05:145 APS-DATA.confirm id: 75, status: 0x00 SUCCESS
08:49:05:146 APS-DATA.confirm request id: 75 -> confirmed, timeout 349686
08:49:05:181 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:05:182 	asdu: 7600000000
08:49:05:182 APS-DATA.indication request id: 75 -> finished
08:49:05:182 APS-DATA.request id: 75 erase from queue
08:49:05:183 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:07:524 APS-DATA.request id: 87, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:07:526 	asdu (length: 2): 7700
08:49:07:545 APS-DATA.confirm id: 87, status: 0x00 SUCCESS
08:49:07:546 APS-DATA.confirm request id: 87 -> confirmed, timeout 352087
08:49:07:583 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:07:583 	asdu: 7700000000
08:49:07:584 APS-DATA.indication request id: 87 -> finished
08:49:07:584 APS-DATA.request id: 87 erase from queue
08:49:07:584 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:09:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:49:09:924 APS-DATA.request id: 98, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:09:925 	asdu (length: 2): 7800
08:49:09:945 APS-DATA.confirm id: 98, status: 0x00 SUCCESS
08:49:09:946 APS-DATA.confirm request id: 98 -> confirmed, timeout 354486
08:49:09:983 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:09:984 	asdu: 7800000000
08:49:09:984 APS-DATA.indication request id: 98 -> finished
08:49:09:984 APS-DATA.request id: 98 erase from queue
08:49:09:984 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:12:324 APS-DATA.request id: 110, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:12:325 	asdu (length: 2): 7900
08:49:12:344 APS-DATA.confirm id: 110, status: 0x00 SUCCESS
08:49:12:345 APS-DATA.confirm request id: 110 -> confirmed, timeout 356886
08:49:12:380 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:12:381 	asdu: 7900000000
08:49:12:381 APS-DATA.indication request id: 110 -> finished
08:49:12:381 APS-DATA.request id: 110 erase from queue
08:49:12:382 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:14:724 APS-DATA.request id: 122, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:14:725 	asdu (length: 2): 7a00
08:49:14:745 APS-DATA.confirm id: 122, status: 0x00 SUCCESS
08:49:14:746 APS-DATA.confirm request id: 122 -> confirmed, timeout 359286
08:49:14:784 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:14:784 	asdu: 7a00000000
08:49:14:784 APS-DATA.indication request id: 122 -> finished
08:49:14:785 APS-DATA.request id: 122 erase from queue
08:49:14:785 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:17:124 APS-DATA.request id: 133, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:17:125 	asdu (length: 2): 7b00
08:49:17:144 APS-DATA.confirm id: 133, status: 0x00 SUCCESS
08:49:17:145 APS-DATA.confirm request id: 133 -> confirmed, timeout 361686
08:49:17:182 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:17:183 	asdu: 7b00000000
08:49:17:183 APS-DATA.indication request id: 133 -> finished
08:49:17:183 APS-DATA.request id: 133 erase from queue
08:49:17:183 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:19:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:49:19:441 Idle timer triggered
08:49:19:459 Master: read param with arg 0x19
08:49:19:517 Device TTL 3234 s flags: 0x7
08:49:19:523 APS-DATA.request id: 145, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:19:524 	asdu (length: 2): 7c00
08:49:19:564 APS-DATA.confirm id: 145, status: 0x00 SUCCESS
08:49:19:565 APS-DATA.confirm request id: 145 -> confirmed, timeout 364085
08:49:19:573 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:19:574 	asdu: 7c00000000
08:49:19:575 APS-DATA.indication request id: 145 -> finished
08:49:19:576 APS-DATA.request id: 145 erase from queue
08:49:19:576 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:21:924 APS-DATA.request id: 156, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:21:925 	asdu (length: 2): 7d00
08:49:21:946 APS-DATA.confirm id: 156, status: 0x00 SUCCESS
08:49:21:946 APS-DATA.confirm request id: 156 -> confirmed, timeout 366486
08:49:21:983 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:21:983 	asdu: 7d00000000
08:49:21:984 APS-DATA.indication request id: 156 -> finished
08:49:21:984 APS-DATA.request id: 156 erase from queue
08:49:21:984 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:24:324 APS-DATA.request id: 168, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:24:326 	asdu (length: 2): 7e00
08:49:24:346 APS-DATA.confirm id: 168, status: 0x00 SUCCESS
08:49:24:347 APS-DATA.confirm request id: 168 -> confirmed, timeout 368887
08:49:24:391 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:24:392 	asdu: 7e00000000
08:49:24:392 APS-DATA.indication request id: 168 -> finished
08:49:24:393 APS-DATA.request id: 168 erase from queue
08:49:24:393 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:26:724 APS-DATA.request id: 180, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:26:725 	asdu (length: 2): 7f00
08:49:26:744 APS-DATA.confirm id: 180, status: 0x00 SUCCESS
08:49:26:745 APS-DATA.confirm request id: 180 -> confirmed, timeout 371286
08:49:26:782 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:26:783 	asdu: 7f00000000
08:49:26:783 APS-DATA.indication request id: 180 -> finished
08:49:26:784 APS-DATA.request id: 180 erase from queue
08:49:26:784 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:29:124 APS-DATA.request id: 191, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:29:126 	asdu (length: 2): 8000
08:49:29:149 APS-DATA.confirm id: 191, status: 0x00 SUCCESS
08:49:29:150 APS-DATA.confirm request id: 191 -> confirmed, timeout 373687
08:49:29:186 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:29:186 	asdu: 8000000000
08:49:29:187 APS-DATA.indication request id: 191 -> finished
08:49:29:187 APS-DATA.request id: 191 erase from queue
08:49:29:187 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:29:441 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:49:31:524 APS-DATA.request id: 203, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:31:525 	asdu (length: 2): 8100
08:49:31:544 APS-DATA.confirm id: 203, status: 0x00 SUCCESS
08:49:31:545 APS-DATA.confirm request id: 203 -> confirmed, timeout 376086
08:49:31:578 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:31:579 	asdu: 8100000000
08:49:31:579 APS-DATA.indication request id: 203 -> finished
08:49:31:579 APS-DATA.request id: 203 erase from queue
08:49:31:580 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:33:924 APS-DATA.request id: 214, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:33:926 	asdu (length: 2): 8200
08:49:33:946 APS-DATA.confirm id: 214, status: 0x00 SUCCESS
08:49:33:947 APS-DATA.confirm request id: 214 -> confirmed, timeout 378487
08:49:33:982 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:33:982 	asdu: 8200000000
08:49:33:982 APS-DATA.indication request id: 214 -> finished
08:49:33:983 APS-DATA.request id: 214 erase from queue
08:49:33:983 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:33:994 Websocket 172.30.32.1:58652 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-10T12:49Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
08:49:33:996 Websocket 127.0.0.1:46392 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-10T12:49Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
08:49:36:324 APS-DATA.request id: 226, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:36:325 	asdu (length: 2): 8300
08:49:36:347 APS-DATA.confirm id: 226, status: 0x00 SUCCESS
08:49:36:348 APS-DATA.confirm request id: 226 -> confirmed, timeout 380886
08:49:36:386 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:36:387 	asdu: 8300000000
08:49:36:387 APS-DATA.indication request id: 226 -> finished
08:49:36:387 APS-DATA.request id: 226 erase from queue
08:49:36:388 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:38:724 APS-DATA.request id: 238, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:38:725 	asdu (length: 2): 8400
08:49:38:745 APS-DATA.confirm id: 238, status: 0x00 SUCCESS
08:49:38:746 APS-DATA.confirm request id: 238 -> confirmed, timeout 383286
08:49:38:788 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:38:789 	asdu: 8400000000
08:49:38:789 APS-DATA.indication request id: 238 -> finished
08:49:38:790 APS-DATA.request id: 238 erase from queue
08:49:38:790 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:39:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:49:41:124 APS-DATA.request id: 249, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:41:126 	asdu (length: 2): 8500
08:49:41:148 APS-DATA.confirm id: 249, status: 0x00 SUCCESS
08:49:41:148 APS-DATA.confirm request id: 249 -> confirmed, timeout 385687
08:49:41:186 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:41:187 	asdu: 8500000000
08:49:41:187 APS-DATA.indication request id: 249 -> finished
08:49:41:188 APS-DATA.request id: 249 erase from queue
08:49:41:188 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:43:524 APS-DATA.request id: 5, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:43:525 	asdu (length: 2): 8600
08:49:43:544 APS-DATA.confirm id: 5, status: 0x00 SUCCESS
08:49:43:545 APS-DATA.confirm request id: 5 -> confirmed, timeout 388086
08:49:43:587 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:43:588 	asdu: 8600000000
08:49:43:588 APS-DATA.indication request id: 5 -> finished
08:49:43:588 APS-DATA.request id: 5 erase from queue
08:49:43:589 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:45:924 APS-DATA.request id: 16, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:45:925 	asdu (length: 2): 8700
08:49:45:945 APS-DATA.confirm id: 16, status: 0x00 SUCCESS
08:49:45:946 APS-DATA.confirm request id: 16 -> confirmed, timeout 390486
08:49:45:982 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:45:982 	asdu: 8700000000
08:49:45:983 APS-DATA.indication request id: 16 -> finished
08:49:45:983 APS-DATA.request id: 16 erase from queue
08:49:45:983 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:48:324 APS-DATA.request id: 28, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:48:325 	asdu (length: 2): 8800
08:49:48:346 APS-DATA.confirm id: 28, status: 0x00 SUCCESS
08:49:48:347 APS-DATA.confirm request id: 28 -> confirmed, timeout 392887
08:49:48:382 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:48:382 	asdu: 8800000000
08:49:48:383 APS-DATA.indication request id: 28 -> finished
08:49:48:383 APS-DATA.request id: 28 erase from queue
08:49:48:383 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:49:441 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:49:49:442 Idle timer triggered
08:49:50:724 APS-DATA.request id: 40, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:50:725 	asdu (length: 2): 8900
08:49:50:744 APS-DATA.confirm id: 40, status: 0x00 SUCCESS
08:49:50:745 APS-DATA.confirm request id: 40 -> confirmed, timeout 395286
08:49:50:778 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:50:779 	asdu: 8900000000
08:49:50:779 APS-DATA.indication request id: 40 -> finished
08:49:50:779 APS-DATA.request id: 40 erase from queue
08:49:50:780 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:53:124 APS-DATA.request id: 51, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:53:125 	asdu (length: 2): 8a00
08:49:53:146 APS-DATA.confirm id: 51, status: 0x00 SUCCESS
08:49:53:146 APS-DATA.confirm request id: 51 -> confirmed, timeout 397686
08:49:53:182 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:53:183 	asdu: 8a00000000
08:49:53:183 APS-DATA.indication request id: 51 -> finished
08:49:53:184 APS-DATA.request id: 51 erase from queue
08:49:53:184 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:55:524 APS-DATA.request id: 63, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:55:526 	asdu (length: 2): 8b00
08:49:55:547 APS-DATA.confirm id: 63, status: 0x00 SUCCESS
08:49:55:548 APS-DATA.confirm request id: 63 -> confirmed, timeout 400087
08:49:55:588 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:55:588 	asdu: 8b00000000
08:49:55:589 APS-DATA.indication request id: 63 -> finished
08:49:55:589 APS-DATA.request id: 63 erase from queue
08:49:55:589 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:57:924 APS-DATA.request id: 74, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:49:57:925 	asdu (length: 2): 8c00
08:49:57:945 APS-DATA.confirm id: 74, status: 0x00 SUCCESS
08:49:57:946 APS-DATA.confirm request id: 74 -> confirmed, timeout 402486
08:49:57:984 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:49:57:985 	asdu: 8c00000000
08:49:57:985 APS-DATA.indication request id: 74 -> finished
08:49:57:986 APS-DATA.request id: 74 erase from queue
08:49:57:986 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:49:59:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:50:00:324 APS-DATA.request id: 86, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:00:325 	asdu (length: 2): 8d00
08:50:00:345 APS-DATA.confirm id: 86, status: 0x00 SUCCESS
08:50:00:346 APS-DATA.confirm request id: 86 -> confirmed, timeout 404886
08:50:00:385 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:00:385 	asdu: 8d00000000
08:50:00:386 APS-DATA.indication request id: 86 -> finished
08:50:00:386 APS-DATA.request id: 86 erase from queue
08:50:00:386 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:02:725 APS-DATA.request id: 98, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:02:726 	asdu (length: 2): 8e00
08:50:02:747 APS-DATA.confirm id: 98, status: 0x00 SUCCESS
08:50:02:748 APS-DATA.confirm request id: 98 -> confirmed, timeout 407287
08:50:02:788 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:02:789 	asdu: 8e00000000
08:50:02:790 APS-DATA.indication request id: 98 -> finished
08:50:02:790 APS-DATA.request id: 98 erase from queue
08:50:02:790 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:04:440 APS-DATA.request id: 106, addrmode: 0x02, addr: 0xfffc, profile: 0x0000, cluster: 0x0036, ep: 0x00 -> 0x00 queue: 0 len: 3 tx.options 0x00
08:50:04:442 	asdu (length: 3): 054101
08:50:04:443 send permit join, duration: 65
08:50:04:445 APS-DATA.request id: 107, addrmode: 0x02, addr: 0xfffc, profile: 0xA1E0, cluster: 0x0021, ep: 0xF2 -> 0xF2 queue: 1 len: 6 tx.options 0x00
08:50:04:446 	asdu (length: 6): 1904020b2800
08:50:04:565 APS-DATA.confirm id: 107, status: 0xE1 
08:50:04:646 APS-DATA.confirm id: 106, status: 0xE1 
08:50:05:124 APS-DATA.request id: 111, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:05:126 	asdu (length: 2): 8f00
08:50:05:146 APS-DATA.confirm id: 111, status: 0x00 SUCCESS
08:50:05:147 APS-DATA.confirm request id: 111 -> confirmed, timeout 409687
08:50:05:185 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:05:186 	asdu: 8f00000000
08:50:05:186 APS-DATA.indication request id: 111 -> finished
08:50:05:186 APS-DATA.request id: 111 erase from queue
08:50:05:187 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:07:524 APS-DATA.request id: 123, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:07:525 	asdu (length: 2): 9000
08:50:07:548 APS-DATA.confirm id: 123, status: 0x00 SUCCESS
08:50:07:549 APS-DATA.confirm request id: 123 -> confirmed, timeout 412086
08:50:07:583 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:07:583 	asdu: 9000000000
08:50:07:584 APS-DATA.indication request id: 123 -> finished
08:50:07:584 APS-DATA.request id: 123 erase from queue
08:50:07:584 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:09:441 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:50:09:924 APS-DATA.request id: 134, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:09:925 	asdu (length: 2): 9100
08:50:09:944 APS-DATA.confirm id: 134, status: 0x00 SUCCESS
08:50:09:945 APS-DATA.confirm request id: 134 -> confirmed, timeout 414486
08:50:09:981 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:09:982 	asdu: 9100000000
08:50:09:982 APS-DATA.indication request id: 134 -> finished
08:50:09:982 APS-DATA.request id: 134 erase from queue
08:50:09:982 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:12:324 APS-DATA.request id: 146, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:12:325 	asdu (length: 2): 9200
08:50:12:345 APS-DATA.confirm id: 146, status: 0x00 SUCCESS
08:50:12:346 APS-DATA.confirm request id: 146 -> confirmed, timeout 416886
08:50:12:382 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:12:383 	asdu: 9200000000
08:50:12:384 APS-DATA.indication request id: 146 -> finished
08:50:12:384 APS-DATA.request id: 146 erase from queue
08:50:12:385 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:14:724 APS-DATA.request id: 158, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:14:725 	asdu (length: 2): 9300
08:50:14:746 APS-DATA.confirm id: 158, status: 0x00 SUCCESS
08:50:14:747 APS-DATA.confirm request id: 158 -> confirmed, timeout 419286
08:50:14:782 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:14:782 	asdu: 9300000000
08:50:14:783 APS-DATA.indication request id: 158 -> finished
08:50:14:783 APS-DATA.request id: 158 erase from queue
08:50:14:784 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:17:124 APS-DATA.request id: 169, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:17:125 	asdu (length: 2): 9400
08:50:17:146 APS-DATA.confirm id: 169, status: 0x00 SUCCESS
08:50:17:147 APS-DATA.confirm request id: 169 -> confirmed, timeout 421686
08:50:17:183 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:17:184 	asdu: 9400000000
08:50:17:184 APS-DATA.indication request id: 169 -> finished
08:50:17:184 APS-DATA.request id: 169 erase from queue
08:50:17:185 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:19:443 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:50:19:444 sql exec SELECT conf FROM zbconf ORDER BY rowid desc limit 1
08:50:19:445 Idle timer triggered
08:50:19:468 Master: read param with arg 0x19
08:50:19:524 APS-DATA.request id: 181, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:19:525 	asdu (length: 2): 9500
08:50:19:535 Device TTL 3174 s flags: 0x7
08:50:19:583 APS-DATA.confirm id: 181, status: 0x00 SUCCESS
08:50:19:584 APS-DATA.confirm request id: 181 -> confirmed, timeout 424086
08:50:19:592 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:19:594 	asdu: 9500000000
08:50:19:594 APS-DATA.indication request id: 181 -> finished
08:50:19:595 APS-DATA.request id: 181 erase from queue
08:50:19:596 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:21:924 APS-DATA.request id: 192, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:21:924 	asdu (length: 2): 9600
08:50:21:942 APS-DATA.confirm id: 192, status: 0x00 SUCCESS
08:50:21:943 APS-DATA.confirm request id: 192 -> confirmed, timeout 426485
08:50:21:983 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:21:984 	asdu: 9600000000
08:50:21:984 APS-DATA.indication request id: 192 -> finished
08:50:21:984 APS-DATA.request id: 192 erase from queue
08:50:21:984 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:24:324 APS-DATA.request id: 204, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:24:325 	asdu (length: 2): 9700
08:50:24:346 APS-DATA.confirm id: 204, status: 0x00 SUCCESS
08:50:24:347 APS-DATA.confirm request id: 204 -> confirmed, timeout 428886
08:50:24:383 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:24:384 	asdu: 9700000000
08:50:24:384 APS-DATA.indication request id: 204 -> finished
08:50:24:384 APS-DATA.request id: 204 erase from queue
08:50:24:385 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:26:724 APS-DATA.request id: 216, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:26:725 	asdu (length: 2): 9800
08:50:26:744 APS-DATA.confirm id: 216, status: 0x00 SUCCESS
08:50:26:745 APS-DATA.confirm request id: 216 -> confirmed, timeout 431286
08:50:26:783 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:26:783 	asdu: 9800000000
08:50:26:784 APS-DATA.indication request id: 216 -> finished
08:50:26:784 APS-DATA.request id: 216 erase from queue
08:50:26:784 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:29:124 APS-DATA.request id: 227, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:29:126 	asdu (length: 2): 9900
08:50:29:147 APS-DATA.confirm id: 227, status: 0x00 SUCCESS
08:50:29:149 APS-DATA.confirm request id: 227 -> confirmed, timeout 433687
08:50:29:183 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:29:184 	asdu: 9900000000
08:50:29:184 APS-DATA.indication request id: 227 -> finished
08:50:29:184 APS-DATA.request id: 227 erase from queue
08:50:29:184 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:29:441 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0

cypres422 · May 10, 2022, 1:16pm

part 2

08:50:31:525 APS-DATA.request id: 239, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:31:526 	asdu (length: 2): 9a00
08:50:31:546 APS-DATA.confirm id: 239, status: 0x00 SUCCESS
08:50:31:547 APS-DATA.confirm request id: 239 -> confirmed, timeout 436087
08:50:31:583 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:31:584 	asdu: 9a00000000
08:50:31:584 APS-DATA.indication request id: 239 -> finished
08:50:31:585 APS-DATA.request id: 239 erase from queue
08:50:31:585 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:33:924 APS-DATA.request id: 250, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:33:925 	asdu (length: 2): 9b00
08:50:33:945 APS-DATA.confirm id: 250, status: 0x00 SUCCESS
08:50:33:946 APS-DATA.confirm request id: 250 -> confirmed, timeout 438486
08:50:33:982 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:33:983 	asdu: 9b00000000
08:50:33:983 APS-DATA.indication request id: 250 -> finished
08:50:33:983 APS-DATA.request id: 250 erase from queue
08:50:33:983 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:33:997 Websocket 172.30.32.1:58652 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-10T12:50Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
08:50:33:998 Websocket 127.0.0.1:46392 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-10T12:50Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
08:50:36:324 APS-DATA.request id: 6, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:36:325 	asdu (length: 2): 9c00
08:50:36:347 APS-DATA.confirm id: 6, status: 0x00 SUCCESS
08:50:36:348 APS-DATA.confirm request id: 6 -> confirmed, timeout 440886
08:50:36:385 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:36:386 	asdu: 9c00000000
08:50:36:386 APS-DATA.indication request id: 6 -> finished
08:50:36:386 APS-DATA.request id: 6 erase from queue
08:50:36:386 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:38:724 APS-DATA.request id: 18, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:38:726 	asdu (length: 2): 9d00
08:50:38:744 APS-DATA.confirm id: 18, status: 0x00 SUCCESS
08:50:38:745 APS-DATA.confirm request id: 18 -> confirmed, timeout 443287
08:50:38:785 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:38:785 	asdu: 9d00000000
08:50:38:786 APS-DATA.indication request id: 18 -> finished
08:50:38:786 APS-DATA.request id: 18 erase from queue
08:50:38:786 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:39:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:50:41:124 APS-DATA.request id: 29, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:41:126 	asdu (length: 2): 9e00
08:50:41:146 APS-DATA.confirm id: 29, status: 0x00 SUCCESS
08:50:41:147 APS-DATA.confirm request id: 29 -> confirmed, timeout 445687
08:50:41:185 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:41:186 	asdu: 9e00000000
08:50:41:186 APS-DATA.indication request id: 29 -> finished
08:50:41:186 APS-DATA.request id: 29 erase from queue
08:50:41:186 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:43:524 APS-DATA.request id: 41, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:43:525 	asdu (length: 2): 9f00
08:50:43:547 APS-DATA.confirm id: 41, status: 0x00 SUCCESS
08:50:43:549 APS-DATA.confirm request id: 41 -> confirmed, timeout 448086
08:50:43:588 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:43:589 	asdu: 9f00000000
08:50:43:590 APS-DATA.indication request id: 41 -> finished
08:50:43:590 APS-DATA.request id: 41 erase from queue
08:50:43:590 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:45:924 APS-DATA.request id: 52, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:45:925 	asdu (length: 2): a000
08:50:45:944 APS-DATA.confirm id: 52, status: 0x00 SUCCESS
08:50:45:945 APS-DATA.confirm request id: 52 -> confirmed, timeout 450486
08:50:45:980 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:45:980 	asdu: a000000000
08:50:45:981 APS-DATA.indication request id: 52 -> finished
08:50:45:981 APS-DATA.request id: 52 erase from queue
08:50:45:981 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:48:324 APS-DATA.request id: 64, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:48:325 	asdu (length: 2): a100
08:50:48:346 APS-DATA.confirm id: 64, status: 0x00 SUCCESS
08:50:48:347 APS-DATA.confirm request id: 64 -> confirmed, timeout 452886
08:50:48:386 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:48:387 	asdu: a100000000
08:50:48:387 APS-DATA.indication request id: 64 -> finished
08:50:48:387 APS-DATA.request id: 64 erase from queue
08:50:48:388 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:49:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:50:49:442 Idle timer triggered
08:50:50:724 APS-DATA.request id: 76, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:50:725 	asdu (length: 2): a200
08:50:50:743 APS-DATA.confirm id: 76, status: 0x00 SUCCESS
08:50:50:744 APS-DATA.confirm request id: 76 -> confirmed, timeout 455286
08:50:50:781 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:50:782 	asdu: a200000000
08:50:50:782 APS-DATA.indication request id: 76 -> finished
08:50:50:783 APS-DATA.request id: 76 erase from queue
08:50:50:783 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:53:124 APS-DATA.request id: 87, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:53:125 	asdu (length: 2): a300
08:50:53:148 APS-DATA.confirm id: 87, status: 0x00 SUCCESS
08:50:53:148 APS-DATA.confirm request id: 87 -> confirmed, timeout 457686
08:50:53:181 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:53:181 	asdu: a300000000
08:50:53:182 APS-DATA.indication request id: 87 -> finished
08:50:53:182 APS-DATA.request id: 87 erase from queue
08:50:53:182 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:55:524 APS-DATA.request id: 99, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:55:525 	asdu (length: 2): a400
08:50:55:546 APS-DATA.confirm id: 99, status: 0x00 SUCCESS
08:50:55:547 APS-DATA.confirm request id: 99 -> confirmed, timeout 460086
08:50:55:579 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:55:580 	asdu: a400000000
08:50:55:580 APS-DATA.indication request id: 99 -> finished
08:50:55:581 APS-DATA.request id: 99 erase from queue
08:50:55:581 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:57:924 APS-DATA.request id: 110, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:50:57:926 	asdu (length: 2): a500
08:50:57:944 APS-DATA.confirm id: 110, status: 0x00 SUCCESS
08:50:57:945 APS-DATA.confirm request id: 110 -> confirmed, timeout 462487
08:50:57:982 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:50:57:983 	asdu: a500000000
08:50:57:984 APS-DATA.indication request id: 110 -> finished
08:50:57:984 APS-DATA.request id: 110 erase from queue
08:50:57:984 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:50:59:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:51:00:324 APS-DATA.request id: 122, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:00:325 	asdu (length: 2): a600
08:51:00:347 APS-DATA.confirm id: 122, status: 0x00 SUCCESS
08:51:00:348 APS-DATA.confirm request id: 122 -> confirmed, timeout 464886
08:51:00:386 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:00:386 	asdu: a600000000
08:51:00:387 APS-DATA.indication request id: 122 -> finished
08:51:00:387 APS-DATA.request id: 122 erase from queue
08:51:00:387 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:02:724 APS-DATA.request id: 134, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:02:726 	asdu (length: 2): a700
08:51:02:745 APS-DATA.confirm id: 134, status: 0x00 SUCCESS
08:51:02:746 APS-DATA.confirm request id: 134 -> confirmed, timeout 467287
08:51:02:788 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:02:789 	asdu: a700000000
08:51:02:789 APS-DATA.indication request id: 134 -> finished
08:51:02:789 APS-DATA.request id: 134 erase from queue
08:51:02:790 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:05:124 APS-DATA.request id: 145, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:05:125 	asdu (length: 2): a800
08:51:05:146 APS-DATA.confirm id: 145, status: 0x00 SUCCESS
08:51:05:146 APS-DATA.confirm request id: 145 -> confirmed, timeout 469686
08:51:05:188 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:05:188 	asdu: a800000000
08:51:05:189 APS-DATA.indication request id: 145 -> finished
08:51:05:189 APS-DATA.request id: 145 erase from queue
08:51:05:190 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:05:440 APS-DATA.request id: 148, addrmode: 0x02, addr: 0xfffc, profile: 0x0000, cluster: 0x0036, ep: 0x00 -> 0x00 queue: 0 len: 3 tx.options 0x00
08:51:05:442 	asdu (length: 3): 063901
08:51:05:442 send permit join, duration: 57
08:51:05:443 APS-DATA.request id: 149, addrmode: 0x02, addr: 0xfffc, profile: 0xA1E0, cluster: 0x0021, ep: 0xF2 -> 0xF2 queue: 1 len: 6 tx.options 0x00
08:51:05:444 	asdu (length: 6): 1905020b2800
08:51:05:643 APS-DATA.confirm id: 148, status: 0xE1 
08:51:05:651 APS-DATA.confirm id: 149, status: 0xE1 
08:51:07:524 APS-DATA.request id: 159, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:07:525 	asdu (length: 2): a900
08:51:07:545 APS-DATA.confirm id: 159, status: 0x00 SUCCESS
08:51:07:546 APS-DATA.confirm request id: 159 -> confirmed, timeout 472086
08:51:07:583 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:07:584 	asdu: a900000000
08:51:07:584 APS-DATA.indication request id: 159 -> finished
08:51:07:584 APS-DATA.request id: 159 erase from queue
08:51:07:584 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:09:441 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:51:09:924 APS-DATA.request id: 170, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:09:926 	asdu (length: 2): aa00
08:51:09:946 APS-DATA.confirm id: 170, status: 0x00 SUCCESS
08:51:09:947 APS-DATA.confirm request id: 170 -> confirmed, timeout 474487
08:51:09:981 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:09:982 	asdu: aa00000000
08:51:09:982 APS-DATA.indication request id: 170 -> finished
08:51:09:983 APS-DATA.request id: 170 erase from queue
08:51:09:983 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:12:324 APS-DATA.request id: 182, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:12:326 	asdu (length: 2): ab00
08:51:12:349 APS-DATA.confirm id: 182, status: 0x00 SUCCESS
08:51:12:350 APS-DATA.confirm request id: 182 -> confirmed, timeout 476887
08:51:12:384 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:12:385 	asdu: ab00000000
08:51:12:385 APS-DATA.indication request id: 182 -> finished
08:51:12:385 APS-DATA.request id: 182 erase from queue
08:51:12:385 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:14:724 APS-DATA.request id: 194, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:14:725 	asdu (length: 2): ac00
08:51:14:750 APS-DATA.confirm id: 194, status: 0x00 SUCCESS
08:51:14:751 APS-DATA.confirm request id: 194 -> confirmed, timeout 479287
08:51:14:785 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:14:786 	asdu: ac00000000
08:51:14:786 APS-DATA.indication request id: 194 -> finished
08:51:14:786 APS-DATA.request id: 194 erase from queue
08:51:14:786 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:17:124 APS-DATA.request id: 205, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:17:126 	asdu (length: 2): ad00
08:51:17:146 APS-DATA.confirm id: 205, status: 0x00 SUCCESS
08:51:17:147 APS-DATA.confirm request id: 205 -> confirmed, timeout 481687
08:51:17:186 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:17:186 	asdu: ad00000000
08:51:17:186 APS-DATA.indication request id: 205 -> finished
08:51:17:187 APS-DATA.request id: 205 erase from queue
08:51:17:187 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:19:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:51:19:441 Idle timer triggered
08:51:19:463 Master: read param with arg 0x19
08:51:19:515 Device TTL 3114 s flags: 0x7
08:51:19:524 APS-DATA.request id: 217, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:19:525 	asdu (length: 2): ae00
08:51:19:569 APS-DATA.confirm id: 217, status: 0x00 SUCCESS
08:51:19:570 APS-DATA.confirm request id: 217 -> confirmed, timeout 484086
08:51:19:577 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:19:578 	asdu: ae00000000
08:51:19:578 APS-DATA.indication request id: 217 -> finished
08:51:19:579 APS-DATA.request id: 217 erase from queue
08:51:19:579 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:21:924 APS-DATA.request id: 228, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:21:926 	asdu (length: 2): af00
08:51:21:946 APS-DATA.confirm id: 228, status: 0x00 SUCCESS
08:51:21:947 APS-DATA.confirm request id: 228 -> confirmed, timeout 486487
08:51:21:984 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:21:985 	asdu: af00000000
08:51:21:986 APS-DATA.indication request id: 228 -> finished
08:51:21:986 APS-DATA.request id: 228 erase from queue
08:51:21:986 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:24:324 APS-DATA.request id: 240, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:24:325 	asdu (length: 2): b000
08:51:24:346 APS-DATA.confirm id: 240, status: 0x00 SUCCESS
08:51:24:347 APS-DATA.confirm request id: 240 -> confirmed, timeout 488886
08:51:24:381 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:24:382 	asdu: b000000000
08:51:24:382 APS-DATA.indication request id: 240 -> finished
08:51:24:383 APS-DATA.request id: 240 erase from queue
08:51:24:383 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:26:724 APS-DATA.request id: 252, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:26:725 	asdu (length: 2): b100
08:51:26:745 APS-DATA.confirm id: 252, status: 0x00 SUCCESS
08:51:26:746 APS-DATA.confirm request id: 252 -> confirmed, timeout 491286
08:51:26:781 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:26:782 	asdu: b100000000
08:51:26:782 APS-DATA.indication request id: 252 -> finished
08:51:26:782 APS-DATA.request id: 252 erase from queue
08:51:26:782 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:29:124 APS-DATA.request id: 7, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:29:125 	asdu (length: 2): b200
08:51:29:146 APS-DATA.confirm id: 7, status: 0x00 SUCCESS
08:51:29:147 APS-DATA.confirm request id: 7 -> confirmed, timeout 493686
08:51:29:181 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:29:182 	asdu: b200000000
08:51:29:182 APS-DATA.indication request id: 7 -> finished
08:51:29:182 APS-DATA.request id: 7 erase from queue
08:51:29:183 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:29:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:51:31:524 APS-DATA.request id: 19, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:31:525 	asdu (length: 2): b300
08:51:31:544 APS-DATA.confirm id: 19, status: 0x00 SUCCESS
08:51:31:545 APS-DATA.confirm request id: 19 -> confirmed, timeout 496086
08:51:31:583 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:31:584 	asdu: b300000000
08:51:31:585 APS-DATA.indication request id: 19 -> finished
08:51:31:585 APS-DATA.request id: 19 erase from queue
08:51:31:585 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:33:924 APS-DATA.request id: 30, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:33:926 	asdu (length: 2): b400
08:51:33:948 APS-DATA.confirm id: 30, status: 0x00 SUCCESS
08:51:33:949 APS-DATA.confirm request id: 30 -> confirmed, timeout 498487
08:51:33:983 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:33:984 	asdu: b400000000
08:51:33:984 APS-DATA.indication request id: 30 -> finished
08:51:33:984 APS-DATA.request id: 30 erase from queue
08:51:33:985 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:33:996 Websocket 172.30.32.1:58652 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-10T12:51Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
08:51:33:998 Websocket 127.0.0.1:46392 send message: {"attr":{"id":"1","lastannounced":null,"lastseen":"2022-05-10T12:51Z","manufacturername":"dresden elektronik","modelid":"ConBee II","name":"Configuration tool 1","swversion":"0x26720700","type":"Configuration tool","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"},"e":"changed","id":"1","r":"lights","t":"event","uniqueid":"00:21:2e:ff:ff:07:d3:c3-01"} (ret = 344)
08:51:36:324 APS-DATA.request id: 42, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:36:326 	asdu (length: 2): b500
08:51:36:347 APS-DATA.confirm id: 42, status: 0x00 SUCCESS
08:51:36:348 APS-DATA.confirm request id: 42 -> confirmed, timeout 500887
08:51:36:387 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:36:388 	asdu: b500000000
08:51:36:388 APS-DATA.indication request id: 42 -> finished
08:51:36:389 APS-DATA.request id: 42 erase from queue
08:51:36:389 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:38:724 APS-DATA.request id: 54, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:38:725 	asdu (length: 2): b600
08:51:38:745 APS-DATA.confirm id: 54, status: 0x00 SUCCESS
08:51:38:746 APS-DATA.confirm request id: 54 -> confirmed, timeout 503286
08:51:38:784 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:38:785 	asdu: b600000000
08:51:38:785 APS-DATA.indication request id: 54 -> finished
08:51:38:785 APS-DATA.request id: 54 erase from queue
08:51:38:786 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:39:441 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:51:41:124 APS-DATA.request id: 65, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:41:125 	asdu (length: 2): b700
08:51:41:145 APS-DATA.confirm id: 65, status: 0x00 SUCCESS
08:51:41:146 APS-DATA.confirm request id: 65 -> confirmed, timeout 505686
08:51:41:186 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:41:187 	asdu: b700000000
08:51:41:187 APS-DATA.indication request id: 65 -> finished
08:51:41:187 APS-DATA.request id: 65 erase from queue
08:51:41:188 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:43:524 APS-DATA.request id: 77, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:43:526 	asdu (length: 2): b800
08:51:43:551 APS-DATA.confirm id: 77, status: 0x00 SUCCESS
08:51:43:552 APS-DATA.confirm request id: 77 -> confirmed, timeout 508087
08:51:43:586 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:43:587 	asdu: b800000000
08:51:43:587 APS-DATA.indication request id: 77 -> finished
08:51:43:588 APS-DATA.request id: 77 erase from queue
08:51:43:588 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:45:924 APS-DATA.request id: 88, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:45:925 	asdu (length: 2): b900
08:51:45:946 APS-DATA.confirm id: 88, status: 0x00 SUCCESS
08:51:45:947 APS-DATA.confirm request id: 88 -> confirmed, timeout 510486
08:51:45:988 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:45:989 	asdu: b900000000
08:51:45:989 APS-DATA.indication request id: 88 -> finished
08:51:45:989 APS-DATA.request id: 88 erase from queue
08:51:45:990 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:48:324 APS-DATA.request id: 100, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:48:325 	asdu (length: 2): ba00
08:51:48:347 APS-DATA.confirm id: 100, status: 0x00 SUCCESS
08:51:48:348 APS-DATA.confirm request id: 100 -> confirmed, timeout 512886
08:51:48:382 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:48:383 	asdu: ba00000000
08:51:48:383 APS-DATA.indication request id: 100 -> finished
08:51:48:384 APS-DATA.request id: 100 erase from queue
08:51:48:384 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:49:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:51:49:441 sql exec SELECT conf FROM zbconf ORDER BY rowid desc limit 1
08:51:49:442 Idle timer triggered
08:51:50:724 APS-DATA.request id: 112, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:50:726 	asdu (length: 2): bb00
08:51:50:746 APS-DATA.confirm id: 112, status: 0x00 SUCCESS
08:51:50:746 APS-DATA.confirm request id: 112 -> confirmed, timeout 515287
08:51:50:784 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:50:784 	asdu: bb00000000
08:51:50:785 APS-DATA.indication request id: 112 -> finished
08:51:50:785 APS-DATA.request id: 112 erase from queue
08:51:50:785 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:53:124 APS-DATA.request id: 123, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:53:126 	asdu (length: 2): bc00
08:51:53:146 APS-DATA.confirm id: 123, status: 0x00 SUCCESS
08:51:53:147 APS-DATA.confirm request id: 123 -> confirmed, timeout 517687
08:51:53:185 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:53:186 	asdu: bc00000000
08:51:53:186 APS-DATA.indication request id: 123 -> finished
08:51:53:186 APS-DATA.request id: 123 erase from queue
08:51:53:187 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:55:524 APS-DATA.request id: 135, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:55:525 	asdu (length: 2): bd00
08:51:55:545 APS-DATA.confirm id: 135, status: 0x00 SUCCESS
08:51:55:546 APS-DATA.confirm request id: 135 -> confirmed, timeout 520086
08:51:55:580 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:55:582 	asdu: bd00000000
08:51:55:582 APS-DATA.indication request id: 135 -> finished
08:51:55:583 APS-DATA.request id: 135 erase from queue
08:51:55:583 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:57:924 APS-DATA.request id: 146, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:51:57:925 	asdu (length: 2): be00
08:51:57:944 APS-DATA.confirm id: 146, status: 0x00 SUCCESS
08:51:57:945 APS-DATA.confirm request id: 146 -> confirmed, timeout 522486
08:51:57:982 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:51:57:983 	asdu: be00000000
08:51:57:983 APS-DATA.indication request id: 146 -> finished
08:51:57:984 APS-DATA.request id: 146 erase from queue
08:51:57:984 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:51:59:440 Daylight now: goldenHour1, status: 160, daylight: 1, dark: 0
08:52:00:324 APS-DATA.request id: 158, addrmode: 0x03, addr: 0x00212effff07d3c3, profile: 0x0000, cluster: 0x0031, ep: 0x00 -> 0x00 queue: 0 len: 2 tx.options 0x00
08:52:00:325 	asdu (length: 2): bf00
08:52:00:344 APS-DATA.confirm id: 158, status: 0x00 SUCCESS
08:52:00:345 APS-DATA.confirm request id: 158 -> confirmed, timeout 524886
08:52:00:382 APS-DATA.indication srcAddr: 0x0000, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 221, rssi: 30
08:52:00:383 	asdu: bf00000000
08:52:00:384 APS-DATA.indication request id: 158 -> finished
08:52:00:384 APS-DATA.request id: 158 erase from queue
08:52:00:384 void deCONZ::zmNode::setFetched(deCONZ::RequestId, bool) fetched item: 8, node: 0x0000
08:52:02:075 Search sensors done

Mimiix · May 10, 2022, 2:42pm

Can you please:

Make a log while trying to pair the device
Make sure to use the log levels
Use Pastebin to post the logs. That way it is way easier to read.

What i do notice: There’s still interference issues in there. This probably have to do with the SSD.

Thanks!

Smanar · May 10, 2022, 2:47pm

Hello can you take a look on the GUI ?
And show your setting inside it ? Can compare it with this one Network lost and configuration restore does not help · dresden-elektronik/deconz-rest-plugin Wiki · GitHub

Mimiix · May 10, 2022, 2:49pm

The logs still contain 0xE1 = Interference and they don’t seem to have any communication other than the Conbee’s MAC. So i think it isn’t showing in deCONZ.

cypres422 · May 10, 2022, 3:39pm

All those logs were made during pairing process.
I used the following log level: INFO, INFO_L2, ERROR, ERROR_L2, APS, APS_L2

Here are the links to the 3 logs:
Initial test (with PoE and USB extension cable): Initial - Pastebin.com
No PoE+: No POE - Pastebin.com
No cable: No USB Cable - Pastebin.com

Smanar · May 10, 2022, 4:16pm

But wich ones flags are you using on your debug ? (“info” “info_l2” “error” “error_l2”, “aps”)
Because I don’t see anything special, and have skipped the Mimixx error message. Have you tried with the SSD on the extension cable ?

It’s normal NWK EXT PAN ID is still 0x000000000000 ?

Mimiix · May 10, 2022, 4:21pm

Log levels and settings are good! @smanar: EXT PAN ID should be that, otherwise, logs would spam.

The common factor is the Interference. All logs show a 0xE1 right after permitting join:

09:04:05:942 send permit join, duration: 65 
09:04:05:943 APS-DATA.request id: 219, addrmode: 0x02, addr: 0xfffc, profile: 0xA1E0, cluster: 0x0021, ep: 0xF2 -> 0xF2 queue: 1 len: 6 tx.options 0x00 
09:04:05:944 	asdu (length: 6): 1900020b2800 
09:04:06:069 APS-DATA.confirm id: 219, status: 0xE1 
09:04:06:100 APS-DATA.confirm id: 218, status: 0xE1

All logs have that,. That means that the SSD is probably causing hte inteference. Can you put the SSD on a USB 2.0 port and see if it changes then?

cypres422 · May 10, 2022, 6:36pm

Same results. I can see the 0xE1 entries in the logs.
The SSD was always on a 6 inches usb extension cable.
the 2nd log below both the Conbee2 and the SSD was using 12 inches extension cables, and apart of each other so approx. 24 inches apart.

ssd on usb2: SSD on USB2 - Pastebin.com
ssd & Conbee with extension cables on usb2: SSD and Conbee on extension cable - Pastebin.com

Mimiix · May 10, 2022, 6:57pm

Nothing is seen at all. As long as the 0xE1 is there and there’s no presence of New Node log lines, that’;s the suspect.

Are the conbee and ssd both on USB 2? if not, try that. Otherwise, you need to figure out a way to isolate the inteference.

cypres422 · May 10, 2022, 7:33pm

Yes, both ConBee and SSD was on USB2…
I removed the SSD and use a brand new install on SD-Card… voilà, it work!

logs using sd-card: SD Card - Pastebin.com