Jahresrückblick 2025 – unser neuer Blogbeitrag ist online! ✨

[Homer]

Systemdata	Bitte Ausfüllen
Hardwaresystem:	Pi
Arbeitsspeicher:	4GB
Festplattenart:	SD-Karte
Betriebssystem:	Linux
Node-Version:	10.x.x
Nodejs-Version:	14.20.0
NPM-Version:	6.14.17
Installationsart:	Skript
Image genutzt:	Nein
Ort/Name der Imagedatei:	Link

Mein Raspi verabschiedet sich alle paar Wochen selbst und zwar komplett. Es startet immer mit

2022-10-31 10:17:20.118 - info: host.raspberrypi iobroker.js-controller version 4.0.23 js-controller starting
2022-10-31 10:17:20.126 - info: host.raspberrypi Copyright (c) 2014-2022 bluefox, 2014 hobbyquaker
2022-10-31 10:17:20.127 - info: host.raspberrypi hostname: raspberrypi, node: v14.20.0

Was danach passiert, hängt wohl von den Umständen ab.
Ergebnis ist immer, dass der Raspi auch über putty nicht mehr erreichbar ist und nur über Wegnehmen der Stromversorgung und Wiederanstecken wieder ans Leben gebracht werden kann.
Heute sah das konkret so aus:

2022-10-31 10:15:00.064 - info: host.raspberrypi instance system.adapter.daswetter.0 started with pid 17747
2022-10-31 10:15:16.237 - info: host.raspberrypi instance system.adapter.daswetter.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION)
2022-10-31 10:30:00.057 - info: host.raspberrypi instance system.adapter.daswetter.0 started with pid 2172
2022-10-31 10:30:16.173 - info: host.raspberrypi instance system.adapter.daswetter.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION)
2022-10-31 10:17:20.118 - info: host.raspberrypi iobroker.js-controller version 4.0.23 js-controller starting
2022-10-31 10:17:20.126 - info: host.raspberrypi Copyright (c) 2014-2022 bluefox, 2014 hobbyquaker
2022-10-31 10:17:20.127 - info: host.raspberrypi hostname: raspberrypi, node: v14.20.0
2022-10-31 10:17:20.127 - info: host.raspberrypi ip addresses: 192.168.2.211 2a00:6020:b209:8e00:34a9:61f5:a0f7:b92e fe80::52bb:6457:77c6:c7f7 192.168.2.33 2a00:6020:b209:8e00:970b:f9f3:99e3:e2f5 fe80::2d77:3397:7440:5e5a
2022-10-31 10:17:22.088 - info: host.raspberrypi connected to Objects and States
2022-10-31 10:17:22.148 - info: host.raspberrypi added notifications configuration of host
2022-10-31 10:17:23.477 - info: host.raspberrypi Delete state "system.host.raspberrypi.versions.nodeCurrent"
2022-10-31 10:17:23.479 - info: host.raspberrypi 43 instances found
2022-10-31 10:17:23.570 - info: host.raspberrypi starting 34 instances
2022-10-31 10:17:23.795 - info: host.raspberrypi Delete state "system.host.raspberrypi.versions.nodeNewest"
2022-10-31 10:17:23.834 - info: host.raspberrypi instance system.adapter.admin.0 started with pid 1040
2022-10-31 10:17:23.852 - info: host.raspberrypi Delete state "system.host.raspberrypi.versions.nodeNewestNext"
2022-10-31 10:17:23.868 - info: host.raspberrypi Delete state "system.host.raspberrypi.versions.npmCurrent"
2022-10-31 10:17:23.882 - info: host.raspberrypi Delete state "system.host.raspberrypi.versions.npmNewest"
2022-10-31 10:17:23.897 - info: host.raspberrypi Delete state "system.host.raspberrypi.versions.npmNewestNext"
2022-10-31 10:17:23.911 - info: host.raspberrypi Some obsolete host states deleted.
2022-10-31 10:17:26.236 - error: admin.0 (1040) admin.0 already running
2022-10-31 10:17:26.239 - warn: admin.0 (1040) Terminated (ADAPTER_ALREADY_RUNNING): Without reason
2022-10-31 10:17:26.957 - error: host.raspberrypi instance system.adapter.admin.0 terminated with code 7 (ADAPTER_ALREADY_RUNNING)
2022-10-31 10:17:26.958 - info: host.raspberrypi Restart adapter system.adapter.admin.0 because enabled
2022-10-31 10:17:27.763 - info: host.raspberrypi instance system.adapter.javascript.0 started with pid 1142
2022-10-31 10:17:31.343 - error: javascript.0 (1142) javascript.0 already running
2022-10-31 10:17:31.346 - warn: javascript.0 (1142) Terminated (ADAPTER_ALREADY_RUNNING): Without reason
2022-10-31 10:17:31.786 - info: host.raspberrypi instance system.adapter.sql.0 started with pid 1154
2022-10-31 10:17:32.014 - error: host.raspberrypi instance system.adapter.javascript.0 terminated with code 7 (ADAPTER_ALREADY_RUNNING)
2022-10-31 10:17:32.015 - info: host.raspberrypi Restart adapter system.adapter.javascript.0 because enabled
2022-10-31 10:17:33.681 - error: sql.0 (1154) sql.0 already running
2022-10-31 10:17:33.684 - warn: sql.0 (1154) Terminated (ADAPTER_ALREADY_RUNNING): Without reason
2022-10-31 10:17:34.320 - error: host.raspberrypi instance system.adapter.sql.0 terminated with code 7 (ADAPTER_ALREADY_RUNNING)
2022-10-31 10:17:34.321 - info: host.raspberrypi Restart adapter system.adapter.sql.0 because enabled
2022-10-31 12:22:45.710 - info: host.raspberrypi instance system.adapter.telegram.0 started with pid 1172

Sprich:
10:17Uhr hat "dasWetter" sich noch normal verhalten. Dann kam 10:17:20.118 die o.g. Meldung, dann nahm das Unglück seinen Lauf.
12:22Uhr habe ich dann neu gestartet.

Ich habe schon viel gelesen, aber nichts gefunden, was Abhilfe liefert.

Wer kann helfen, was kann ich tun?

VG

[Homoran]

@homer so viele verschiedene Versionen?

[Homer]

@homoran Was meinst du damit?

Doppelpost oben ist nun korrigiert ;-)

[Homoran]

@homer sagte in Absturz bei automatischem Start von js-controller:

Doppelpost oben ist nun korrigiert

und editiert mit viel vorher unsichtbarem Text :joy:

[Homoran]

@homer da springt aver auch deine Uhrzeit zu beginn.

sieht aus, als ob das Problem schon vorher war.
Code 7 bedeutet, dass da bereits ein Prozess läuft., der nicht vollständig beendet wurde.

möglich dass da neu gestartet und due Uhrzeit noch nicht synchronisiert war.

[Homer]

@homoran said in Absturz bei automatischem Start von js-controller:

Code 7 bedeutet, dass da bereits ein Prozess läuft., der nicht vollständig beendet wurde.

Ok. Und was kann ich dagegen tun?

Auch bei einem normalen Neustart erhalte ich diese Meldungen, z.B.:

2022-10-31 12:23:48.043 - error: backitup.0 (2279) backitup.0 already running
2022-10-31 12:23:48.047 - warn: backitup.0 (2279) Terminated (ADAPTER_ALREADY_RUNNING): Without reason
2022-10-31 12:23:48.097 - info: host.raspberrypi instance system.adapter.hm-rpc.1 started with pid 2348
2022-10-31 12:23:48.729 - error: host.raspberrypi instance system.adapter.backitup.0 terminated with code 7 (ADAPTER_ALREADY_RUNNING)

Mein Problem aber ist das unvermittelte

2022-10-31 10:17:20.118 - info: host.raspberrypi iobroker.js-controller version 4.0.23 js-controller starting

[Homoran]

@homer sagte in Absturz bei automatischem Start von js-controller:

                        2022-10-31 10:30:16.173 - info: host.raspberrypi instance system.adapt

unmittelbar davor, obwohl zeitlich später. Da stimmt was mit deiner Zeit nicht.

[Homer]

@homoran Ok, ja, wenn ich mir den Absturz vom 29.9. ansehe, sind die Zeiten auch durcheinander:

022-09-29 12:21:57.516 - info: smartgarden.0 (3568) 1/ setServiceStates: relationship searching
2022-09-29 12:30:00.019 - info: javascript.0 (1566) script.js.Hüllenüberwachung.Status_zum_Versenden.Status_in_Variablen_schreiben: 116T 22:15h
2022-09-29 12:30:00.058 - info: host.raspberrypi instance system.adapter.daswetter.0 started with pid 24456
2022-09-29 12:30:16.386 - info: host.raspberrypi instance system.adapter.daswetter.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION)
2022-09-29 12:31:28.291 - warn: fullybrowser.0 (3312) updateDeviceERROR 192.168.2.151
2022-09-29 12:33:31.006 - warn: fullybrowser.0 (3312) updateDeviceERROR 192.168.2.152
2022-09-29 12:35:00.324 - info: smartgarden.0 (3568) 1/ setServiceStates: relationship searching
2022-09-29 12:35:00.330 - info: smartgarden.0 (3568) 1/ setServiceStates: relationship searching
2022-09-29 12:35:33.255 - warn: fullybrowser.0 (3312) updateDeviceERROR 192.168.2.152
2022-09-29 12:24:07.310 - info: host.raspberrypi iobroker.js-controller version 4.0.21 js-controller starting
2022-09-29 12:24:07.320 - info: host.raspberrypi Copyright (c) 2014-2022 bluefox, 2014 hobbyquaker
2022-09-29 12:24:07.321 - info: host.raspberrypi hostname: raspberrypi, node: v14.20.0
2022-09-29 12:24:07.322 - info: host.raspberrypi ip addresses: 192.168.2.211 2a00:6020:b209:8e00:34a9:61f5:a0f7:b92e fe80::52bb:6457:77c6:c7f7 192.168.2.33 2a00:6020:b209:8e00:970b:f9f3:99e3:e2f5 fe80::2d77:3397:7440:5e5a
2022-09-29 12:24:09.464 - error: host.raspberrypi-Server Cannot start inMem-objects on port 9001: Failed to lock DB file "/opt/iobroker/iobroker-data/objects.jsonl"!
2022-09-29 12:24:13.857 - info: host.raspberrypi iobroker.js-controller version 4.0.21 js-controller starting
2022-09-29 12:24:13.863 - info: host.raspberrypi Copyright (c) 2014-2022 bluefox, 2014 hobbyquaker
2022-09-29 12:24:13.864 - info: host.raspberrypi hostname: raspberrypi, node: v14.20.0
2022-09-29 12:24:13.864 - info: host.raspberrypi ip addresses: 192.168.2.211 2a00:6020:b209:8e00:34a9:61f5:a0f7:b92e fe80::52bb:6457:77c6:c7f7 192.168.2.33 2a00:6020:b209:8e00:970b:f9f3:99e3:e2f5 fe80::2d77:3397:7440:5e5a
2022-09-29 12:24:15.978 - error: host.raspberrypi-Server Cannot start inMem-objects on port 9001: Failed to lock DB file "/opt/iobroker/iobroker-data/objects.jsonl"!

Das

pi@raspberrypi:~ $ date
Mo 31. Okt 17:58:18 CET 2022

passt aber.

Was kann ich dagegen tun?