Test Adapter ioBroker.backitup v3.1.x

[toki1973]

Habe auch eine Synoligy.Der Backup User ist nicht über cifs verbunden

[Homoran]

@toki1973
Hast du jetzt nochmal versucht den Timer auf eine nahe Zeit zu stellen bei der das Backup starten soll?

In deinem log steht das:

backitup.0
2019-12-12 15:26:52.306
info
[minimal] backup was activated at 02:00 every 1 day(s)

bis 02:00 wollte ich jetzt nicht warten.
Was passiert denn bei einem manuellen start des Backups

[toki1973]

@Homoran Ich t
Test ja die ganze Zeit mi dem manuellen Backup;) Nur der Fenster Dialog geht auf und bleibt bei der Meldung oben einfach stehen.

[Homoran]

@toki1973 sagte in Test Adapter Backitup v1.3.x:

Ich t
Test ja die ganze Zeit mi dem manuellen Backup;)

Da sehe ich nichts von im log!

sieht bei mir unter debug so aus:

2019-12-12 19:19:33.738 - debug: backitup.0 [minimal/mount] done
2019-12-12 19:19:37.685 - debug: backitup.0 [minimal/minimal] Backup created: /opt/iobroker/backups/minimal_2019_12_12-19_19_33_VM01_backupiobroker.tar.gz
2019-12-12 19:19:37.728 - debug: backitup.0 [minimal/minimal] done
2019-12-12 19:19:37.730 - debug: backitup.0 [minimal/cifs] done
2019-12-12 19:19:37.731 - debug: backitup.0 [minimal/clean] done
2019-12-12 19:19:37.743 - debug: backitup.0 [minimal/history] backitup.0.history.html
2019-12-12 19:19:37.754 - debug: backitup.0 [minimal/umount] mount activ... umount in 60 Seconds!!

[simatec]

@toki1973
Stelle die Instanz von Backitup auf debug und poste den Log, wenn du das Backup ausführst.
Welche Version hast du installiert?
Wie ist dein System sonst aufgebaut?
node, npm, js-contoller Versionen?

[toki1973]

@simatec @Homoran
RASP 3

Platform       : linux
Architecture   : arm
CPUs           : 4
Speed          : 1200 MHz
Model          : ARMv7 Processor rev 4 (v7l)
RAM            : 926 MB
System uptime  : 21d. 04:45:56
Node.js        : v10.16.0
Disk size      : 14.4 GiB
Disk free      : 11.1 GiB
adapters count : 262
NPM            : v6.9.0

Und im Log tut sich nicht viel:

backitup.0
2019-12-12 19:33:03.647
debug
[minimal] 10 00 02 */1 * * 
backitup.0
2019-12-12 19:33:03.589
info
[minimal] backup was activated at 02:00 every 1 day(s)
backitup.0
2019-12-12 19:33:03.427
info
starting. Version 1.3.0 in /opt/iobroker/node_modules/iobroker.backitup, node: v10.16.0
backitup.0
2019-12-12 19:33:03.264
debug
statesDB connected
backitup.0
2019-12-12 19:33:03.166
debug
objectDB connected

[Homoran]

@toki1973

mich irritiert dein log in mehrfacher hinsicht.

1.) Wieso hast du da Zeilenumbrüche drin?

2.) Die Zeile: backitup.0 2019-12-12 19:33:03.647 debug [minimal] 10 00 02 */1 * *
taucht bei mir überhaupt nicht auf.
Außerdem ist der Cron 6-stellig mit 10 Sekunden zur Vollen 2. Stunde.
Wieso das?

[toki1973]

@Homoran
Ich habe einfach aus dem Log Tab heraus kopiert. Der Cron wird ja hier eingestellt.


[simatec]

@Homoran sagte in Test Adapter Backitup v1.3.x:

Außerdem ist der Cron 6-stellig mit 10 Sekunden zur Vollen 2. Stunde.
Wieso das?

Das ist so korrekt
Es wird immer 10 Sekunden später ausgeführt

[simatec]

@toki1973 sagte in Test Adapter Backitup v1.3.x:

Und im Log tut sich nicht viel:

Kann ja auch nicht, wenn du 2 Uhr eingestellt hast.

[Homoran]

@simatec
@toki1973 sagte in Test Adapter Backitup v1.3.x:

Ich t
Test ja die ganze Zeit mi dem manuellen Backup;)

[simatec]

Ab sofort ist die Version 1.3.3 im Github und ab spätestens heute Nacht auch in der latest Repo.

Changelog

1.3.3 (14.12.2019)

• (simatec) Fix Webinterface for Restore
• (simatec) Fix MySql Backup
• (simatec) Added some debug logs for Restore
• (simatec) some Bug Fix
• (simatec) Messagebox for restore list
• (simatec) hide password on log
• (simatec) Added password hiding
• (simatec) Clean Code
• (simatec) detected history path
• (simatec) Fix deteced

[MathiasJ]

bin wieder auf die 1.3.2 zurück.
IObroker rödelt sich zu tode und nichts passiert.
Das Popup bleibt leer, bzw ich sehe nur Backup gestartet, das war's
Wenn ich dann in der ordner /opt/iobroker/backup gehe, habe ich hier gefühlte 1000 backups liegen. Diese werden aber nicht auf die NAS - Dropbox - FTP und Googledrive weitergereicht.

[Homoran]

@MathiasJ
Bitte Instanz auf debug stellen und log posten.

[simatec]

@MathiasJ
Diese Aussagen helfen leider nicht.
Bitte poste den Debug Log.
Gibt es errors?
Was für Backups wolltest du erstellen?

[Jan1]

@Homoran
Mir ist da eben was aufgefallen.
Der Ordner backups im IOBroker Verzeichnis wird beim Backup erstellen an gemeckert. Ich habe mir dann das mal angesehen und der ist nicht mehr vorhanden. Also von Hand angelegt und jetzt wirds seltsam, in der Konsole kann ich ihn sehen:

root@Beelink:/opt/iobroker# ls
backups                       iob            node_modules
CHANGELOG_FIXER_LINUX.md      iobroker       package.json
CHANGELOG_INSTALLER_LINUX.md  iobroker-data  package-lock.json
fix_installation.sh           lib            README.md
install                       LICENSE        reinstall.js

in FileZilla nicht:

und wenn ich den Fixer laufen lasse, dann kommt auch ne Fehlermeldung genau zu dem Ordner:

Created /etc/sudoers.d/iobroker
Fixing directory permissions...
chown: Zugriff auf '/opt/iobroker/backups' nicht möglich: Der Rechner ist nicht aktiv
This system does not support setting default permissions.
Do not use npm to manually install adapters unless you know what you are doing!

Was ist denn da los?

Die Backups werden aber korrekt angelegt:

Log vom Backup:

Gestartet...
[DEBUG] [mount] - mount activ... umount is started before mount!!
[DEBUG] [mount] - done
[DEBUG] [iobroker] - host.Beelink 6477 states saved

[DEBUG] [iobroker] - host.Beelink 4684 objects saved

[DEBUG] [iobroker] - Backup created: /opt/iobroker/backups/iobroker_2019_12_15-10_46_41_BeeLink_backupiobroker.tar.gz

[DEBUG] [iobroker] - done
[ERROR] [historyDB] - [IGNORED] No source for compress!
[DEBUG] [zigbee] - done
[DEBUG] [cifs] - done
[ERROR] [clean] - Backup files not deleted from /opt/iobroker/backups because some errors.
[DEBUG] [clean] - done
[DEBUG] [history] - backitup.0.history.html
[DEBUG] [umount] - mount activ... umount in 60 Seconds!!
[DEBUG] [umount] - done
[EXIT] 0

[simatec]

@Jan1
Ich gehe davon aus, dass dein mount aktiv war.
Da der mount auf den Ordner backups geht, kann der Fixer da keine Rechte auf dem NAS setzen.
Schalte mal History Backup aus.
Du hast keinen Pfad vergeben, somit bekommst du die Fehlermeldung und das Backup läuft nicht sauber durch

[Jan1]

@simatec
Bingo, hatte den Haken bei History gesetzt und den Pfad nicht zugewiesen (übersehen). Jetzt läuft das wunderbar:

Gestartet...
[DEBUG] [mount] - mount activ... umount is started before mount!!
[DEBUG] [mount] - done
[DEBUG] [iobroker] - host.Beelink 6480 states saved

[DEBUG] [iobroker] - host.Beelink 4716 objects saved

[DEBUG] [iobroker] - Backup created: /opt/iobroker/backups/iobroker_2019_12_15-12_33_22_BeeLink_backupiobroker.tar.gz

[DEBUG] [iobroker] - done
[DEBUG] [historyDB] - done
[DEBUG] [zigbee] - done
[DEBUG] [cifs] - done
[DEBUG] [clean] - done
[DEBUG] [history] - backitup.0.history.html
[DEBUG] [umount] - mount activ... umount in 60 Seconds!!
[DEBUG] [umount] - done
[EXIT] 0

[simatec]

@Jan1
Sehr gut ... kleiner Tipp noch.
Wenn du beim manuellen Backup alle Debugmeldungen haben willst, kannst du in den Haupteinstellungen von backitup debug aktivieren und bekommst somit die volle Ausgabe aller Daten

[vauvau07]

@simatec
mit backitup bin ich von Anfang an dabei, einfach Super.
auf einem Testsystem mit neustem Adapterstand habe ich jetzt auch backitup 1.3.3
Auch bei mir iobroker rödelt sich zu tode und nichts passiert.
Das Popup bleibt leer, bzw ich sehe nur Backup gestartet, das war's

host.iobroker2	2019-12-15 13:16:10.216	error	Caught by controller[0]: at processImmediate (timers.js:658:5)
host.iobroker2	2019-12-15 13:16:10.216	error	Caught by controller[0]: at tryOnImmediate (timers.js:676:5)
host.iobroker2	2019-12-15 13:16:10.216	error	Caught by controller[0]: at runCallback (timers.js:705:18)
host.iobroker2	2019-12-15 13:16:10.216	error	Caught by controller[0]: at Immediate.setImmediate (/opt/iobroker/node_modules/iobroker.js-controller/lib/adapter.js:4749:38)
host.iobroker2	2019-12-15 13:16:10.215	error	Caught by controller[0]: at Adapter.emit (events.js:198:13)
host.iobroker2	2019-12-15 13:16:10.215	error	Caught by controller[0]: at Adapter.adapter.on (/opt/iobroker/node_modules/iobroker.backitup/main.js:67:17)
host.iobroker2	2019-12-15 13:16:10.215	error	Caught by controller[0]: at startBackup (/opt/iobroker/node_modules/iobroker.backitup/main.js:44:9)
host.iobroker2	2019-12-15 13:16:10.215	error	Caught by controller[0]: at executeScripts (/opt/iobroker/node_modules/iobroker.backitup/lib/execute.js:176:37)
host.iobroker2	2019-12-15 13:16:10.215	error	Caught by controller[0]: TypeError: Cannot read property 'dropbox' of null
backitup.0	2019-12-15 13:16:09.694	info	(1376) Terminated (NO_ERROR): Without reason
backitup.0	2019-12-15 13:16:09.693	info	(1376) terminating
backitup.0	2019-12-15 13:16:09.188	error	at processImmediate (timers.js:658:5)
backitup.0	2019-12-15 13:16:09.188	error	at tryOnImmediate (timers.js:676:5)
backitup.0	2019-12-15 13:16:09.188	error	at runCallback (timers.js:705:18)
backitup.0	2019-12-15 13:16:09.188	error	at Immediate.setImmediate (/opt/iobroker/node_modules/iobroker.js-controller/lib/adapter.js:4749:38)
backitup.0	2019-12-15 13:16:09.188	error	at Adapter.emit (events.js:198:13)
backitup.0	2019-12-15 13:16:09.188	error	at Adapter.adapter.on (/opt/iobroker/node_modules/iobroker.backitup/main.js:67:17)
backitup.0	2019-12-15 13:16:09.188	error	at startBackup (/opt/iobroker/node_modules/iobroker.backitup/main.js:44:9)
backitup.0	2019-12-15 13:16:09.188	error	at executeScripts (/opt/iobroker/node_modules/iobroker.backitup/lib/execute.js:176:37)
backitup.0	2019-12-15 13:16:09.188	error	(1376) TypeError: Cannot read property 'dropbox' of null
backitup.0	2019-12-15 13:16:09.188	error	(1376) uncaught exception: Cannot read property 'dropbox' of null
javascript.0	2019-12-15 13:16:00.221	info	(20087) script.js.Klima___Energie.UWZ: [{"object":"{\"center\":\"UWZ\",\"areaID\":\"UWZDE26129\",\"dtgEnd\":1576436400,\"areaType\":\"UWZCODE\",\"dtgStart\":1576393200,\"payload\":{\"translationsLong
backitup.0	2019-12-15 13:15:58.899	debug	(1376) mount activ... umount in 2 Seconds!!
backitup.0	2019-12-15 13:15:48.908	debug	(1376) [iobroker] 10 00 01 */1 * *
backitup.0	2019-12-15 13:15:48.897	info	(1376) [iobroker] backup was activated at 01:00 every 1 day(s)
backitup.0	2019-12-15 13:15:48.865	info	(1376) starting. Version 1.3.3 in /opt/iobroker/node_modules/iobroker.backitup, node: v10.17.0
backitup.0	2019-12-15 13:15:47.971	debug	(1376) States connected to redis: 127.0.0.1:9000
backitup.0	2019-12-15 13:15:47.919	debug	(1376) statesDB connected
backitup.0	2019-12-15 13:15:47.918	debug	(1376) States create PubSub Client
backitup.0	2019-12-15 13:15:47.913	debug	(1376) Objects connected to redis: 127.0.0.1:9001
backitup.0	2019-12-15 13:15:47.911	debug	(1376) Redis States: Use Redis connection: 127.0.0.1:9000
backitup.0	2019-12-15 13:15:47.910	debug	(1376) objectDB connected
backitup.0	2019-12-15 13:15:47.903	debug	(1376) Objects client initialize lua scripts
backitup.0	2019-12-15 13:15:47.903	debug	(1376) Objects create PubSub Client
backitup.0	2019-12-15 13:15:47.901	debug	(1376) Objects client ready ... initialize now
backitup.0	2019-12-15 13:15:47.879	debug	(1376) Redis Objects: Use Redis connection: 127.0.0.1:9001