Test js-controller v2.0.x (GitHub)
-
@darkiop Ooohk,
- dein 1. ist in meiner Liste
- dein 2. jetzt auch (bei dir tut der restart nicht ... können wir gern tief rein "diggen"
-
- sollte seit 2.0.22 gefixt sein
Dann zu 4. ... liefert /var/log/syslog irgendwas? Einerseits spielt da der nicht funktio0nierende restart rein, aber auch hier ist jetzt die neue Fehlermeldung interessant:
- sollte seit 2.0.22 gefixt sein
2019-10-05 03:58:42.777 - error: host.iobroker-hwr iobroker path.js:1077 path = process.cwd(); ^Error: ENOENT: no such file or directory, uv_cwd at Object.resolve (path.js:1077:24) at Function.Module._resolveLookupPaths (internal/modules/cjs/loader.js:534:17) at Function.Module._resolveFilename (internal/modules/cjs/loader.js:629:20) at Function.Module._load (internal/modules/cjs/loader.js:562:25) at Module.require (internal/modules/cjs/loader.js:692:17) at require (internal/modules/cjs/helpers.js:25:18) at Object.<anonymous> (/opt/iobroker/node_modules/iobroker.js-controller/iobroker.js:1:1) at Module._compile (internal/modules/cjs/loader.js:778:30) at Object.Module._extensions..js (internal/modules/cjs/loader.js:789:10) at Module.load (internal/modules/cjs/loader.js:653:32)
Wie geht es denn der SD Karte so? Dieser Fehler heisst an sich das das Verzeichnis weg ist ... und damit wird merkwürdig. Deshalb schau mal zu der Zeit bitte in /var/log/syslog
Ansonsten wäre ist bei: Filesystem check, Netzteil checken/tauschen? ... -
@darkiop So, dann wollen wir mal.
An sich ist die Logik so (du hast ja jetzt sytemd und nicht mehr init.d) das systemd selbst den restart macht wenn der controller mit einem Exitcode != 0 sich beendet.Also man nehme ein System wo iobroker per systemd gestartet ist. Wenn du jetzt den js-controller-Prozess killst (ps auxww|grep js-controller -... dann kill prozessid) merkt systemd das und startet Ihn neu.
Bei mir im /var/log/syslog sieht das dann so aus:
Oct 5 12:42:34 io-test systemd[1]: iobroker.service: Main process exited, code=exited, status=1/FAILURE Oct 5 12:42:44 io-test systemd[1]: iobroker.service: Failed with result 'exit-code'. Oct 5 12:42:45 io-test systemd[1]: iobroker.service: Service hold-off time over, scheduling restart. Oct 5 12:42:45 io-test systemd[1]: iobroker.service: Scheduled restart job, restart counter is at 1. Oct 5 12:42:45 io-test systemd[1]: Stopped ioBroker Server. Oct 5 12:42:45 io-test systemd[1]: Started ioBroker Server. ... startet wieder ...Fangen wir mal damit an ob das bei dir korrekt tut.
-
@apollon77 ich mach heut Abend nochmal ne Test Session. Die Karte ist eigentlich neu, prüfe sie aber. Alternativ hab ich auch Ersatz da.
Das mit dem Skript Download habe ich auch bei der 2.0.22. geh heute Abend nochmals mit beiden zurück auf die 1.5 und teste da.
-
@apollon77
@Stuebi
Ich habe den shelly Adapter mal deinstalliert.
Eine erneute installation brachte folgenden Fehler zu Tage...2019-10-05 13:20:51.118 - info: host.iobroker-host iobroker host.iobroker-host install adapter shelly 2019-10-05 13:20:51.133 - info: host.iobroker-host iobroker upload [2] shelly.admin /opt/iobroker/node_modules/iobroker.shelly/admin/words.js words.js application/javascript 2019-10-05 13:20:51.217 - info: host.iobroker-host iobroker upload [1] shelly.admin /opt/iobroker/node_modules/iobroker.shelly/admin/shelly.png shelly.png image/png 2019-10-05 13:20:51.272 - info: host.iobroker-host iobroker upload [0] shelly.admin /opt/iobroker/node_modules/iobroker.shelly/admin/index_m.html index_m.html text/html 2019-10-05 13:20:51.347 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly created/updated 2019-10-05 13:20:51.503 - info: host.iobroker-host iobroker host.iobroker-host create instance shelly 2019-10-05 13:20:51.508 - info: host.iobroker-host iobroker host.iobroker-host object shelly.0.info.connection created 2019-10-05 13:20:51.537 - info: host.iobroker-host iobroker host.iobroker-host object shelly.0.info created 2019-10-05 13:20:51.568 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.sigKill created 2019-10-05 13:20:51.602 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.eventLoopLag created 2019-10-05 13:20:51.633 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.outputCount created 2019-10-05 13:20:51.664 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.inputCount created 2019-10-05 13:20:51.695 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.uptime created 2019-10-05 13:20:51.725 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.memRss created 2019-10-05 13:20:51.756 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.memHeapTotal created 2019-10-05 13:20:51.805 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.memHeapUsed created 2019-10-05 13:20:51.864 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.cputime created 2019-10-05 13:20:51.894 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.cpu created 2019-10-05 13:20:51.938 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.compactMode created 2019-10-05 13:20:51.968 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.connected created 2019-10-05 13:20:51.997 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0.alive created 2019-10-05 13:20:52.039 - info: host.iobroker-host iobroker host.iobroker-host object system.adapter.shelly.0 created 2019-10-05 13:20:52.045 - error: host.iobroker-host iobroker (node:19932) UnhandledPromiseRejectionWarning: Error: Connection is closed. at close (/opt/iobroker/node_modules/ioredis/built/redis/event_handler.js:115:25) at Socket.<anonymous> (/opt/iobroker/node_modules/ioredis/built/redis/event_handler.js:82:20) at Object.onceWrapper (events.js:315:30) at emitOne (events.js:116:13) at Socket.emit (events.js:211:7) at TCP._handle.close [as _onclose] (net.js:561:12)(node:19932) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). (rejection id: 1)(node:19932) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. 2019-10-05 13:20:53.043 - info: host.iobroker-host iobroker exit 0Hilft das weiter?
Uninstall
2019-10-05 13:24:46.024 - info: host.iobroker-host iobroker del shelly 2019-10-05 13:24:47.014 - info: host.iobroker-host iobroker Delete adapter "shelly" 2019-10-05 13:24:47.037 - info: host.iobroker-host iobroker host.iobroker-host Counted 1 instances of shelly 2019-10-05 13:24:47.042 - info: host.iobroker-host iobroker host.iobroker-host Counted 1 adapter for shelly 2019-10-05 13:24:47.060 - info: host.iobroker-host iobroker host.iobroker-host Counted 1 channels of shelly 2019-10-05 13:24:47.158 - info: host.iobroker-host iobroker host.iobroker-host Counted 14 states of shelly 2019-10-05 13:24:47.211 - info: host.iobroker-host iobroker host.iobroker-host Deleting 17 object(s). 2019-10-05 13:24:48.038 - info: host.iobroker-host object deleted system.adapter.shelly.0 2019-10-05 13:24:48.043 - info: host.iobroker-host iobroker npm uninstall iobroker.shelly --silent --save --prefix "/opt/iobroker" (System call) 2019-10-05 13:24:48.204 - error: host.iobroker-host Cannot write files: /opt/iobroker/iobroker-data/files/shelly.admin/_data.json: ENOENT: no such file or directory, open '/opt/iobroker/iobroker-data/files/shelly.admin/_data.json' 2019-10-05 13:25:00.031 - info: host.iobroker-host instance system.adapter.poolcontroller.0 started with pid 27732 2019-10-05 13:25:14.532 - info: host.iobroker-host iobroker exit 0 -
@apollon77 sagte in [Aufruf] js-controller 2.0 Beta Test:
@SBorg Ok, Dashboard wie gesagt tut bei mir und anderen ... ich weiss nicht hilfreich für dich, aber ürde ich gerade nicht dem controller anlasten
Ist auch keinerlei Kritik und ich kann es auch nachvollziehen, gerade wenn man es selbst nicht provozieren kann. Ich weiß deinen Einsatz und Engagement auch zu würdigen
Ich weiß halt nicht wie viele Tester das Dashboard nutzen. Broadlink und DasWetter fielen ja auch zuerst nicht auf, außer bei mir
Irgendwie denke ich halt auch an das Release, gerade wenn es dann mehr User nutzen und es dann nicht geht...
Und nun natürlich noch das obligatorische a b e r...
Unter 1.5.14 und der Vor-Node-RED Version läuft das Dashboard. Nur mit der alten Red-Version kommt es ja zu Timing-Problemen mit dem JS 2.x. Da ich in der FireFox-Konsole Fehler mit socket.io (da gab es doch Änderungen?) habe beim aufrufen des Dashboards, tippe ich leider doch auf den JS-Controller? -
@sven12 beides ignore. Haben beide nichts zu sagen. Es halt alles geklappt.
-
@SBorg dein Feedback und Tests sind auch super. Die Web Meldungen haben damit zu tun das der Browser Probleme hat mit dem Webserver den der node-red Prozess auf macht zu reden.
Das hat mit dem was der Controller da geändert hat nichts zu tun. Hast finden Browser Fehler bitte nochmal für mich? Mal danach gegoogelt? -
bei mir funktioniert der g-homa Adapter nicht mehr. Hat den jemand im Einsatz und hat Probleme seit js-controller 2.x?
Wenn ich anschalten will schaltet er gleich wieder aus. Dabei zappelt der VIS-Schalter (fancyswitch - Giva Labs iButton) paar mal hin- und her. Schaltbefehl über telegram geht auch nicht mehr und füht zum selben Problem. Ich habe auch dabei alle javascript Adapter ausgeschaltet um hier Fehler auszuschließen.
Log sagt:g-homa.0 2019-10-05 14:52:23.574 debug (3918) system.adapter.admin.1: logging true g-homa.0 2019-10-05 14:51:29.908 debug (3918) powerFactor in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:29.908 debug (3918) power in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:29.907 debug (3918) current in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:29.907 debug (3918) voltage in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:29.810 debug (3918) voltage != null: false g-homa.0 2019-10-05 14:51:29.810 debug (3918) power != null: false g-homa.0 2019-10-05 14:51:29.810 debug (3918) powerFactor != null: false g-homa.0 2019-10-05 14:51:29.810 debug (3918) current != null: false g-homa.0 2019-10-05 14:51:29.809 debug (3918) extendPlug: type = normal, energyMeasurement != null: true g-homa.0 2019-10-05 14:51:29.806 debug type: normal g-homa.0 2019-10-05 14:51:29.806 debug switched from: remote g-homa.0 2019-10-05 14:51:29.806 debug state: off g-homa.0 2019-10-05 14:51:29.806 debug (3918) Got updated info for Plug 4ce7ac: g-homa.0 2019-10-05 14:51:28.616 debug (3918) powerFactor in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:28.615 debug (3918) power in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:28.615 debug (3918) current in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:28.614 debug (3918) voltage in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:28.553 debug (3918) voltage != null: false g-homa.0 2019-10-05 14:51:28.553 debug (3918) power != null: false g-homa.0 2019-10-05 14:51:28.552 debug (3918) powerFactor != null: false g-homa.0 2019-10-05 14:51:28.552 debug (3918) current != null: false g-homa.0 2019-10-05 14:51:28.552 debug (3918) extendPlug: type = normal, energyMeasurement != null: true g-homa.0 2019-10-05 14:51:28.549 debug type: normal g-homa.0 2019-10-05 14:51:28.549 debug switched from: remote g-homa.0 2019-10-05 14:51:28.549 debug state: off g-homa.0 2019-10-05 14:51:28.549 debug (3918) Got updated info for Plug 4ce7ac: g-homa.0 2019-10-05 14:51:28.500 debug (3918) powerFactor in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:28.500 debug (3918) power in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:28.499 debug (3918) current in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:28.499 debug (3918) voltage in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:28.405 debug (3918) voltage != null: false g-homa.0 2019-10-05 14:51:28.404 debug (3918) power != null: false g-homa.0 2019-10-05 14:51:28.404 debug (3918) powerFactor != null: false g-homa.0 2019-10-05 14:51:28.404 debug (3918) current != null: false g-homa.0 2019-10-05 14:51:28.403 debug (3918) extendPlug: type = normal, energyMeasurement != null: true g-homa.0 2019-10-05 14:51:28.400 debug type: normal g-homa.0 2019-10-05 14:51:28.400 debug switched from: remote g-homa.0 2019-10-05 14:51:28.400 debug state: on g-homa.0 2019-10-05 14:51:28.400 debug (3918) Got updated info for Plug 4ce7ac: g-homa.0 2019-10-05 14:51:27.392 debug (3918) powerFactor in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:27.392 debug (3918) power in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:27.392 debug (3918) current in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:27.391 debug (3918) voltage in plug.energyMeasurement => false g-homa.0 2019-10-05 14:51:27.335 debug (3918) voltage != null: false g-homa.0 2019-10-05 14:51:27.335 debug (3918) power != null: false g-homa.0 2019-10-05 14:51:27.335 debug (3918) powerFactor != null: false g-homa.0 2019-10-05 14:51:27.335 debug (3918) current != null: false g-homa.0 2019-10-05 14:51:27.334 debug (3918) extendPlug: type = normal, energyMeasurement != null: true g-homa.0 2019-10-05 14:51:27.332 debug type: normal g-homa.0 2019-10-05 14:51:27.332 debug switched from: remote g-homa.0 2019-10-05 14:51:27.332 debug state: on g-homa.0 2019-10-05 14:51:27.332 debug (3918) Got updated info for Plug 4ce7ac: g-homa.0 2019-10-05 14:51:13.232 debug (3918) system.adapter.admin.1: logging false g-homa.0 2019-10-05 14:49:15.644 debug (3918) powerFactor in plug.energyMeasurement => false g-homa.0 2019-10-05 14:49:15.644 debug (3918) power in plug.energyMeasurement => false g-homa.0 2019-10-05 14:49:15.643 debug (3918) current in plug.energyMeasurement => false g-homa.0 2019-10-05 14:49:15.642 debug (3918) voltage in plug.energyMeasurement => false g-homa.0 2019-10-05 14:49:15.519 debug (3918) voltage != null: false g-homa.0 2019-10-05 14:49:15.519 debug (3918) power != null: false g-homa.0 2019-10-05 14:49:15.519 debug (3918) powerFactor != null: false g-homa.0 2019-10-05 14:49:15.518 debug (3918) current != null: false g-homa.0 2019-10-05 14:49:15.518 debug (3918) extendPlug: type = normal, energyMeasurement != null: true g-homa.0 2019-10-05 14:49:15.516 debug type: normal g-homa.0 2019-10-05 14:49:15.516 debug switched from: remote g-homa.0 2019-10-05 14:49:15.516 debug state: off g-homa.0 2019-10-05 14:49:15.516 debug (3918) Got updated info for Plug 4ce7ac: g-homa.0 2019-10-05 14:49:14.392 debug (3918) powerFactor in plug.energyMeasurement => false g-homa.0 2019-10-05 14:49:14.392 debug (3918) power in plug.energyMeasurement => false g-homa.0 2019-10-05 14:49:14.392 debug (3918) current in plug.energyMeasurement => false g-homa.0 2019-10-05 14:49:14.391 debug (3918) voltage in plug.energyMeasurement => false g-homa.0 2019-10-05 14:49:14.294 debug (3918) voltage != null: false g-homa.0 2019-10-05 14:49:14.293 debug (3918) power != null: false g-homa.0 2019-10-05 14:49:14.293 debug (3918) powerFactor != null: false g-homa.0 2019-10-05 14:49:14.292 debug (3918) current != null: false g-homa.0 2019-10-05 14:49:14.292 debug (3918) extendPlug: type = normal, energyMeasurement != null: true g-homa.0 2019-10-05 14:49:14.289 debug type: normal g-homa.0 2019-10-05 14:49:14.289 debug switched from: remote g-homa.0 2019-10-05 14:49:14.289 debug state: off g-homa.0 2019-10-05 14:49:14.289 debug (3918) Got updated info for Plug 4ce7ac: -
@lobomau Dann leg doch mal bei ghoma ein Issue an ...
-
@lobomau Alternativ leg doch mal ein Subscribe im Javascript adapter auf den relevanten State und logge alle Änderungen mit state.val, state.ack und state.from Vllt wird man daraus schlauer
-
@apollon77 sagte in [Aufruf] js-controller 2.0 Beta Test:
@SBorg ...Das hat mit dem was der Controller da geändert hat nichts zu tun. Hast finden Browser Fehler bitte nochmal für mich? Mal danach gegoogelt?
Da bist du der Fachmann
Google hat zwar einiges zu Tage gefördert, aber wie üblich, wenn es interessant wird verläuft es im Sand...
Der socket.io kommt dann im paar Sekundentakt, wobei ich nicht weiß, ob die beiden ersten schon immer da waren:
Bringt es vielleicht etwas meine Flows zu sichern und Node-RED mal kpl. zu de-/neuinstallieren? Ev. hat es bei dem testen einfach nur bei mir was zerschossen...
-
@apollon77 Mein iobroker-hwr läuft unter init.d und der iobroker-master im Container.
Blöderweise schreibt das Diet Pi auch kein syslog in der Standardconfig, d.h. ich habe da aktuell auch keines.
Ich mache jetzt folgendes:
Ich nehm ne neue SD Karte und setze den HWR mit Rasbian neu auf.
Des weiteren werd ich noch einen zweiten Docker Container mit iobroker als Salve für die Tests starten.
-
@apollon77
Sorry für die Umstände... Shelly auf 3.1.1 hoch gezogen, keine Änderung.
Reboot ,
Jetzt läuft der Shelly Adapter ohne Probleme..Also wie immer Reboot tut gut...
-
@SBorg sagte in [Aufruf] js-controller 2.0 Beta Test:
Bringt es vielleicht etwas meine Flows zu sichern und Node-RED mal kpl. zu de-/neuinstallieren? Ev. hat es bei dem testen einfach nur bei mir was zerschossen...
versuch das mal.
Die Meldung zeigt das er versucht zum Port 1880 von node-red zu verbunden und der Server das ablehnt.
-
@darkiop Ok, Ansonsten: Wenn init.d dann schau mal ob in /opt/iobroker/node_modules/iobroker.js-controller/lib ein iobroker.pid File liegt wenn der sauber gestartet wurde und läuft. Wenn ja sollte das restart eigentlich tun. Wenn nein ist da was komisch
-
Also, hier mal ein kleiner Zwischenstand:
Ich habe den iobroker-hwr neu aufgesetzt - mit dem aktuellen Rasbian lite + Node 10 + iobroker 2.0.22.
Und, du wirst es nicht glauben, das IPv4/Reconnect Thema scheint hier erledigt zu sein ... also liegt die Vermutung nahe das es an Diet Pi lag ... Habe nun mehrmals schon den Master abgewürgt, und jedes mal nachdem er wieder hochgefahren war, war auch der Slave wieder verbunden.
Der automatische Restart unter systemd auf dem RPI funktioniert ebenfalls.
Werd das jetzt mal so über Nacht laufen lassen und Morgen dann nochmal den Skript Export testen (aktuell kommt da immer noch der Hinweis auch auf die fehlende Package.zip).
-
@darkiop Glückwunsch!
-
@Stabilostick Ich frage mich aber gerade was hier seitens Diet Pi eingespart wurde damit es zu diesem Verhalten gekommen ist. Immerhin bleibt die Erfahrung
-
@darkiop Cooooool, wieder ein Thema was sich "von selbst erledigt"
Ok, das was ich gefixt habe waren ungültige Downloads (also ZIP Files die keine waren).
Das es gar nicht ging hatte ich nicht -
@darkiop
OT: Du warst der Auslöser
-> https://forum.iobroker.net/post/307432
