Zigbee devices on Conbee 2 with Phoscon in Home Assistant not responding

deCONZ General Support
1

whats the issue:

  • Home Assistant and the Phoscon app within HA stopped communicating with connected Zigbee devices

  • Conbee 2 was set to Zigbee channel 15, but wifi channel 2 in use with neighbours, therefore possible RF interference. Other wifi channels I see are 1, 6 and 11, so those should not interfere (see ZigBee and Wi-Fi Coexistence | MetaGeek)

  • I suspected RF interference from wifi channel 2, therefore changed Zigbee channel to 25 on Deconz/Phoscon (with Deconz, leave → join)

  • pairing worked sometimes, but when trying to turn off light, they blink

  • Also use ZHA on Zigbee channel 20 (Sky Connect)

  • Did a fresh reinstall of Deconz Addon and Deconz Integration in Home Assistant

  • seemed to work; light bulbs and switches paired to Conbee 2 in Phoscon

  • Next morning lights did not respond to switch or blinked, even though switch is still in Phoscon and not grey. Light are also still visible and do seem to respond to changes in Phoscon. The next day the blinking of light bulbs when trying to turn them off was back.

  • Conbee 2 with Deconz addon and Phoscon was working for years on 1 meter extension usb cable

  • Installed SSD connected to usb 3 port, but Conbee 2 continued working for many months since

  • Because I was able to reinstall Deconz in home Assistant and Phoscon could pair light bulbs, there does not seem to be a hardware faillure.

  • The blinking suggests to me the Conbee 2 and the Zigbee device cannot communicate properly

  • Phoscon Firmware 26720700, version 2.22.02 / 19-9-2022

  • Expected behaviour: successful pairing and being able to reed status of sensors and to be able to turn lights on/off and dim them.

  • What could be causing this issue? Is it hardware, RF interference or software? What can be done about it?

2

Moved to the correct category.

Lets start from the bottom: Can you share some logs?

In How to get logs? you can find out how. Please use Pastebin when sharing./

3

Forgive me for the noob question.

I’ve downloaded UtraVNC viewer. What server:port do I enter? I’ve tried myHAadress.duckdns.org: 5900 (the IP adres of my HA instance and then :5900), but that didn’t work.
In Home Assistant Add-on I did enter 5900 as port for VNC connection.

After that, how do I get the debug view logs, or willt hat show up immediately?

4

I believe you need to use the internal IP, instead of the duckdns.

In the VNC, you can access help>debug logs (as my post i linked before describes).

5

Yes, thank you! That worked. This is just a few small sections of the debug view log:

17:34:58:514 aps request id: 23 finished, erase from queue
17:34:58:914 poll node 00:17:88:01:09:9a:ea:07-0b
17:34:58:915 Poll light node Woonkamer filament staande lamp
17:34:58:916 Idle timer triggered
17:34:58:918 Force binding of attribute reporting for node Maud en Ramon Hue Dimmer Switch
17:34:58:919 read attributes of 0x00178801099AEA07 cluster: 0x0006: [
17:34:58:920 0x0000
17:34:58:921 ]

17:34:59:362 asdu: 183e010000001000
17:34:59:913 poll node 00:15:8d:00:07:36:6f:79-01
17:34:59:914 Poll light node Woonkamer INNR lamp eetkamer
17:34:59:916 Idle timer triggered
17:34:59:917 Force binding of attribute reporting for node Maud en Ramon Hue Dimmer Switch
17:35:00:167 read attributes of 0x00158D0007366F79 cluster: 0x0006: [
17:35:00:168 0x0000
17:35:00:170 ]
17:35:00:171 add task 52406 type 19 to 0x00158D0007366F79 cluster 0x0006 req.id 38
17:35:00:171 Poll APS request 38 to 0x00158D0007366F79 cluster: 0x0006
17:35:00:213 APS-DATA.request id: 38, addrmode: 0x03, addr: 0x00158d0007366f79, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x00
17:35:00:215 asdu (length: 5): 103f000000

17:35:08:050 APS-DATA.confirm id: 112, status: 0x00 SUCCESS
17:35:08:051 APS-DATA.confirm request id: 112 → confirmed, timeout 1367521093
17:35:08:122 APS-DATA.indication srcAddr: 0x2bfc, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 255, rssi: -65
17:35:08:123 asdu: 89000503026f7406ffff2e2100040323feffac33bc647825020f606f7406ffff2e210007ea9a0901881700c57b25020f34
17:35:08:125 APS-DATA.indication request id: 112 → finished
17:35:08:126 APS-DATA.request id: 112 erase from queue
17:35:08:512 poll node 00:15:8d:00:07:36:6f:79-01
17:35:08:514 Poll light node Woonkamer INNR lamp eetkamer
17:35:08:563 read attributes of 0x00158D0007366F79 cluster: 0x0006: [
17:35:08:564 0x0000
17:35:08:564 ]

17:35:09:913 Wait 2s till query finished
17:35:09:915 APS-DATA.request id: 128, addrmode: 0x03, addr: 0x00178801099aea07, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x0B queue: 0 len: 5 tx.options 0x00
17:35:09:916 asdu (length: 5): 104c000000
17:35:09:985 APS-DATA.request id: 130, addrmode: 0x03, addr: 0xbc33acfffe230304, profile: 0x0104, cluster: 0x0008, ep: 0x01 → 0x01 queue: 1 len: 5 tx.options 0x00
17:35:09:986 asdu (length: 5): 104d000000
17:35:10:032 Poll APS confirm 128 status: 0x00
17:35:10:033 Erase task req-id: 128, type: 19 zcl seqno: 76 send time 0, profileId: 0x0104, clusterId: 0x0006
17:35:10:034 APS-DATA.confirm id: 128, status: 0x00 SUCCESS
17:35:10:034 APS-DATA.confirm request id: 128 → erase from queue
17:35:10:035 APS-DATA.indication srcAddr: 0x7bc5, srcEp: 0x0B dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -43
17:35:10:036 asdu: 184c010000001000
17:35:10:036 APS-DATA.request id: 128 erase from queue
17:35:10:037 Node data 0x00178801099aea07 profileId: 0x0104, clusterId: 0x0006
17:35:10:037 0x00178801099AEA07: update ZCL value 0x0B/0x0006/0x0000 after 0 s
17:35:10:094 APS-DATA.confirm id: 130, status: 0x00 SUCCESS
17:35:10:095 APS-DATA.confirm request id: 130 → erase from queue
17:35:10:166 aps request id: 130 finished, erase from queue
17:35:10:179 APS-DATA.indication srcAddr: 0x7864, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0008, lqi: 255, rssi: -78
17:35:10:180 asdu: 184d010000002019
17:35:10:181 APS-DATA.request id: 134, addrmode: 0x03, addr: 0xbc33acfffe230304, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x00
17:35:10:183 asdu (length: 5): 104e000000
17:35:10:270 APS-DATA.confirm id: 134, status: 0x00 SUCCESS
17:35:10:271 APS-DATA.confirm request id: 134 → erase from queue
17:35:10:272 APS-DATA.indication srcAddr: 0x7864, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -78
17:35:10:273 asdu: 184e010000001000
17:35:10:274 APS-DATA.request id: 134 erase from queue
17:35:10:914 Daylight now: solarNoon, status: 170, daylight: 1, dark: 0
17:35:10:915 Wait 1s till query finished
17:35:11:013 poll node 00:15:8d:00:07:36:6f:79-01
17:35:11:014 Poll light node Woonkamer INNR lamp eetkamer
17:35:11:063 read attributes of 0x00158D0007366F79 cluster: 0x0006: [
17:35:11:064 0x0000
17:35:11:064 ]
17:35:11:065 add task 52459 type 19 to 0x00158D0007366F79 cluster 0x0006 req.id 139
17:35:11:065 Poll APS request 139 to 0x00158D0007366F79 cluster: 0x0006
17:35:11:114 APS-DATA.request id: 139, addrmode: 0x03, addr: 0x00158d0007366f79, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x00
17:35:11:115 asdu (length: 5): 104f000000
17:35:11:225 Poll APS confirm 139 status: 0x00
17:35:11:226 Erase task req-id: 139, type: 19 zcl seqno: 79 send time 0, profileId: 0x0104, clusterId: 0x0006
17:35:11:226 APS-DATA.confirm id: 139, status: 0x00 SUCCESS
17:35:11:227 APS-DATA.confirm request id: 139 → erase from queue
17:35:11:295 aps request id: 139 finished, erase from queue
17:35:11:313 APS-DATA.indication srcAddr: 0x3c9d, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -43
17:35:11:314 asdu: 084f010000001000
17:35:11:314 Node data 0x00158d0007366f79 profileId: 0x0104, clusterId: 0x0006
17:35:11:315 0x00158D0007366F79: update ZCL value 0x01/0x0006/0x0000 after 0 s
17:35:11:316 APS-DATA.request id: 142, addrmode: 0x02, addr: 0x3c9d, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x04
17:35:11:316 asdu (length: 5): 104f0b0100
17:35:11:395 APS-DATA.confirm id: 142, status: 0x00 SUCCESS
17:35:11:396 APS-DATA.confirm request id: 142 → erase from queue
17:35:11:453 aps request id: 142 finished, erase from queue
17:35:11:846 APS-DATA.request id: 145, addrmode: 0x03, addr: 0x804b50fffee8da44, profile: 0x0000, cluster: 0x0031, ep: 0x00 → 0x00 queue: 0 len: 2 tx.options 0x00
17:35:11:847 asdu (length: 2): 8a00
17:35:11:887 APS-DATA.confirm id: 145, status: 0x00 SUCCESS
17:35:11:888 APS-DATA.confirm request id: 145 → confirmed, timeout 1367524935
17:35:11:966 poll node 00:17:88:01:09:9a:ea:07-0b
17:35:11:967 Poll light node Woonkamer filament staande lamp
17:35:11:967 Idle timer triggered
17:35:11:968 Force binding of attribute reporting for node Maud en Ramon Hue Dimmer Switch
17:35:11:969 read attributes of 0x00178801099AEA07 cluster: 0x0006: [
17:35:11:970 0x0000
17:35:11:971 ]
17:35:11:972 add task 52464 type 19 to 0x00178801099AEA07 cluster 0x0006 req.id 147
17:35:11:973 Poll APS request 147 to 0x00178801099AEA07 cluster: 0x0006
17:35:11:973 APS-DATA.request id: 147, addrmode: 0x03, addr: 0x00178801099aea07, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x0B queue: 1 len: 5 tx.options 0x00
17:35:11:974 asdu (length: 5): 1050000000
17:35:12:065 APS-DATA.indication srcAddr: 0x504f, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 255, rssi: -79
17:35:12:066 asdu: 8a000600036f7406ffff2e21006f7406ffff2e210000000402008c6f7406ffff2e21006962f3feff23a460fc2b25020f926f7406ffff2e2100796f3607008d15009d3c25020f6f
17:35:12:068 APS-DATA.indication request id: 145 → finished
17:35:12:069 APS-DATA.request id: 145 erase from queue
17:35:12:164 Poll APS confirm 147 status: 0x00
17:35:12:166 Erase task req-id: 147, type: 19 zcl seqno: 80 send time 0, profileId: 0x0104, clusterId: 0x0006
17:35:12:166 APS-DATA.confirm id: 147, status: 0x00 SUCCESS
17:35:12:167 APS-DATA.confirm request id: 147 → erase from queue
17:35:12:248 aps request id: 147 finished, erase from queue
17:35:12:249 APS-DATA.indication srcAddr: 0x7bc5, srcEp: 0x0B dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -44
17:35:12:250 asdu: 1850010000001000
17:35:12:250 Node data 0x00178801099aea07 profileId: 0x0104, clusterId: 0x0006
17:35:12:251 0x00178801099AEA07: update ZCL value 0x0B/0x0006/0x0000 after 0 s
17:35:12:914 Skip idle timer callback, too early: elapsed 948 msec
17:35:13:104 poll node 00:15:8d:00:07:36:6f:79-01
17:35:13:106 Poll light node Woonkamer INNR lamp eetkamer
17:35:13:156 read attributes of 0x00158D0007366F79 cluster: 0x0006: [
17:35:13:157 0x0000
17:35:13:158 ]
17:35:13:158 add task 52469 type 19 to 0x00158D0007366F79 cluster 0x0006 req.id 154
17:35:13:159 Poll APS request 154 to 0x00158D0007366F79 cluster: 0x0006
17:35:13:220 APS-DATA.request id: 154, addrmode: 0x03, addr: 0x00158d0007366f79, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x00
17:35:13:221 asdu (length: 5): 1051000000
17:35:13:348 Poll APS confirm 154 status: 0x00
17:35:13:350 Erase task req-id: 154, type: 19 zcl seqno: 81 send time 0, profileId: 0x0104, clusterId: 0x0006
17:35:13:350 APS-DATA.confirm id: 154, status: 0x00 SUCCESS
17:35:13:351 APS-DATA.confirm request id: 154 → erase from queue
17:35:13:395 aps request id: 154 finished, erase from queue
17:35:13:414 APS-DATA.indication srcAddr: 0x3c9d, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -43
17:35:13:415 asdu: 0851010000001000
17:35:13:416 Node data 0x00158d0007366f79 profileId: 0x0104, clusterId: 0x0006
17:35:13:416 0x00158D0007366F79: update ZCL value 0x01/0x0006/0x0000 after 0 s
17:35:13:417 APS-DATA.request id: 157, addrmode: 0x02, addr: 0x3c9d, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x04
17:35:13:418 asdu (length: 5): 10510b0100
17:35:13:493 APS-DATA.confirm id: 157, status: 0x00 SUCCESS
17:35:13:494 APS-DATA.confirm request id: 157 → erase from queue
17:35:13:557 aps request id: 157 finished, erase from queue
17:35:13:914 poll node 00:17:88:01:09:9a:ea:07-0b
17:35:13:916 Poll light node Woonkamer filament staande lamp
17:35:13:919 Idle timer triggered
17:35:13:921 Force binding of attribute reporting for node Maud en Ramon Hue Dimmer Switch
17:35:13:938 read attributes of 0x00178801099AEA07 cluster: 0x0006: [
17:35:13:939 0x0000
17:35:13:940 ]
17:35:13:940 add task 52474 type 19 to 0x00178801099AEA07 cluster 0x0006 req.id 161
17:35:13:941 Poll APS request 161 to 0x00178801099AEA07 cluster: 0x0006
17:35:14:013 APS-DATA.request id: 161, addrmode: 0x03, addr: 0x00178801099aea07, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x0B queue: 0 len: 5 tx.options 0x00
17:35:14:015 asdu (length: 5): 1052000000
17:35:14:047 Poll APS confirm 161 status: 0x00
17:35:14:048 Erase task req-id: 161, type: 19 zcl seqno: 82 send time 0, profileId: 0x0104, clusterId: 0x0006
17:35:14:048 APS-DATA.confirm id: 161, status: 0x00 SUCCESS
17:35:14:049 APS-DATA.confirm request id: 161 → erase from queue
17:35:14:110 APS-DATA.indication srcAddr: 0x7bc5, srcEp: 0x0B dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -43
17:35:14:111 asdu: 1852010000001000
17:35:14:111 APS-DATA.request id: 161 erase from queue
17:35:14:112 Node data 0x00178801099aea07 profileId: 0x0104, clusterId: 0x0006
17:35:14:112 0x00178801099AEA07: update ZCL value 0x0B/0x0006/0x0000 after 0 s
17:35:14:806 APS-DATA.request id: 166, addrmode: 0x03, addr: 0x804b50fffee8da44, profile: 0x0000, cluster: 0x0031, ep: 0x00 → 0x00 queue: 0 len: 2 tx.options 0x00
17:35:14:807 asdu (length: 2): 8b03
17:35:14:846 APS-DATA.confirm id: 166, status: 0x00 SUCCESS
17:35:14:847 APS-DATA.confirm request id: 166 → confirmed, timeout 1367527895
17:35:14:926 poll node 00:15:8d:00:07:36:6f:79-01
17:35:14:928 Poll light node Woonkamer INNR lamp eetkamer
17:35:14:929 Idle timer triggered
17:35:14:930 Force binding of attribute reporting for node Maud en Ramon Hue Dimmer Switch
17:35:14:944 APS-DATA.indication srcAddr: 0x504f, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 52, rssi: -80
17:35:14:945 asdu: 8b000603036f7406ffff2e2100040323feffac33bc647825020f616f7406ffff2e210007ea9a0901881700c57b25020f406f7406ffff2e2100118e8917006f0d00c63612000282
17:35:14:946 APS-DATA.indication request id: 166 → finished
17:35:14:947 APS-DATA.request id: 166 erase from queue
17:35:15:038 read attributes of 0x00158D0007366F79 cluster: 0x0006: [
17:35:15:039 0x0000
17:35:15:041 ]
17:35:15:042 add task 52479 type 19 to 0x00158D0007366F79 cluster 0x0006 req.id 169
17:35:15:043 Poll APS request 169 to 0x00158D0007366F79 cluster: 0x0006
17:35:15:044 APS-DATA.request id: 169, addrmode: 0x03, addr: 0x00158d0007366f79, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x00
17:35:15:044 asdu (length: 5): 1053000000
17:35:15:141 Poll APS confirm 169 status: 0x00
17:35:15:143 Erase task req-id: 169, type: 19 zcl seqno: 83 send time 0, profileId: 0x0104, clusterId: 0x0006
17:35:15:144 APS-DATA.confirm id: 169, status: 0x00 SUCCESS
17:35:15:144 APS-DATA.confirm request id: 169 → erase from queue
17:35:15:219 aps request id: 169 finished, erase from queue
17:35:15:237 APS-DATA.indication srcAddr: 0x3c9d, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -42
17:35:15:238 asdu: 0853010000001000
17:35:15:239 Node data 0x00158d0007366f79 profileId: 0x0104, clusterId: 0x0006
17:35:15:240 0x00158D0007366F79: update ZCL value 0x01/0x0006/0x0000 after 0 s
17:35:15:241 APS-DATA.request id: 172, addrmode: 0x02, addr: 0x3c9d, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x04
17:35:15:242 asdu (length: 5): 10530b0100
17:35:15:338 APS-DATA.confirm id: 172, status: 0x00 SUCCESS
17:35:15:339 APS-DATA.confirm request id: 172 → erase from queue
17:35:15:375 aps request id: 172 finished, erase from queue
17:35:15:914 poll node 00:17:88:01:09:9a:ea:07-0b
17:35:15:916 Poll light node Woonkamer filament staande lamp
17:35:15:917 Idle timer triggered
17:35:15:919 Force binding of attribute reporting for node Maud en Ramon Hue Dimmer Switch
17:35:16:291 read attributes of 0x00178801099AEA07 cluster: 0x0006: [
17:35:16:293 0x0000
17:35:16:294 ]
17:35:16:295 add task 52485 type 19 to 0x00178801099AEA07 cluster 0x0006 req.id 177
17:35:16:296 Poll APS request 177 to 0x00178801099AEA07 cluster: 0x0006
17:35:16:313 APS-DATA.request id: 177, addrmode: 0x03, addr: 0x00178801099aea07, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x0B queue: 0 len: 5 tx.options 0x00
17:35:16:314 asdu (length: 5): 1054000000
17:35:16:356 Poll APS confirm 177 status: 0x00
17:35:16:357 Erase task req-id: 177, type: 19 zcl seqno: 84 send time 0, profileId: 0x0104, clusterId: 0x0006
17:35:16:358 APS-DATA.confirm id: 177, status: 0x00 SUCCESS
17:35:16:358 APS-DATA.confirm request id: 177 → erase from queue
17:35:16:406 aps request id: 177 finished, erase from queue
17:35:16:420 APS-DATA.indication srcAddr: 0x7bc5, srcEp: 0x0B dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -43
17:35:16:421 asdu: 1854010000001000
17:35:16:422 Node data 0x00178801099aea07 profileId: 0x0104, clusterId: 0x0006
17:35:16:422 0x00178801099AEA07: update ZCL value 0x0B/0x0006/0x0000 after 0 s
17:35:16:913 poll node 00:15:8d:00:07:36:6f:79-01
17:35:16:915 Poll light node Woonkamer INNR lamp eetkamer
17:35:16:917 Idle timer triggered
17:35:16:921 Force binding of attribute reporting for node Maud en Ramon Hue Dimmer Switch
17:35:16:934 APS-DATA.request id: 182, addrmode: 0x03, addr: 0x60a423fffef36269, profile: 0x0104, cluster: 0x0008, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x00
17:35:16:935 asdu (length: 5): 1055000000
17:35:16:974 APS-DATA.confirm id: 182, status: 0x00 SUCCESS
17:35:16:975 APS-DATA.confirm request id: 182 → erase from queue
17:35:16:976 aps request id: 182 finished, erase from queue
17:35:17:044 APS-DATA.indication srcAddr: 0x2bfc, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0008, lqi: 255, rssi: -66
17:35:17:045 asdu: 1855010000002001
17:35:17:046 APS-DATA.request id: 184, addrmode: 0x03, addr: 0x60a423fffef36269, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x00
17:35:17:048 asdu (length: 5): 1056000000
17:35:17:093 APS-DATA.confirm id: 184, status: 0x00 SUCCESS
17:35:17:094 APS-DATA.confirm request id: 184 → erase from queue
17:35:17:149 aps request id: 184 finished, erase from queue
17:35:17:170 APS-DATA.indication srcAddr: 0x2bfc, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -67
17:35:17:172 asdu: 1856010000001000
17:35:17:394 read attributes of 0x00158D0007366F79 cluster: 0x0006: [
17:35:17:395 0x0000
17:35:17:396 ]
17:35:17:396 add task 52490 type 19 to 0x00158D0007366F79 cluster 0x0006 req.id 187
17:35:17:397 Poll APS request 187 to 0x00158D0007366F79 cluster: 0x0006
17:35:17:426 APS-DATA.request id: 187, addrmode: 0x03, addr: 0x00158d0007366f79, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x00
17:35:17:427 asdu (length: 5): 1057000000
17:35:17:460 Poll APS confirm 187 status: 0x00
17:35:17:461 Erase task req-id: 187, type: 19 zcl seqno: 87 send time 0, profileId: 0x0104, clusterId: 0x0006
17:35:17:462 APS-DATA.confirm id: 187, status: 0x00 SUCCESS
17:35:17:463 APS-DATA.confirm request id: 187 → erase from queue
17:35:17:555 aps request id: 187 finished, erase from queue
17:35:17:568 APS-DATA.indication srcAddr: 0x3c9d, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -42
17:35:17:569 asdu: 0857010000001000
17:35:17:570 Node data 0x00158d0007366f79 profileId: 0x0104, clusterId: 0x0006
17:35:17:571 0x00158D0007366F79: update ZCL value 0x01/0x0006/0x0000 after 0 s
17:35:17:572 APS-DATA.request id: 190, addrmode: 0x02, addr: 0x3c9d, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x04
17:35:17:573 asdu (length: 5): 10570b0100
17:35:17:660 APS-DATA.confirm id: 190, status: 0x00 SUCCESS
17:35:17:661 APS-DATA.confirm request id: 190 → erase from queue
17:35:17:743 aps request id: 190 finished, erase from queue
17:35:17:854 APS-DATA.request id: 192, addrmode: 0x03, addr: 0xbc33acfffe230304, profile: 0x0000, cluster: 0x0031, ep: 0x00 → 0x00 queue: 0 len: 2 tx.options 0x00
17:35:17:855 asdu (length: 2): 8c00
17:35:17:895 APS-DATA.confirm id: 192, status: 0x00 SUCCESS
17:35:17:896 APS-DATA.confirm request id: 192 → confirmed, timeout 1367530942
17:35:17:976 Idle timer triggered
17:35:17:978 Force binding of attribute reporting for node Maud en Ramon Hue Dimmer Switch
17:35:18:000 APS-DATA.indication srcAddr: 0x7864, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 255, rssi: -78
17:35:18:001 asdu: 8c000700036f7406ffff2e21006f7406ffff2e210000000402004d6f7406ffff2e21006962f3feff23a460fc2b25020f5a6f7406ffff2e2100796f3607008d15009d3c25020f32
17:35:18:002 APS-DATA.indication request id: 192 → finished
17:35:18:003 APS-DATA.request id: 192 erase from queue
17:35:18:559 poll node 00:17:88:01:09:9a:ea:07-0b
17:35:18:561 Poll light node Woonkamer filament staande lamp
17:35:18:611 read attributes of 0x00178801099AEA07 cluster: 0x0006: [
17:35:18:612 0x0000
17:35:18:613 ]
17:35:18:613 add task 52496 type 19 to 0x00178801099AEA07 cluster 0x0006 req.id 197
17:35:18:614 Poll APS request 197 to 0x00178801099AEA07 cluster: 0x0006
17:35:18:670 APS-DATA.request id: 197, addrmode: 0x03, addr: 0x00178801099aea07, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x0B queue: 0 len: 5 tx.options 0x00
17:35:18:671 asdu (length: 5): 1058000000
17:35:18:754 Poll APS confirm 197 status: 0x00
17:35:18:756 Erase task req-id: 197, type: 19 zcl seqno: 88 send time 0, profileId: 0x0104, clusterId: 0x0006
17:35:18:757 APS-DATA.confirm id: 197, status: 0x00 SUCCESS
17:35:18:758 APS-DATA.confirm request id: 197 → erase from queue
17:35:18:827 APS-DATA.indication srcAddr: 0x7bc5, srcEp: 0x0B dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -43
17:35:18:829 asdu: 1858010000001000
17:35:18:830 APS-DATA.request id: 197 erase from queue
17:35:18:830 Node data 0x00178801099aea07 profileId: 0x0104, clusterId: 0x0006
17:35:18:831 0x00178801099AEA07: update ZCL value 0x0B/0x0006/0x0000 after 0 s
17:35:18:913 Skip idle timer callback, too early: elapsed 937 msec
17:35:19:617 poll node 00:15:8d:00:07:36:6f:79-01
17:35:19:619 Poll light node Woonkamer INNR lamp eetkamer
17:35:19:665 read attributes of 0x00158D0007366F79 cluster: 0x0006: [
17:35:19:666 0x0000
17:35:19:666 ]
17:35:19:667 add task 52502 type 19 to 0x00158D0007366F79 cluster 0x0006 req.id 204
17:35:19:668 Poll APS request 204 to 0x00158D0007366F79 cluster: 0x0006
17:35:19:725 APS-DATA.request id: 204, addrmode: 0x03, addr: 0x00158d0007366f79, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x00
17:35:19:727 asdu (length: 5): 1059000000
17:35:19:824 Poll APS confirm 204 status: 0x00
17:35:19:826 Erase task req-id: 204, type: 19 zcl seqno: 89 send time 0, profileId: 0x0104, clusterId: 0x0006
17:35:19:827 APS-DATA.confirm id: 204, status: 0x00 SUCCESS
17:35:19:828 APS-DATA.confirm request id: 204 → erase from queue
17:35:19:903 aps request id: 204 finished, erase from queue
17:35:19:919 Idle timer triggered
17:35:19:920 Force binding of attribute reporting for node Maud en Ramon Hue Dimmer Switch
17:35:20:032 APS-DATA.request id: 206, addrmode: 0x03, addr: 0x804b50fffee8da44, profile: 0x0104, cluster: 0x0008, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x00
17:35:20:033 asdu (length: 5): 105a000000
17:35:20:034 APS-DATA.indication srcAddr: 0x2bfc, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x0002, lqi: 255, rssi: -67
17:35:20:035 asdu: 020000
17:35:20:036 APS-DATA.request id: 208, addrmode: 0x02, addr: 0x2bfc, profile: 0x0000, cluster: 0x8002, ep: 0x00 → 0x00 queue: 1 len: 17 tx.options 0x04
17:35:20:037 asdu (length: 17): 0200000010400f3511472b0040002b0000
17:35:20:053 APS-DATA.indication srcAddr: 0x3c9d, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -43
17:35:20:054 asdu: 0859010000001000
17:35:20:055 Node data 0x00158d0007366f79 profileId: 0x0104, clusterId: 0x0006
17:35:20:056 0x00158D0007366F79: update ZCL value 0x01/0x0006/0x0000 after 0 s
17:35:20:058 APS-DATA.request id: 210, addrmode: 0x02, addr: 0x3c9d, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 2 len: 5 tx.options 0x04
17:35:20:059 asdu (length: 5): 10590b0100
17:35:20:142 APS-DATA.confirm id: 206, status: 0x00 SUCCESS
17:35:20:143 APS-DATA.confirm request id: 206 → erase from queue
17:35:20:215 aps request id: 206 finished, erase from queue
17:35:20:228 APS-DATA.indication srcAddr: 0x504f, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0008, lqi: 255, rssi: -77
17:35:20:229 asdu: 185a010000002001
17:35:20:230 APS-DATA.request id: 213, addrmode: 0x03, addr: 0x804b50fffee8da44, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 2 len: 5 tx.options 0x00
17:35:20:231 asdu (length: 5): 105b000000
17:35:20:308 APS-DATA.confirm id: 208, status: 0x00 SUCCESS
17:35:20:310 aps request id: 208 finished, erase from queue
17:35:20:431 APS-DATA.confirm id: 210, status: 0x00 SUCCESS
17:35:20:432 APS-DATA.confirm request id: 210 → erase from queue
17:35:20:514 APS-DATA.confirm id: 213, status: 0x00 SUCCESS
17:35:20:515 APS-DATA.confirm request id: 213 → erase from queue
17:35:20:516 aps request id: 210 finished, erase from queue
17:35:20:596 APS-DATA.indication srcAddr: 0x504f, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -78
17:35:20:597 asdu: 185b010000001000
17:35:20:598 APS-DATA.request id: 213 erase from queue
17:35:20:829 APS-DATA.request id: 217, addrmode: 0x03, addr: 0xbc33acfffe230304, profile: 0x0000, cluster: 0x0031, ep: 0x00 → 0x00 queue: 0 len: 2 tx.options 0x00
17:35:20:830 asdu (length: 2): 8d03
17:35:20:883 APS-DATA.confirm id: 217, status: 0x00 SUCCESS
17:35:20:884 APS-DATA.confirm request id: 217 → confirmed, timeout 1367533918
17:35:20:951 Daylight now: solarNoon, status: 170, daylight: 1, dark: 0
17:35:20:952 poll node 00:15:8d:00:07:36:6f:79-01
17:35:20:953 Poll light node Woonkamer INNR lamp eetkamer
17:35:20:954 Idle timer triggered
17:35:20:954 Force binding of attribute reporting for node Maud en Ramon Hue Dimmer Switch
17:35:20:956 APS-DATA.indication srcAddr: 0x7864, srcEp: 0x00 dstAddrMode: 2, profile: 0x0000, cluster: 0x8031, lqi: 255, rssi: -78
17:35:20:957 asdu: 8d000703036f7406ffff2e210044dae8feff504b804f5025020f586f7406ffff2e210007ea9a0901881700c57b25020f626f7406ffff2e2100ec944cfeff72025cd1e5120002ae
17:35:20:958 APS-DATA.indication request id: 217 → finished
17:35:20:959 APS-DATA.request id: 217 erase from queue
17:35:20:959 APS-DATA.request id: 220, addrmode: 0x03, addr: 0xbc33acfffe230304, profile: 0x0104, cluster: 0x0008, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x00
17:35:20:960 asdu (length: 5): 105c000000
17:35:21:129 APS-DATA.confirm id: 220, status: 0x00 SUCCESS
17:35:21:130 APS-DATA.confirm request id: 220 → erase from queue
17:35:21:144 APS-DATA.indication srcAddr: 0x7864, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0008, lqi: 255, rssi: -76
17:35:21:146 asdu: 185c010000002019
17:35:21:146 APS-DATA.request id: 220 erase from queue
17:35:21:147 APS-DATA.request id: 222, addrmode: 0x03, addr: 0xbc33acfffe230304, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x00
17:35:21:148 asdu (length: 5): 105d000000
17:35:21:149 Websocket 172.30.32.1:52554 send message: {“attr”:{“id”:“2”,“lastannounced”:null,“lastseen”:“2023-10-04T15:35Z”,“manufacturername”:“IKEA of Sweden”,“modelid”:“TRADFRI bulb GU10 WW 400lm”,“name”:“Jonas spotje wand”,“swversion”:“2.3.093”,“type”:“Dimmable light”,“uniqueid”:“bc:33:ac:ff:fe:23:03:04-01”},“e”:“changed”,“id”:“2”,“r”:“lights”,“t”:“event”,“uniqueid”:“bc:33:ac:ff:fe:23:03:04-01”} (ret = 347)
17:35:21:151 Websocket 127.0.0.1:53906 send message: {“attr”:{“id”:“2”,“lastannounced”:null,“lastseen”:“2023-10-04T15:35Z”,“manufacturername”:“IKEA of Sweden”,“modelid”:“TRADFRI bulb GU10 WW 400lm”,“name”:“Jonas spotje wand”,“swversion”:“2.3.093”,“type”:“Dimmable light”,“uniqueid”:“bc:33:ac:ff:fe:23:03:04-01”},“e”:“changed”,“id”:“2”,“r”:“lights”,“t”:“event”,“uniqueid”:“bc:33:ac:ff:fe:23:03:04-01”} (ret = 347)
17:35:21:232 read attributes of 0x00158D0007366F79 cluster: 0x0006: [
17:35:21:235 0x0000
17:35:21:236 ]
17:35:21:237 add task 52509 type 19 to 0x00158D0007366F79 cluster 0x0006 req.id 224
17:35:21:237 Poll APS request 224 to 0x00158D0007366F79 cluster: 0x0006
17:35:21:238 APS-DATA.request id: 224, addrmode: 0x03, addr: 0x00158d0007366f79, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 1 len: 5 tx.options 0x00
17:35:21:238 asdu (length: 5): 105e000000
17:35:21:289 APS-DATA.confirm id: 222, status: 0x00 SUCCESS
17:35:21:289 APS-DATA.confirm request id: 222 → erase from queue
17:35:21:290 APS-DATA.indication srcAddr: 0x7864, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -77
17:35:21:291 asdu: 185d010000001000
17:35:21:292 APS-DATA.request id: 222 erase from queue
17:35:21:353 Poll APS confirm 224 status: 0x00
17:35:21:354 Erase task req-id: 224, type: 19 zcl seqno: 94 send time 0, profileId: 0x0104, clusterId: 0x0006
17:35:21:355 APS-DATA.confirm id: 224, status: 0x00 SUCCESS
17:35:21:356 APS-DATA.confirm request id: 224 → erase from queue
17:35:21:418 aps request id: 224 finished, erase from queue
17:35:21:512 APS-DATA.indication srcAddr: 0x3c9d, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -43
17:35:21:513 asdu: 085e010000001000
17:35:21:514 Node data 0x00158d0007366f79 profileId: 0x0104, clusterId: 0x0006
17:35:21:515 0x00158D0007366F79: update ZCL value 0x01/0x0006/0x0000 after 0 s
17:35:21:516 APS-DATA.request id: 228, addrmode: 0x02, addr: 0x3c9d, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x04
17:35:21:516 asdu (length: 5): 105e0b0100
17:35:21:609 APS-DATA.confirm id: 228, status: 0x00 SUCCESS
17:35:21:610 APS-DATA.confirm request id: 228 → erase from queue
17:35:21:687 aps request id: 228 finished, erase from queue
17:35:21:913 Idle timer triggered
17:35:21:915 Force binding of attribute reporting for node Maud en Ramon Hue Dimmer Switch
17:35:22:518 poll node 00:17:88:01:09:9a:ea:07-0b
17:35:22:519 Poll light node Woonkamer filament staande lamp
17:35:22:567 read attributes of 0x00178801099AEA07 cluster: 0x0006: [
17:35:22:568 0x0000
17:35:22:568 ]
17:35:22:569 add task 52515 type 19 to 0x00178801099AEA07 cluster 0x0006 req.id 233
17:35:22:570 Poll APS request 233 to 0x00178801099AEA07 cluster: 0x0006
17:35:22:637 APS-DATA.request id: 233, addrmode: 0x03, addr: 0x00178801099aea07, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x0B queue: 0 len: 5 tx.options 0x00
17:35:22:638 asdu (length: 5): 105f000000
17:35:22:720 Poll APS confirm 233 status: 0x00
17:35:22:721 Erase task req-id: 233, type: 19 zcl seqno: 95 send time 0, profileId: 0x0104, clusterId: 0x0006
17:35:22:722 APS-DATA.confirm id: 233, status: 0x00 SUCCESS
17:35:22:722 APS-DATA.confirm request id: 233 → erase from queue
17:35:22:738 APS-DATA.indication srcAddr: 0x7bc5, srcEp: 0x0B dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -43
17:35:22:739 asdu: 185f010000001000
17:35:22:740 APS-DATA.request id: 233 erase from queue
17:35:22:741 Node data 0x00178801099aea07 profileId: 0x0104, clusterId: 0x0006
17:35:22:742 0x00178801099AEA07: update ZCL value 0x0B/0x0006/0x0000 after 0 s
17:35:22:914 Idle timer triggered
17:35:22:915 Force binding of attribute reporting for node Maud en Ramon Hue Dimmer Switch
17:35:23:588 poll node 00:15:8d:00:07:36:6f:79-01
17:35:23:590 Poll light node Woonkamer INNR lamp eetkamer
17:35:23:640 read attributes of 0x00158D0007366F79 cluster: 0x0006: [
17:35:23:641 0x0000
17:35:23:642 ]

17:35:25:918 Force binding of attribute reporting for node Maud en Ramon Hue Dimmer Switch
17:35:26:063 read attributes of 0x00158D0007366F79 cluster: 0x0006: [
17:35:26:065 0x0000
17:35:26:066 ]
17:35:26:067 add task 52532 type 19 to 0x00158D0007366F79 cluster 0x0006 req.id 0
17:35:26:069 Poll APS request 0 to 0x00158D0007366F79 cluster: 0x0006
17:35:26:113 APS-DATA.request id: 0, addrmode: 0x03, addr: 0x00158d0007366f79, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x00
17:35:26:114 asdu (length: 5): 1062000000
17:35:26:199 Poll APS confirm 0 status: 0x00
17:35:26:200 Erase task req-id: 0, type: 19 zcl seqno: 98 send time 0, profileId: 0x0104, clusterId: 0x0006
17:35:26:201 APS-DATA.confirm id: 0, status: 0x00 SUCCESS
17:35:26:202 APS-DATA.confirm request id: 0 → erase from queue
17:35:26:268 APS-DATA.indication srcAddr: 0x3c9d, srcEp: 0x01 dstAddrMode: 2, profile: 0x0104, cluster: 0x0006, lqi: 255, rssi: -42
17:35:26:269 asdu: 0862010000001000
17:35:26:272 APS-DATA.request id: 0 erase from queue
17:35:26:274 Node data 0x00158d0007366f79 profileId: 0x0104, clusterId: 0x0006
17:35:26:275 0x00158D0007366F79: update ZCL value 0x01/0x0006/0x0000 after 0 s
17:35:26:276 APS-DATA.request id: 3, addrmode: 0x02, addr: 0x3c9d, profile: 0x0104, cluster: 0x0006, ep: 0x01 → 0x01 queue: 0 len: 5 tx.options 0x04
17:35:26:278 asdu (length: 5): 10620b0100
17:35:26:365 APS-DATA.confirm id: 3, status: 0x00 SUCCESS
17:35:26:366 APS-DATA.confirm request id: 3 → erase from queue
17:35:26:443 aps request id: 3 finished, erase from queue
17:35:26:749 APS-DATA.request id: 6, addrmode: 0x03, addr: 0x00178801099aea07, profile: 0x0000, cluster: 0x0031, ep: 0x00 → 0x00 queue: 0 len: 2 tx.options 0x00
17:35:26:752 asdu (length: 2): 8f00

17:35:26:949 poll node 00:17:88:01:09:9a:ea:07-0b
17:35:26:951 Poll light node Woonkamer filament staande lamp
17:35:26:952 Idle timer triggered
17:35:26:952 Force binding of attribute reporting for node Maud en Ramon Hue Dimmer Switch
17:35:26:953 giveup binding srcAddr: 0x60A423FFFEF36269

I´ve tried to turn on and off some lights using the paired switches (Philips Hue) in 2 different rooms (master bed room and living room) and guess what they worked as they should! It´s the classic: problem doens´t occur when you bring in help.

As a noob I can’t read the log, that is I do not understand what this all means, so if anyone can make sense of it, your help is appreciated.

6

Can you share it in Pastebin please :)?

7

In pastebin, new copy and past

8

Nothing wrong with these logs.

CAn you try to pair a light and make logs while doing that?

9

Paired GU10 Ikea Tradfri light without issues

10

Nothing going wrong here.

What is the problem now exactly?

11

Right now there is no problem. The problem was at first zigbee devices dropping to the point basically nothing worked. Then I changed Zigbee channel and re-installed Deconz in Home Assistant. After that it worked sometimes, but sometimes lights wouldn’t respond or just blink when trying to turn them on or off.

I did replace the usb extension cable (1m) with a longer one (3 meter) maybe that solved the remaining RF interference???

If and when the problem returns, I will try to take debug view logs of that moment and post them here. Untill then I guess there is no issue to be solved.

12

The extension cable might have done the trick.

If you see it in the future, take note on the logs and especially for 0xE1. That is the code for interference.

13

Ok. Thank you for helping me.

1 Like