Test js-controller v2.0.x (GitHub)
-
@apollon77 sagte in [Aufruf] js-controller 2.0 Beta Test:
(Apollon77) fix potential cases where objects/states files were not stored
Funktioniert! Daumen hoch!
Logs schicke ich später.
-
@darkiop Strange nummer. Welche nodejs version hast du?
-
@apollon77 leider will redis immer noch nicht...
Connecting to previous DB "file"... Creating backup ... This can take some time ... please be patient! host.iobroker 16727 states saved host.iobroker 19327 objects saved Backup created: /opt/iobroker/backups/2019_10_02-13_54_13_backupiobroker-migration.tar.gz Connecting to new DB "redis" ... States NOT connected Objects NOT connected New Database could not be connected. Please check your settings. No settings have been changed.Kann ich sonst noch irgendwas überprüfen, wo es haken könnte?
-
┬─[darkiop@iobroker-hwr:~]─[14:06:17] ╰─>$ node -v && npm -v v10.16.3 6.9.0 ┬─[root@iobroker-master:/opt/iobroker]─[14:06:43] ╰─># node -v && npm -v v10.16.3 6.9.0iobroker-master / iobroker-hwr auf 2.0.19:
- adapter hue.0 beendet, iobroker-master neu gestartet = hue.0 ist immer noch deaktiviert
- dann hue.0 aktiviert, iobroker-master neu gestartet = hue.0 ist aktiviert
- parallel dazu den timestamp der objects.json beobachtet, datei wurde nach Änderung neu geschrieben (5s)
Würde sagen das objects.json Thema ist gefixt.
Bei den Tests ist mir leider noch etwas weiteres aufgefallen. Bin daher zum Test nochmal auf die 1.5.14 zurück:
iobroker-master / iobroker-hwr auf 2.0.19, beide verbunden
Wird der iobroker-master neugestartet = iobroker-hwr verbindet sich nicht mehr wenn iobroker-master onlineiobroker-master / iobroker-hwr auf 1.5.14
Wird der iobroker-master neugestartet = iobroker-hwr verbindet sich wieder iobroker-master online -
@apollon77 nun geht es weiter ABER bricht ab.
Die Redis DB ist nun auch schon 70MB also hat es wohl zum teil geklappt laut iobroker status / iobroker setup custom laufe ich auf redis ... Hoffe ich hab den n icht abgebrochen dabei weil alles hing habe ich Docker Container Neu gestartet ..
Habe bei Instanzen die Adapter Icons nicht mehr und bei Objekte fast überall das I icon. Er Installiert wohl nach und nach nun die Adapter. Wie beim Minimal restore ... aber scheint auf Redis zu laufen. Ist das normal?
Edit: Glaub ich hätte nicht Neustarten sollen .. Lasse gerade mal ein Restore laufen aber iobroker ist laut status mit Redis ...
Mal schauen was nun passiert.Edit2: Nach dem Restore ist redit DB auf 120Mb gestiegen und alles "scheint" zu laufen. Vielleicht kann man die Meldungen etwas Optimieren
Hatte jetzt gedacht das es nicht geklappt hat. -
@apollon77 ich nehme vorerst meine Aussage zurück, ich war wohl etwas schnell mit dem Installieren der neuen Version, ist immer noch 2.0.17.
Probiere nachher nochmal -
@coyote Das sieht nach der alten version aus! SIcher das Du latest Update 2.0.19 drauf hast?
-
@darkiop sagte in [Aufruf] js-controller 2.0 Beta Test:
iobroker-master / iobroker-hwr auf 2.0.19, beide verbunden
Wird der iobroker-master neugestartet = iobroker-hwr verbindet sich nicht mehr wenn iobroker-master onlineBitte Log vom Slave ... an sich sollte er es ein paar mal versuchen und sich dann retarten und spätestens dann wieder connecten. hat bei mir in den tests perfekt geklappt ...
-
@apollon77 sagte in [Aufruf] js-controller 2.0 Beta Test:
@SBorg Hast Du noch alte 1.5.x logs um zu sehen wie lange zwischen start und end war und wie lange es jetzt ist? hast ja die "starting " und "wurde beendet" logs ...
Und: Was ist das für ein System? Effektiv das wo der Master läuft (wil ist ja file/file korrekt?)
Hmm, nicht gut... :
2019-09-29 00:26:03.823 - info: daswetter.0 starting. Version 2.8.1 in /opt/iobroker/node_modules/iobroker.daswetter, node: v8.16.1 2019-09-29 00:26:26.138 - info: host.Ubuntu instance system.adapter.daswetter.0 terminated with code 11 (Desired termination)23 Sekunden ...
Ist ein Intel Dual Core mit 1.8GHz und 2 GB RAM, nur Master und keine Slaves, file/file
Der JS-Controller produziert eine Systemauslastung von 100%, ohne bin ich unter 10%, beim RAM bin ich alleine für den Broker schon > 1GB. Ich habe zwar keine Werte für den 1.5.14 parat, der braucht aber deutlich weniger. -
@ChrisXY Also die Meldung ist in jedem Fall nicht vollständig und da hat auf jedem Fall ws nicht geklappt weil danach die ganzen Updates hätten kommen müssen. Ich checke nochmal bei mir.
Auch diese Meldung "iobroker deamon not running ..." ist nicht normal.
Also die Migration hat definitiv nicht geklappt.
Mit deinem Restore hast Du das Backup in Redis eingespielt und jetzt spult er sein "Normales" Programm ab. Also das geht auch, aber ich muss checken was die Migration hat
-
@apollon77 sagte in [Aufruf] js-controller 2.0 Beta Test:
Bitte Log vom Slave ... an sich sollte er es ein paar mal versuchen und sich dann retarten und spätestens dann wieder connecten. hat bei mir in den tests perfekt geklappt ...
Er schafft es nicht. Und da ist dann auch wieder der ECONNREFUSED. Aber zu dem Zeitpunkt hat der iobroker-hwr definitiv eine IPv4 (wieso sollte er dich auch verlieren nach dem Verlust der Verbindung :)) Nach dem Verbindungsverlust läuft auch kein iob-Prozess mehr auf dem iobroker-hwr.
-
@darkiop Und was ist im Log Nach dem "starting node restart.js"? an sich sollte der js-controller da sich restarten! Ganz automagisch ... also das tut er bei mir
-
@apollon77 sagte in [Aufruf] js-controller 2.0 Beta Test:
Und was ist im Log Nach dem "starting node restart.js"? an sich sollte der js-controller da sich restarten! Ganz automagisch ... also das tut er bei mir
Nichts mehr, hab es eben noch mal provoziert. In der Folge ist kein iobroker Prozess mehr auf dem iobroker-hwr am laufen.
Interessant ist auch das in diesem Zusammenhang immer der Fehler mit dem Unknown Skript geworfen wird:
2019-10-02 19:04:10.089 - warn: host.iobroker-hwr Cannot get view: ReplyError: Error Unknown Script 47ca5e051ba19850d94c45a1fc8725ff04ae868f 2019-10-02 19:04:10.093 - info: host.iobroker-hwr instance system.adapter.smartmeter.0 terminated with code 0 (NO_ERROR) 2019-10-02 19:04:10.094 - info: host.iobroker-hwr All instances are stopped. 2019-10-02 19:04:10.132 - warn: host.iobroker-hwr Cannot get view: ReplyError: Error Unknown Script 47ca5e051ba19850d94c45a1fc8725ff04ae868f -
@darkiop das unknown Skript ist klar weil connection weg. Das kann ich mal noch optimieren aber egal.
Das Thema ist das der Controller sich neu starten will aber er es bei dir nicht tut. Das log sagt das er es versucht. Frage ist jetzt warum es nicht tut ... hm ... Das ist Strange. Sagt /var/log/syslog irgendwas?
-
@apollon77 sagte in [Aufruf] js-controller 2.0 Beta Test:
Das ist Strange. Sagt /var/log/syslog irgendwas?
Nichts. Auch nicht in messages.
-
@darkiop gestartet war der Slave manuell mir iobroker Start oder beim Boot?
-
@apollon77 sagte in [Aufruf] js-controller 2.0 Beta Test:
gestartet war der Slave manuell mir iobroker Start oder beim Boot?
Das teste ich schnell, aktuell ist er manuell gestartet. Melde ich gleich wieder.
-
@darkiop Danke. Mach langsam. Ich erstmal Kino
-
@apollon77 sagte in [Aufruf] js-controller 2.0 Beta Test:
Danke. Mach langsam. Ich erstmal Kino
Wir gleich Couch + Netflix - das durchbooten geht aber vorher noch
-
Macht keinen Unterschied - der erste Fehlerblock war der manuell gestartete ioBroker, der zweite durchs Starkskript beim booten:
2019-10-02 19:44:51.660 - warn: host.iobroker-hwr Slave controller detected disconnection. Stop all instances. 2019-10-02 19:44:51.666 - info: host.iobroker-hwr stopInstance system.adapter.smartmeter.0 2019-10-02 19:44:51.667 - info: host.iobroker-hwr stopInstance forced system.adapter.smartmeter.0 killing pid 2798 2019-10-02 19:44:51.668 - info: host.iobroker-hwr stopInstance system.adapter.smartmeter.1 2019-10-02 19:44:51.669 - info: host.iobroker-hwr stopInstance forced system.adapter.smartmeter.1 killing pid 2813 2019-10-02 19:44:51.672 - warn: smartmeter.0 (2798) ERROR CLOSING SERIALPORT 2019-10-02 19:44:51.674 - warn: smartmeter.1 (2813) ERROR CLOSING SERIALPORT 2019-10-02 19:44:53.159 - warn: smartmeter.1 (2813) Cannot connect/reconnect to objects DB. Terminating 2019-10-02 19:44:53.160 - warn: smartmeter.0 (2798) Cannot connect/reconnect to objects DB. Terminating 2019-10-02 19:45:04.162 - error: host.iobroker-hwr connect ECONNREFUSED 192.168.1.82:9000 2019-10-02 19:45:04.164 - error: host.iobroker-hwr Error: connect ECONNREFUSED 192.168.1.82:9000 at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1106:14) 2019-10-02 19:45:08.692 - warn: host.iobroker-hwr Slave controller detected disconnection. Stop all instances. 2019-10-02 19:45:08.694 - info: host.iobroker-hwr stopInstance system.adapter.smartmeter.0 2019-10-02 19:45:08.694 - info: host.iobroker-hwr stopInstance system.adapter.smartmeter.1 2019-10-02 19:45:11.070 - warn: host.iobroker-hwr Cannot get view: ReplyError: Error Unknown Script 47ca5e051ba19850d94c45a1fc8725ff04ae868f 2019-10-02 19:45:11.074 - info: host.iobroker-hwr instance system.adapter.smartmeter.1 terminated with code 0 (NO_ERROR) 2019-10-02 19:45:11.075 - info: host.iobroker-hwr All instances are stopped. 2019-10-02 19:45:11.111 - warn: host.iobroker-hwr Cannot get view: ReplyError: Error Unknown Script 47ca5e051ba19850d94c45a1fc8725ff04ae868f 2019-10-02 19:45:11.112 - info: host.iobroker-hwr instance system.adapter.smartmeter.0 terminated with code 0 (NO_ERROR) 2019-10-02 19:45:21.678 - info: host.iobroker-hwr iobroker _restart 2019-10-02 19:45:22.210 - info: host.iobroker-hwr iobroker Starting node restart.js 2019-10-02 19:46:49.416 - info: host.iobroker-hwr iobroker.js-controller version 2.0.19 js-controller starting 2019-10-02 19:46:49.427 - info: host.iobroker-hwr Copyright (c) 2014-2019 bluefox, 2014 hobbyquaker 2019-10-02 19:46:49.429 - info: host.iobroker-hwr hostname: iobroker-hwr, node: v10.16.3 2019-10-02 19:46:49.431 - info: host.iobroker-hwr ip addresses: 10.3.1.22 fe80::dea6:32ff:fe17:78f5 2019-10-02 19:46:55.775 - info: host.iobroker-hwr connected to Objects and States 2019-10-02 19:46:57.118 - warn: host.iobroker-hwr Multihost discovery server: service started on 0.0.0.0:50005 2019-10-02 19:47:03.673 - info: host.iobroker-hwr 85 instances found 2019-10-02 19:47:03.691 - info: host.iobroker-hwr starting 2 instances 2019-10-02 19:47:03.716 - info: host.iobroker-hwr instance system.adapter.smartmeter.0 started with pid 987 2019-10-02 19:47:07.708 - info: host.iobroker-hwr instance system.adapter.smartmeter.1 started with pid 1010 2019-10-02 19:48:45.976 - warn: host.iobroker-hwr Slave controller detected disconnection. Stop all instances. 2019-10-02 19:48:45.982 - info: host.iobroker-hwr stopInstance system.adapter.smartmeter.0 2019-10-02 19:48:45.983 - info: host.iobroker-hwr stopInstance forced system.adapter.smartmeter.0 killing pid 987 2019-10-02 19:48:45.985 - info: host.iobroker-hwr stopInstance system.adapter.smartmeter.1 2019-10-02 19:48:45.985 - info: host.iobroker-hwr stopInstance forced system.adapter.smartmeter.1 killing pid 1010 2019-10-02 19:48:45.990 - warn: smartmeter.1 (1010) ERROR CLOSING SERIALPORT 2019-10-02 19:48:47.477 - warn: smartmeter.1 (1010) Cannot connect/reconnect to objects DB. Terminating 2019-10-02 19:48:47.478 - warn: smartmeter.0 (987) Cannot connect/reconnect to objects DB. Terminating 2019-10-02 19:48:58.479 - error: host.iobroker-hwr connect ECONNREFUSED 192.168.1.82:9000 2019-10-02 19:48:58.480 - error: host.iobroker-hwr Error: connect ECONNREFUSED 192.168.1.82:9000 at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1106:14) 2019-10-02 19:49:03.124 - warn: host.iobroker-hwr Slave controller detected disconnection. Stop all instances. 2019-10-02 19:49:03.126 - info: host.iobroker-hwr stopInstance system.adapter.smartmeter.0 2019-10-02 19:49:03.127 - info: host.iobroker-hwr stopInstance system.adapter.smartmeter.1 2019-10-02 19:49:04.261 - warn: host.iobroker-hwr Cannot get view: ReplyError: Error Unknown Script 47ca5e051ba19850d94c45a1fc8725ff04ae868f 2019-10-02 19:49:04.265 - info: host.iobroker-hwr instance system.adapter.smartmeter.1 terminated with code 0 (NO_ERROR) 2019-10-02 19:49:04.266 - info: host.iobroker-hwr All instances are stopped. 2019-10-02 19:49:04.299 - warn: host.iobroker-hwr Cannot get view: ReplyError: Error Unknown Script 47ca5e051ba19850d94c45a1fc8725ff04ae868f 2019-10-02 19:49:04.300 - info: host.iobroker-hwr instance system.adapter.smartmeter.0 terminated with code 0 (NO_ERROR) 2019-10-02 19:49:04.300 - info: host.iobroker-hwr All instances are stopped. 2019-10-02 19:49:15.988 - info: host.iobroker-hwr iobroker _restart 2019-10-02 19:49:16.492 - info: host.iobroker-hwr iobroker Starting node restart.js
