Neuer Blogbeitrag: Monatsrückblick - Dezember 2025 🎄

[hennerich]

@simatec sagte in Backitup Adapter bleibt rot - keine Debug Meldungen:

@hennerich
Mach mal einen iobroker restart

Hab ich eben gemacht. Dauerte nur ewig wegen diesem Problem hier.

Hier das Log (sorry, wenns etwas länger ist)

2022-02-03 12:21:48.266 - info: host.raspberrypi instance system.adapter.backitup.0 started with pid 10583
2022-02-03 12:21:49.801 - debug: backitup.0 (10583) Redis Objects: Use Redis connection: 127.0.0.1:9001
2022-02-03 12:21:49.890 - debug: backitup.0 (10583) Objects client ready ... initialize now
2022-02-03 12:21:49.893 - debug: backitup.0 (10583) Objects create System PubSub Client
2022-02-03 12:21:49.895 - debug: backitup.0 (10583) Objects create User PubSub Client
2022-02-03 12:21:49.897 - debug: backitup.0 (10583) Objects client initialize lua scripts
2022-02-03 12:21:49.938 - debug: backitup.0 (10583) Objects connected to redis: 127.0.0.1:9001
2022-02-03 12:21:49.950 - debug: backitup.0 (10583) objectDB connected
2022-02-03 12:21:49.953 - debug: backitup.0 (10583) Redis States: Use Redis connection: 127.0.0.1:9000
2022-02-03 12:21:49.965 - debug: backitup.0 (10583) States create System PubSub Client
2022-02-03 12:21:49.967 - debug: backitup.0 (10583) States create User PubSub Client
2022-02-03 12:21:49.981 - debug: backitup.0 (10583) States connected to redis: 127.0.0.1:9000
2022-02-03 12:21:49.983 - debug: backitup.0 (10583) statesDB connected
2022-02-03 12:21:50.388 - debug: backitup.0 (10583) Plugin sentry Initialize Plugin (enabled=true)
2022-02-03 12:21:50.722 - info: backitup.0 (10583) starting. Version 2.2.4 in /opt/iobroker/node_modules/iobroker.backitup, node: v12.22.10, js-controller: 3.3.22
2022-02-03 12:21:50.797 - debug: backitup.0 (10583) Backitup has recognized a linux system
2022-02-03 12:21:52.329 - info: host.raspberrypi instance system.adapter.trashschedule.0 started with pid 10598
2022-02-03 12:21:54.544 - info: trashschedule.0 (10598) starting. Version 1.4.1 in /opt/iobroker/node_modules/iobroker.trashschedule, node: v12.22.10, js-controller: 3.3.22
2022-02-03 12:21:54.756 - info: trashschedule.0 (10598) configurured iCal preview is 60 days - increase this value to find more events in the future
2022-02-03 12:21:54.853 - info: trashschedule.0 (10598) State value to set for "trashschedule.0.type.bioabfalltonne.nextWeekday" has to be type "string" but received type "number"
2022-02-03 12:21:54.893 - info: trashschedule.0 (10598) State value to set for "trashschedule.0.type.restabfalltonne.nextWeekday" has to be type "string" but received type "number"
2022-02-03 12:21:54.937 - info: trashschedule.0 (10598) State value to set for "trashschedule.0.type.papiertonne.nextWeekday" has to be type "string" but received type "number"
2022-02-03 12:21:55.051 - info: trashschedule.0 (10598) State value to set for "trashschedule.0.type.gelbeTonne.nextWeekday" has to be type "string" but received type "number"
2022-02-03 12:21:58.046 - info: vis-google-fonts.0 (10613) starting. Version 1.0.3 in /opt/iobroker/node_modules/iobroker.vis-google-fonts, node: v12.22.10, js-controller: 3.3.22
2022-02-03 12:21:58.730 - info: vis-google-fonts.0 (10613) Terminated (NO_ERROR): Without reason
2022-02-03 12:21:59.327 - info: host.raspberrypi instance system.adapter.vis-google-fonts.0 terminated while should be started once
2022-02-03 12:22:00.320 - info: host.raspberrypi instance system.adapter.device-reminder.0 started with pid 10628
2022-02-03 12:22:02.172 - info: device-reminder.0 (10628) starting. Version 1.2.9 in /opt/iobroker/node_modules/iobroker.device-reminder, node: v12.22.10, js-controller: 3.3.22
2022-02-03 12:22:02.290 - info: device-reminder.0 (10628) Device "Waschmaschine" was successfully created
2022-02-03 12:22:02.469 - info: device-reminder.0 (10628) Device "Trockner" was successfully created
2022-02-03 12:22:03.449 - info: daswetter.0 (10553) still wrong data structure from server received! repaired...
2022-02-03 12:22:04.323 - info: host.raspberrypi instance system.adapter.sourceanalytix.0 started with pid 10643
2022-02-03 12:22:06.599 - info: sourceanalytix.0 (10643) starting. Version 0.4.12 in /opt/iobroker/node_modules/iobroker.sourceanalytix, node: v12.22.10, js-controller: 3.3.22
2022-02-03 12:22:06.640 - info: sourceanalytix.0 (10643) Welcome to SourceAnalytix, making things ready ...
2022-02-03 12:22:06.711 - info: sourceanalytix.0 (10643) Found 4 SourceAnalytix enabled states
2022-02-03 12:22:06.713 - info: sourceanalytix.0 (10643) Initialising (1 of 4) "javascript.0.Verbrauchszaehler.HeizölVerbrauchTotal"
2022-02-03 12:22:06.774 - error: sourceanalytix.0 (10643) Check settings for javascript.0.Verbrauchszaehler.HeizölVerbrauchTotal ! Known valueAtDeviceReset : (8432.67) > known cumulative value (0) cannot proceed
2022-02-03 12:22:06.774 - error: sourceanalytix.0 (10643) Troubleshoot Data javascript.0.Verbrauchszaehler.HeizölVerbrauchTotal custom Data : {"_id":"javascript.0.Verbrauchszaehler.HeizölVerbrauchTotal","type":"state","common":{"name":"HeizölVerbrauchTotal","role":"","type":"number","desc":"Manuell erzeugt","def":"","unit":"Liter","read":true,"write":true,"custom":{"influxdb.0":{"enabled":true,"changesOnly":false,"debounce":0,"maxLength":10,"retention":"31536000","changesRelogInterval":0,"changesMinDelta":0,"storageType":"","aliasId":""},"sourceanalytix.0":{"enabled":true,"alias":"","selectedPrice":"Oil","selectedUnit":"l","costs":true,"consumption":true,"meter_values":false,"start_day":8446.41,"start_week":8446.41,"start_month":8421.220000000001,"start_quarter":8421.220000000001,"start_year":8421.220000000001,"valueAtDeviceReset":8432.67,"valueAtDeviceInit":null,"cumulativeValue":8446.41}}},"native":{},"from":"system.adapter.sourceanalytix.0","user":"system.user.admin","ts":1641164400727,"acl":{"object":1636,"owner":"system.user.admin","ownerGroup":"system.group.administrator","state":1636}}
2022-02-03 12:22:06.775 - error: sourceanalytix.0 (10643) Cannot handle calculations for javascript.0.Verbrauchszaehler.HeizölVerbrauchTotal, check log messages and adjust settings!
2022-02-03 12:22:06.777 - error: sourceanalytix.0 (10643) Initialization of javascript.0.Verbrauchszaehler.HeizölVerbrauchTotal failed, check warn messages !
2022-02-03 12:22:06.777 - info: sourceanalytix.0 (10643) Initialising (2 of 4) "shelly.0.SHPLG-S#B4CF23#1.Relay0.Power"
2022-02-03 12:22:08.657 - info: sourceanalytix.0 (10643) Initialization of shelly.0.SHPLG-S#B4CF23#1.Relay0.Power successfully
2022-02-03 12:22:08.658 - info: sourceanalytix.0 (10643) Initialising (3 of 4) "shelly.0.SHPLG2-1#2F4EF7#1.Relay0.Power"
2022-02-03 12:22:09.550 - info: daswetter.0 (10553) Terminated (ADAPTER_REQUESTED_TERMINATION): All data handled, adapter stopped until next scheduled moment
2022-02-03 12:22:09.940 - info: sourceanalytix.0 (10643) Initialization of shelly.0.SHPLG2-1#2F4EF7#1.Relay0.Power successfully
2022-02-03 12:22:09.941 - info: sourceanalytix.0 (10643) Initialising (4 of 4) "javascript.0.Verbrauchszaehler.StromVerbrauchTotal"
2022-02-03 12:22:10.067 - info: daswetter.0 (10553) cleaned everything up...
2022-02-03 12:22:10.138 - info: host.raspberrypi instance system.adapter.daswetter.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION)
2022-02-03 12:22:10.808 - info: sourceanalytix.0 (10643) Initialization of javascript.0.Verbrauchszaehler.StromVerbrauchTotal successfully
2022-02-03 12:22:10.817 - warn: sourceanalytix.0 (10643) Cannot handle calculations for 1 of 4 enabled states, check error messages
2022-02-03 12:22:10.818 - info: sourceanalytix.0 (10643) Successfully activated SourceAnalytix for 3 of 4 states, will do my Job until you stop me!

[Homoran]

@hennerich sagte in Backitup Adapter bleibt rot - keine Debug Meldungen:

sorry, wenns etwas länger ist

die ersten 270 Zeilen wären ja auch nicht nötig gewesen.

und ab 292 auch nicht.
Da ist nichts auffälliges

[hennerich]

@homoran sagte in Backitup Adapter bleibt rot - keine Debug Meldungen:

Da ist nichts auffälliges

P.S. hab das Log oben eingekürzt

[Homoran]

@hennerich jetzt gehen mir die Ideen aus.
Versuch mal

iobroker stop
iobroker upload all
iobroker start

kann aber dauern

[hennerich]

@homoran
Na ich hab eben mal aus @apollon77 seiner Doku die node.js Version auf 14 angehoben und bin eben noch beim

ioBroker fix

Ich befürchte nur, dass das Script wieder hier hängen bleibt:

Fixing directory permissions ...

[hennerich]

Jo, wie vermutet steht das Script seit 30min an dieser Stelle. Die letzten beiden Male hab ich dann mit CTRL+C abgebrochen und den ioBroker wieder gestartet. Keine Ahnung ob man das darf oder wie ich feststelle, wo das Script hängt.

[simatec]

@hennerich Dann gehe ich stark dvon aus, dass dein System irgendwo ein grundliegendes Problem hat

[Homoran]

@simatec sagte in Backitup Adapter bleibt rot - keine Debug Meldungen:

@hennerich Dann gehe ich stark dvon aus, dass dein System irgendwo ein grundliegendes Problem hat

@hennerich
Das sehe ich dann genauso.

Ob neu aufsetzen und dann das letzte Backup einspielen hilft müsstest du testen.
Es kann natürlich sein, dass das Problem mit dem Restore wiederkommt

[simatec]

@hennerich Sichere doch mal die Einstellungen von Backitup und lösche Instanz und Adapter
Im Anschluss mal neu installieren und durchstarten
Wenn das läuft, schiebe die Einstellungen von Backitup wieder zurück

[hennerich]

Könnt ihr mir trotzdem kurz sagen, wie ich jetzt mit dem Fix Prozess umgehen soll?

[simatec]

@hennerich Naja abbrechen ist nicht so gut
Der sollte auch durchlaufen ... Also denke ich, dass es mit deinem System zu tun hat.
Da ist was krum ... Deshalb auch die hohen Lasten in deinem anderen Thread

[hennerich]

@simatec sagte in Backitup Adapter bleibt rot - keine Debug Meldungen:

@hennerich Naja abbrechen ist nicht so gut
Der sollte auch durchlaufen ... Also denke ich, dass es mit deinem System zu tun hat.

Naja, gestern Abend hatte ich den Fix um ca. 21 Uhr angestoßen und heute morgen gegen 03 Uhr lief der immer noch. Soll ich jetzt einfach noch länger warten?

[Thomas Braun]

@hennerich

Da klemmt es anderswo.
Schau mal mit

dmesg -T | grep -i ext4

wie es dem Dateisystem geht.

[hennerich]

@thomas-braun
Ok, hab in einer neuen SSH Session den Befehl ausgeführt:

pi@raspberrypi:~ $ dmesg -T | grep -i ext4
[Fr Jan 14 18:14:58 2022] Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1  smsc95xx.macaddr=DC:A6:32:A8:F4:42 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  console=ttyS0,115200 console=tty1 root=PARTUUID=68f86542-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
[Fr Jan 14 18:14:59 2022] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[Fr Jan 14 18:14:59 2022] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[Fr Jan 14 18:15:01 2022] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)

[Thomas Braun]

@hennerich
Okay, das Dateisystem ruft schon mal nicht laut um Hilfe.

[Thomas Braun]

@hennerich

Du könntest aber einfach die Kiste mal nach 3 Wochen uptime neustarten.
Eigentlich sollte das zwar möglich sein, wenn da aber kleiner Schluckauf herrscht kann das System so langsam werden. Speicherauslastung?

free -ht --mega

[hennerich]

@thomas-braun
hier die Ausgabe und Danke noch mal

pi@raspberrypi:~ $ free -ht --mega
              total        used        free      shared  buff/cache   available
Mem:           3,8G        627M        1,2G        200M        2,0G        3,3G
Swap:           99M         13M         86M
Total:         3,9G        641M        1,3G

Also Fix Script abbrechen, Raspberry neu starten und Fix wieder starten?

[Homoran]

@hennerich sagte in Backitup Adapter bleibt rot - keine Debug Meldungen:

Also Fix Script abbrechen

der läuft noch?
wäre interessant ob der auch aktiv ist.

@Thomas-Braun
htop???

[Thomas Braun]

@hennerich

Im Moment sieht die Auslastung gesund aus, aber es ist auf den Swap ausgewichen worden, d.h. der Speicher war komplett ausgenutzt.
Wie groß ist das Backup? Irgendwelche Hollywood-Filme von Überwachungskameras dabei?

[hennerich]

@thomas-braun

htop zeigt das hier:

Meine Backupgröße ist