ioBroker startet nicht mehr

[Magnus 0]

@thomas-braun

pi@DELO0150:~ $ sudo ln -s /usr/bin/node /usr/bin/nodejs
ln: die symbolische Verknüpfung '/usr/bin/nodejs' konnte nicht angelegt werden: Die Datei existiert bereits
pi@DELO0150:~ $ uname -m && type -P nodejs node npm && nodejs -v && node -v && npm -v && iob -v && whoami && groups && pwd && sudo apt update &> /dev/null && sudo apt update && apt policy nodejs
armv7l
/usr/bin/nodejs
/usr/bin/node
/usr/bin/npm
v16.17.1
v16.17.1
8.15.0
4.0.23
pi
pi adm dialout cdrom sudo audio video plugdev games users input netdev gpio i2c spi iobroker
/home/pi
OK:1 http://archive.raspberrypi.org/debian buster InRelease
OK:2 http://raspbian.raspberrypi.org/raspbian buster InRelease
OK:3 https://deb.nodesource.com/node_16.x buster InRelease
Paketlisten werden gelesen... Fertig
Abhängigkeitsbaum wird aufgebaut.
Statusinformationen werden eingelesen.... Fertig
Alle Pakete sind aktuell.
nodejs:
  Installiert:           16.17.1-deb-1nodesource1
  Installationskandidat: 16.17.1-deb-1nodesource1
  Versionstabelle:
 *** 16.17.1-deb-1nodesource1 500
        500 https://deb.nodesource.com/node_16.x buster/main armhf Packages
        100 /var/lib/dpkg/status
     10.24.0~dfsg-1~deb10u1 500
        500 http://raspbian.raspberrypi.org/raspbian buster/main armhf Packages

[Thomas Braun]

@magnus-0

Starte die Kiste mal sauber durch.

[Magnus 0]

@thomas-braun

also "sudo reboot"?

[Thomas Braun]

@magnus-0

Ja.

[Magnus 0]

@thomas-braun

Gleiches Problem immer noch.

[Thomas Braun]

@magnus-0

iobroker status
iobroker update -i

[Magnus 0]

@thomas-braun

pi@DELO0150:~ $ iobroker status
Server Cannot start inMem-objects on port 9001: Failed to lock DB file "/opt/iobroker/iobroker-data/objects.jsonl"!

[Magnus 0]

@thomas-braun

pi@DELO0150:~ $ iobroker update -i
Server Cannot start inMem-objects on port 9001: Failed to lock DB file "/opt/iobroker/iobroker-data/objects.jsonl"!

[Thomas Braun]

@magnus-0

systemctl status iobroker.service
iobroker status
sudo systemctl stop iobroker.service
iobroker start

[Magnus 0]

@thomas-braun sagte in ioBroker startet nicht mehr:

iobroker start

pi@DELO0150:~ $ systemctl status iobroker.service
● iobroker.service - ioBroker Server
   Loaded: loaded (/lib/systemd/system/iobroker.service; enabled; vendor preset: enabled)
   Active: active (running) since Fri 2022-09-30 20:56:19 CEST; 28s ago
     Docs: http://iobroker.net
 Main PID: 882 (iobroker.js-con)
    Tasks: 11 (limit: 4915)
   CGroup: /system.slice/iobroker.service
           └─882 iobroker.js-controller

Sep 30 20:56:19 DELO0150 systemd[1]: Started ioBroker Server.
pi@DELO0150:~ $ iobroker status
Server Cannot start inMem-objects on port 9001: Failed to lock DB file "/opt/iobroker/iobroker-data/objects.jsonl"!
pi@DELO0150:~ $ sudo systemctl stop iobroker.service
pi@DELO0150:~ $ iobroker start

[Thomas Braun]

@magnus-0 sagte in ioBroker startet nicht mehr:

/opt/iobroker/iobroker-data/objects.jsonl

sudo apt install lsof
sudo lsof /opt/iobroker/iobroker-data/objects.jsonl

[Magnus 0]

@thomas-braun sagte in ioBroker startet nicht mehr:

sudo lsof /opt/iobroker/iobroker-data/objects.jsonl

pi@DELO0150:~ $ sudo apt install lsof
Paketlisten werden gelesen... Fertig
Abhängigkeitsbaum wird aufgebaut.
Statusinformationen werden eingelesen.... Fertig
Die folgenden NEUEN Pakete werden installiert:
  lsof
0 aktualisiert, 1 neu installiert, 0 zu entfernen und 0 nicht aktualisiert.
Es müssen 307 kB an Archiven heruntergeladen werden.
Nach dieser Operation werden 447 kB Plattenplatz zusätzlich benutzt.
Holen:1 http://mirror1.hs-esslingen.de/pub/Mirrors/archive.raspbian.org/raspbian buster/main armhf lsof armhf 4.91+dfsg-1 [307 kB]
Es wurden 307 kB in 2 s geholt (196 kB/s).
Vormals nicht ausgewähltes Paket lsof wird gewählt.
(Lese Datenbank ... 53671 Dateien und Verzeichnisse sind derzeit installiert.)
Vorbereitung zum Entpacken von .../lsof_4.91+dfsg-1_armhf.deb ...
Entpacken von lsof (4.91+dfsg-1) ...
lsof (4.91+dfsg-1) wird eingerichtet ...
Trigger für man-db (2.8.5-2) werden verarbeitet ...
pi@DELO0150:~ $ sudo lsof /opt/iobroker/iobroker-data/objects.jsonl
COMMAND    PID     USER   FD   TYPE DEVICE  SIZE/OFF   NODE NAME
iobroker. 1226 iobroker   19u   REG  179,2 972533859 261398 /opt/iobroker/iobroker-data/objects.jsonl

[Thomas Braun]

@magnus-0 sagte in ioBroker startet nicht mehr:

sudo kill 1226

[Magnus 0]

@thomas-braun sagte in ioBroker startet nicht mehr:

sudo kill 1226

pi@DELO0150:~ $ sudo kill 1226
kill: (1226): Kein passender Prozess gefunden

[Magnus 0]

@thomas-braun

Da ja der ioBroker dauert neustartet, ändert sich glaub die PID.

Ich habe jetzt mal sekündlich folgenden Befehl eingegeben:

pi@DELO0150:~ $ sudo lsof /opt/iobroker/iobroker-data/objects.jsonl
pi@DELO0150:~ $ sudo lsof /opt/iobroker/iobroker-data/objects.jsonl
pi@DELO0150:~ $ sudo lsof /opt/iobroker/iobroker-data/objects.jsonl
pi@DELO0150:~ $ sudo lsof /opt/iobroker/iobroker-data/objects.jsonl
COMMAND    PID     USER   FD   TYPE DEVICE  SIZE/OFF   NODE NAME
iobroker. 1952 iobroker   19u   REG  179,2 972533859 261398 /opt/iobroker/iobroker-data/objects.jsonl

Wenn ich den Befehl ein paar Sekunden später wieder eingebe, steht wieder eine andere PID dabei.

[Thomas Braun]

@magnus-0 sagte in ioBroker startet nicht mehr:

ändert sich glaub die PID.

Ja, natürlich. Mir fällt nur im Moment nix dazu ein warum der ioBroker dauernd neustartet.

[Magnus 0]

@thomas-braun

Achso ok, ist das vielleicht normal, dass er sich 30 Sekunden mit der Datenbank verbinden möchte und wenn das nicht klappt einen Neustart durchführt?

Folgend ein Log-Auszug:

2022-09-30 21:15:05.006  - error: host.DELO0150 No connection to databases possible, restart
2022-09-30 21:15:05.016  - info: host.DELO0150 iobroker _restart
2022-09-30 21:15:05.525  - info: host.DELO0150 connected to Objects and States
2022-09-30 21:15:05.555  - info: host.DELO0150 added notifications configuration of host
2022-09-30 21:15:05.563  - info: host.DELO0150 Node.js version has changed from 16.16.0 to 16.17.1
2022-09-30 21:15:05.632  - info: host.DELO0150 Successfully updated capabilities "cap_net_admin, cap_net_bind_service, cap_net_raw" for /usr/bin/node
2022-09-30 21:15:05.717  - info: host.DELO0150 Plugin sentry Sentry Plugin disabled for this process because sending of statistic data is disabled for the system
2022-09-30 21:15:05.786  - info: host.DELO0150 7 instances found
2022-09-30 21:15:05.812  - info: host.DELO0150 starting 7 instances
2022-09-30 21:15:05.909  - info: host.DELO0150 instance system.adapter.admin.0 started with pid 2060
2022-09-30 21:15:10.520  - info: host.DELO0150 iobroker.js-controller version 4.0.23 js-controller starting
2022-09-30 21:15:10.527  - info: host.DELO0150 Copyright (c) 2014-2022 bluefox, 2014 hobbyquaker
2022-09-30 21:15:10.528  - info: host.DELO0150 hostname: DELO0150, node: v16.17.1
2022-09-30 21:15:10.529  - info: host.DELO0150 ip addresses: 192.168.178.150 fe80::5068:6694:ad08:cc79
2022-09-30 21:15:40.549  - error: host.DELO0150 No connection to databases possible, restart
2022-09-30 21:15:40.558  - info: host.DELO0150 iobroker _restart
2022-09-30 21:15:41.154  - info: host.DELO0150 connected to Objects and States
2022-09-30 21:15:41.184  - info: host.DELO0150 added notifications configuration of host
2022-09-30 21:15:41.193  - info: host.DELO0150 Node.js version has changed from 16.16.0 to 16.17.1
2022-09-30 21:15:41.261  - info: host.DELO0150 Successfully updated capabilities "cap_net_admin, cap_net_bind_service, cap_net_raw" for /usr/bin/node
2022-09-30 21:15:41.352  - info: host.DELO0150 Plugin sentry Sentry Plugin disabled for this process because sending of statistic data is disabled for the system
2022-09-30 21:15:41.408  - info: host.DELO0150 7 instances found
2022-09-30 21:15:41.434  - info: host.DELO0150 starting 7 instances
2022-09-30 21:15:41.539  - info: host.DELO0150 instance system.adapter.admin.0 started with pid 2095
2022-09-30 21:15:46.246  - info: host.DELO0150 iobroker.js-controller version 4.0.23 js-controller starting
2022-09-30 21:15:46.252  - info: host.DELO0150 Copyright (c) 2014-2022 bluefox, 2014 hobbyquaker
2022-09-30 21:15:46.253  - info: host.DELO0150 hostname: DELO0150, node: v16.17.1
2022-09-30 21:15:46.254  - info: host.DELO0150 ip addresses: 192.168.178.150 fe80::5068:6694:ad08:cc79

[Magnus 0]

@thomas-braun

Denkst du, wir bekommen das heute irgendwie hin?

[Thomas Braun]

@magnus-0

sudo systemctl disable iobroker.service
sudo systemctl stop iobroker.service

Sollte den restart loop unterbrechen.

[Magnus 0]

@thomas-braun

pi@DELO0150:~ $ sudo systemctl disable iobroker.service
Removed /etc/systemd/system/multi-user.target.wants/iobroker.service.