Server Cannot start inMem-objects on port 9001

[flugwelle]

Ich hatte letzten Freitag auch so ein Problem. Alles lief vorher unauffällig. Dann habe ich bemerkt, dass scheinbar Teile sich neu starteten, denn ich habe Notifications bekommen, die nur bei einem Neustart kommen. Etwa zwei Stunden später war ioBroker weg (bzw. da ist es mir aufgefallen).

Ich habe dann so die üblichen Tests gemacht und im Log auch die Out of Memory Meldung gefunden

FATAL ERROR: MarkCompactCollector: young object promotion failed Allocation failed - JavaScript heap out of memory
 1: 0xa3ac10 node::Abort() [iobroker.js-controller]
 2: 0x970199 node::FatalError(char const*, char const*) [iobroker.js-controller]
 3: 0xbba5ce v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [iobroker.js-controller]
 4: 0xbba947 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [iobroker.js-controller]
 5: 0xd76b65  [iobroker.js-controller]
...

Da ich keine Zeit für eine weitere Fehlersuche hatte, habe ich schnell den Speicher der VM von 12 auf 20GB angehoben - und schon lief der ioBroker wieder!

Meine states.jsonl ist übrigens auch knappe 500MB groß ...

[apollon77]

@flugwelle ok. Eine States mit 500mb ist krass. Wie groß ist objects.jsonl und wie viele Objekte und States laut Admin?

[flugwelle]

@apollon77 said in Server Cannot start inMem-objects on port 9001:

Wie groß ist objects.jsonl und wie viele Objekte und States laut Admin?

objects.jsonl ist 41MB bei 50475 Objekten ...

[apollon77]

@flugwelle das passt. Aber wo hast du 50k Objekte her!??! Das klingt Zuviel es sei denn es ist Absicht. Ggf Ble Adapter im Spiel?

[flugwelle]

@apollon77 said in Server Cannot start inMem-objects on port 9001:

Aber wo hast du 50k Objekte her!??! Das klingt Zuviel es sei denn es ist Absicht.

Was heisst Absicht ... die sind da, keine Ahnung, wer da was beisteuert.
Kann man das irgend auflisten? Welcher Adapter wieviele Objekte hat?

Ich könnte mir vorstellen, dass der Unifi Adapter mit allen Netzwerk Clients eine Menge ausmacht ...

[flugwelle]

Noch mal die Frage in die Runde: kann man irgendwie herausfinden, welche Adapter wieviele Objekte haben?
In der Zwischenzeit ist mein System bei 67826 Objekten und die states.jsonl bei 689MB ...

[Glasfaser]

@flugwelle

Auf die schnelle ...

.

[flugwelle]

@glasfaser Klappt nicht ... vermutlich weil es zu groß ist. Wenn ich nur die Auswahl exportiere bekomme ich ein .json - ansonsten leider nicht.

[Glasfaser]

@flugwelle

du brauchst nichts exportieren ... steht doch schon im Popup Feld drin ..

[flugwelle]

@glasfaser Ich soll jetzt jede Zeile einzeln ausprobieren? Nicht wirklich - oder?

[Glasfaser]

@flugwelle

Du brauchst doch nur den Hauptordner anwählen !!!

oder per Befehl

iob list objects admin.* | wc -l

[flugwelle]

@glasfaser Schon klar ... aber ich muss das bei jedem Hauptordner machen. Das mit dem iob list ist da schon praktischer - danke.

Ich glaube ich habe auch schon einen Kandidaten gefunden - der Unifi-Protect Baum hat schlappe 35K Objekte ...

[Chris_90]

Hallo zusammen,
Ich wollte kurz mal eine Meldung zu dem Thema abgeben.
Mir war es vor kurzem zweimal im Abstand von wenigen Wochen zu dem eingangs erwähnten Problem gekommen.
Meine Objects.json1 Datei war plötzlich 500M groß.

Auf meinem iobroker läuft auch so gut wie nix, ich nutze es nur für 1x Heizungsthermostat, 3 Steckdosen, 1 Lampe und ein paar Fensterkontakte. Insofern war das für mich ganz und gar unerklärlich.
Wenn ich aktuell die Anzahl der Objects abfrage zeigt mir der iobroker ganze 31 an. Die objects.json1 ist 7,6M groß, also nicht besorgniserregend.

Um das Teil zum fliegen zu bekommen musste ich beide male restoren.

Langfristig abhilfe geschafft hat vermutlich der Hinweis von @AlCalzone: fix: avoid huge DB files by compressing daily

Ich hatte aber im Zuge dessen nochmal eingehends geprüft, dass mein OS und die iobroker Installation auf dem aktuellsten Stand ist. (war noch auf buster im repo eingestellt)

Fazit: Meine Installation läuft jetzt wieder seit mehr als 1 Monat ohne zwischenfälle!

[apollon77]

@chris_90 Danke für Feedback. Wir bereiten gerade einen js-controller 4.0.24 vor der das dann für alle bringt.

[micw42]

Hallo,
auch ich kann berichten, dass ich alle paar Wochen diesen Fehler habe und der iobroker dann nicht mehr erreichbar ist.
Ich komme in dem Fall auch nicht mehr mit ssh auf den pi, ein ping funktioniert komischerweise aber noch.
Muss dann den Stecker ziehen, danach läuft wieder alles.

Das nur zur Info, ich warte dann mal auf das Update ...

[apollon77]

@micw42 naja sttooooppp ... wie kommst Du darauf das diese Beschreibung von Dir zu dem Fehler passt um den es hier geht?

Dein Fehlerbild würde eher bedeuten das du zuviel RAM verbrauchst und er dann startet zu Swappen und da nicht mehr rauskommt - das wäre was ganz anderes und auch ganz anders zu lösen.

Wen Wenn du den hier beschriebenen Fehler hättest, würde er auch nach deine Strom-weg nicht mehr starten. AM besten details in eigenem Thread liefern

[micw42]

Hm, weil diese Meldung immer die letzte im Log ist, wenn es passiert:

2022-11-21 08:17:22.426 - info: host.raspberrypi iobroker.js-controller version 4.0.23 js-controller starting
2022-11-21 08:17:22.433 - info: host.raspberrypi Copyright (c) 2014-2022 bluefox, 2014 hobbyquaker
2022-11-21 08:17:22.434 - info: host.raspberrypi hostname: raspberrypi, node: v14.20.0
2022-11-21 08:17:22.435 - info: host.raspberrypi ip addresses: 192.168.178.56 fd00::85ce:9c7a:3bcd:95ac fe80::3782:4c12:e099:c79e
2022-11-21 08:17:24.559 - error: host.raspberrypi-Server Cannot start inMem-objects on port 9001: Failed to lock DB file "/opt/iobroker/iobroker-data/objects.jsonl"!
2022-11-21 08:17:29.145 - info: host.raspberrypi iobroker.js-controller version 4.0.23 js-controller starting
2022-11-21 08:17:29.153 - info: host.raspberrypi Copyright (c) 2014-2022 bluefox, 2014 hobbyquaker
2022-11-21 08:17:29.153 - info: host.raspberrypi hostname: raspberrypi, node: v14.20.0
2022-11-21 08:17:29.154 - info: host.raspberrypi ip addresses: 192.168.178.56 fd00::85ce:9c7a:3bcd:95ac fe80::3782:4c12:e099:c79e
2022-11-21 08:17:31.270 - error: host.raspberrypi-Server Cannot start inMem-objects on port 9001: Failed to lock DB file "/opt/iobroker/iobroker-data/objects.jsonl"!
2022-11-21 09:22:54.527 - info: host.raspberrypi iobroker.js-controller version 4.0.23 js-controller starting

[Thomas Braun]

@micw42 sagte in Server Cannot start inMem-objects on port 9001:

raspberrypi, node: v14.20.0

Auf nodejs 16 gehen.

[apollon77]

@micw42 das so alleine sagt nichts. Kann auch sein das einfach das Tanzeinlagen restart Loop war. Dann kann das auch passieren. Am Ende musst du ja rausfinden warum der Host nicht mehr reagiert. Das andere ist ggf nur ein folgethema.

Ich würde mal in /var/log/syslog schauen ob da was mit „oom“ steht. Ich tippe ja

[micw42]

Habe mal reingeguckt.
Von oom keine Spur. Der pi scheint zum besagten Zeitpunkt einen Neustart gemacht zu haben:

Nov 21 08:17:01 raspberrypi CRON[30132]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Nov 21 08:17:05 raspberrypi kernel: [ 0.000000] Booting Linux on physical CPU 0x0
...
Nov 21 08:17:34 raspberrypi systemd[1]: Stopped ioBroker Server.
Nov 21 08:17:34 raspberrypi systemd[1]: Started ioBroker Server.
Nov 21 09:22:54 raspberrypi systemd-timesyncd[318]: Synchronized to time server for the first time 217.91.44.17:123 (2.debian.pool.ntp.org).
Nov 21 09:23:01 raspberrypi systemd[1]: systemd-hostnamed.service: Succeeded.

Habt ihr da eine Erklärung für?