Test js-controller v2.0.x (GitHub)
-
Hi, habe auch mal upgedatet. Alles sofort geklappt. Mir fällt nur auf, dass ich unter den Objekten welche mittels Historie oder statistics mitlogge nicht mehr deaktivieren kann. Also die Maulschlüssel öffnen ganz normal die Einstellungen.Der Haken aktiv lässt sich auch ohne weiteres deaktiviern nur beim Speichern werden Änderungen nicht übernommen.
Systemdaten:
ioBroker-Rock Typ: js-controller Titel: JS controller OS: linux Verfügbar: 2.0.29 Eingerichtet: 2.0.29 Ereignisse: ⇥24 / ↦13 ioBroker-Rock Betriebssystem linux Architektur arm64 CPUs 4 Geschwindigkeit 1296 MHz Modell unknown RAM 3.9 GB System Betriebszeit 2 T. 18:38:11 Node.js v10.16.3 NPM 6.9.0 Festplatte Größe 56.1 GB Festplatte frei 47.85 GB Anzahl der Adapter 293 Betriebszeit 00:11:12 Aktive Instanzen 22 Hostname ioBroker-Rockdas hier taucht auch im log auf.Nach neustart..
Error 2019-10-14 17:46:22.010 warn from InMemDB: Error: Unknown Script 47ca5e051ba19850d94c45a1fc8725ff04ae868f
Error 2019-10-14 17:46:22.007 warn from InMemDB: Error: Unknown Script 47ca5e051ba19850d94c45a1fc8725ff04ae868f -
@smartboart Die Scripts Fehler könnten kommen wenn Du verschiedene Versionen laufen hast (Master/Slave ode rso) . Kann dass sein? Ggf bitte nochmal neu starten. Ich arbeite noch an einer nächsten version die da Dinge noch fixt.
Das andere mit Custom ich ansehen. Ist aktuell nicht bekannt. Kann es noch jemand nachvollziehen?
-
@apollon77
ja hab nen multihost system, aber beide hochgezogen...
Beides neu gestartet, der Skript Fehler ist aber immernoch im log..Der tauchte auch im master bei iobroker upgrade self im Anschluss auf. Das Upgrade ging erst beim 2 mal durch.. Hatte vorher das vorletzte releas drauf 2.0.25, was ohne Probleme zu installieren war..
-
@apollon77
hallo, hatte vorher nur states auf redis..Hab jetzt auch file auf redis umgestellt. Im Anschluss waren meine oben beschriebenen Fehler beseitigt.. Falls die Info hilfreich ist. Danke für eure tolle Arbeit! -
Bei Adapter Updates habe ich folgende Gyp Fehler im Log.. oben wurde beschrieben es hat hier mit dem js controller nix zu tun . Meine Python Installation meldet bei
apt-get install python-dev allerdings dass alles aktuell ist und nichts upzudaten wäre.. Die fehler haben keine Auswirkungen. mich würde trotzdem interessieren was die Ursache dafür ist...
-
Den ersten Härtetest hat das System heute schon hinter sich.
Stromausfall und die USV war abgeschaltet
weil ich den Batteriepack mit zur Arbeit hatte zum Austausch.
Nach 30 Minuten fährt das System wieder hoch als wäre nichts geschehen.
-
@smartboart mehr log bitte
-
Hallo nochmals ich,
ich habe mit das Reconnection Handling nochmal angesehen, weil es anders war wie gewollt.
Die 2.0.30 auf GitHub hat das umgebaut.Ich wäre hier nochmal froh wenn Ihr checken könntet. Vor allem interessant ist das Verhalten von Slaves wenn der Master weg ist bzw. das verhalten des Gesamtsystems bei Redis-Nutzung wenn Redis weg ist.
Mit der 2.0.30 wird bis zu ca. 40s versucht die Verbindung wieder herzustellen. Wenn das gelingt kommt das ganze ohne Restarts aus und auch aufgelaufene Datenänderungen (zB setState oder Infos zu State-Änderungen) werden nachgespielt.
Wenn es länger braucht beenden sich die Adapter wie bisher und alles wartet das die DB wieder da ist. -
Habe beide auf die 2.0.30 gezogen.
Beim installieren gab es ungewöhnlich viele Warnungen, die hatte ich vorher nicht - siehe Log. Beide laufen aber ohne Auffälligkeiten.
-
Zu deinen gewünschten Tests:
Testfall 1:
master + slave = alive
master beenden
nicht wieder startenTestfall 2:
master + slave = alive
master beenden
20s warten
wieder startenTestfall 3:
master + slave = alive
redis beenden
nicht wieder startenTestfall 4:
master + slave = alive
redis beenden
paar Sekunden warten
redis starten
prüfen ob States die innerhalb der 40s erzeugt werden nach dem starten von redis verfügbar sind -
Testfall 1:
iobroker-master um 10:26:02 beendet und nicht wieder gestartet, log auf slave. Nach ner gewissen Zeit beenden sich die Adapter und der controller lauert:
-
Testfall 2:
iobroker-master um 10:30:05 beendet und nach 20s wieder gestartet, log auf slave:
--> Kein Log das die Verbindung wieder besteht. 10:32:37 wurde der iobroker-master wieder gestartet und war ein paar Sekunden später auch wieder Verbunden (--> ersichtlich im Admin).
-
Testfall 3
iobroker-redis um 10:45:13 Uhr beendet. Log Master.
Einige Minuten später iobroker-redis wieder gestartet - der iobroker-master schafft es nicht wieder auf die Beine. Nach einem restart des Containers für den Master ist wieder alles verbunden. -
Testfall 4
┬─[darkiop@odin:~]─[11:00:32]
╰─>$ docker stop iobroker-redis┬─[darkiop@odin:~]─[11:02:15]
╰─>$ docker start iobroker-redissmartmeter.1 hat einen Wert von 2019-10-15 11:01:34.726 über sql.0 in die DB geschrieben!
-
@darkiop Alles unix dgram complier warnungen
Aber ja ist egal, tut alles -
Danke für die Tests!!
- Testfall1 : So soll es sein
- Testfall 2: Auch hier soll es so sein. Wenn Du auf "debug" oder "silly" log hättest würdest du die reconnects als Log sehen.
- Testfall 3 Bitte mit der neuen 2.0.31 auf Github nochmal testen
- Testfall 4; Cooool
-
@apollon77 sagte in [Aufruf] js-controller 2.0 Beta Test:
Danke für die Tests!!
Gern!
- Testfall 3 Bitte mit der neuen 2.0.31 auf Github nochmal testen
Da stimmt was nicht:
┬─[darkiop@odin:~]─[13:35:02] ╰─>$ docker stop iobroker-redis iobroker-redis ┬─[darkiop@odin:~]─[13:41:53] ╰─>$ docker start iobroker-redis iobroker-redisLog Master:
2019-10-15 13:41:48.364 - error: scenes.0 (1492) connect ETIMEDOUT 2019-10-15 13:41:48.366 - error: pi-hole.0 (1228) connect ETIMEDOUT 2019-10-15 13:41:48.368 - error: harmony.0 (388) connect ETIMEDOUT 2019-10-15 13:41:48.368 - error: simple-api.0 (1695) connect ETIMEDOUT 2019-10-15 13:41:48.372 - error: javascript.1 (1068) connect ETIMEDOUT 2019-10-15 13:41:48.372 - error: sql.0 (1819) connect ETIMEDOUT 2019-10-15 13:41:48.372 - error: telegram.0 (2364) connect ETIMEDOUT 2019-10-15 13:41:48.375 - error: host.iobroker-master connect ETIMEDOUT 2019-10-15 13:41:48.379 - error: hm-rega.0 (403) connect ETIMEDOUT 2019-10-15 13:41:48.379 - error: hs100.0 (480) connect ETIMEDOUT 2019-10-15 13:41:48.379 - error: tr-064-community.0 (2710) connect ETIMEDOUT 2019-10-15 13:41:48.385 - error: stiebel-isg.0 (2029) connect ETIMEDOUT 2019-10-15 13:41:48.385 - error: moma.0 (1162) connect ETIMEDOUT 2019-10-15 13:41:48.390 - error: ping.0 (1378) connect ETIMEDOUT 2019-10-15 13:41:48.391 - error: hm-rpc.1 (426) connect ETIMEDOUT 2019-10-15 13:41:48.392 - error: backitup.0 (457) connect ETIMEDOUT 2019-10-15 13:41:48.393 - error: hm-rpc.2 (450) connect ETIMEDOUT 2019-10-15 13:41:48.393 - error: javascript.0 (808) connect ETIMEDOUT 2019-10-15 13:41:48.399 - error: mercedesme.0 (1108) connect ETIMEDOUT 2019-10-15 13:41:48.407 - error: info.0 (789) connect ETIMEDOUT 2019-10-15 13:42:00.004 - warn: host.iobroker-master instance system.adapter.daswetter.0 already running with pid 11372 2019-10-15 13:42:03.215 - info: host.iobroker-master instance system.adapter.daswetter.0 terminated with code 0 (NO_ERROR) 2019-10-15 13:42:04.501 - debug: harmony.0 (388) system.adapter.admin.0: logging true 2019-10-15 13:42:04.532 - debug: harmony.0 (388) States connected to redis: 192.168.1.86:6379 2019-10-15 13:42:20.048 - error: admin.0 (419) uncaught exception: Maximum call stack size exceeded 2019-10-15 13:42:20.052 - error: admin.0 (419) RangeError: Maximum call stack size exceeded at Sender.frameAndSend (/opt/iobroker/node_modules/ws/lib/Sender.js:166:14) at /opt/iobroker/node_modules/ws/lib/Sender.js:126:12 at Sender.applyExtensions (/opt/iobroker/node_modules/ws/lib/Sender.js:287:5) at /opt/iobroker/node_modules/ws/lib/Sender.js:120:10 at Sender.flush (/opt/iobroker/node_modules/ws/lib/Sender.js:268:3) at /opt/iobroker/node_modules/ws/lib/Sender.js:270:10 at /opt/iobroker/node_modules/ws/lib/Sender.js:127:7 at Sender.applyExtensions (/opt/iobroker/node_modules/ws/lib/Sender.js:287:5) at /opt/iobroker/node_modules/ws/lib/Sender.js:120:10 at Sender.flush (/opt/iobroker/node_modules/ws/lib/Sender.js:268:3) 2019-10-15 13:42:20.318 - error: host.iobroker-master Caught by controller[0]: RangeError: Maximum call stack size exceeded 2019-10-15 13:42:20.320 - error: host.iobroker-master Caught by controller[0]: at Sender.frameAndSend (/opt/iobroker/node_modules/ws/lib/Sender.js:166:14) 2019-10-15 13:42:20.321 - error: host.iobroker-master Caught by controller[0]: at /opt/iobroker/node_modules/ws/lib/Sender.js:126:12 2019-10-15 13:42:20.323 - error: host.iobroker-master Caught by controller[0]: at Sender.applyExtensions (/opt/iobroker/node_modules/ws/lib/Sender.js:287:5) 2019-10-15 13:42:20.324 - error: host.iobroker-master Caught by controller[0]: at /opt/iobroker/node_modules/ws/lib/Sender.js:120:10 2019-10-15 13:42:20.325 - error: host.iobroker-master Caught by controller[0]: at Sender.flush (/opt/iobroker/node_modules/ws/lib/Sender.js:268:3) 2019-10-15 13:42:20.326 - error: host.iobroker-master Caught by controller[0]: at /opt/iobroker/node_modules/ws/lib/Sender.js:270:10 2019-10-15 13:42:20.327 - error: host.iobroker-master Caught by controller[0]: at /opt/iobroker/node_modules/ws/lib/Sender.js:127:7 2019-10-15 13:42:20.328 - error: host.iobroker-master Caught by controller[0]: at Sender.applyExtensions (/opt/iobroker/node_modules/ws/lib/Sender.js:287:5) 2019-10-15 13:42:20.328 - error: host.iobroker-master Caught by controller[0]: at /opt/iobroker/node_modules/ws/lib/Sender.js:120:10 2019-10-15 13:42:20.329 - error: host.iobroker-master Caught by controller[0]: at Sender.flush (/opt/iobroker/node_modules/ws/lib/Sender.js:268:3) 2019-10-15 13:42:20.331 - info: host.iobroker-master instance system.adapter.admin.0 terminated with code 0 (NO_ERROR) 2019-10-15 13:42:20.333 - info: host.iobroker-master Restart adapter system.adapter.admin.0 because enabled 2019-10-15 13:42:20.340 - debug: harmony.0 (388) system.adapter.admin.0: logging false 2019-10-15 13:42:49.810 - info: tankerkoenig.0 (2155) Reading data from tankerkoenig ... 2019-10-15 13:42:50.388 - info: host.iobroker-master instance system.adapter.admin.0 started with pid 27743 2019-10-15 13:43:00.021 - info: host.iobroker-master instance system.adapter.daswetter.0 started with pid 28216 2019-10-15 13:43:09.649 - info: host.iobroker-master instance system.adapter.daswetter.0 terminated with code 0 (NO_ERROR)Keine neue States da:
-
@darkiop in dem Fall ist Admin gestorben weil sich irgendwie Dinge aufgestaut haben und Admin restartet. Ggf fehlen dadurch Daten? Lad im browser mal neu. Jetzt fehlende States da?
Ansonsten hat sich der iobroker aber wieder gefangen mit der Version oder?!
-
@darkiop Aahhh noch eine Frage: du hast nur States im redis, korrekt?
-
Ok, zweiter Test - jetzt ohne den admin.0 crash ....
der Master ist wieder auf den Beinen, der Slave hat es aber nicht geschaft. stop/start aufm Slave und er ist wieder verbunden.
Puffert der controller auch Logs? Die 3 hier sind eigentlich entstanden während redis weg war, geschrieben wurden sie nach dem redis wieder da war:
2019-10-15 14:00:00.786 - info: javascript.0 (618) script.js.PRODUKTIV.Beleuchtung.01_Bewegungsmelder_Flur: +++ Bewegung im Flur. Helligkeitsschwelle bei < 10 | Aktuelle Helligkeit: 31.8 | Licht wird nicht geschaltet. +++ 2019-10-15 14:00:01.180 - info: javascript.0 (618) script.js.PRODUKTIV.Beleuchtung.01_Bewegungsmelder_Flur: +++ Bewegung im Flur. Helligkeitsschwelle bei < 10 | Aktuelle Helligkeit: 32.6 | Licht wird nicht geschaltet. +++ 2019-10-15 14:00:01.523 - info: javascript.0 (618) script.js.PRODUKTIV.Beleuchtung.01_Bewegungsmelder_Flur: +++ Bewegung im Flur. Helligkeitsschwelle bei < 10 | Aktuelle Helligkeit: 32.6 | Licht wird nicht geschaltet. +++Edit:
So lange war redis weg:
