search

rdmtc / RedMatic-HomeKit

HAP-Nodejs based Node-RED nodes to create (bridged) HomeKit Accessories
Apache License 2.0
61 stars 22 forks source link

Abstürze, RedMatic-HomeKit lässt sich nicht installieren #146

Closed superpower10 closed 1 year ago

superpower10 commented 5 years ago

Hier das Log:

May  9 17:30:06 ccu3-webui daemon.err node-red: 9 May 17:30:06 - [red] Uncaught Exception:
May  9 17:30:06 ccu3-webui daemon.err node-red: 9 May 17:30:06 - Error: This callback function has already been called by someone else; it can only be called one time.
May  9 17:30:06 ccu3-webui daemon.err node-red:     at /usr/local/addons/redmatic/lib/node_modules/redmatic-homekit/node_modules/hap-nodejs/lib/util/once.js:12:13
May  9 17:30:06 ccu3-webui daemon.err node-red:     at Characteristic.LeakDetected.addListener.callback (/usr/local/addons/redmatic/lib/node_modules/redmatic-homekit/homematic-devices/lib/accessory.js:203:13)
May  9 17:30:06 ccu3-webui daemon.err node-red:     at Characteristic.LeakDetected.emit (events.js:194:15)
May  9 17:30:06 ccu3-webui daemon.err node-red:     at Characteristic.LeakDetected.Characteristic.getValue (/usr/local/addons/redmatic/lib/node_modules/redmatic-homekit/node_modules/hap-nodejs/lib/Characteristic.js:164:10)
May  9 17:30:06 ccu3-webui daemon.err node-red:     at Bridge.<anonymous> (/usr/local/addons/redmatic/lib/node_modules/redmatic-homekit/node_modules/hap-nodejs/lib/Accessory.js:769:20)
May  9 17:30:06 ccu3-webui daemon.err node-red:     at Array.forEach (<anonymous>)
May  9 17:30:06 ccu3-webui daemon.err node-red:     at Bridge.Accessory._handleGetCharacteristics (/usr/local/addons/redmatic/lib/node_modules/redmatic-homekit/node_modules/hap-nodejs/lib/Accessory.js:733:8)
May  9 17:30:06 ccu3-webui daemon.err node-red:     at HAPServer.emit (events.js:189:13)
May  9 17:30:06 ccu3-webui daemon.err node-red:     at HAPServer._handleCharacteristics (/usr/local/addons/redmatic/lib/node_modules/redmatic-homekit/node_modules/hap-nodejs/lib/HAPServer.js:926:10)
May  9 17:30:06 ccu3-webui daemon.err node-red:     at HAPServer.<anonymous> (/usr/local/addons/redmatic/lib/node_modules/redmatic-homekit/node_modules/hap-nodejs/lib/HAPServer.js:209:39)
May  9 17:30:06 ccu3-webui daemon.err node-red: Node-RED exited with non-zero exit status 1
hobbyquaker commented 5 years ago

habe eine vermutung, ich befürchte da gibts ein schwerwiegenden bug beim bereitstellen von heizungsgruppen in homekit. Falls Du die verwendest: starte mal im Safe Mode und deaktiviere im CCU Configuration Node das VirtualDevices Interface.

hobbyquaker commented 5 years ago

Oh, ah halt. Bei Dir hat es wohl eine andere Ursache, da gehts um ein Wassermelder. Muss ich untersuchen.

hobbyquaker commented 5 years ago

Was mir sehr helfen würde wär mal ein Log auf Debug Level dass alles vom Start bis zum Crash enthält.

superpower10 commented 5 years ago

OK. Habe auf Debug gestellt.

Sobald es wieder abstürzt, werde ich das LOG-File hier posten

superpower10 commented 5 years ago

Also nachdem ich mehrere Updates gemacht habe. Raspberrymatic und Redmatic auf die neueste Version, startet Redmatic gar nicht mehr.

Bildschirmfoto 2019-05-12 um 16 06 36 
May 12 14:50:19 ccu3-webui daemon.info node-red[790]: Starting flows
May 12 14:50:19 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] local connection on ccu >= v3.41 detected
May 12 14:50:20 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] paramsets loaded from /usr/local/addons/redmatic/var/paramsets.json
May 12 14:50:20 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] metadata loaded from /usr/local/addons/redmatic/var/ccu_localhost.json
May 12 14:50:20 ccu3-webui daemon.info node-red[790]: Started flows
May 12 14:50:21 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] Interfaces: ReGaHSS, BidCos-RF, HmIP-RF, VirtualDevices
May 12 14:50:21 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] ReGaHSS binrpc port 31999 connected
May 12 14:50:21 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] init BidCos-RF binrpc://127.0.0.1:2047 nr_AKHydZ_BidCos-RF
May 12 14:50:21 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] init HmIP-RF http://127.0.0.1:2048 nr_D24DjW_HmIP-RF
May 12 14:50:21 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] init VirtualDevices http://127.0.0.1:2048 nr_D24DjW_VirtualDevices
May 12 14:50:21 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] binrpc server listening on binrpc://127.0.0.1:2047
May 12 14:50:21 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] xmlrpc server listening on http://127.0.0.1:2048
May 12 14:50:22 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] HmIP-RF http port 32010 connected
May 12 14:50:22 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] BidCos-RF binrpc port 32001 connected
May 12 14:50:23 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] metadata saved to /usr/local/addons/redmatic/var/ccu_localhost.json
May 12 14:50:23 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] metadata saved to /usr/local/addons/redmatic/var/ccu_localhost.json
May 12 14:50:31 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] VirtualDevices http port 39292 connected
May 12 14:50:31 ccu3-webui daemon.info node-red[790]: [redmatic-homekit-homematic-devices:d2eec606.c68ba] publish 47 devices
May 12 14:50:51 ccu3-webui daemon.info node-red[790]: [redmatic-homekit-homematic-devices:d2eec606.c68ba] publish done
May 12 14:50:55 ccu3-webui daemon.info node-red[790]: [redmatic-homekit-bridge:RedMatic Bridge] bridge already published (46 Accessories) RedMatic Bridge CC:22:3D:FB:81:EC on port 51826
May 12 14:54:57 ccu3-webui daemon.info redmatic: Stopping Node-RED
May 12 14:54:57 ccu3-webui daemon.info node-red[790]: Stopping flows
May 12 14:54:58 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] de-init BidCos-RF binrpc://127.0.0.1:2047 done
May 12 14:54:58 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] de-init HmIP-RF http://127.0.0.1:2048 done
May 12 14:54:58 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] de-init VirtualDevices http://127.0.0.1:2048 done
May 12 14:54:58 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] binrpc server closed
May 12 14:54:58 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] xmlrpc server closed
May 12 14:54:58 ccu3-webui daemon.info node-red[790]: [ccu-connection:localhost] rpc close done
May 12 14:54:58 ccu3-webui daemon.info node-red[790]: Stopped flows
May 12 14:54:59 ccu3-webui daemon.info redmatic: Node-RED stopped
May 12 15:07:48 ccu3-webui daemon.info redmatic-pkg: Package redmatic-homekit update 2.3.2 to 2.3.3
May 12 15:07:48 ccu3-webui daemon.info redmatic-pkg: Get https://github.com/rdmtc/RedMatic/releases/download/v4.4.3/redmatic-pkg-redmatic-homekit-2.3.3.tar.gz
May 12 15:47:43 ccu3-webui daemon.info redmatic-pkg: Package redmatic-homekit update 2.3.2 to 2.3.3
May 12 15:47:43 ccu3-webui daemon.info redmatic-pkg: Get https://github.com/rdmtc/RedMatic/releases/download/v4.4.3/redmatic-pkg-redmatic-homekit-2.3.3.tar.gz
May 12 16:03:32 ccu3-webui daemon.info redmatic-pkg: Package redmatic-homekit update 2.3.2 to 2.3.3
May 12 16:03:32 ccu3-webui daemon.info redmatic-pkg: Get https://github.com/rdmtc/RedMatic/releases/download/v4.4.3/redmatic-pkg-redmatic-homekit-2.3.3.tar.gz
hobbyquaker commented 5 years ago

Args, blödes Problem: Beim ersten Start nach einem Update versucht das Startscript die Zusatzpakete mit Binärabhängigkeiten (also alle die im RedMatic UI unter "Packages" installiert sind) zu aktualiseren. Dazu versucht es die redmatic-pkg-*.tar.gz Dateien direkt von Github runterzuladen (ersichtlich in Deinem Log ganz unten: Get https://github.com/rdmtc/RedMatic/releases/download/v4.4.3/redmatic-pkg-redmatic-homekit-2.3.3.tar.gz). Das scheint nie zu einem Ende zu kommen, ich vermute/befürchte dass Du grade auch auf ein Problem stößt dass zur Zeit um sich greift: superlangsame Github Downloads, sowohl bei der Telekom als auch bei Unity seit einigen Wochen immer wieder nur ein paar KB/s... Das RedMatic-HomeKit Paket das er da laden will ist 22MB groß...

Als schnellen Workaround würde ich folgendes Vorschlagen: Die Datei /usr/local/addons/redmatic/var/do_pkg_upgrade löschen und dann nochmal RedMatic neu starten. Dann versucht er nicht die Updates zu machen und Du bleibst erstmal auf der vorherigen RedMatic-HomeKit Version. Später kannst dann das Update von RedMatic-HomeKit nochmal manuell versuchen indem Du es einfach im RedMatic UI unter Packages einmal deinstallierst und dann wieder neu installierst, anschließend Node-RED neu starten. Auch sinnvoll wäre es wenn Du mal schaust mit welcher Geschwindigkeit Du von Github im Browser runterladen kannst - um diese Vermutung was die Ursache angeht zu prüfen.

superpower10 commented 5 years ago

So etwas ähnliches hatte ich mir schon gedacht und bereits HomeKit deinstalliert. Danach hat sich Redmatic automatisch gestartet.

Jetzt versuche ich gerade HomeKit wieder zu installieren.

In /usr/local/addons/redmatic/var/pkg-upgrade.log steht:

Package redmatic-homekit update 2.3.2 to 2.3.3
Get https://github.com/rdmtc/RedMatic/releases/download/v4.4.3/redmatic-pkg-redmatic-homekit-2.3.3.tar.gz
curl: (56) OpenSSL SSL_read: SSL_ERROR_SYSCALL, errno 104
superpower10 commented 5 years ago

In /usr/local/addons/redmatic/var/pkg-upgrade.log steht:

Package redmatic-homekit update 2.3.2 to 2.3.3
Get https://github.com/rdmtc/RedMatic/releases/download/v4.4.3/redmatic-pkg-redmatic-homekit-2.3.3.tar.gz
curl: (56) OpenSSL SSL_read: SSL_ERROR_SYSCALL, errno 104
hobbyquaker commented 5 years ago

Hmm. Macht mich erstmal ratlos. Gibt es bei Dir spezielle Netzwerkbegenheiten (Firewall, Proxy, ...) oder hängt die CCU "ganz normal" über einen Consumer-Router (Fritzbox, Speedport, ...) am Internet? Aus irgendeinem Grund scheitert da wohl die TLS Negotation zwischen Curl und dem Github bzw. Amazon S3 Webserver. Wenn Du ein "ganz normales" Netzwerk hast würde ich vorschlagen (ein bisschen aus Verzweiflung weil mir nichts besseres einfällt, aber schaden tut es sicher nicht) mal alles neuzustarten (Router, CCU) und es einfach noch mal zu probieren. Wenn das Problem weiter besteht müssten wir mal auf der Commandline ein Curl Download testen mit mehr Debug Output und wenn das keine verwertbaren Erkentnisse bringt das ganze mal Sniffen, aber gleich vorneweg: ich bin kein TLS und OpenSSL Experte, solchen Fehlern auf die Schliche zu kommen ist nicht ganz trivial, aber ich glaub ich weiss wo ich dann Hilfe bekommen kann ;-)

superpower10 commented 5 years ago

Kein Chance. RedMatic-HomeKit lässt sich nicht installieren. Es dreht und dreht und nichts passiert. Auch nach Stunden nicht.

Kann man das auch selbst herunterladen und installieren? Wenn ja, wie?

Oder wie testet man mit Curl einen Download?

hobbyquaker commented 5 years ago

Manuell auf der Commandline sollte der Download via Curl und die Installation so funktionieren:

/usr/bin/curl https://github.com/rdmtc/RedMatic/releases/download/v4.6.0/redmatic-pkg-redmatic-homekit-2.3.3.tar.gz -o /usr/local/addons/redmatic/tmp/redmatic-homekit.tar.gz --location

cd /usr/local/addons/redmatic

tar --no-same-owner -xzf tmp/redmatic-homekit.tar.gz

rm tmp/redmatic-homekit.tar.gz

/etc/config/rc.d/redmatic restart

Spannend wird dabei was das Curl Kommando "sagt"... Wenn das mit dem Curl Download schon fehlschlägt könntest die Datei auch anderswo runterladen und per (win)scp nach /usr/local/addons/redmatic/tmp/redmatic-homekit.tar.gz kopieren.

superpower10 commented 5 years ago

Also es liegt wohl doch an GitHub. Die Geschwindigkeit ist unter aller s....

Bildschirmfoto 2019-05-14 um 20 53 56

Deswg. fände ich es gut, wenn man so eine Anzeige auch auf der GUI im Web sehen würde, dann wüsste man Bescheid...

Per Browser dauert das download nur ein paar Sekunden...

Aber auch die CCU3 ist seit der neuesten RaspberryMatic Version unglaublich langsam beim installieren von Add-Ons und Backups wieder einspielen (Security lässt wohl grüßen)

superpower10 commented 5 years ago

So jetzt hat es funktioniert. Vielen Dank