js-controller 3.0/3.1 jetzt im Latest!

[dslraser]

@dirk1962 sagte in js-controller 3.0 jetzt im Latest!:

Wird das irgendwo gespeichert?

schau mal in die Signatur von @apollon77

Logfiles auf Platte /opt/iobroker/log/… nutzen, Admin schneidet Zeilen ab

[apollon77]

@fabib also der Fehler kommt irgendwie von zigbee direkt und scheinbar Kommunikation. Sehe da wenig Zusammenhang mit dem Controller. Frag mal Lieberman den zigbee threads nach bzw da im GitHub.

[apollon77]

@oFbEQnpoLKKl6mbY5e13 sonst mir mit Verweis aufs GitHub issue an iobroker@fischer-ka.de schicken.

[dirk1962]

@apollon77 sagte in js-controller 3.0 jetzt im Latest!:

@dirk1962 hast du vllt noch das install log vom letzten Update von iot?

Ich hoffe, dass Du das meinst.

[rewenode]

Braucht der js-controller 3.0 tatsächlich soviel weniger Speicher? Oder ist da was bei mir im argen? Alle Adapter laufen jedenfalls und auch im Log keine Auffälligkeiten.

[Marty56]

@liv-in-sky Ich habe ein ganz ähnliches Problem. Bei mir sind das PNGs, die ich vor sehr langer Zeit mal in ein eigenes Verzeichnis unterhalb der VIS ICONs Verzeichnis kopiert hatte, die ich aber schon seit mehreren Monaten (mehr als 12) nicht mehr in VIS benutze.

Mir ist es deshalb total unklar, warum die noch geladen werden und diese Warning erzeugen. Ich vermute, dass VIS beim Editieren immer noch alte HTML Code Stücke sinnlosere Weise mit in der Datenbank hat, die diese PNGs referenzieren, aber nie mehr anzeigen. Das würde auch erklären, warum das erstmalige Laden meiner Visualisierung so lange dauert.

PS: Ich habe gerade mal den Quelltext von dem VIS HTML Code angeschaut und da ist unter Index ein Ordner Bilder und der referenziert bei mir die PNGs, die nicht gefunden werden.

Wie ich das jetzt fixe, ist mir unklar.

[knopers1]

Das Update des RFLink-Adapters zerschießt mir die Serielle Schnittstelle.

raspberrypi

Betriebssystem
    linux
Betriebssystem
    linux
Architektur
    arm
CPUs
    4
Geschwindigkeit
    1500 MHz
Modell
    ARMv7 Processor rev 3 (v7l)
RAM
    3.81 GB
System Betriebszeit
    10 T. 22:55:36
Node.js
    v10.20.1 (Empfohlene Version v12.16.3)
NPM
    6.14.4
Festplatte Größe
    233.73 GB
Festplatte frei
    229.18 GB
Anzahl der Adapter
    346
Betriebszeit
    3 T. 00:01:36
Aktive Instanzen
    23
Hostname
    raspberrypi

Das hier stimmt nicht:
2020-05-01 08:32:49.599 - error: rflink.0 (2973) uncaught exception: SerialPort.list no longer takes a callback and only returns a promise
2020-05-01 08:32:49.609 - error: rflink.0 (2973) TypeError: SerialPort.list no longer takes a callback and only returns a promise

2020-05-01 08:30:03.576 - info: host.raspberrypi iobroker upload [2] rflink.admin /opt/iobroker/node_modules/iobroker.rflink/admin/rflink.png rflink.png image/png
2020-05-01 08:30:03.635 - info: host.raspberrypi iobroker upload [1] rflink.admin /opt/iobroker/node_modules/iobroker.rflink/admin/parse.js parse.js application/javascript
2020-05-01 08:30:03.714 - info: host.raspberrypi iobroker upload [0] rflink.admin /opt/iobroker/node_modules/iobroker.rflink/admin/index.html index.html text/html
2020-05-01 08:30:03.770 - info: host.raspberrypi iobroker Adapter "rflink" updated
2020-05-01 08:30:03.771 - info: host.raspberrypi iobroker host.raspberrypi Adapter "system.adapter.rflink.0" is started
2020-05-01 08:30:03.795 - info: host.raspberrypi "system.adapter.rflink.0" enabled
2020-05-01 08:30:03.814 - info: host.raspberrypi instance system.adapter.rflink.0 started with pid 1666
2020-05-01 08:30:04.820 - info: host.raspberrypi iobroker exit 0
2020-05-01 08:30:06.134 - info: rflink.0 (1666) starting. Version 2.1.0 in /opt/iobroker/node_modules/iobroker.rflink, node: v10.20.1, js-controller: 3.0.20
2020-05-01 08:30:06.282 - info: rflink.0 (1666) Serial port opened
2020-05-01 08:30:07.212 - info: rflink.0 (1666) Connected
2020-05-01 08:30:09.311 - info: ical.0 (1645) Terminated (NO_ERROR): Without reason
2020-05-01 08:30:09.830 - info: host.raspberrypi instance system.adapter.ical.0 terminated with code 0 (NO_ERROR)
2020-05-01 08:30:21.393 - error: rflink.0 (1666) uncaught exception: SerialPort.list no longer takes a callback and only returns a promise
2020-05-01 08:30:21.397 - error: rflink.0 (1666) TypeError: SerialPort.list no longer takes a callback and only returns a promise
at Function.SerialPort.list (/opt/iobroker/node_modules/@serialport/stream/lib/index.js:651:11)
at Adapter.adapter.on.obj (/opt/iobroker/node_modules/iobroker.rflink/main.js:43:36)
at Adapter.emit (events.js:198:13)
at change (/opt/iobroker/node_modules/iobroker.js-controller/lib/adapter.js:5304:34)
at Immediate.setImmediate (/opt/iobroker/node_modules/iobroker.js-controller/lib/states/statesInRedis.js:234:41)
at runCallback (timers.js:705:18)
at tryOnImmediate (timers.js:676:5)
at processImmediate (timers.js:658:5)
2020-05-01 08:30:21.493 - info: rflink.0 (1666) terminating
2020-05-01 08:30:21.495 - info: rflink.0 (1666) Terminated (NO_ERROR): Without reason
2020-05-01 08:30:22.018 - info: host.raspberrypi instance system.adapter.rflink.0 terminated with code 0 (NO_ERROR)
2020-05-01 08:30:22.019 - info: host.raspberrypi Restart adapter system.adapter.rflink.0 because enabled
2020-05-01 08:30:52.044 - info: host.raspberrypi instance system.adapter.rflink.0 started with pid 2299
2020-05-01 08:30:53.956 - info: rflink.0 (2299) starting. Version 2.1.0 in /opt/iobroker/node_modules/iobroker.rflink, node: v10.20.1, js-controller: 3.0.20
2020-05-01 08:30:54.095 - info: rflink.0 (2299) Serial port opened
2020-05-01 08:30:55.025 - info: rflink.0 (2299) Connected
2020-05-01 08:31:00.460 - info: javascript.0 (30309) script.js.common.StromzaehlerWemo: setForeignState(id=javascript.0.StromMeter.Wert, state="648578.00")
2020-05-01 08:31:06.026 - info: host.raspberrypi Update repository "latest" under "http://download.iobroker.net/sources-dist-latest.json"
2020-05-01 08:31:22.254 - error: rflink.0 (2299) uncaught exception: SerialPort.list no longer takes a callback and only returns a promise
2020-05-01 08:31:22.264 - error: rflink.0 (2299) TypeError: SerialPort.list no longer takes a callback and only returns a promise
at Function.SerialPort.list (/opt/iobroker/node_modules/@serialport/stream/lib/index.js:651:11)
at Adapter.adapter.on.obj (/opt/iobroker/node_modules/iobroker.rflink/main.js:43:36)
at Adapter.emit (events.js:198:13)
at change (/opt/iobroker/node_modules/iobroker.js-controller/lib/adapter.js:5304:34)
at Immediate.setImmediate (/opt/iobroker/node_modules/iobroker.js-controller/lib/states/statesInRedis.js:234:41)
at runCallback (timers.js:705:18)
at tryOnImmediate (timers.js:676:5)
at processImmediate (timers.js:658:5)
2020-05-01 08:31:22.334 - info: rflink.0 (2299) terminating
2020-05-01 08:31:22.335 - info: rflink.0 (2299) Terminated (NO_ERROR): Without reason
2020-05-01 08:31:22.853 - info: host.raspberrypi instance system.adapter.rflink.0 terminated with code 0 (NO_ERROR)
2020-05-01 08:31:22.853 - info: host.raspberrypi Restart adapter system.adapter.rflink.0 because enabled
2020-05-01 08:31:48.770 - info: host.raspberrypi "system.adapter.rflink.0" disabled
2020-05-01 08:31:54.229 - info: host.raspberrypi "system.adapter.rflink.0" enabled
2020-05-01 08:31:54.229 - info: host.raspberrypi stopInstance system.adapter.rflink.0 (force=false, process=true)
2020-05-01 08:31:54.231 - info: host.raspberrypi stopInstance system.adapter.rflink.0 send kill signal
2020-05-01 08:31:55.292 - info: host.raspberrypi stopInstance system.adapter.rflink.0 killing pid 2957
2020-05-01 08:31:55.302 - info: rflink.0 (2957) starting. Version 2.1.0 in /opt/iobroker/node_modules/iobroker.rflink, node: v10.20.1, js-controller: 3.0.20
2020-05-01 08:31:55.453 - info: rflink.0 (2957) Serial port opened
2020-05-01 08:31:56.383 - info: rflink.0 (2957) Connected
2020-05-01 08:31:57.267 - info: host.raspberrypi instance system.adapter.rflink.0 started with pid 2973
2020-05-01 08:31:57.273 - warn: rflink.0 (2957) Got terminate signal. Checking desired PID: 0 vs own PID 2957
2020-05-01 08:31:57.277 - info: rflink.0 (2957) terminating
2020-05-01 08:31:57.279 - info: rflink.0 (2957) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
2020-05-01 08:31:57.288 - warn: rflink.0 (2957) Got terminate signal. Checking desired PID: 2973 vs own PID 2957
2020-05-01 08:31:57.804 - error: host.raspberrypi instance system.adapter.rflink.0 terminated by request of the instance itself and will not be restarted, before user restarts it.
2020-05-01 08:31:57.804 - info: host.raspberrypi Do not restart adapter system.adapter.rflink.0 because desired by instance
2020-05-01 08:31:59.163 - info: rflink.0 (2973) starting. Version 2.1.0 in /opt/iobroker/node_modules/iobroker.rflink, node: v10.20.1, js-controller: 3.0.20
2020-05-01 08:31:59.665 - info: rflink.0 (2973) Serial port opened
2020-05-01 08:32:00.594 - info: rflink.0 (2973) Connected
2020-05-01 08:32:00.814 - info: javascript.0 (30309) script.js.common.StromzaehlerWemo: setForeignState(id=javascript.0.StromMeter.Wert, state="648579.00")
2020-05-01 08:32:49.599 - error: rflink.0 (2973) uncaught exception: SerialPort.list no longer takes a callback and only returns a promise
2020-05-01 08:32:49.609 - error: rflink.0 (2973) TypeError: SerialPort.list no longer takes a callback and only returns a promise
at Function.SerialPort.list (/opt/iobroker/node_modules/@serialport/stream/lib/index.js:651:11)
at Adapter.adapter.on.obj (/opt/iobroker/node_modules/iobroker.rflink/main.js:43:36)
at Adapter.emit (events.js:198:13)
at change (/opt/iobroker/node_modules/iobroker.js-controller/lib/adapter.js:5304:34)
at Immediate.setImmediate (/opt/iobroker/node_modules/iobroker.js-controller/lib/states/statesInRedis.js:234:41)
at runCallback (timers.js:705:18)
at tryOnImmediate (timers.js:676:5)
at processImmediate (timers.js:658:5)
2020-05-01 08:32:49.775 - info: rflink.0 (2973) terminating
2020-05-01 08:32:49.776 - info: rflink.0 (2973) Terminated (NO_ERROR): Without reason
2020-05-01 08:32:50.295 - info: host.raspberrypi instance system.adapter.rflink.0 terminated with code 0 (NO_ERROR)
2020-05-01 08:32:50.296 - info: host.raspberrypi Restart adapter system.adapter.rflink.0 because enabled

[apollon77]

@rewenode naja ein bissl optimiert haben wir aber direkt nach dem Start ist das schwer zu sagen. Warte mal wie es morgen aussieht.

[apollon77]

@Marty56 hm ... klingt nach einem issue für Vis wo sich GitHub freut.

[apollon77]

@knopers1 Jupp. Ich bin schuld. Fix version kommt nachher.

[liv-in-sky]

@Marty56
erstmal danke für's melden - werde das morgen nochmal näher ansehen, ob ich das irgendwie nachvollziehen kann - meld mich dann

[apollon77]

@knopers1 rflink 2.1.4 sollte das gefixt haben

[Thisoft]

Hallo,

ich bekomme aktuell nach dem Update auf Node 12 und js-controller 3.0.20 folgenden Fehler vom SQL-Adapter:

sql.0
2020-05-03 04:26:14.114
error
(7144) ConnectionError: Failed to connect to 192.168.137.xxx:1433 - Cannot call write after a stream was destroyed

was kann ich denn dagegen tun?

[knopers1]

@apollon77 said in js-controller 3.0 jetzt im Latest!:

@knopers1 rflink 2.1.4 sollte das gefixt haben

ja, 2.1.4 läuft wieder :). Besten Dank. Meine Anerkennung apollon77. "Du hast es drauf"

[apollon77]

@Thisoft nur Update von dem genannten oder auch von sql? Welche sql Version?

Wann kommt der Fehler?

Bissl mehr context und log wäre schön.

[Thisoft]

@apollon77 Sorry, war schon spät Also, ich hab zuerst von nodejs 8.x auf 12.16.3 updatet. Danach:

npm rebuild

was mir mit der folgenden Ausgabe antwortet:

@types/node@12.7.1 /home/iobroker/node_modules/@types/node

das kommt mir schonmal komisch vor...?

Dann reboot, danach "iobroker" update und "iobroker upgrade self"
Danach den Installationsfixer drüber laufen lassen. Der hat alles ohne Fehlermeldung ausgeführt.
Danach alle Adapter die zum Update anstanden über die Adminoberfläche updatet, u.a. auch den SQL-Adapter auf 1.12.3

Ja, und das wäre jetzt ertstmal der Stand. Hier nochmal ein Log vom SQL-Adapter mit Debug-Logging:

2020-05-03 11:11:57.617  - info: host.ioBroker-Ubuntu Restart adapter system.adapter.sql.0 because enabled
2020-05-03 11:11:58.636  - info: host.ioBroker-Ubuntu instance system.adapter.sql.0 started with pid 5436
2020-05-03 11:11:58.915  - debug: sql.0 (5436) Redis Objects: Use Redis connection: 0.0.0.0:9001
2020-05-03 11:11:58.933  - debug: sql.0 (5436) Objects client ready ... initialize now
2020-05-03 11:11:58.935  - debug: sql.0 (5436) Objects create System PubSub Client
2020-05-03 11:11:58.935  - debug: sql.0 (5436) Objects create User PubSub Client
2020-05-03 11:11:58.936  - debug: sql.0 (5436) Objects client initialize lua scripts
2020-05-03 11:11:58.946  - debug: sql.0 (5436) Objects connected to redis: 0.0.0.0:9001
2020-05-03 11:11:58.948  - debug: sql.0 (5436) objectDB connected
2020-05-03 11:11:58.948  - debug: sql.0 (5436) Redis States: Use Redis connection: 0.0.0.0:9000
2020-05-03 11:11:58.952  - debug: sql.0 (5436) States create User PubSub Client
2020-05-03 11:11:58.953  - debug: sql.0 (5436) States create System PubSub Client
2020-05-03 11:11:58.957  - debug: sql.0 (5436) States connected to redis: 0.0.0.0:9000
2020-05-03 11:11:58.958  - debug: sql.0 (5436) statesDB connected
2020-05-03 11:11:59.755  - debug: sql.0 (5436) Plugin sentry Initialize Plugin (enabled=true)
2020-05-03 11:11:59.801  - info: sql.0 (5436) starting. Version 1.12.3 in /opt/iobroker/node_modules/iobroker.sql, node: v12.16.3, js-controller: 3.0.20
2020-05-03 11:12:00.024  - info: host.ioBroker-Ubuntu instance system.adapter.weatherunderground.0 started with pid 5452
2020-05-03 11:12:00.072  - debug: sql.0 (5436) system.adapter.admin.0: logging true
2020-05-03 11:12:00.091  - error: sql.0 (5436) ConnectionError: Failed to connect to 192.168.137.13:1433 - Cannot call write after a stream was destroyed

Hilft das weiter?

[Peoples]

@apollon77 sagte in js-controller 3.0 jetzt im Latest!:
...

• Der neue js-controller kann erkennen wenn es ein Node.js Update gab durch welches ggf, Adapter nicht mehr funktionieren und sollte diese automatisch reparieren (rebuilden). Wer also überlegt in dem Zuge des Tests seine Node.js Version anzuheben bitte mal explizit NICHT die übliche Anleitung nach dem Node-js update mit dem Rebuild befolgen sondern ioBroker einfach nach dem Node.js Update starten. Interessant ist ob sich alles selbst "heilt"
  ....

Update wie beschrieben durchgeführt, Zigbee war veraltet beim ersten "Trying to rebuild it..." kein Erfolg danach kam dann ein zweiter Versuch welcher den Zigbee-Adapter wieder reparieren konnte.

Bis jetzt bei mir keine Probleme Top wie immer

[apollon77]

@Thisoft ip ist korrekt? Port auch? Es sieht so aus als ob die dB Verbindung geschlossen wird. Sagt das logfile der Datenbank irgendwas?

Downgrade gern mal auf sql 1.9.x und schau was da passiert. Würde mich aber wundern wenn es da tut.

[apollon77]

@Peoples Jupp. So soll es quasi sein.

[Thisoft]

@apollon77 Auch wenn Du's nicht erwartest, aber die Version 1.9.5 funktioniert. Was mir dabei allerdings auffällt, er führt beim Starten automatisch ein Rebuild aus:

2020-05-03 11:34:26.099 - info: host.ioBroker-Ubuntu Adapter system.adapter.sql.0 needs rebuild and will be restarted afterwards.
2020-05-03 11:34:26.099 - info: host.ioBroker-Ubuntu system.adapter.sql.0 will be rebuilt
2020-05-03 11:34:26.099 - warn: host.ioBroker-Ubuntu adapter "sql" seems to be installed for a different version of Node.js. Trying to rebuild it... 2 attempt
2020-05-03 11:34:26.100 - info: host.ioBroker-Ubuntu iobroker rebuild sql --install
2020-05-03 11:34:26.240 - info: host.ioBroker-Ubuntu iobroker npm-rebuild: npm install --loglevel error --production (System call) in "/opt/iobroker/node_modules/iobroker.sql"
2020-05-03 11:34:40.150 - info: host.ioBroker-Ubuntu iobroker npm-rebuild: ../deps/libmagic/src/fsmagic.c: In function ‘file_fsmagic’:../deps/libmagic/src/fsmagic.c:223:13: warning: In the GNU C Library, "major" is defined by . For historical compatibility, it is currently defined by as well, but we plan to remove this soon. To use "major", include directly. If you did not intend to use a system-defined macro "major", you should undefine it after including . COMMA, (long)major(sb->st_rdev), ^~~~~~~~~~~~~~~~~~~~~~~~~~~ ../deps/libmagic/src/fsmagic.c:224:13: warning: In the GNU C Library, "minor" is defined by . For historical compatibility, it is currently defined by as well, but we plan to remove this soon. To use "minor", include directly. If you did not intend to use a system-defined macro "minor", you should undefine it after including . (long)minor(sb->st_rdev)) == -1) ^~~~~~~~~~~~~~~~~~~~~~~~~~~ ../deps/libmagic/src/fsmagic.c:258:13: warning: In the GNU C Library, "major" is defined by . For historical compatibility, it is currently defined by as well, but we plan to remove this soon. To use "major", include directly. If you did not intend to use a system-defined macro "major", you should undefine it after including . COMMA, (long)major(sb->st_rdev), ^~~~~~~~~~~~~~~~~~~~~~~~~~~ ../deps/libmagic/src/fsmagic.c:259:13: warning: In the GNU C Library, "minor" is defined by . For historical compatibility, it is currently defined by as well, but we plan to remove this soon. To use "minor", include directly. If you did not intend to use a system-defined macro "minor", you should undefine it after including . (long)minor(sb->st_rdev)) == -1) ^~~~~~~~~~~~~~~~~~~~~~~~~~~ 
2020-05-03 11:34:45.056 - info: host.ioBroker-Ubuntu iobroker npm-rebuild: 
2020-05-03 11:34:45.057 - info: host.ioBroker-Ubuntu iobroker npm-rebuild: Rebuild sql done
2020-05-03 11:34:46.060 - info: host.ioBroker-Ubuntu iobroker npm-rebuild: exit 0
2020-05-03 11:34:46.082 - info: host.ioBroker-Ubuntu instance system.adapter.sql.0 started with pid 7239

Wenn ich wieder auf die 1.12 gehe macht er das nicht - und es funktioniert eben auch nicht...

Übrigens, ich hab einen MS-SQLServer im Einsatz. Ist der vielleicht zu selten um genug getestet zu sein ?