Beta-Test js-controller 2.2.x GitHub
-
@apollon77 Moin, habe heute morgen ein update vom Bring! Adapter gemacht, und jetzt wollte ich die Instanz und den Adapter löschen, da ich den eigentlich nicht mehr benötige (Alexa2 sei Dank)...
Habe einen ganz komischen Effekt, wenn ich im Admin ( 3.7.5) ( js-controller 2.2.4, Node 10.17.0, NPM 6.13.0) die Instanz löschen lasse, löscht er sie, anschließend öffnet sich aber die Konfig-Seite vom Bring-Adapter und die Instanz ist wieder da.
Im Log steht "packet manager not found" ..Wenn ich die Instanz stoppe, dann läuft auch kein Process mehr, hab auch mal die ganze VM rebootet... mit nem anderem Adapter das gleiche.. hmm hat noch jemand das Problem?
Hier das log ( hab mal dem rtsp-adapter getestet)( 11.41 Uhr nochmal bearbeitet auf debug)
2019-12-31 11:39:35.775 - info: host.iobroker "system.adapter.rtspStream.0" enabled 2019-12-31 11:39:35.798 - info: host.iobroker instance system.adapter.rtspStream.0 started with pid 5753 2019-12-31 11:39:35.890 - info: host.iobroker instance system.adapter.openweathermap.0 terminated with code 0 (NO_ERROR) 2019-12-31 11:39:36.357 - debug: rtspStream.0 (5753) Redis Objects: Use Redis connection: 0.0.0.0:9001 2019-12-31 11:39:36.397 - debug: rtspStream.0 (5753) Objects client ready ... initialize now 2019-12-31 11:39:36.401 - debug: rtspStream.0 (5753) Objects create System PubSub Client 2019-12-31 11:39:36.401 - debug: rtspStream.0 (5753) Objects create User PubSub Client 2019-12-31 11:39:36.402 - debug: rtspStream.0 (5753) Objects client initialize lua scripts 2019-12-31 11:39:36.425 - debug: rtspStream.0 (5753) Objects connected to redis: 0.0.0.0:9001 2019-12-31 11:39:36.428 - debug: rtspStream.0 (5753) objectDB connected 2019-12-31 11:39:36.430 - debug: rtspStream.0 (5753) Redis States: Use Redis connection: 0.0.0.0:9000 2019-12-31 11:39:36.443 - debug: rtspStream.0 (5753) States create User PubSub Client 2019-12-31 11:39:36.461 - debug: rtspStream.0 (5753) States create System PubSub Client 2019-12-31 11:39:36.512 - debug: rtspStream.0 (5753) States connected to redis: 0.0.0.0:9000 2019-12-31 11:39:36.513 - debug: rtspStream.0 (5753) statesDB connected 2019-12-31 11:39:37.252 - info: rtspStream.0 (5753) starting. Version 0.0.1 in /opt/iobroker/node_modules/iobroker.rtspStream, node: v10.17.0 2019-12-31 11:39:37.271 - debug: rtspStream.0 (5753) Starting rtsp Stream 2019-12-31 11:39:37.371 - debug: rtspStream.0 (5753) State Change: rtspStream.0.startStream to true ack false 2019-12-31 11:39:37.372 - debug: rtspStream.0 (5753) Start stream on rtsp://admin:admin@192.168.0.88/12with port 554 2019-12-31 11:39:43.201 - info: host.iobroker iobroker del rtspStream.0 2019-12-31 11:39:44.323 - info: host.iobroker iobroker Delete adapter "rtspStream.0" 2019-12-31 11:39:44.339 - info: host.iobroker iobroker host.iobroker Counted 1 instances of rtspStream.0 2019-12-31 11:39:44.377 - info: host.iobroker iobroker host.iobroker Counted 1 states of rtspStream.0 2019-12-31 11:39:44.388 - info: host.iobroker iobroker host.iobroker Counted 14 states of system.adapter.rtspStream.0 2019-12-31 11:39:46.124 - info: host.iobroker iobroker host.iobroker Deleting 16 object(s). 2019-12-31 11:39:46.905 - info: host.iobroker object deleted system.adapter.rtspStream.0 2019-12-31 11:39:46.905 - info: host.iobroker stopInstance system.adapter.rtspStream.0 (force=false, process=true) 2019-12-31 11:39:46.909 - info: rtspStream.0 (5753) Got terminate signal TERMINATE_YOURSELF 2019-12-31 11:39:46.906 - info: host.iobroker stopInstance system.adapter.rtspStream.0 send kill signal 2019-12-31 11:39:46.913 - info: Set hostname iobroker for system.adapter.rtspStream.0 2019-12-31 11:39:46.928 - info: host.iobroker stopInstance system.adapter.rtspStream.0 (force=false, process=true) 2019-12-31 11:39:46.931 - info: host.iobroker stopInstance system.adapter.rtspStream.0 send kill signal 2019-12-31 11:39:46.934 - info: rtspStream.0 (5753) Got terminate signal TERMINATE_YOURSELF 2019-12-31 11:39:47.410 - info: rtspStream.0 (5753) terminating 2019-12-31 11:39:47.411 - info: rtspStream.0 (5753) Terminated (START_IMMEDIATELY_AFTER_STOP): Without reason 2019-12-31 11:39:47.907 - info: host.iobroker stopInstance system.adapter.rtspStream.0 killing pid 5753 2019-12-31 11:39:47.914 - info: host.iobroker iobroker exit 0 -
@ilovegym bekannt. Siehe weiter oben. Wird in der 2.2.4 gefixt werden.
-
So, passend zum Jahresende hätte ich hier noch für Euch die 2.2.5 als "Latest RC1"
Änderungen zur 2.2.3 vorher:
- (Apollon77) add certificate handling if a local file is specified and do not overwrite if invalid in
setup first - (Apollon77) add check in objects lib
- (Apollon77) only initialize PacketManager when needed to prevent error messages shown when not relevant
- (Apollon77) change logging when no packetmanageer found to info
- (Apollon77) disable gz-log-rotation on windows; remove added logging from debugging
- (Apollon77) make sure adapters and instances can be deleted again
Mit der Version lass sich Adapter wieder löschen und lokale Zertifikat-Files sollten bei
iobroker cert viewund `setup first bei Updates (@twonky ) wieder tunEs gibt noch ein Known Issue wo wir gerade überlegen wie wir es genau fixen: Man kann aktuell keine "Custom"-Objektsettings (History, iqontrol, telegram ...) mehr deaktivieren/löschen. Das liegt an einem anderen Fix. Wir sind hier noch am Diskutiren wie wir es fixen ... Entweder im Controller ode rim Admin ... Mal schauen.
Dann Happy New Year!
Ingo
- (Apollon77) add certificate handling if a local file is specified and do not overwrite if invalid in
-
-
@apollon77 Danke für die tollen Updates, und auch einen guten Rutsch!
Instanzen lassen sich wieder löschen, super. Soweit läuft das.
-
Klasse Ingo, ich lass das über den Jahreswechsel laufen und checke Moren das Log
Euch allen einen guten Rutsch!
-
Euch auch nen guten Rutsch
-
@apollon77: Das einzige was ich auf dem slave gemacht habe war:
iobroker stop
npm install iobroker.js-controller@2.2.4
iobroker startAuf dem master hatte ich garnichts gemacht. Es sollte doch in keinem Fall der slave Zertifikate des master updaten dürfen oder?
-
@twonky im Controller 2.x haben wir einen Zertifikats Check eingebaut. Der wird bei jedem Controller Update ausgeführt. Egal wo.
Weiterhin: formal gesehen weiß ein Slave nur bedingt das er ein Slave ist. Bei file dBs geht das noch einigermaßen. Bei redis Nutzung ist das eh hinfällig. Daher wird bei einem Controller Update das Zertifikat Objekt gelesen und geprüft .... egal wo das Update läuft.
Aber jetzt mit der 2.2.5 werden file Angaben als User hier geprüft aber nicht geändert.
-
@apollon77 Ich habe nachts nach dem geplanten Neustart des Admin Adapters fast eine Stunde lang Fehlermeldungen:
host.ioBroker 2020-01-01 02:59:00.547 error instance system.adapter.admin.0 terminated with code 156 (156) host.ioBroker 2020-01-01 02:58:01.572 info instance system.adapter.admin.0 started with pid 6569 host.ioBroker 2020-01-01 02:58:00.544 info Restart adapter system.adapter.admin.0 because enabled host.ioBroker 2020-01-01 02:58:00.543 error instance system.adapter.admin.0 terminated with code 156 (156) host.ioBroker 2020-01-01 02:57:01.572 info instance system.adapter.admin.0 started with pid 5870 host.ioBroker 2020-01-01 02:57:00.545 info Restart adapter system.adapter.admin.0 because enabled host.ioBroker 2020-01-01 02:57:00.544 error instance system.adapter.admin.0 terminated with code 156 (156) host.ioBroker 2020-01-01 02:56:01.569 info instance system.adapter.admin.0 started with pid 5237 host.ioBroker 2020-01-01 02:56:00.545 info Restart adapter system.adapter.admin.0 because enabled host.ioBroker 2020-01-01 02:56:00.544 error instance system.adapter.admin.0 terminated with code 156 (156) host.ioBroker 2020-01-01 02:55:01.572 info instance system.adapter.admin.0 started with pid 4550 host.ioBroker 2020-01-01 02:55:00.547 info Restart adapter system.adapter.admin.0 because enabled host.ioBroker 2020-01-01 02:55:00.546 error instance system.adapter.admin.0 terminated with code 156 (156) host.ioBroker 2020-01-01 02:54:11.814 info instance system.adapter.daswetter.0 terminated with code 0 (NO_ERROR) host.ioBroker 2020-01-01 02:54:01.586 info instance system.adapter.admin.0 started with pid 3923 host.ioBroker 2020-01-01 02:54:00.554 info Restart adapter system.adapter.admin.0 because enabled host.ioBroker 2020-01-01 02:54:00.553 error instance system.adapter.admin.0 terminated with code 156 (156) host.ioBroker 2020-01-01 02:54:00.028 info instance system.adapter.daswetter.0 started with pid 3907 host.ioBroker 2020-01-01 02:53:01.582 info instance system.adapter.admin.0 started with pid 3227 host.ioBroker 2020-01-01 02:53:00.553 info Restart adapter system.adapter.admin.0 because enabled host.ioBroker 2020-01-01 02:53:00.553 error instance system.adapter.admin.0 terminated with code 156 (156) host.ioBroker 2020-01-01 02:52:01.583 info instance system.adapter.admin.0 started with pid 2604 host.ioBroker 2020-01-01 02:52:00.555 info Restart adapter system.adapter.admin.0 because enabledIst nichts Dramatisches. Aber das System braucht eben fast 1 Stunde bis es sich wieder gefangen hat.
Ich bin mir aber nicht sicher ob es jetzt am Controler V 2.2.5 oder am Admin V 3.7.5 liegt, da ich blöderweise beie geupdatet habe. -
@Chaot ok. Checke es.
-
@Chaot Ist das log komplett? Hat der Admin adapter zwichendurch nichts gesagt?
-
@apollon77 Nich ganz.
Der Fehler startet mit dem Neustart des Admin Adapters:
Das hat er gestern auch schon gemacht, da habe ich das aber nicht beachtet.
Er hat dann fast eine Stunde gebraucht um sich wieder zu fangen. Den weiteren Tag läuft alles ohne weitere Fehlermeldung. -
@Chaot Ich kann es nicht nachvollziehen
Daher nochmal: Ist das das VOLLE log? nicht irgendwie aussortiert/gefiltert? Ansonsten stehh doch Admin loglevel mal auf debug und schau was nächste nacht im Log steht.Ich vermisse da die ausgaben das Admin sich beendet hat wegen de, Restart und so ...
-
Ansonsten Willkommen im neuen Jahr. Ich habe gerade auf GitHub die 2.2.6 (aka Latest RC2) gestellt, Änderung ist minimal. Es gab ein paar Stellen wo ein Check für den Fall das Die Objects-DB nicht verbunden ist nicht gegriffen haben; das kann beim Stoppen von Adaptern zu crashes desselben führen ...
Have fun!
-
@apollon77 Der zweite gepostete log ist der komplette Bereich ohne Kürzungen.
Der Adapter steht jetzt auf debug. Mal schauen was morgen kommt.
Willst du eventuell den Log von 31.12.auch? -
@Chaot sagte in Beta-Test js-controller 2.2.x GitHub:
Willst du eventuell den Log von 31.12.auch?
wenn der genauso aussieht dann bringt er irgendwie nicht viel ...
Das log würde nahelegen das beim Start von Admin irgendeine ganz generische node exception fliegt. Falls es nochmal passiert müsstest Du mal wach bleiben und genau während der Zeit versuchen den Adapter auf Kommandozeile zu starten das man sehen kann was passiert.
Ich finde es interessant wie schnell die Prozess ID steigt ... An sich wird die mit jedem Prozess um ein erhöht ... bei dir ist hier innerhalb von 60s eine Steigerung von mehreren hundert! ... Strange strange
-
@apollon77 Das scheint er aber nur beim scheduled Start zu machen.
Gerade jetzt mein Controler Update kam nichts dregleichen und auch beim letzten Update kann ich micht erinnern das er da sowas gemacht hat.
Ich habe jetzt für 16 Uhr einen Neustart ins Schedule geschrieben. Mal schauen was er macht. -
@apollon77
Adapter hat jetzt den Restart aus dem Schedule hingelegt. Bisher diese Medlungen:admin.0 2020-01-01 16:02:05.600 debug (1307) Next repo update on 1/2/2020, 4:01:28 PM admin.0 2020-01-01 16:02:05.484 debug (1307) Subscribe OBJECTS: * admin.0 2020-01-01 16:02:05.462 info (1307) Use link "http://localhost:8081" to configure. admin.0 2020-01-01 16:02:05.461 info (1307) http server listening on port 8081 admin.0 2020-01-01 16:02:05.322 info (1307) received all objects admin.0 2020-01-01 16:02:03.936 info (1307) requesting all objects admin.0 2020-01-01 16:02:03.936 info (1307) requesting all states admin.0 2020-01-01 16:02:03.915 debug (1307) Schedule restart: * 2,16 * * * admin.0 2020-01-01 16:02:03.805 info (1307) starting. Version 3.7.5 in /opt/iobroker/node_modules/iobroker.admin, node: v10.18.0 admin.0 2020-01-01 16:02:02.993 debug (1307) statesDB connected admin.0 2020-01-01 16:02:02.992 debug (1307) States connected to redis: 127.0.0.1:6379 admin.0 2020-01-01 16:02:02.986 debug (1307) States create System PubSub Client admin.0 2020-01-01 16:02:02.983 debug (1307) States create User PubSub Client admin.0 2020-01-01 16:02:02.976 debug (1307) Redis States: Use Redis connection: 127.0.0.1:6379 admin.0 2020-01-01 16:02:02.974 debug (1307) objectDB connected admin.0 2020-01-01 16:02:02.968 debug (1307) Objects connected to redis: 127.0.0.1:9001 admin.0 2020-01-01 16:02:02.942 debug (1307) Objects client initialize lua scripts admin.0 2020-01-01 16:02:02.941 debug (1307) Objects create User PubSub Client admin.0 2020-01-01 16:02:02.940 debug (1307) Objects create System PubSub Client admin.0 2020-01-01 16:02:02.936 debug (1307) Objects client ready ... initialize now admin.0 2020-01-01 16:02:02.900 debug (1307) Redis Objects: Use Redis connection: 127.0.0.1:9001 host.ioBroker 2020-01-01 16:02:01.593 info instance system.adapter.admin.0 started with pid 1307 host.ioBroker 2020-01-01 16:02:00.564 info Restart adapter system.adapter.admin.0 because enabled host.ioBroker 2020-01-01 16:02:00.563 error instance system.adapter.admin.0 terminated with code 156 (156) admin.0 2020-01-01 16:02:00.014 info (382) Terminated (START_IMMEDIATELY_AFTER_STOP): Without reason admin.0 2020-01-01 16:02:00.012 info (382) terminating admin.0 2020-01-01 16:02:00.007 info (382) terminating http server on port 8081 admin.0 2020-01-01 16:02:00.005 info (382) Scheduled restart. admin.0 2020-01-01 16:01:30.166 debug (382) Subscribes: dummy admin.0 2020-01-01 16:01:30.165 debug (382) Subscribe LOGS admin.0 2020-01-01 16:01:29.164 debug (382) system.adapter.admin.0: logging true admin.0 2020-01-01 16:01:29.143 debug (382) Change log subscriber state: true admin.0 2020-01-01 16:01:29.142 debug (382) Disable logging, because no one socket connected host.ioBroker 2020-01-01 16:01:28.030 info Update repository "latest" under "http://download.iobroker.net/sources-dist-latest.json" admin.0 2020-01-01 16:01:27.887 debug (382) Subscribes: info.0.newsfeed admin.0 2020-01-01 16:01:23.745 debug (382) Subscribes: info.0.newsfeed admin.0 2020-01-01 16:01:23.741 debug (382) Subscribe STATES: info.0.newsfeed admin.0 2020-01-01 16:01:23.688 debug (382) Subscribes: no subscribes host.ioBroker 2020-01-01 16:01:07.550 info instance system.adapter.tvspielfilm.0 terminated with code 0 (NO_ERROR) admin.0 2020-01-01 16:01:05.547 debug (382) Next repo update on 1/2/2020, 3:54:47 PM admin.0 2020-01-01 16:01:05.436 debug (382) Subscribe OBJECTS: * admin.0 2020-01-01 16:01:05.425 info (382) Use link "http://localhost:8081" to configure. admin.0 2020-01-01 16:01:05.425 info (382) http server listening on port 8081 admin.0 2020-01-01 16:01:05.290 info (382) received all objects admin.0 2020-01-01 16:01:03.853 info (382) requesting all objects admin.0 2020-01-01 16:01:03.852 info (382) requesting all states admin.0 2020-01-01 16:01:03.832 debug (382) Schedule restart: * 2,16 * * * admin.0 2020-01-01 16:01:03.730 info (382) starting. Version 3.7.5 in /opt/iobroker/node_modules/iobroker.admin, node: v10.18.0 admin.0 2020-01-01 16:01:02.937 debug (382) statesDB connected admin.0 2020-01-01 16:01:02.936 debug (382) States connected to redis: 127.0.0.1:6379 admin.0 2020-01-01 16:01:02.929 debug (382) States create System PubSub Client admin.0 2020-01-01 16:01:02.927 debug (382) States create User PubSub Client admin.0 2020-01-01 16:01:02.922 debug (382) Redis States: Use Redis connection: 127.0.0.1:6379 admin.0 2020-01-01 16:01:02.920 debug (382) objectDB connected admin.0 2020-01-01 16:01:02.915 debug (382) Objects connected to redis: 127.0.0.1:9001 admin.0 2020-01-01 16:01:02.894 debug (382) Objects client initialize lua scripts admin.0 2020-01-01 16:01:02.893 debug (382) Objects create User PubSub Client admin.0 2020-01-01 16:01:02.890 debug (382) Objects create System PubSub Client admin.0 2020-01-01 16:01:02.884 debug (382) Objects client ready ... initialize now admin.0 2020-01-01 16:01:02.842 debug (382) Redis Objects: Use Redis connection: 127.0.0.1:9001 host.ioBroker 2020-01-01 16:01:01.572 info instance system.adapter.admin.0 started with pid 382 host.ioBroker 2020-01-01 16:01:00.544 info Restart adapter system.adapter.admin.0 because enabled host.ioBroker 2020-01-01 16:01:00.542 error instance system.adapter.admin.0 terminated with code 156 (156) admin.0 2020-01-01 16:01:00.012 info (32179) Terminated (START_IMMEDIATELY_AFTER_STOP): Without reason admin.0 2020-01-01 16:01:00.011 info (32179) terminating admin.0 2020-01-01 16:01:00.007 info (32179) terminating http server on port 8081 admin.0 2020-01-01 16:01:00.005 info (32179) Scheduled restart.Anders sortiert:
Die Fehler kommen im Minutentakt:host.ioBroker 2020-01-01 16:05:01.584 info instance system.adapter.admin.0 started with pid 3296 host.ioBroker 2020-01-01 16:05:00.555 info Restart adapter system.adapter.admin.0 because enabled host.ioBroker 2020-01-01 16:05:00.554 error instance system.adapter.admin.0 terminated with code 156 (156) admin.0 2020-01-01 16:05:00.012 info (2673) Terminated (START_IMMEDIATELY_AFTER_STOP): Without reason admin.0 2020-01-01 16:05:00.010 info (2673) terminating admin.0 2020-01-01 16:05:00.007 info (2673) terminating http server on port 8081 admin.0 2020-01-01 16:05:00.005 info (2673) Scheduled restart. admin.0 2020-01-01 16:04:05.772 debug (2673) Next repo update on 1/2/2020, 4:01:28 PM admin.0 2020-01-01 16:04:05.624 debug (2673) Subscribe OBJECTS: * admin.0 2020-01-01 16:04:05.602 info (2673) Use link "http://localhost:8081" to configure. admin.0 2020-01-01 16:04:05.601 info (2673) http server listening on port 8081 admin.0 2020-01-01 16:04:05.447 info (2673) received all objects admin.0 2020-01-01 16:04:03.987 info (2673) requesting all objects admin.0 2020-01-01 16:04:03.987 info (2673) requesting all states admin.0 2020-01-01 16:04:03.964 debug (2673) Schedule restart: * 2,16 * * * admin.0 2020-01-01 16:04:03.864 info (2673) starting. Version 3.7.5 in /opt/iobroker/node_modules/iobroker.admin, node: v10.18.0 admin.0 2020-01-01 16:04:03.018 debug (2673) statesDB connected admin.0 2020-01-01 16:04:03.017 debug (2673) States connected to redis: 127.0.0.1:6379 admin.0 2020-01-01 16:04:03.010 debug (2673) States create System PubSub Client admin.0 2020-01-01 16:04:03.008 debug (2673) States create User PubSub Client admin.0 2020-01-01 16:04:03.002 debug (2673) Redis States: Use Redis connection: 127.0.0.1:6379 admin.0 2020-01-01 16:04:03.000 debug (2673) objectDB connected admin.0 2020-01-01 16:04:02.995 debug (2673) Objects connected to redis: 127.0.0.1:9001 admin.0 2020-01-01 16:04:02.973 debug (2673) Objects client initialize lua scripts admin.0 2020-01-01 16:04:02.972 debug (2673) Objects create User PubSub Client admin.0 2020-01-01 16:04:02.971 debug (2673) Objects create System PubSub Client admin.0 2020-01-01 16:04:02.967 debug (2673) Objects client ready ... initialize now admin.0 2020-01-01 16:04:02.928 debug (2673) Redis Objects: Use Redis connection: 127.0.0.1:9001 host.ioBroker 2020-01-01 16:04:01.608 info instance system.adapter.admin.0 started with pid 2673 host.ioBroker 2020-01-01 16:04:00.578 info Restart adapter system.adapter.admin.0 because enabled host.ioBroker 2020-01-01 16:04:00.576 error instance system.adapter.admin.0 terminated with code 156 (156) -
@apollon77
Ich habe es selbst gefunden
Der Schedule steht auf 2** und nicht auf 02***
Ich habe daran zwar nicht wissentlich was geändert, aber das dürfte der Grund sein.
Jetzt müsste nur einmalig um 2 Uhr der Fehlerhost.ioBroker 2020-01-01 16:08:00.556 error instance system.adapter.admin.0 terminated with code 156 (156)kommen.
