Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

deconz 6.1.0 doesnt start on Raspberry Pi 4 #1480

Closed
fti7 opened this issue Jul 20, 2020 · 30 comments · Fixed by #1483
Closed

deconz 6.1.0 doesnt start on Raspberry Pi 4 #1480

fti7 opened this issue Jul 20, 2020 · 30 comments · Fixed by #1483
Assignees

Comments

@fti7
Copy link

fti7 commented Jul 20, 2020

[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] firmware.sh: executing... 
/usr/bin/GCFFlasher_internal: line 71: /usr/bin/GCFFlasher_internal.bin: No such file or directory
[16:39:03] INFO: 
[cont-init.d] firmware.sh: exited 0.
[cont-init.d] nginx.sh: executing... 
[cont-init.d] nginx.sh: exited 0.
[cont-init.d] vnc.sh: executing... 
[cont-init.d] vnc.sh: exited 0.
[cont-init.d] done.
[services.d] starting services
[14:39:04] INFO: Starting udevd...
[14:39:04] INFO: Running the OSRAM LEdvance OTA updater...
[14:39:04] INFO: Running the deCONZ OTA updater...
[services.d] done.
[16:39:04] INFO: Waiting for device...
[14:39:04] INFO: Running the IKEA OTA updater...
[14:39:04] INFO: Can't fetch data from osram!

[16:39:08] INFO: Starting VNC server...
[16:39:11] INFO: Waiting for VNC to start
[16:39:11] INFO: Starting the deCONZ gateway...
./run: line 71: /usr/bin/deCONZ: No such file or directory
[cont-finish.d] executing container finish scripts...
[cont-finish.d] done.
[s6-finish] waiting for services.
[s6-finish] sending all processes the TERM signal.

homeassistant/armhf-addon-deconz:6.0.1

EDIT: FIXED in 6.1.0 - But still not starting - see bugreports below

Workround:
For 6.1.0 with the "qt.qpa.screen: QXcbConnection: Could not connect to display :0" Error:

Under Configure, remove the Host Port mapping for 5900/tcp.
After this, VNC will not be started

@pvizeli can you maybe look into this? thx

@mjhcdk
Copy link

mjhcdk commented Jul 20, 2020

Have a similar problem , Deconz upgraded to Version 6.0.0 on Hass.io on PI4. and now it can't start. Have also tried to reboot PI

[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] firmware.sh: executing...
[16:58:17] INFO: GCFFlasher V3_13 (c) dresden elektronik ingenieurtechnik gmbh
Path | Vendor | Product | Serial | Type
-----------------+--------+---------+------------+-------
/dev/ttyACM0 | 0x1CF1 | 0x0030 | | ConBee II
/dev/ttyAMA0 | 0x0000 | 0x0000 | | RaspBee
[cont-init.d] firmware.sh: exited 0.
[cont-init.d] nginx.sh: executing...
[cont-init.d] nginx.sh: exited 0.
[cont-init.d] vnc.sh: executing...
[cont-init.d] vnc.sh: exited 0.
[cont-init.d] done.
[services.d] starting services
[14:58:18] INFO: Running the deCONZ OTA updater...
[services.d] done.
[14:58:18] INFO: Starting udevd...
[14:58:18] INFO: Running the IKEA OTA updater...
[14:58:18] INFO: Running the OSRAM LEdvance OTA updater...
[16:58:18] INFO: Waiting for device...
[16:58:24] INFO: Starting VNC server...

[16:58:29] INFO: Waiting for VNC to start
[16:58:29] INFO: Starting the deCONZ gateway...
qt.qpa.screen: QXcbConnection: Could not connect to display :0
Could not connect to any X display.
[cont-finish.d] executing container finish scripts...
[cont-finish.d] done.
[s6-finish] waiting for services.
[s6-finish] sending all processes the TERM signal.

@gerbenp
Copy link

gerbenp commented Jul 20, 2020

Have also an problem with DeCONZ 6.1.0 on Home Assistant (Hass.io) on an Raspberry Pi 4 with 2 GB of RAM.

[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] firmware.sh: executing...
[17:16:20] INFO: GCFFlasher V3_13 (c) dresden elektronik ingenieurtechnik gmbh
Path | Vendor | Product | Serial | Type
-----------------+--------+---------+------------+-------
/dev/ttyACM0 | 0x1CF1 | 0x0030 | | ConBee II
/dev/ttyAMA0 | 0x0000 | 0x0000 | | RaspBee
[cont-init.d] firmware.sh: exited 0.
[cont-init.d] nginx.sh: executing...
[cont-init.d] nginx.sh: exited 0.
[cont-init.d] vnc.sh: executing...
[cont-init.d] vnc.sh: exited 0.
[cont-init.d] done.
[services.d] starting services
[services.d] done.
[15:16:21] INFO: Running the deCONZ OTA updater...
[15:16:21] INFO: Starting udevd...
[15:16:21] INFO: Running the OSRAM LEdvance OTA updater...
[15:16:21] INFO: Running the IKEA OTA updater...
[17:16:21] INFO: Waiting for device...
[17:16:21] INFO: Starting VNC server...
[17:16:24] INFO: Waiting for VNC to start
[17:16:25] INFO: Starting the deCONZ gateway...
qt.qpa.screen: QXcbConnection: Could not connect to display :0
Could not connect to any X display.
[cont-finish.d] executing container finish scripts...
[cont-finish.d] done.
[s6-finish] waiting for services.
[s6-finish] sending all processes the TERM signal.

@althaus
Copy link

althaus commented Jul 20, 2020

For me 6.1 fails on Hassio@Synology

[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] firmware.sh: executing... 
/usr/bin/GCFFlasher_internal.bin: error while loading shared libraries: libQt5Core.so.5: cannot open shared object file: No such file or directory
[17:14:29] INFO: 
[cont-init.d] firmware.sh: exited 0.
[cont-init.d] nginx.sh: executing... 
[cont-init.d] nginx.sh: exited 0.
[cont-init.d] vnc.sh: executing... 
[cont-init.d] vnc.sh: exited 0.
[cont-init.d] done.
[services.d] starting services
[services.d] done.
[15:14:31] INFO: Running the deCONZ OTA updater...
[15:14:31] INFO: Running the OSRAM LEdvance OTA updater...
[15:14:31] INFO: Running the IKEA OTA updater...
[17:14:31] INFO: Waiting for device...
[15:14:31] INFO: Starting udevd...
[17:14:32] INFO: Starting VNC server...
[17:14:37] INFO: Waiting for VNC to start
[17:14:38] INFO: Starting the deCONZ gateway...
deCONZ: error while loading shared libraries: libQt5Core.so.5: cannot open shared object file: No such file or directory
[cont-finish.d] executing container finish scripts...
[cont-finish.d] done.

[s6-finish] waiting for services.
[s6-finish] sending all processes the TERM signal.

@posavasos
Copy link

After uptading to deCONZ 6.0.1, the add-on doesn't start on my Raspberry Pi 3 Model B+ 32bit with ConBee USB gateway

[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] firmware.sh: executing... 
/usr/bin/GCFFlasher_internal: line 71: /usr/bin/GCFFlasher_internal.bin: No such file or directory
[17:35:14] INFO: 
[cont-init.d] firmware.sh: exited 0.
[cont-init.d] nginx.sh: executing... 
[cont-init.d] nginx.sh: exited 0.
[cont-init.d] vnc.sh: executing... 
[cont-init.d] vnc.sh: exited 0.
[cont-init.d] done.
[services.d] starting services
[services.d] done.
[15:35:15] INFO: Running the deCONZ OTA updater...
[15:35:15] INFO: Running the OSRAM LEdvance OTA updater...
[15:35:15] INFO: Starting udevd...
[17:35:15] INFO: Waiting for device...
[15:35:15] INFO: Running the IKEA OTA updater...
[15:35:15] INFO: Can't fetch data from osram!
[17:35:20] INFO: Starting the deCONZ gateway...
./run: line 71: /usr/bin/deCONZ: No such file or directory
[cont-finish.d] executing container finish scripts...
[cont-finish.d] done.
[s6-finish] waiting for services.
[s6-finish] sending all processes the TERM signal.

@fti7
Copy link
Author

fti7 commented Jul 20, 2020

the armhf Issues seems to be fixed with 6.1.0 (9e67f09)

Unfortunately, my Supervisor UI doesnt offer me this Version yet

@knallt
Copy link

knallt commented Jul 20, 2020

Same here for 6.0. Unfortunately I tried to uninstall, but didn't help.
Hope data is still there.

@fti7
Copy link
Author

fti7 commented Jul 20, 2020

Upgraded to 6.1.0 (Reload @ Supervisor Menu)

[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] firmware.sh: executing... 
[17:53:06] INFO: GCFFlasher V3_13 (c) dresden elektronik ingenieurtechnik gmbh
Path             | Vendor | Product | Serial     | Type
-----------------+--------+---------+------------+-------
/dev/ttyACM0     | 0x1CF1 | 0x0030  |            | ConBee II 
/dev/ttyACM1     | 0x1CF1 | 0x0030  |            | ConBee II 
/dev/ttyAMA0     | 0x0000 | 0x0000  |            | RaspBee 
[cont-init.d] firmware.sh: exited 0.
[cont-init.d] nginx.sh: executing... 
[cont-init.d] nginx.sh: exited 0.
[cont-init.d] vnc.sh: executing... 
[cont-init.d] vnc.sh: exited 0.
[cont-init.d] done.
[services.d] starting services
[services.d] done.
[17:53:07] INFO: Waiting for device...
[15:53:07] INFO: Running the deCONZ OTA updater...
[15:53:07] INFO: Starting udevd...
[15:53:07] INFO: Running the OSRAM LEdvance OTA updater...
[15:53:07] INFO: Running the IKEA OTA updater...
[15:53:07] INFO: Can't fetch data from osram!

[17:53:11] INFO: Starting VNC server...
[17:53:14] INFO: Waiting for VNC to start
[17:53:15] INFO: Starting the deCONZ gateway...
qt.qpa.screen: QXcbConnection: Could not connect to display :0
Could not connect to any X display.
[cont-finish.d] executing container finish scripts...
[cont-finish.d] done.
[s6-finish] waiting for services.
[s6-finish] sending all processes the TERM signal.

@gerbenp
Copy link

gerbenp commented Jul 20, 2020

@fti7

the armhf Issues seems to be fixed with 6.1.0 (9e67f09)

Unfortunately, my Supervisor UI doesnt offer me this Version yet

You can force it in the Supervisor UI if you want. Go to the add-on store, click on the three-dots menu and select 'Reload'. That forced the 6.1.0 update for me.

@fti7 fti7 changed the title deconz 6.0.1 doesnt start on Raspberry Pi 4 deconz 6.1.0 doesnt start on Raspberry Pi 4 Jul 20, 2020
@posavasos
Copy link

The 6.1.0 version solved the problem on my Raspberry Pi 3 Model B+

@QuadNL
Copy link

QuadNL commented Jul 20, 2020

Have a similar problem , Deconz upgraded to Version 6.0.0 on Hass.io on PI4. and now it can't start. Have also tried to reboot PI

[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] firmware.sh: executing...
[16:58:17] INFO: GCFFlasher V3_13 (c) dresden elektronik ingenieurtechnik gmbh
Path | Vendor | Product | Serial | Type
-----------------+--------+---------+------------+-------
/dev/ttyACM0 | 0x1CF1 | 0x0030 | | ConBee II
/dev/ttyAMA0 | 0x0000 | 0x0000 | | RaspBee
[cont-init.d] firmware.sh: exited 0.
[cont-init.d] nginx.sh: executing...
[cont-init.d] nginx.sh: exited 0.
[cont-init.d] vnc.sh: executing...
[cont-init.d] vnc.sh: exited 0.
[cont-init.d] done.
[services.d] starting services
[14:58:18] INFO: Running the deCONZ OTA updater...
[services.d] done.
[14:58:18] INFO: Starting udevd...
[14:58:18] INFO: Running the IKEA OTA updater...
[14:58:18] INFO: Running the OSRAM LEdvance OTA updater...
[16:58:18] INFO: Waiting for device...
[16:58:24] INFO: Starting VNC server...

[16:58:29] INFO: Waiting for VNC to start
[16:58:29] INFO: Starting the deCONZ gateway...
qt.qpa.screen: QXcbConnection: Could not connect to display :0
Could not connect to any X display.
[cont-finish.d] executing container finish scripts...
[cont-finish.d] done.
[s6-finish] waiting for services.
[s6-finish] sending all processes the TERM signal.

Idem at Pi4 4GB after update from 6.0.1 to 6.1.0.

@fti7
Copy link
Author

fti7 commented Jul 20, 2020

For 6.1.0 with the "qt.qpa.screen: QXcbConnection: Could not connect to display :0" Error:
Workround:
Under Configure, remove the Host Port mapping for 5900/tcp.
After this, VNC will not be started

@dhartmann84
Copy link

My deconz addon has not started since the update from 5.3.6 to 6.1.0. I have a Raspberry 4 with 4GB Ram.

[s6-init] making user provided files available at /var/run/s6/etc...exited 0. [s6-init] ensuring user provided files have correct perms...exited 0. [fix-attrs.d] applying ownership & permissions fixes... [fix-attrs.d] done. [cont-init.d] executing container initialization scripts... [cont-init.d] firmware.sh: executing... [18:22:03] INFO: GCFFlasher V3_13 (c) dresden elektronik ingenieurtechnik gmbh Path | Vendor | Product | Serial | Type -----------------+--------+---------+------------+------- /dev/ttyACM0 | 0x1CF1 | 0x0030 | | ConBee II /dev/ttyUSB0 | 0x0403 | 0x6015 | | ConBee /dev/ttyAMA0 | 0x0000 | 0x0000 | | RaspBee [cont-init.d] firmware.sh: exited 0. [cont-init.d] nginx.sh: executing... [cont-init.d] nginx.sh: exited 0. [cont-init.d] vnc.sh: executing... [cont-init.d] vnc.sh: exited 0. [cont-init.d] done. [services.d] starting services [16:22:03] INFO: Starting udevd... [16:22:03] INFO: Running the OSRAM LEdvance OTA updater... [services.d] done. [16:22:03] INFO: Running the deCONZ OTA updater... [16:22:03] INFO: Running the IKEA OTA updater... [18:22:03] INFO: Waiting for device... [16:22:04] INFO: Can't fetch data from osram! [18:22:08] INFO: Starting VNC server... [18:22:11] INFO: Waiting for VNC to start [18:22:11] INFO: Starting the deCONZ gateway... qt.qpa.screen: QXcbConnection: Could not connect to display :0 Could not connect to any X display. [cont-finish.d] executing container finish scripts... [cont-finish.d] done. [s6-finish] waiting for services. [s6-finish] sending all processes the TERM signal.

@dhartmann84
Copy link

My deconz addon has not started since the update from 5.3.6 to 6.1.0. I have a Raspberry 4 with 4GB Ram.

[s6-init] making user provided files available at /var/run/s6/etc...exited 0. [s6-init] ensuring user provided files have correct perms...exited 0. [fix-attrs.d] applying ownership & permissions fixes... [fix-attrs.d] done. [cont-init.d] executing container initialization scripts... [cont-init.d] firmware.sh: executing... [18:22:03] INFO: GCFFlasher V3_13 (c) dresden elektronik ingenieurtechnik gmbh Path | Vendor | Product | Serial | Type -----------------+--------+---------+------------+------- /dev/ttyACM0 | 0x1CF1 | 0x0030 | | ConBee II /dev/ttyUSB0 | 0x0403 | 0x6015 | | ConBee /dev/ttyAMA0 | 0x0000 | 0x0000 | | RaspBee [cont-init.d] firmware.sh: exited 0. [cont-init.d] nginx.sh: executing... [cont-init.d] nginx.sh: exited 0. [cont-init.d] vnc.sh: executing... [cont-init.d] vnc.sh: exited 0. [cont-init.d] done. [services.d] starting services [16:22:03] INFO: Starting udevd... [16:22:03] INFO: Running the OSRAM LEdvance OTA updater... [services.d] done. [16:22:03] INFO: Running the deCONZ OTA updater... [16:22:03] INFO: Running the IKEA OTA updater... [18:22:03] INFO: Waiting for device... [16:22:04] INFO: Can't fetch data from osram! [18:22:08] INFO: Starting VNC server... [18:22:11] INFO: Waiting for VNC to start [18:22:11] INFO: Starting the deCONZ gateway... qt.qpa.screen: QXcbConnection: Could not connect to display :0 Could not connect to any X display. [cont-finish.d] executing container finish scripts... [cont-finish.d] done. [s6-finish] waiting for services. [s6-finish] sending all processes the TERM signal.

Disable VNC fix the Problem on my RP4.

@QuadNL
Copy link

QuadNL commented Jul 20, 2020

For 6.1.0 with the "qt.qpa.screen: QXcbConnection: Could not connect to display :0" Error:
Workround:
Under Configure, remove the Host Port mapping for 5900/tcp.
After this, VNC will not be started

Thanks, this workaround let's my Deconz addon start.

@vdiogo
Copy link

vdiogo commented Jul 20, 2020

Same issue after upgrading to 6.1.0

@frenck
Copy link
Member

frenck commented Jul 20, 2020

Guys the issue is clear. Please, instead of "same issue" or "me too", please just use the 👍 emoji on the initial issue report/description. Thanks 👍

@frenck
Copy link
Member

frenck commented Jul 20, 2020

My current feeling says this is limited to ARMHF installations like the Raspberry Pi.
I'm currently unable to reproduce this on other platforms, so will move over to a Pi for further testing. If someone reads this with an AMD64, for example, I would love to know if it breaks for you.

Edit: Got it reproduced on an ODROID N2, so I have something to work with now.
Edit2: Found the root issue
image

Looking for a solution.

@frenck frenck self-assigned this Jul 20, 2020
@Mimiix
Copy link
Contributor

Mimiix commented Jul 20, 2020

If a Intel Celeron J3355 with 64 arch counts for AMD64: No issues on that (synology DS218+ VM with HA generic install and Addon).

@GitHubxtsnl
Copy link

GitHubxtsnl commented Jul 20, 2020

I've also upgraded deCONZ to the 6.1.0 release.
running on a Pi4 with 4GB RAM, running Home Assistant 0.112.4
I've disabled the VNC port in the configuration of deCONZ but this does not solve my issue.
I can access the and log in to Phoscon app and I can see my bulbs and sensors here, I can see the status off lights, some are on and some are off.
The deCONZ add-on is now started but none of my bulbs or sensors are online and available within HA.
Hope this helps in solving the issue.

here is a snippet of the log:

22:20:55:909 don't close database yet, keep open for 900 seconds
22:21:02:092 don't close database yet, keep open for 900 seconds
22:21:09:085 don't close database yet, keep open for 900 seconds
22:21:15:272 don't close database yet, keep open for 900 seconds
22:21:22:063 don't close database yet, keep open for 900 seconds
22:21:29:087 don't close database yet, keep open for 900 seconds
22:21:30:086 Current channel 25
22:21:30:094 Device TTL 2062 s flags: 0x7
22:21:35:195 don't close database yet, keep open for 900 seconds
22:21:41:937 don't close database yet, keep open for 900 seconds
22:21:47:088 don't close database yet, keep open for 900 seconds
22:21:55:083 don't close database yet, keep open for 900 seconds
22:22:00:882 don't close database yet, keep open for 900 seconds
22:22:06:086 don't close database yet, keep open for 900 seconds
22:22:07:658 ZCL attribute report 0xEC1BBDFFFEA684B5 for cluster: 0x0006, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
22:22:07:674 ZCL attribute report 0xEC1BBDFFFEA684B5 for cluster: 0x0008, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
22:22:07:873 ZCL attribute report 0xEC1BBDFFFEA7F6C7 for cluster: 0x0006, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
22:22:07:878 ZCL attribute report 0xEC1BBDFFFEA7F6C7 for cluster: 0x0008, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
22:22:12:093 don't close database yet, keep open for 900 seconds
22:22:17:998 don't close database yet, keep open for 900 seconds
22:22:22:468 ZCL attribute report 0x00158D0004C0A818 for cluster: 0x0001, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
22:22:25:125 don't close database yet, keep open for 900 seconds
22:22:30:087 Current channel 25
22:22:30:094 Device TTL 2002 s flags: 0x7
22:22:31:088 don't close database yet, keep open for 900 seconds
22:22:36:655 ZCL attribute report 0xEC1BBDFFFEA6CCEF for cluster: 0x0008, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
22:22:39:083 don't close database yet, keep open for 900 seconds
22:22:45:085 don't close database yet, keep open for 900 seconds
22:22:51:085 don't close database yet, keep open for 900 seconds
22:22:57:085 don't close database yet, keep open for 900 seconds
22:23:03:073 don't close database yet, keep open for 900 seconds
22:23:09:084 don't close database yet, keep open for 900 seconds
22:23:15:264 don't close database yet, keep open for 900 seconds
22:23:20:845 don't close database yet, keep open for 900 seconds
22:23:27:086 don't close database yet, keep open for 900 seconds
22:23:30:087 Current channel 25
22:23:30:095 Device TTL 1942 s flags: 0x7
22:23:33:087 don't close database yet, keep open for 900 seconds
22:23:38:769 ZCL attribute report 0xEC1BBDFFFEA6CCEF for cluster: 0x0006, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
22:23:39:266 don't close database yet, keep open for 900 seconds
22:23:45:084 don't close database yet, keep open for 900 seconds
22:23:51:089 don't close database yet, keep open for 900 seconds
22:23:57:133 dev /dev/ttyAMA0
22:23:57:134 GW firmware version: 0x26580700
22:23:57:134 GW firmware version is up to date: 0x26580700
22:23:58:087 don't close database yet, keep open for 900 seconds
22:24:05:025 don't close database yet, keep open for 900 seconds
22:24:11:255 don't close database yet, keep open for 900 seconds
22:24:17:969 don't close database yet, keep open for 900 seconds
22:24:25:087 don't close database yet, keep open for 900 seconds
22:24:30:087 Current channel 25
22:24:30:095 Device TTL 1882 s flags: 0x7
22:24:31:088 don't close database yet, keep open for 900 seconds
22:24:32:646 no button map for: lumi.sensor_magnet ep: 0x01 cl: 0x0000 cmd: 0x0A pl[0]: 002
22:24:32:646 ZCL attribute report 0x00158D00042E766B for cluster: 0x0000, ep: 0x01, frame control: 0x1C, mfcode: 0x1234 
22:24:32:647 0x00158D00042E766B extract Xiaomi special attribute 0xFF02
22:24:32:647 	64 on/off 1
22:24:32:647 	01 battery 3025 (0x0BD1)
22:24:32:647 	04 unknown 17320 (0x43A8)
22:24:32:647 	06 LQI (?) 4294967296 (0x0100000000)
22:24:32:647 	Struct index 05 unknown (counter?) 29 (0x001D)
22:24:32:647 	Struct index 06 unknown (counter?) 89 (0x59)
22:24:36:188 don't close database yet, keep open for 900 seconds
22:24:41:983 don't close database yet, keep open for 900 seconds
22:24:47:093 don't close database yet, keep open for 900 seconds
22:24:55:087 don't close database yet, keep open for 900 seconds
22:25:00:892 don't close database yet, keep open for 900 seconds
22:25:06:085 don't close database yet, keep open for 900 seconds
22:25:07:657 ZCL attribute report 0xEC1BBDFFFEA684B5 for cluster: 0x0006, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
22:25:07:675 ZCL attribute report 0xEC1BBDFFFEA684B5 for cluster: 0x0008, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
22:25:07:873 ZCL attribute report 0xEC1BBDFFFEA7F6C7 for cluster: 0x0006, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
22:25:07:877 ZCL attribute report 0xEC1BBDFFFEA7F6C7 for cluster: 0x0008, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
22:25:12:084 don't close database yet, keep open for 900 seconds
22:25:18:090 don't close database yet, keep open for 900 seconds
22:25:26:087 don't close database yet, keep open for 900 seconds
22:25:30:087 Current channel 25
22:25:30:095 Device TTL 1822 s flags: 0x7
22:25:33:087 don't close database yet, keep open for 900 seconds
22:25:36:653 ZCL attribute report 0xEC1BBDFFFEA6CCEF for cluster: 0x0008, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
22:25:39:997 don't close database yet, keep open for 900 seconds
22:25:46:263 don't close database yet, keep open for 900 seconds
22:25:52:973 don't close database yet, keep open for 900 seconds
22:26:00:091 don't close database yet, keep open for 900 seconds
22:26:06:089 don't close database yet, keep open for 900 seconds
22:26:11:180 don't close database yet, keep open for 900 seconds
22:26:16:974 don't close database yet, keep open for 900 seconds
22:26:22:089 don't close database yet, keep open for 900 seconds
22:26:30:088 don't close database yet, keep open for 900 seconds
22:26:30:099 Current channel 25
22:26:30:107 Device TTL 1762 s flags: 0x7
22:26:35:889 don't close database yet, keep open for 900 seconds
22:26:38:773 ZCL attribute report 0xEC1BBDFFFEA6CCEF for cluster: 0x0006, ep: 0x01, frame control: 0x08, mfcode: 0x0000 
22:26:41:088 don't close database yet, keep open for 900 seconds
22:26:47:086 don't close database yet, keep open for 900 seconds
22:26:52:996 don't close database yet, keep open for 900 seconds
22:26:59:194 don't close database yet, keep open for 900 seconds
22:27:06:087 don't close database yet, keep open for 900 seconds
22:27:11:181 don't close database yet, keep open for 900 seconds
22:27:16:087 don't close database yet, keep open for 900 seconds
22:27:22:087 don't close database yet, keep open for 900 seconds
.
.
.
22:31:52:073 skip configure report for cluster: 0x0008 attr: 0x0000 of node 0xEC1BBDFFFEA7F6C7 (seems to be active)
22:31:52:073 skip binding for attribute reporting of ep: 0x00 cluster 0x1000 (end-device might sleep)
22:31:57:072 skip binding for attribute reporting of ep: 0x00 cluster 0x1000 (end-device might sleep)
22:31:57:131 dev /dev/ttyAMA0
22:31:57:131 GW firmware version: 0x26580700
22:31:57:131 GW firmware version is up to date: 0x26580700
22:32:00:838 don't close database yet, keep open for 900 seconds
22:32:02:072 binding for cluster 0x0000 of 0xD0CF5EFFFE2108C1 exists (verified by reporting)
22:32:02:072 binding for cluster 0x0006 of 0xD0CF5EFFFE2108C1 exists (verified by reporting)
22:32:02:072 binding for cluster 0x0008 of 0xD0CF5EFFFE2108C1 exists (verified by reporting)
22:32:02:072 binding for cluster 0x0300 of 0xD0CF5EFFFE2108C1 exists (verified by reporting)
22:32:02:072 skip binding for attribute reporting of ep: 0x00 cluster 0x1000 (end-device might sleep)
22:32:02:193 ZCL configure reporting rsp seq: 9 0xD0CF5EFFFE2108C1 for ep: 0x01 cluster: 0x0006 attr: 0x0000 status: 0x00
22:32:02:238 ZCL configure reporting rsp seq: 10 0xD0CF5EFFFE2108C1 for ep: 0x01 cluster: 0x0008 attr: 0x0000 status: 0x00
22:32:02:270 ZCL configure reporting rsp seq: 11 0xD0CF5EFFFE2108C1 for ep: 0x01 cluster: 0x0300 attr: 0x0003 status: 0x00
22:32:02:271 ZCL configure reporting rsp seq: 11 0xD0CF5EFFFE2108C1 for ep: 0x01 cluster: 0x0300 attr: 0x0004 status: 0x00
22:32:02:271 ZCL configure reporting rsp seq: 11 0xD0CF5EFFFE2108C1 for ep: 0x01 cluster: 0x0300 attr: 0x0007 status: 0x00
22:32:02:271 ZCL configure reporting rsp seq: 11 0xD0CF5EFFFE2108C1 for ep: 0x01 cluster: 0x0300 attr: 0x0008 status: 0x00
22:32:02:422 verified group capacity: 255 and group count: 1 of LightNode 0xd0cf5efffe2108c1
22:32:02:423 0xd0cf5efffe2108c1 found group 0xFFF0
22:32:03:423 0x00178801102D75CB error APSDE-DATA.confirm: 0xE9 on task
22:32:06:086 don't close database yet, keep open for 900 seconds
22:32:10:072 binding for cluster 0x0000 of 0x90FD9FFFFEE92B62 exists (verified by reporting)
22:32:10:072 binding for cluster 0x0006 of 0x90FD9FFFFEE92B62 exists (verified by reporting)
22:32:10:072 binding for cluster 0x0300 of 0x90FD9FFFFEE92B62 exists (verified by reporting)
22:32:10:072 skip configure report for cluster: 0x0300 attr: 0x0007 of node 0x90FD9FFFFEE92B62 (wait reading or unsupported)
22:32:10:072 skip config172.30.32.2 - - [20/Jul/2020:20:32:11 +0000] "GET /api/A2372245F6/lights/3?_=1595276993651 HTTP/1.1" 200 469 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:13 +0000] "GET /api/A2372245F6/lights/5?_=1595276993652 HTTP/1.1" 200 374 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:13 +0000] "GET /api/A2372245F6/groups?_=1595276993653 HTTP/1.1" 200 1275 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:13 +0000] "GET /api/A2372245F6/lights?_=1595276993654 HTTP/1.1" 200 8172 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:14 +0000] "GET /api/A2372245F6/sensors?_=1595276993655 HTTP/1.1" 200 3623 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:14 +0000] "GET /api/A2372245F6/config?_=1595276993656 HTTP/1.1" 200 3330 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:16 +0000] "GET /api/A2372245F6/lights/5?_=1595276993657 HTTP/1.1" 200 374 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:16 +0000] "GET /api/A2372245F6/lights/20?_=1595276993658 HTTP/1.1" 200 374 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:19 +0000] "GET /api/A2372245F6/lights/4?_=1595276993659 HTTP/1.1" 200 374 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:19 +0000] "GET /api/A2372245F6/lights/5?_=1595276993660 HTTP/1.1" 200 374 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:21 +0000] "GET /api/A2372245F6/lights/5?_=1595276993661 HTTP/1.1" 200 374 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:22 +0000] "GET /api/A2372245F6/lights/11?_=1595276993662 HTTP/1.1" 200 368 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:22 +0000] "GET /api/A2372245F6/lights/6?_=1595276993663 HTTP/1.1" 200 374 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:22 +0000] "GET /api/A2372245F6/lights/5?_=1595276993664 HTTP/1.1" 200 374 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:23 +0000] "GET /pwa/devices-lights.html?_v=4154ad416996058bda9ab2d1af622fe5bef45cec,6,1,22&gwid=00212EFFFF059C11 HTTP/1.1" 200 12999 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/index.html?1590152521000&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:23 +0000] "GET /pwa/developer.js HTTP/1.1" 404 142 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/devices-lights.html?_v=4154ad416996058bda9ab2d1af622fe5bef45cec,6,1,22&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:23 +0000] "GET /api/A2372245F6/config?_=1595277142963 HTTP/1.1" 200 3330 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/devices-lights.html?_v=4154ad416996058bda9ab2d1af622fe5bef45cec,6,1,22&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:23 +0000] "GET /api/A2372245F6/config?_=1595277142964 HTTP/1.1" 200 3330 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/devices-lights.html?_v=4154ad416996058bda9ab2d1af622fe5bef45cec,6,1,22&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:23 +0000] "GET /api/A2372245F6/lights?_=1595277142965 HTTP/1.1" 200 8172 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/devices-lights.html?_v=4154ad416996058bda9ab2d1af622fe5bef45cec,6,1,22&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:23 +0000] "GET /api/A2372245F6/lights?_=1595277142966 HTTP/1.1" 200 8172 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/devices-lights.html?_v=4154ad416996058bda9ab2d1af622fe5bef45cec,6,1,22&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:24 +0000] "GET /websocket HTTP/1.1" 101 32652 "-" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:24 +0000] "GET /api/A2372245F6/sensors/new HTTP/1.1" 200 34 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/devices-lights.html?_v=4154ad416996058bda9ab2d1af622fe5bef45cec,6,1,22&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:26 +0000] "GET /api/A2372245F6/lights/12?_=1595277142967 HTTP/1.1" 200 374 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/devices-lights.html?_v=4154ad416996058bda9ab2d1af622fe5bef45cec,6,1,22&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:26 +0000] "GET /api/A2372245F6/lights/6?_=1595277142968 HTTP/1.1" 200 374 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/devices-lights.html?_v=4154ad416996058bda9ab2d1af622fe5bef45cec,6,1,22&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:26 +0000] "GET /api/A2372245F6/lights/20?_=1595277142969 HTTP/1.1" 200 374 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/devices-lights.html?_v=4154ad416996058bda9ab2d1af622fe5bef45cec,6,1,22&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:29 +0000] "GET /api/A2372245F6/sensors/new HTTP/1.1" 200 34 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/devices-lights.html?_v=4154ad416996058bda9ab2d1af622fe5bef45cec,6,1,22&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:29 +0000] "GET /api/A2372245F6/lights/4?_=1595277142970 HTTP/1.1" 200 374 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/devices-lights.html?_v=4154ad416996058bda9ab2d1af622fe5bef45cec,6,1,22&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:29 +0000] "GET /api/A2372245F6/lights/6?_=1595277142971 HTTP/1.1" 200 374 "https://ha.xxxxxxxx.nl:8123/api/hassio_ingress/Klvu9V-1fRApXDOWJa0tyH4UOrn-4ZcbDU51Stq_8Fo/pwa/devices-lights.html?_v=4154ad416996058bda9ab2d1af622fe5bef45cec,6,1,22&gwid=00212EFFFF059C11" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
172.30.32.2 - - [20/Jul/2020:20:32:30 +0000] "GET /websocket HTTP/1.1" 101 2018 "-" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/84.0.4147.89 Safari/537.36"
ure report for cluster: 0x0300 attr: 0x0003 of node 0x90FD9FFFFEE92B62 (wait reading or unsupported)
22:32:10:073 skip configure report for cluster: 0x0300 attr: 0x0004 of node 0x90FD9FFFFEE92B62 (wait reading or unsupported)
22:32:10:073 skip binding for attribute reporting of ep: 0x00 cluster 0x1000 (end-device might sleep)
22:32:10:129 ZCL configure reporting rsp seq: 16 0x90FD9FFFFEE92B62 for ep: 0x01 cluster: 0x0006 attr: 0x0000 status: 0x00
22:32:10:194 ZCL configure reporting rsp seq: 17 0x90FD9FFFFEE92B62 for ep: 0x01 cluster: 0x0300 attr: 0x0008 status: 0x00
22:32:10:198 Bind response success for 0x90fd9ffffee92b62 ep: 0x01 cluster: 0x0008
22:32:10:198 skip configure report for cluster: 0x0008 attr: 0x0000 of node 0x90FD9FFFFEE92B62 (wait reading or unsupported)
22:32:10:605 verified group capacity: 255 and group count: 1 of LightNode 0x90fd9ffffee92b62
22:32:10:606 0x90fd9ffffee92b62 found group 0xFFF0
22:32:12:087 don't close database yet, keep open for 900 seconds
22:32:16:073 skip binding for attribute reporting of ep: 0x00 cluster 0x1000 (end-device might sleep)
22:32:16:620 verified group capacity: 24 and group count: 1 of LightNode 0x00178801102f7099
22:32:16:620 0x00178801102f7099 found group 0xFFF0
22:32:17:118 don't close database yet, keep open for 900 seconds
22:32:21:072 binding for cluster 0x0000 of 0x000D6FFFFEC3ACF9 exists (verified by reporting)
22:32:21:072 binding for cluster 0x0006 of 0x000D6FFFFEC3ACF9 exists (verified by reporting)
22:32:21:073 skip binding for attribute reporting of ep: 0x00 cluster 0x1000 (end-device might sleep)
22:32:21:169 ZCL configure reporting rsp seq: 24 0x000D6FFFFEC3ACF9 for ep: 0x01 cluster: 0x0006 attr: 0x0000 status: 0x00
22:32:21:229 Bind response success for 0x000d6ffffec3acf9 ep: 0x01 cluster: 0x0008
22:32:21:229 skip configure report for cluster: 0x0008 attr: 0x0000 of node 0x000D6FFFFEC3ACF9 (wait reading or unsupported)
22:32:21:275 verified group capacity: 255 and group count: 1 of LightNode 0x000d6ffffec3acf9
22:32:21:275 0x000d6ffffec3acf9 found group 0xFFF0
22:32:24:067 don't close database yet, keep open for 900 seconds
22:32:24:074 Websocket disconnected 127.0.0.1:53380 (state: 0) 
22:32:24:285 New websocket 127.0.0.1:53810 (state: 3) 
22:32:26:072 binding for cluster 0x0000 of 0xEC1BBDFFFEA6CCEF exists (verified by reporting)
22:32:26:072 binding for cluster 0x0006 of 0xEC1BBDFFFEA6CCEF exists (verified by reporting)
22:32:26:072 skip configure report for cluster: 0x0006 attr: 0x0000 of node 0xEC1BBDFFFEA6CCEF (seems to be active)
22:32:26:072 binding for cluster 0x0008 of 0xEC1BBDFFFEA6CCEF exists (verified by reporting)
22:32:26:072 skip configure report for cluster: 0x0008 attr: 0x0000 of node 0xEC1BBDFFFEA6CCEF (seems to be active)
22:32:26:073 skip binding for attribute reporting of ep: 0x00 cluster 0x1000 (end-device might sleep)
22:32:26:411 verified group capacity: 255 and group count: 1 of LightNode 0xec1bbdfffea6ccef
22:32:26:412 0xec1bbdfffea6ccef found group 0xFFF0
22:32:30:089 don't close database yet, keep open for 900 seconds
22:32:30:102 Current channel 25
22:32:30:110 Device TTL 1401 s flags: 0x7
22:32:30:572 Websocket disconnected 127.0.0.1:53810 (state: 0) 
22:32:31:072 binding for cluster 0x0000 of 0x086BD7FFFE54CC92 exists (verified by reporting)
22:32:31:072 binding for cluster 0x0006 of 0x086BD7FFFE54CC92 exists (verified by reporting)
22:32:31:072 binding for cluster 0x0008 of 0x086BD7FFFE54CC92 exists (verified by reporting)
22:32:31:072 binding for cluster 0x0300 of 0x086BD7FFFE54CC92 exists (verified by reporting)
22:32:31:072 skip binding for attribute reporting of ep: 0x00 cluster 0x1000 (end-device might sleep)
22:32:31:214 ZCL configure reporting rsp seq: 36 0x086BD7FFFE54CC92 for ep: 0x01 cluster: 0x0008 attr: 0x0000 status: 0x00
22:32:31:271 ZCL configure reporting rsp seq: 37 0x086BD7FFFE54CC92 for ep: 0x01 cluster: 0x0300 attr: 0x0003 status: 0x00
22:32:31:271 ZCL configure reporting rsp seq: 37 0x086BD7FFFE54CC92 for ep: 0x01 cluster: 0x0300 attr: 0x0004 status: 0x00

@frenck
Copy link
Member

frenck commented Jul 20, 2020

@GitHubxtsnl That issue is not related to this one. However, it looks like an issue with deCONZ itself, which should be reported with dresden/deCONZ.

@frenck
Copy link
Member

frenck commented Jul 20, 2020

A workaround for the VNC issue has been found, currently testing an implemented change.

@vdiogo
Copy link

vdiogo commented Jul 20, 2020

Issue remains after update to 6.1.1: Deconz add-on starts and I can open UI, and IKEA lights are detected, but cannot trigger any action on them. Also cannot add new lights from discovery.

Tried to restart Hassio and behaviour is the same

@jvyoralek
Copy link

I can confirm for aarch64 (Cortex-A53) the last version 6.1.1 resolved issue with VNC - had exactly as described in the issue description - and everything works fine now. Thanks for the quick fix.

@frenck
Copy link
Member

frenck commented Jul 20, 2020

@vdiogo That is not the problem reported in this issue. Please don't stack different problems, instead open up separate issues with details for each problem. Thanks 👍

@vdiogo
Copy link

vdiogo commented Jul 20, 2020

@frenck noted 👍

@GitHubxtsnl
Copy link

after I preformed the update to 6.1.1, enabled VNC again all seems to be working. I had to add the deCONZ integration again allowing it to pair with the ConBeeII.

@averstappen
Copy link

My current feeling says this is limited to ARMHF installations like the Raspberry Pi.
I'm currently unable to reproduce this on other platforms, so will move over to a Pi for further testing. If someone reads this with an AMD64, for example, I would love to know if it breaks for you.

My error seems very similar to what is reported in this issue, but in my case on amd64 platform. Logging below is from a local ly installed version where I added the ARCH info:

[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] firmware.sh: executing... 
/usr/bin/GCFFlasher_internal.bin: error while loading shared libraries: libQt5Core.so.5: cannot open shared object file: No such file or directory
[22:23:10] INFO: 
[cont-init.d] firmware.sh: exited 0.
[cont-init.d] nginx.sh: executing... 
[cont-init.d] nginx.sh: exited 0.
[cont-init.d] vnc.sh: executing... 
[cont-init.d] vnc.sh: exited 0.
[cont-init.d] done.
[services.d] starting services
[services.d] done.
[22:23:10] INFO: Running the deCONZ OTA updater...
[22:23:10] INFO: Waiting for device...
[22:23:10] INFO: Running the IKEA OTA updater...
[22:23:10] INFO: Starting udevd...
[22:23:10] INFO: Running the OSRAM LEdvance OTA updater...
[22:23:10] INFO: ARCH = amd64
ERROR: ld.so: object '/usr/lib/x86_64-linux-gnu//usr/lib/x86_64-linux-gnu/libQt5Core.so.5.11.3' from LD_PRELOAD cannot be preloaded (cannot open shared object file): ignored.
[22:23:10] INFO: Starting VNC server...

ERROR: ld.so: object '/usr/lib/x86_64-linux-gnu//usr/lib/x86_64-linux-gnu/libQt5Core.so.5.11.3' from LD_PRELOAD cannot be preloaded (cannot open shared object file): ignored.
[22:23:14] INFO: Waiting for VNC to start

If I remove the VNC port mapping the output changes, but the addon still fails to start:

[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] firmware.sh: executing... 
/usr/bin/GCFFlasher_internal.bin: error while loading shared libraries: libQt5Core.so.5: cannot open shared object file: No such file or directory
[22:27:40] INFO: 
[cont-init.d] firmware.sh: exited 0.
[cont-init.d] nginx.sh: executing... 
[cont-init.d] nginx.sh: exited 0.
[cont-init.d] vnc.sh: executing... 
[cont-init.d] vnc.sh: exited 0.
[cont-init.d] done.
[services.d] starting services
[services.d] done.
[22:27:40] INFO: Starting udevd...
[22:27:40] INFO: Running the OSRAM LEdvance OTA updater...
[22:27:40] INFO: Running the IKEA OTA updater...
[22:27:40] INFO: Running the deCONZ OTA updater...
[22:27:40] INFO: Waiting for device...
[22:27:40] INFO: Starting the deCONZ gateway...
deCONZ: error while loading shared libraries: libQt5Core.so.5: cannot open shared object file: No such file or directory
[cont-finish.d] executing container finish scripts...
[cont-finish.d] done.
[s6-finish] waiting for services.
[s6-finish] sending all processes the TERM signal.

@labaland
Copy link

labaland commented Jul 22, 2020

Upgraded deconz to 6.1.1 with hassio addons on my synology today and now i cant start it. reinstall did not help.

[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] firmware.sh: executing...
/usr/bin/GCFFlasher_internal.bin: error while loading shared libraries: libQt5Core.so.5: cannot open shared object file: No such file or directory
[20:53:03] INFO:
[cont-init.d] firmware.sh: exited 0.
[cont-init.d] nginx.sh: executing...
[cont-init.d] nginx.sh: exited 0.
[cont-init.d] vnc.sh: executing...
[cont-init.d] vnc.sh: exited 0.
[cont-init.d] done.
[services.d] starting services
[services.d] done.
[18:53:05] INFO: Starting udevd...
[18:53:05] INFO: Running the IKEA OTA updater...
[20:53:05] INFO: Waiting for device...
[18:53:05] INFO: Running the deCONZ OTA updater...
[18:53:05] INFO: Running the OSRAM LEdvance OTA updater...
[20:53:05] INFO: Starting the deCONZ gateway...
deCONZ: error while loading shared libraries: libQt5Core.so.5: cannot open shared object file: No such file or directory
Error: writing output failed: Broken pipe
[cont-finish.d] executing container finish scripts...
[cont-finish.d] done.
[s6-finish] waiting for services.
[s6-finish] sending all processes the TERM signal.

@labaland
Copy link

labaland commented Jul 24, 2020

Same error as above with 6.1.2 When restoring back to 5.3.6 it works again!
VNC is disabled, and all network ports under configuration are disabled
Hassio on synology DS916+

@pvizeli
Copy link
Member

pvizeli commented Jul 25, 2020

For synology user or people with old EOL kernel 3 -> #1487

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Projects
None yet
Development

Successfully merging a pull request may close this issue.