Test Adapter ioBroker.backitup v3.1.x

[Frank_y]

@simatec
@iobrokerVM:~$ cat /etc/os-release

PRETTY_NAME="Debian GNU/Linux 9 (stretch)"
NAME="Debian GNU/Linux"
VERSION_ID="9"
VERSION="9 (stretch)"
VERSION_CODENAME=stretch
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"

which nodejs && nodejs -v && which node && node -v && which npm && npm -v && apt policy nodejs
/usr/bin/nodejs
v12.18.3
/usr/bin/node
v12.18.3
/usr/bin/npm
6.14.6
nodejs:
  Installiert:           12.18.3-1nodesource1
  Installationskandidat: 12.18.3-1nodesource1
  Versionstabelle:
 *** 12.18.3-1nodesource1 500
        500 https://deb.nodesource.com/node_12.x stretch/main amd64 Packages
        100 /var/lib/dpkg/status
     4.8.2~dfsg-1 500
        500 http://ftp.de.debian.org/debian stretch/main amd64 Packages

js-Controller 3.1.6

[Thomas Braun]

@Frank_y System auf den letzten Stand bringen. Aktuell ist node 12.8.4

[Frank_y]

@Thomas-Braun
@simatec
Ausgangspunkt mit Backitup 1.5.8 und angepassten Rechten von oben (hier funktioniert alles)
Update node.js 12.18.3 ->12.18.4
reboot
iobroker fixer
reboot ->Snapshot erstellt
Update Backitup auf 1.6.7
Start Backitup über cron-Job
->gleicher Fehler: backup wird erstellt, aber Datenpunkte zur Rückmeldung zeigen einen Fehler

Rollback auf Snapshot ( Backitup 1.5.8 mit node.js 12.18.4+fixer)
Start Backitup über cron-job
->Backup ok und Datenpunkte zur Rückmeldung melden i.O.

[simatec]

@Frank_y
1.6.7 hat einiges mehr an Fehlerüberwachung.
Werden denn in der 1.5.8 deine alten Backups gelöscht? So wie ich deinen Inhalt des Backupordners sehe, wird da wohl nicht gelöscht.
Also liegt das Problem nicht an der 1.6.7 sondern an deinen Rechten

[sigi234]

@simatec

Hallo, habe ein History Backup gemacht, wird das im Log nicht angezeigt?
V 1.6.8

[Frank_y]

@simatec
ich habe in der Adpaterkonfiguration '10 Stück' eingestellt. Und genau diese 10 letzten Versionen liegen lokal und in der Dropbox. Der Rest wird sauber lokal und in der Dropbox gelöscht. Ich nutze den Adapter auch schon seit ca. 1 Jahr störungsfrei.

[simatec]

@sigi234
Nein die werden nicht angezeigt, da es nur optionale Backups zum iobroker Backup sind.

[Frank_y]

@simatec
Wäre es eine Möglichkeit Versionen zwischen 1.5.8 und 1.6.7 zu installieren, um zu schauen ab wann es nicht mehr sauber durchläuft. Welche Versionsschritte wäre hier ggf. hilfreich?

[simatec]

@Frank_y
Ich werde morgen mal eine Testversion mit ein paar Debug Ausgaben bauen. Dann können wir das gerne gemeinsam testen.
Werden denn die Backups auf der Dropbox gelöscht oder auch dort nicht.

Noch eine Frage hast du die Einstellungen von Backitup nach dem löschen wieder hochgeladen oder hast du Backitup komplett neu eingerichtet?

Du kannst auch noch einmal folgendes versuchen.

• In den Instanzen löschen
• In Adapter löschen
• backitup.0 in den Objekten löschen
• iobroker neustarten
• backitup installieren
• backitup manuell einrichten (kein Restore der settings)

[simatec]

@Frank_y sagte in Test Adapter Backitup v1.6.x:

@simatec
Wäre es eine Möglichkeit Versionen zwischen 1.5.8 und 1.6.7 zu installieren, um zu schauen ab wann es nicht mehr sauber durchläuft. Welche Versionsschritte wäre hier ggf. hilfreich?

An dem clean wurde in Version 1.6.6 gearbeitet.
Die könntest du testen oder dann halt die 1.6.5

So könnte man es eingrenzen

[JB_Sullivan]

Was hat mir der Eintrag ERROR vor dem Zeitstempel zu sagen? BackItUP 1.6.8

Die Backup Dateien sind sowohl lokal als auch auf Google Drive korrekt erzeugt worden - soweit ich das auf den ersten Blick erkennen kann.

[SBorg]

@JB_Sullivan Hehehe, wollte ich gerade auch posten. IMHO ein Fehler, denn der Success darunter steht auch immer auf false. Das funktionierte bis vor ein paar Tagen auch noch (ich nutze die beiden, um es mir in der VIS anzeigen zu lassen), muss also wahrscheinlich mit einem der letzten Updates "eingeschleppt" worden sein.

[mickym]

@JB_Sullivan sagte in Test Adapter Backitup v1.6.x:

Was hat mir der Eintrag ERROR vor dem Zeitstempel zu sagen? BackItUP 1.6.8

Die Backup Dateien sind sowohl lokal als auch auf Google Drive korrekt erzeugt worden - soweit ich das auf den ersten Blick erkennen kann.

Ich kann das auch bestätigen. Es gibt auch im LOG überhaupt keine Nachricht mehr, dass ein Backup gelaufen ist (weiß nicht mehr ob das früher so war). Aber das Backup selbst funktioniert!!! Also auch bei mir werden die Dateien lokal richtig erzeugt.

[simatec]

@JB_Sullivan
Was wird bei dir in dem Objekt backitup.0.output.line ausgegeben?

[simatec]

@mickym
Was wird bei dir in dem Objekt backitup.0.output.line ausgegeben?

[mickym]

@simatec sagte in Test Adapter Backitup v1.6.x:

@mickym
Was wird bei dir in dem Objekt backitup.0.output.line ausgegeben?

da steht das:

[DEBUG] [clean] - delete /opt/iobroker/backups/zigbee.0_2020_09_04-19_11_11_backupiobroker.tar.gz

Ich hatte das aber schon in meinem Beitrag damals angemerkt, dass die Löschbefehle nun als letztes ausgegeben werden und sich an der Reihenfolge was geändert hat.
siehe: Beitrag 668 in diesem Thread

[simatec]

@mickym @JB_Sullivan @Frank_y
Könnt ihr bitte mal die DEv-Version von Github installieren und testen, ob euer Problem damit behoben ist?

Hier der Github-Link:
https://github.com/simatec/ioBroker.backitup/tarball/dev

Diesen bitte direkt als Quelle einfügen

[JB_Sullivan]

@simatec
Gerade installiert, Adapter gestoppt, neu gestartet, Objekte aktualisiert und der ERROR steht immer noch da - oder ändert sich das erst, wenn das nächste Backup gelaufen ist?

Unter backitup.0.output.line wird

[DEBUG] [clean] - delete C:\iobroker\GLT\backups\historyDB_2020_09_24-02_00_24_backupiobroker.tar.gz

ausgegeben

[mickym]

@simatec Also bei mir sieht das gut aus:

Das Einzige was ich nicht weiß, ist dass das Feld unter Info ==> latestBackup leer bleibt. Das zeigt es auch trotz Neustart des Adapters so an. (s. letzter LOG-EIntrag)

Hier mal das Log

backitup.0	2020-09-29 17:27:56.558	debug	(7141) No backup file was found
backitup.0	2020-09-29 17:27:56.536	info	(7141) [iobroker] backup was activated at 17:20 every 1 day(s)
backitup.0	2020-09-29 17:27:56.465	info	(7141) starting. Version 1.6.8 in /opt/iobroker/node_modules/iobroker.backitup, node: v12.18.4, js-controller: 3.1.6
backitup.0	2020-09-29 17:27:56.248	debug	(7141) Plugin sentry Initialize Plugin (enabled=true)
backitup.0	2020-09-29 17:27:55.748	debug	(7141) statesDB connected
backitup.0	2020-09-29 17:27:55.747	debug	(7141) States connected to redis: 127.0.0.1:9000
backitup.0	2020-09-29 17:27:55.738	debug	(7141) States create System PubSub Client
backitup.0	2020-09-29 17:27:55.735	debug	(7141) States create User PubSub Client
backitup.0	2020-09-29 17:27:55.727	debug	(7141) Redis States: Use Redis connection: 127.0.0.1:9000
backitup.0	2020-09-29 17:27:55.725	debug	(7141) objectDB connected
backitup.0	2020-09-29 17:27:55.718	debug	(7141) Objects connected to redis: 127.0.0.1:9001
backitup.0	2020-09-29 17:27:55.707	debug	(7141) Objects client initialize lua scripts
backitup.0	2020-09-29 17:27:55.705	debug	(7141) Objects create User PubSub Client
backitup.0	2020-09-29 17:27:55.704	debug	(7141) Objects create System PubSub Client
backitup.0	2020-09-29 17:27:55.700	debug	(7141) Objects client ready ... initialize now
backitup.0	2020-09-29 17:27:55.668	debug	(7141) Redis Objects: Use Redis connection: 127.0.0.1:9001
host.MWHome	2020-09-29 17:27:52.695	info	instance system.adapter.backitup.0 started with pid 7141
host.MWHome	2020-09-29 17:27:50.176	info	instance system.adapter.backitup.0 terminated with code 11 (ADAPTER_REQUESTED_TERMINATION)
backitup.0	2020-09-29 17:27:49.625	info	(4070) Terminated (ADAPTER_REQUESTED_TERMINATION): Without reason
backitup.0	2020-09-29 17:27:49.624	debug	(4070) Plugin sentry destroyed
backitup.0	2020-09-29 17:27:49.623	info	(4070) terminating
backitup.0	2020-09-29 17:27:49.622	info	(4070) cleaned everything up...
backitup.0	2020-09-29 17:27:49.621	info	(4070) Got terminate signal TERMINATE_YOURSELF
host.MWHome	2020-09-29 17:27:49.616	info	stopInstance system.adapter.backitup.0 send kill signal
host.MWHome	2020-09-29 17:27:49.610	info	stopInstance system.adapter.backitup.0 (force=false, process=true)
backitup.0	2020-09-29 17:23:32.109	debug	(4070) [iobroker] exec: done
backitup.0	2020-09-29 17:23:32.106	debug	(4070) [iobroker] exec: done
backitup.0	2020-09-29 17:23:31.956	debug	(4070) [iobroker/history] backitup.0.history.json
backitup.0	2020-09-29 17:23:31.954	debug	(4070) [iobroker/history] backitup.0.history.html
backitup.0	2020-09-29 17:23:31.583	debug	(4070) [iobroker/clean] done
backitup.0	2020-09-29 17:23:31.573	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/zigbee.0_2020_09_05-02_03_24_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.568	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/zigbee.0_2020_09_06-02_03_16_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.562	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/zigbee.0_2020_09_07-02_03_14_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.557	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/zigbee.0_2020_09_07-12_48_24_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.552	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/zigbee.0_2020_09_07-13_00_30_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.546	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/zigbee.0_2020_09_07-13_10_32_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.537	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/mysql_2020_09_05-02_03_24_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.531	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/mysql_2020_09_06-02_03_16_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.524	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/mysql_2020_09_07-02_03_11_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.520	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/mysql_2020_09_07-12_48_23_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.514	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/mysql_2020_09_07-13_00_30_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.508	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/mysql_2020_09_07-13_10_29_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.499	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/iobroker_2020_09_05-02_00_10_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.488	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/iobroker_2020_09_06-02_00_10_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.476	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/iobroker_2020_09_07-02_00_10_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.466	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/iobroker_2020_09_07-12_45_10_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.453	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/iobroker_2020_09_07-12_57_10_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:31.439	debug	(4070) [iobroker/clean] delete /opt/iobroker/backups/iobroker_2020_09_07-13_07_10_backupiobroker.tar.gz
backitup.0	2020-09-29 17:23:30.983	debug	(4070) [iobroker/zigbee] done
backitup.0	2020-09-29 17:23:30.982	debug	(4070) [iobroker/zigbee] found zigbee database: zigbee.0
backitup.0	2020-09-29 17:23:30.527	debug	(4070) [iobroker/mysql] done
backitup.0	2020-09-29 17:23:30.525	debug	(4070) [iobroker/mysql] MySql File deleted!
backitup.0	2020-09-29 17:23:29.450	debug	(4070) [iobroker/iobroker] done
backitup.0	2020-09-29 17:23:28.401	debug	(4070) [iobroker/iobroker] Backup created: /opt/iobroker/backups/iobroker_2020_09_29-17_20_10_backupiobroker.tar.gz
backitup.0	2020-09-29 17:20:13.116	debug	(4070) [iobroker/iobroker] host.MWHome 3369 objects saved
backitup.0	2020-09-29 17:20:13.077	debug	(4070) [iobroker/iobroker] host.MWHome 3720 states saved
backitup.0	2020-09-29 17:20:10.154	debug	(4070) Backup has started ...
backitup.0	2020-09-29 17:19:32.104	debug	(4070) system.adapter.admin.0: logging true
backitup.0	2020-09-29 17:19:00.509	debug	(4070) system.adapter.admin.0: logging false
backitup.0	2020-09-29 17:18:29.118	debug	(4070) No backup file was found
backitup.0	2020-09-29 17:18:29.098	info	(4070) [iobroker] backup was activated at 17:20 every 1 day(s)
backitup.0	2020-09-29 17:18:29.044	info	(4070) starting. Version 1.6.8 in /opt/iobroker/node_modules/iobroker.backitup, node: v12.18.4, js-controller: 3.1.6
backitup.0	2020-09-29 17:18:28.882	debug	(4070) Plugin sentry Initialize Plugin (enabled=true)
backitup.0	2020-09-29 17:18:28.394	debug	(4070) statesDB connected
backitup.0	2020-09-29 17:18:28.393	debug	(4070) States connected to redis: 127.0.0.1:9000
backitup.0	2020-09-29 17:18:28.384	debug	(4070) States create System PubSub Client
backitup.0	2020-09-29 17:18:28.382	debug	(4070) States create User PubSub Client
backitup.0	2020-09-29 17:18:28.375	debug	(4070) Redis States: Use Redis connection: 127.0.0.1:9000
backitup.0	2020-09-29 17:18:28.373	debug	(4070) objectDB connected
backitup.0	2020-09-29 17:18:28.366	debug	(4070) Objects connected to redis: 127.0.0.1:9001
backitup.0	2020-09-29 17:18:28.355	debug	(4070) Objects client initialize lua scripts
backitup.0	2020-09-29 17:18:28.354	debug	(4070) Objects create User PubSub Client
backitup.0	2020-09-29 17:18:28.352	debug	(4070) Objects create System PubSub Client
backitup.0	2020-09-29 17:18:28.349	debug	(4070) Objects client ready ... initialize now
backitup.0	2020-09-29 17:18:28.317	debug	(4070) Redis Objects: Use Redis connection: 127.0.0.1:9001
host.MWHome	2020-09-29 17:18:25.479	info	instance system.adapter.backitup.0 started with pid 4070

[JB_Sullivan]

@mickym Hat sich bei dir nach der Installation aus dem DEV die Versionsnummer geändert?

Bei dir war das Problem ja offensichtlich ein Problem mit einer ZIGBEE Daten Sicherung.

Bei mir ist es etwas in der HISTORY Sicherung - vielleicht wurde das noch nicht gefixt.