ioBroker startet nicht mehr nach

[figugegu]

Guten Tag liebe Community
Vor ein paar Monaten hat sich aus dem nichts mal mein Raspberry aufgehängt. Kein Zugriff mehr über SSH...
Konnte nur noch den Netzstecker ziehen.
Danach lief aber wieder alles wie es sollte. Dies kam dann noch so zwei/drei mal vor.

Nun, letzte Nacht war es mal wieder soweit.
Nun habe wieder den Stecker gezogen. Soweit alles gut, Zugriff auf PI (Putty/SSH) wieder möglich.
Aber: ioBroker ist nun nicht mehr erreichbar. restart oder start über Putty bringt kein Ergebnis.
Was könnte hier der Fehler sein? Gestern hatte ich noch ein paar Adapter ein Update verpasst, System lief danach aber noch Problemlos.
Auch Phoscon ist noch erreichbar...

In diesem Thread hab ich was gefunden. Aber ich habe nichts bei mir das "0" ist...

Vielen Dank im Voraus!

iobroker logs von letzter Nacht:

2021-07-24 00:37:11.242  - info: web.0 (5960) ==>Connected system.user.admin from ::ffff:192.168.178.31
2021-07-24 00:39:48.383  - info: web.0 (5960) <==Disconnect system.user.admin from ::ffff:192.168.178.31 vis.0
2021-07-24 00:49:24.349  - info: web.0 (5960) ==>Connected system.user.admin from ::ffff:192.168.178.31
2021-07-24 00:50:22.294  - info: javascript.0 (2255) Stop script script.js.Eigene_Scripts.Lüftung.Lüftung_Bad
2021-07-24 00:50:22.345  - info: javascript.0 (2255) Start javascript script.js.Eigene_Scripts.Lüftung.Lüftung_Bad
2021-07-24 00:50:22.373  - info: javascript.0 (2255) script.js.Eigene_Scripts.Lüftung.Lüftung_Bad: registered 2 subscriptions and 0 schedules
2021-07-24 00:50:51.324  - info: web.0 (5960) <==Disconnect system.user.admin from ::ffff:192.168.178.31 vis.0
2021-07-24 01:15:55.663  - info: web.0 (5960) ==>Connected system.user.admin from ::ffff:192.168.178.31
2021-07-24 01:15:57.828  - info: musiccast.0 (29525) MusicCast: musiccast.0.R-N602_00A274B3.main.power identified for command with false
2021-07-24 01:15:57.837  - info: musiccast.0 (29525) MusicCast: musiccast.0.WX-030_0D9E7533.main.power identified for command with false
2021-07-24 01:16:03.332  - info: web.0 (5960) <==Disconnect system.user.admin from ::ffff:192.168.178.31 vis.0
2021-07-24 03:17:28.537  - info: history.0 (31455) Delete old history "/opt/iobroker/iobroker-data/Datenlog/20210709/history.deconz.0.Sensors.31.temperature.json"
2021-07-24 03:37:28.443  - info: history.0 (31455) Delete old history "/opt/iobroker/iobroker-data/Datenlog/20200723/history.deconz.0.Sensors.19.temperature.json"
2021-07-24 03:37:28.450  - info: history.0 (31455) Delete old history "/opt/iobroker/iobroker-data/Datenlog/20200723/history.deconz.0.Sensors.20.humidity.json"
2021-07-24 03:37:28.451  - info: history.0 (31455) Delete old history dir "/opt/iobroker/iobroker-data/Datenlog/20200723"
2021-07-24 03:26:37.028  - info: host.raspberrypi iobroker.js-controller version 3.2.16 js-controller starting
2021-07-24 03:26:37.036  - info: host.raspberrypi Copyright (c) 2014-2021 bluefox, 2014 hobbyquaker
2021-07-24 03:26:37.036  - info: host.raspberrypi hostname: raspberrypi, node: v12.22.1
2021-07-24 03:26:37.037  - info: host.raspberrypi ip addresses: 192.168.178.50 2a02:168:e9f2:0:4959:bf06:b035:d2fa fe80::617b:db3e:efc5:b4c6
2021-07-24 03:26:37.079  - error: host.raspberrypi-Server Cannot load /opt/iobroker/iobroker-data/objects.json: /opt/iobroker/iobroker-data/objects.json: Unexpected end of JSON input. Try last Backup!
2021-07-24 03:26:37.081  - error: host.raspberrypi-Server Cannot load /opt/iobroker/iobroker-data/objects.json.bak: /opt/iobroker/iobroker-data/objects.json.bak: Unexpected end of JSON input. Continue with empty dataset!
2021-07-24 03:26:37.158  - error: host.raspberrypi Cannot read system.config: null (OK when migrating or restoring)
2021-07-24 03:26:37.196  - error: host.raspberrypi-Server Cannot load /opt/iobroker/iobroker-data/states.json: /opt/iobroker/iobroker-data/states.json: Unexpected end of JSON input. Try last Backup!
2021-07-24 03:26:37.439  - info: host.raspberrypi connected to Objects and States
2021-07-24 03:26:37.588  - warn: host.raspberrypi logger system.adapter.admin.0.logging was deleted
2021-07-24 03:26:37.590  - warn: host.raspberrypi logger system.adapter.javascript.0.logging was deleted
2021-07-24 03:26:37.590  - warn: host.raspberrypi logger system.adapter.cloud.0.logging was deleted
2021-07-24 03:26:37.623  - info: host.raspberrypi added notifications configuration of host
2021-07-24 03:26:37.630  - error: host.raspberrypi Cannot find view "system" for search "instance"
2021-07-24 03:26:37.631  - error: host.raspberrypi Could not add notifications config of this host: Could not get notifications setup from instances: Cannot find view "system"
2021-07-24 03:26:37.645  - info: host.raspberrypi Plugin sentry Sentry Plugin disabled for this process because sending of statistic data is disabled for the system
2021-07-24 03:26:37.652  - error: host.raspberrypi Cannot find view "system" for search "host"
2021-07-24 03:26:37.660  - error: host.raspberrypi Cannot find view "system" for search "state"
2021-07-24 03:26:37.661  - error: host.raspberrypi Cannot find view "system" for search "instance"
2021-07-24 03:26:37.663  - error: host.raspberrypi Could not collect system.host.raspberrypi states to check for obsolete states: Error: Cannot find view "system"
2021-07-24 03:26:37.664  - error: host.raspberrypi _design/system missing - call node iobroker.js setup
2021-07-24 03:26:37.869  - info: host.raspberrypi Created UUID: be390c95-8c89-87c9-c1f4-be408e8c84a4

iobroker status

 Cannot read system.config: null (OK when migrating or restoring)
 Cannot find view "system" for search "host"
iobroker is running on this host.


Objects type: file
States  type: file

pi@raspberrypi:~ $ ls -la /opt/iobroker/iobroker-data/backup-objects/
insgesamt 43364
drwxrwxr-x+ 2 iobroker iobroker    4096 Jul 24 10:27 .
drwxrwxr-x+ 8 iobroker iobroker    4096 Jul 24 11:01 ..
-rw-rw-r--+ 1 iobroker iobroker 1812448 Jul 16 21:23 2021-07-16_21-23_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1812909 Jul 17 21:23 2021-07-17_21-23_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1812891 Jul 18 21:23 2021-07-18_21-23_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1816954 Jul 19 21:23 2021-07-19_21-23_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1816953 Jul 20 02:01 2021-07-20_02-01_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1816930 Jul 20 20:12 2021-07-20_20-12_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1817136 Jul 21 01:01 2021-07-21_01-01_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1817135 Jul 21 04:50 2021-07-21_04-50_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1817130 Jul 21 08:40 2021-07-21_08-40_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1818227 Jul 21 21:23 2021-07-21_21-23_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1818243 Jul 22 02:01 2021-07-22_02-01_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241620 Jul 22 10:39 2021-07-22_10-39_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1818250 Jul 22 11:32 2021-07-22_11-32_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241622 Jul 22 12:39 2021-07-22_12-39_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241640 Jul 22 14:40 2021-07-22_14-40_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241569 Jul 22 16:40 2021-07-22_16-40_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241509 Jul 22 18:40 2021-07-22_18-40_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241543 Jul 22 20:41 2021-07-22_20-41_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1815997 Jul 22 21:23 2021-07-22_21-23_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241505 Jul 22 22:41 2021-07-22_22-41_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241618 Jul 23 00:41 2021-07-23_00-41_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241501 Jul 23 02:41 2021-07-23_02-41_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241593 Jul 23 04:42 2021-07-23_04-42_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241481 Jul 23 06:42 2021-07-23_06-42_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241537 Jul 23 08:42 2021-07-23_08-42_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241548 Jul 23 10:43 2021-07-23_10-43_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1816012 Jul 23 10:51 2021-07-23_10-51_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241593 Jul 23 12:43 2021-07-23_12-43_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241590 Jul 23 14:43 2021-07-23_14-43_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1816013 Jul 23 14:44 2021-07-23_14-44_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241936 Jul 23 16:43 2021-07-23_16-43_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1838501 Jul 23 16:44 2021-07-23_16-44_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker  242203 Jul 23 18:43 2021-07-23_18-43_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1838616 Jul 23 18:44 2021-07-23_18-44_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker  242159 Jul 23 20:43 2021-07-23_20-43_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1838574 Jul 23 20:44 2021-07-23_20-44_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker  242212 Jul 23 22:43 2021-07-23_22-43_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1838600 Jul 23 22:45 2021-07-23_22-45_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker  242193 Jul 24 00:43 2021-07-24_00-43_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1838627 Jul 24 00:45 2021-07-24_00-45_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker  242085 Jul 24 02:43 2021-07-24_02-43_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker 1838624 Jul 24 02:45 2021-07-24_02-45_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker    3509 Jul 24 03:26 2021-07-24_03-26_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker  242122 Jul 24 06:35 2021-07-24_06-35_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker    3511 Jul 24 06:50 2021-07-24_06-50_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241665 Jul 24 06:51 2021-07-24_06-51_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241686 Jul 24 08:51 2021-07-24_08-51_states.json.gz
-rw-rw-r--+ 1 iobroker iobroker    3510 Jul 24 10:26 2021-07-24_10-26_objects.json.gz
-rw-rw-r--+ 1 iobroker iobroker  241699 Jul 24 10:27 2021-07-24_10-27_states.json.gz

[Thomas Braun]

@figugegu Schau nach stark geschrumpften Dateigrößen.

[Homoran]

@figugegu sagte in ioBroker startet nicht mehr nach:

-rw-rw-r--+ 1 iobroker iobroker 1838624 Jul 24 02:45 2021-07-24_02-45_objects.json.gz

Da hate deine Objects gefetzt!

@figugegu sagte in ioBroker startet nicht mehr nach:

Aber ich habe nichts bei mir das "0" ist...

was soll "0" sein?

[figugegu]

Danke euch. Habs wieder hingekriegt. Der Hinweis mit den Dateigrössen und dass es meine Objects zerlegt hat, hat geholfen.
Habe den ioBroker so wieder zum laufen gebarcht:

iobroker stop
cd /opt/iobroker/iobroker-data/
mv objects.json objects.json.old
mv states.json states.json.old
cd backup-objects/
gunzip -ck 2021-07-24_02-45_objects.json.gz > /opt/iobroker/iobroker-data/objects.json
gunzip -ck 2021-07-24_02-43_states.json.gz > /opt/iobroker/iobroker-data/states.json
iobroker start

Mit "0" meinte ich dass es keine Dateien gab die gar keinen Inhalt mehr haben. Dachte das wäre der ausschlaggebende Punkt, nicht wenn die Dateigrösse einfach nur schrumpft.

Generell, kann es einen Grund geben dass sich der PI hie und da mal aufhängt?
Eventuell eine "schlechte" SD-Karte?

Vielen Dank und einen schönen Samstag

[Thomas Braun]

@figugegu sagte in ioBroker startet nicht mehr nach:

Generell, kann es einen Grund geben dass sich der PI hie und da mal aufhängt?
Eventuell eine "schlechte" SD-Karte?

Ganz sicher gibt es einen Grund dafür. Hier bei mir rennt der Pi 24/7 stabil durch.
Ohne Log Files kann man aber da nichts zu sagen.

[figugegu]

@thomas-braun
Ich nehme an du meinst die Log-Files vom System, nicht vom ioBroker, oder? Weil es ist ja nicht in erster Linie der ioBroker der nicht mehr tut, sondern der Pi ist gar nicht mehr erreichbar...
Aber ich hab da immer mal wieder Meldungen welche ich noch nicht verfolgt habe.
Z.B. immer wieder Error-Meldungen wie

error: history.0 (11851) history.0 already running

Das kann ich nicht nachvollziehen, habe mich aber auch noch nicht damit beschäftigt.

Anbei noch die Sys-Log. Ich sehe daraus nichts ungewöhnlichs, bin aber auch Laie was da anbelangt...
syslog.txt

[Homoran]

@figugegu sagte in ioBroker startet nicht mehr nach:

Das kann ich nicht nachvollziehen,

da läuft ein Prozess doppelt. War wohl unsauber gestoppt.
einfach mal den Raspi rebooten

oder den Prozess killen (hier PID 11851)

[Thomas Braun]

@figugegu

Jul 24 03:46:05 raspberrypi dhcpcd[702]: eth0: Router Advertisement from fe80::3a10:d5ff:fe5b:16c4
Jul 24 03:26:20 raspberrypi fake-hwclock[122]: Sa Jul 24 01:17:01 UTC 2021

Da schmiert die Kiste ab und macht eine Zeitreise. Vermutlich ein Backup-Prozess der den Speicher weglutscht.

free -ht --mega

Und den Desktop inkl. des VNC-Servers ausknipsen!
Server laufen ohne Desktop. Immer!

[figugegu]

@thomas-braun sagte in ioBroker startet nicht mehr nach:

Und den Desktop inkl. des VNC-Servers ausknipsen!
Server laufen ohne Desktop. Immer!

Hmmm, danke! Aber ich hab keinen Desktop. Hab die Lite Version. Schon immer gehabt.

[Homoran]

@figugegu und was sagt der Befehl?

[Thomas Braun]

@figugegu Der VNC wird aber mit dem target Graphical Interface z.B. gestartet.

Jul 24 06:50:28 raspberrypi systemd[1]: Reached target Graphical Interface.

Stell das auf RunLevel 3 ein.

[figugegu]

@homoran sagte in ioBroker startet nicht mehr nach:

@figugegu und was sagt der Befehl?

pi@raspberrypi:~ $ free -ht --mega
              total        used        free      shared  buff/cache   available
Mem:           3.8G        848M        2.6G        8.0M        393M        3.1G
Swap:           99M          0B         99M
Total:         3.9G        848M        2.7G

@thomas-braun sagte in ioBroker startet nicht mehr nach:

@figugegu Der VNC wird aber mit dem target Graphical Interface z.B. gestartet.

Jul 24 06:50:28 raspberrypi systemd[1]: Reached target Graphical Interface.

Stell das auf RunLevel 3 ein.

OK, das war mir nicht bewusst!
Habs in der Raspi-Config deaktiviert... reicht das?

Danke für eure Hilfe!

[Thomas Braun]

@figugegu

who -r

Und deine Speicherauslastung ist verdächtig niedrig. Da stimmt irgendwas nicht, würde ich behaupten.

[figugegu]

@thomas-braun

Läuft in Run-Level 5... Dann wechsle ich das mal auf 3

Warum meinst du dass die Auslastung niedrig ist?
Es laufen 15 Instanzen.

[Homoran]

@figugegu sagte in ioBroker startet nicht mehr nach:

Es laufen 15 Instanzen.

was zeigt denn iobroker in den Instanzen an?

@Thomas-Braun
bei meinem Test-Cubie würde es passen

kann leider keine Konsole dahin aufmachen

[Thomas Braun]

@homoran Ich hatte mich auch ehrlich gesagt geguckt und 87 oderso MB gelesen.

[figugegu]

@homoran sagte in ioBroker startet nicht mehr nach:

was zeigt denn iobroker in den Instanzen an?

1.2GB benutzt, 3.1GB frei

[Homoran]

@figugegu danke!

dann muss ich dem mal beizeiten nachgehen.

wenn schon von den Instanzen

@figugegu sagte in ioBroker startet nicht mehr nach:

1.2GB benutzt,

wird, kann der gesamte RAM Verbrauch des Raspi nicht nur 848MB sein.
Selbst wenn dort der gesamze RAM Verbrauch des Hosts angezeigt würde passen die Werte nicht zusammen.

Deswegen fiel uns der "zu niedrige" Wert auf.

[figugegu]

@homoran
Ja, die Zahlen stimmen wirklich nicht überein... ist mir nicht aufgefallen.
Hab jetzt nochmals zeitgleich geschaut - angezeigte Differenz ca. 300MB