UPDATE 31.10.: Amazon Alexa - ioBroker Skill läuft aus ?

[simatec]

@drapo
Was hat der User backup für Rechte über FTP?

[drapo]

@simatec Du hast Recht. Es war ein Rechte Problem. Mit dem Admin Benutzer läuft das Backup ohne weiteres durch. Erstaunt bin ich nur darüber dass ich gar nichts an irgendwelchen Berechtigungen geändert hab und auf einmal diese Probleme auftreten.

[Bibo*13]

Hi,
wird es irgendwann vielleicht auch Möglich sein das nicht nur für das Iobroker Backup sondern auch für zigbee, regdis, grafana, influx, javascript, usw im History-log eine json hinterlegt wird.
Ich würde gerne auch diese Daten in meiner VIS anzeigen.

vielen Dank

[FoxRo]

Hi @simatec
Nachdem IoBroker selbst auf Deinen BackItUp Adapter aufmerksam gemacht hat, habe ich mir diesen mal installiert. Nachdem ich auch die Zugriffsrechte korrekt gesetzt hatte, hat er sofort seine Arbeit auf- und mir für die Zukunft eine Menge manuelle Arbeit ab-genommen.
Vielen Dank für den coolen Adapter!! So einfach ist Plug&Play ;-)

[simatec]

@foxro
Schön zu hören, dass du ihn nutzt ... 😉

[Meister Mopper]

Moin @simatec,

ich habe die Adapterversion von 1.8.5 auf 2.1.0 angehoben, es wurde jedoch

• beim Einrichten der Instanz festgestellt, dass keine Zigbee-Instanz installiert war. ->Stimmt: die wurde auf einen Slave geschoben (was mit 1.8.5 kein Problem ist), weil dort das TIboard dran hängt.

• mit dieser Adapterversion keine Backups funktionierten, weder in opt/iobroker/backups noch auf das NAS und google drive

Nachdem ich nach 1.8.5 zurück bin funktionieren die Backups wieder (auch Zigbee) aber ich erhalte nach dem automatischen Backup eine Fehlermeldung und der Adapter startet neu:

Spoiler

host.iobroker	2021-04-11 02:02:17.428	info	instance system.adapter.backitup.0 started with pid 24438
host.iobroker	2021-04-11 02:01:47.405	info	Restart adapter system.adapter.backitup.0 because enabled
host.iobroker	2021-04-11 02:01:47.405	error	instance system.adapter.backitup.0 terminated with code 1 (JS_CONTROLLER_STOPPED)
host.iobroker	2021-04-11 02:01:47.404	error	Caught by controller[0]: at processImmediate (internal/timers.js:463:21)
host.iobroker	2021-04-11 02:01:47.404	error	Caught by controller[0]: at Immediate.<anonymous> (/opt/iobroker/node_modules/iobroker.backitup/lib/scripts/94-historyJSON.js:124:41)
host.iobroker	2021-04-11 02:01:47.404	error	Caught by controller[0]: at JSON.parse (<anonymous>)
host.iobroker	2021-04-11 02:01:47.401	error	Caught by controller[0]: SyntaxError: Unexpected token , in JSON at position 516
backitup.0	2021-04-11 02:01:47.239	error	(139) Unexpected token , in JSON at position 516
backitup.0	2021-04-11 02:01:47.239	error	at processImmediate (internal/timers.js:463:21)
backitup.0	2021-04-11 02:01:47.239	error	at Immediate.<anonymous> (/opt/iobroker/node_modules/iobroker.backitup/lib/scripts/94-historyJSON.js:124:41)
backitup.0	2021-04-11 02:01:47.239	error	at JSON.parse (<anonymous>)
backitup.0	2021-04-11 02:01:47.239	error	(139) SyntaxError: Unexpected token , in JSON at position 516
backitup.0	2021-04-11 02:01:47.238	error	(139) uncaught exception: Unexpected token , in JSON at position 516

Hier noch die Konfig der Instanz:

Spoiler

Ich kann mir nicht erklären, welchen 'token' der Adapter 'expected'.

[simatec]

@meister-mopper
Die Meldung dass keine zigbee Instanz auf dem Host liegt ist neu.
Bei der 1.8.5 gab es diese noch nicht.
Trotzdem sollte dein zigbee Backup nicht vollständig sein. Poste mal den Inhalt des zigbee Backups
Ich würde dir raten auf 2.1.0 zu gehen und auf deinem Slave eine Instanz zu installieren, die dann zigbee sichert.

[simatec]

Ab sofort steht die Version 2.1.1 auf Github und im latest bereit ...

Changelog

2.1.1 (11.04.2021)

• (simatec) Bugfix redis
• (simatec) debug Log for Restore request added
• (simatec) Bugfix influxdb
• (simatec) ignore Filenames for javascript-Backup added

[Meister Mopper]

@simatec

In der Tat ist das zigbee Backup leer, hatte ich in sträflicher Weise noch nicht getestet. Ich probier es mal mit einer Backitup-Instanz auf dem Slave.

Wie ich bereits schrieb, werden bei mir mit 2.1.0 keine Backups geschrieben, und die o. a. Fehlermeldung kommt mit 1.8.5 nachdem ich von 2.1.0 zurück bin..

[simatec]

@meister-mopper
Dann benötige ich mal den Log von der Backup Erstellung unter 2.1.0

[Meister Mopper]

@simatec

Habe erneut 2.1.0 installiert und ein Backup angeschoben. Das Backupfenster bleibt mind. 3 Minuten stehen, dann kommt ein browser refresh und das Fenster wird geschlossen.

In opt/iobroker/backups wurde ein neues Backup gespeichert. Das redis Backup ist nicht vorhanden.

Auf dem NAS und google drive tut sich nichts.

Hier das debug-log im ioBroker:

Spoiler

backitup.0	2021-04-11 17:36:47.379	debug	(21225) telegram-instance: telegram.0
backitup.0	2021-04-11 17:34:34.929	debug	(21225) [iobroker/redis] Created redistmp directory
backitup.0	2021-04-11 17:34:34.929	debug	(21225) [iobroker/redis] old redis tmp directory "/opt/iobroker/backups/redistmp" successfully deleted
backitup.0	2021-04-11 17:34:34.928	debug	(21225) [iobroker/redis] Try deleting the old redis tmp directory: "/opt/iobroker/backups/redistmp"
backitup.0	2021-04-11 17:34:34.927	debug	(21225) [iobroker/redis] Start Redis Backup ...
backitup.0	2021-04-11 17:34:34.324	debug	(21225) [iobroker/iobroker] done
backitup.0	2021-04-11 17:34:33.300	debug	(21225) [iobroker/iobroker] Backup created: /opt/iobroker/backups/iobroker_2021_04_11-17_34_22_backupiobroker.tar.gz
backitup.0	2021-04-11 17:34:26.043	debug	(21225) [iobroker/iobroker] host.iobroker 18530 objects saved
backitup.0	2021-04-11 17:34:26.011	debug	(21225) [iobroker/iobroker] host.iobroker 21538 states saved
backitup.0	2021-04-11 17:34:22.541	debug	(21225) Backup has started ...
backitup.0	2021-04-11 17:34:08.997	debug	(21225) detect last backup file: iobroker_2021_04_10-09_02_14_backupiobroker.tar.gz
backitup.0	2021-04-11 17:34:08.997	debug	(21225) detect backup file 4 from googledrive: iobroker_2021_03_31-02_01_10_backupiobroker.tar.gz
backitup.0	2021-04-11 17:34:08.996	debug	(21225) detect backup file 3 from googledrive: iobroker_2021_04_01-02_01_10_backupiobroker.tar.gz
backitup.0	2021-04-11 17:34:08.996	debug	(21225) detect backup file 2 from googledrive: iobroker_2021_04_03-02_01_10_backupiobroker.tar.gz
backitup.0	2021-04-11 17:34:08.996	debug	(21225) detect backup file 1 from googledrive: iobroker_2021_04_11-02_01_10_backupiobroker.tar.gz
backitup.0	2021-04-11 17:34:07.979	debug	(21225) detect backup file 4 from ftp: iobroker_2021_04_10-09_02_14_backupiobroker.tar.gz
backitup.0	2021-04-11 17:34:07.979	debug	(21225) detect backup file 3 from ftp: iobroker_2021_04_05-02_01_10_backupiobroker.tar.gz
backitup.0	2021-04-11 17:34:07.979	debug	(21225) detect backup file 2 from ftp: iobroker_2021_04_03-02_01_10_backupiobroker.tar.gz
backitup.0	2021-04-11 17:34:07.978	debug	(21225) detect backup file 1 from ftp: iobroker_2021_04_01-02_01_10_backupiobroker.tar.gz
backitup.0	2021-04-11 17:34:07.500	debug	(21225) telegram-instance: telegram.0
backitup.0	2021-04-11 17:34:05.959	debug	(21225) FTP: connected.
backitup.0	2021-04-11 17:34:05.722	debug	(21225) [ccu] 10 39 01 */30 * *
backitup.0	2021-04-11 17:34:05.714	info	(21225) [ccu] backup was activated at 01:39 every 30 day(s)
backitup.0	2021-04-11 17:34:05.714	debug	(21225) [iobroker] 10 01 02 */2 * *
backitup.0	2021-04-11 17:34:05.699	info	(21225) [iobroker] backup was activated at 02:01 every 2 day(s)
backitup.0	2021-04-11 17:34:05.649	info	(21225) starting. Version 2.1.0 in /opt/iobroker/node_modules/iobroker.backitup, node: v12.22.1, js-controller: 3.2.16
backitup.0	2021-04-11 17:34:05.530	debug	(21225) Plugin sentry Initialize Plugin (enabled=true)
backitup.0	2021-04-11 17:34:04.797	debug	(21225) statesDB connected
backitup.0	2021-04-11 17:34:04.796	debug	(21225) States connected to redis: 127.0.0.1:6379
backitup.0	2021-04-11 17:34:04.792	debug	(21225) States create User PubSub Client
backitup.0	2021-04-11 17:34:04.792	debug	(21225) States create System PubSub Client
backitup.0	2021-04-11 17:34:04.788	debug	(21225) Redis States: Use Redis connection: 127.0.0.1:6379
backitup.0	2021-04-11 17:34:04.787	debug	(21225) objectDB connected
backitup.0	2021-04-11 17:34:04.782	debug	(21225) Objects connected to redis: 0.0.0.0:9001
backitup.0	2021-04-11 17:34:04.768	debug	(21225) Objects client initialize lua scripts
backitup.0	2021-04-11 17:34:04.767	debug	(21225) Objects create User PubSub Client
backitup.0	2021-04-11 17:34:04.767	debug	(21225) Objects create System PubSub Client
backitup.0	2021-04-11 17:34:04.766	debug	(21225) Objects client ready ... initialize now
backitup.0	2021-04-11 17:34:04.745	debug	(21225) Redis Objects: Use Redis connection: 0.0.0.0:9001

Hier der Ordner /opt/iobroker/backups:

Spoiler

-rw-rw-r--+ 1 iobroker iobroker 21093792 Apr  7 02:01 iobroker_2021_04_07-02_01_10_backupiobroker.tar.gz
-rw-rw-r--+ 1 iobroker iobroker 21092630 Apr  9 02:01 iobroker_2021_04_09-02_01_10_backupiobroker.tar.gz
-rw-rw-r--+ 1 iobroker iobroker 21102472 Apr 10 08:56 iobroker_2021_04_10-08_55_56_backupiobroker.tar.gz
-rw-rw-r--+ 1 iobroker iobroker 21095026 Apr 10 09:02 iobroker_2021_04_10-09_02_14_backupiobroker.tar.gz
-rw-rw-r--+ 1 iobroker iobroker 21072355 Apr 11 02:01 iobroker_2021_04_11-02_01_10_backupiobroker.tar.gz
-rw-rw-r--+ 1 iobroker iobroker 21093693 Apr 11 17:29 iobroker_2021_04_11-17_29_44_backupiobroker.tar.gz
-rw-rw-r--+ 1 iobroker iobroker 21093599 Apr 11 17:34 iobroker_2021_04_11-17_34_22_backupiobroker.tar.gz
-rw-rw-r--+ 1 iobroker iobroker  1235163 Apr  3 02:01 redis_2021_04_03-02_01_22_backupiobroker.tar.gz
-rw-rw-r--+ 1 iobroker iobroker  1256577 Apr  5 02:01 redis_2021_04_05-02_01_21_backupiobroker.tar.gz
-rw-rw-r--+ 1 iobroker iobroker  1273063 Apr 10 09:02 redis_2021_04_10-09_02_25_backupiobroker.tar.gz
-rw-rw-r--+ 1 iobroker iobroker  1250573 Apr 11 02:01 redis_2021_04_11-02_01_22_backupiobroker.tar.gz
drwxrwxr-x+ 2 iobroker iobroker     4096 Apr 11 17:34 redistmp

[Meister Mopper]

@simatec

Hier bleibt der Prozess offenbar stehen:

Spoiler

Started iobroker ...
[DEBUG] [iobroker] start with {"type":"creator","time":"02:01","debugging":true,"everyXDays":"2","deleteBackupAfter":0,"ftp":{"enabled":true,"type":"storage","source":"cifs","host":"192.168.178.100","debugging":true,"deleteOldBackup":true,"ownDir":true,"bkpType":"Minimal","dir":"home/backup/standard","dirMinimal":"home/backup/standard","user":"ioBroker","pass":"****","port":"21"},"googledrive":{"enabled":true,"type":"storage","source":"cifs","debugging":true,"deleteOldBackup":true,"accessJson":"****","ownDir":true,"bkpType":"Minimal","dir":"/backupDir/minimal","dirMinimal":"/backupDir/minimal"},"dir":"/opt/iobroker","redis":{"enabled":true,"type":"creator","ftp":{"enabled":true,"type":"storage","source":"cifs","host":"192.168.178.100","debugging":true,"deleteOldBackup":true,"ownDir":true,"bkpType":"Minimal","dir":"home/backup/standard","dirMinimal":"home/backup/standard","user":"ioBroker","pass":"****","port":"21"},"cifs":{"enabled":false,"mountType":"CIFS","type":"storage","source":"cifs","mount":"192.168.178.100","debugging":true,"fileDir":"/opt/iobroker/node_modules/iobroker.backitup","wakeOnLAN":true,"macAd":"00:11:32:B6:EA:F0","wolTime":"25","smb":"vers=1.0","sudo":true,"cifsDomain":"","deleteOldBackup":false,"ownDir":true,"bkpType":"Minimal","dir":"homes/ioBroker/backup/standard","dirMinimal":"homes/ioBroker/backup/standard","user":"ioBroker","pass":"****"},"dropbox":{"enabled":false,"type":"storage","source":"cifs","debugging":true,"deleteOldBackup":false,"accessToken":"****","ownDir":false,"bkpType":"Minimal","dir":"/backupDir","dirMinimal":"/backupDir/minimal"},"webdav":{"enabled":false,"type":"storage","source":"cifs","debugging":true,"deleteOldBackup":false,"username":"username","pass":"****","url":"https://example.com/remote.php/dav/files/username/","ownDir":false,"bkpType":"Minimal","dir":"/backupDir","dirMinimal":"/backupDir/iobroker"},"googledrive":{"enabled":true,"type":"storage","source":"cifs","debugging":true,"deleteOldBackup":true,"accessJson":"****","ownDir":true,"bkpType":"Minimal","dir":"/backupDir/minimal","dirMinimal":"/backupDir/minimal"},"aof":false,"path":"/var/lib/redis/dump.rdb"},"historyHTML":{"enabled":true,"type":"message","entriesNumber":"","systemLang":"de"},"historyJSON":{"enabled":true,"type":"message","entriesNumber":"","systemLang":"de"},"telegram":{"enabled":true,"notificationsType":"Telegram","type":"message","instance":"telegram.0","SilentNotice":true,"NoticeType":"longTelegramNotice","User":"allTelegramUsers","onlyError":false,"telegramWaiting":5000,"systemLang":"de"},"email":{"enabled":true,"notificationsType":"Telegram","type":"message","instance":"","NoticeType":"longEmailNotice","emailReceiver":"xxx@xxx.com","emailSender":"xxx@xxx.com","onlyError":false,"emailWaiting":0,"systemLang":"de"},"pushover":{"enabled":true,"notificationsType":"Telegram","type":"message","instance":"","SilentNotice":false,"NoticeType":"longPushoverNotice","deviceID":"","onlyError":false,"pushoverWaiting":0,"systemLang":"de"},"whatsapp":{"enabled":true,"notificationsType":"Telegram","type":"message","instance":"","NoticeType":"longWhatsappNotice","onlyError":false,"whatsappWaiting":0,"systemLang":"de"},"backupDir":"/opt/iobroker/backups"}
[DEBUG] [iobroker] - host.iobroker 21538 states saved

[DEBUG] [iobroker] - host.iobroker 18530 objects saved

[DEBUG] [iobroker] - Backup created: /opt/iobroker/backups/iobroker_2021_04_11-17_49_13_backupiobroker.tar.gz

[DEBUG] [iobroker] - done
[DEBUG] [redis] - Start Redis Backup ...
[DEBUG] [redis] - Try deleting the old redis tmp directory: "/opt/iobroker/backups/redistmp"
[DEBUG] [redis] - old redis tmp directory "/opt/iobroker/backups/redistmp" successfully deleted
[DEBUG] [redis] - Created redistmp directory

[Rene_HM]

Seit ein paar Tagen habe ich das Problem, das backups auf meiner Fritzbox nicht mehr erzeugt werden. Ich bin mir leider nicht sicher, ob das erst seit dem update auf die 2.x nicht mehr funktioniert. Kann gut sein, dass das Problem schon eher aufgetaucht ist, ich es nur nicht gemerkt habe. Bin mir auch nicht sicher, ob es ein Adapter-Problem ist, oder auf meine Umgebung hier zurückzuführen ist...

Folgendes Phänomen: Ich bekomme im log die Fehlermeldung

2021-04-11 01:30:11.532  - error: backitup.0 (25174) [ccu] Backup folder not created: Error: EPERM: operation not permitted, chmod '/opt/iobroker/backups'Please reinstall backitup and run "iobroker fix"!!
2021-04-11 01:30:11.562  - debug: backitup.0 (25174) Backup has started ...
2021-04-11 01:30:22.007  - debug: backitup.0 (25174) [ccu/mount] first mount attempt with smb option failed. try next mount attempt without smb option ...
2021-04-11 01:30:22.514  - debug: backitup.0 (25174) [ccu/mount] [undefined Error: Command failed: sudo mount -t cifs -o username=xxx,password=****,rw,file_mode=0777,dir_mode=0777 //192.168.xx.xx/LiveSystem_Espressobin /opt/iobroker/backups
2021-04-11 01:30:22.522  - debug: backitup.0 (25174) [ccu/mount] mount error(112): Host is down
2021-04-11 01:30:22.524  - debug: backitup.0 (25174) [ccu/mount] Refer to the mount.cifs(8) manual page (e.g. man mount.cifs)
2021-04-11 01:30:22.530  - debug: backitup.0 (25174) [ccu/mount] [IGNORED] Error: Command failed: sudo mount -t cifs -o username=xxx,password=****,rw,file_mode=0777,dir_mode=0777 //192.168.xx.xx/LiveSystem_Espressobin /opt/iobroker/backups
2021-04-11 01:30:22.532  - debug: backitup.0 (25174) [ccu/mount] mount error(112): Host is down
2021-04-11 01:30:22.537  - debug: backitup.0 (25174) [ccu/mount] Refer to the mount.cifs(8) manual page (e.g. man mount.cifs)

Das "host is down" macht micht stutzig, da die FB definitiv erreichbar ist. Also habe ich das ganze manuell versucht:

1. Versuch: Befehl wie im log auf der console eingeben. Ergebnis ist wie im Adapter

sudo mount -t cifs -o username=xxx,password=xxx,rw,file_mode=0777,dir_mode=0777 //192.168.xx.xx/LiveSystem_Espressobin /opt/iobroker/backups
mount error(112): Host is down
Refer to the mount.cifs(8) manual page (e.g. man mount.cifs)

2. Versuch: erst umount und dann noch ein mount-Versuch, funktioniert auch nicht:

sudo umount /opt/iobroker/backups
sudo mount -t cifs -o username=xxx,password=xxx,rw,file_mode=0777,dir_mode=0777 //192.168.xx.xx/LiveSystem_Espressobin /opt/iobroker/backups
mount error(112): Host is down
Refer to the mount.cifs(8) manual page (e.g. man mount.cifs)

3. Versuch: erst umount und die SMB-Version auf 1.0 setzen, das funktioniert dann

sudo umount /opt/iobroker/backups
sudo mount -t cifs -o username=xxx,password=xxx,vers=1.0,rw,file_mode=0777,dir_mode=0777 //192.168.3.1/LiveSystem_Espressobin /opt/iobroker/backups

Leider führt ein mount mit vers=1.0 ohne umount zu einem nächsten Fehler:

 sudo mount -t cifs -o username=xxx,password=xxx,vers=1.0,rw,file_mode=0777,dir_mode=0777 //192.168.3.1/LiveSystem_Espressobin /opt/iobroker/backups
mount error(16): Device or resource busy
Refer to the mount.cifs(8) manual page (e.g. man mount.cifs)

Hier noch meine config dazu:

-> @simatec könnest du das umount (evtl. optional) und die SMB-Version ("vers=1.0") in den Adapter einbauen? Die SMB Version hast du ja bereits im admin und anscheinend war das auch schon mal drin (im log sehe ich "first mount attempt with smb option failed. try next mount attempt without smb option ", aber ich sehe keinen Unterschied in den Kommandos)
oder alternativ hat ja vielleicht noch jemand eine andere Idee?

[simatec]

@meister-mopper Installiere mal die Version 2.1.1

[simatec]

@rene_hm
So wie ich das sehe, hast du eine FB.
Poste mal bitte dein Config der FB.
Zu dem Device Busy würde ich dir raten dein System mal zut Sicherheit neuzustarten
Hatte das bei mir auch mal gehabt

[Meister Mopper]

@simatec
So, habe mal 2.1.1 installiert. Funktioniert problemlos, Danke!! :+1:

[Rene_HM]

@simatec sagte in Test Adapter Backitup v2.1.x:

So wie ich das sehe, hast du eine FB.

ja, richtig

Poste mal bitte dein Config der FB.

welche config meinst da damit?

Zu dem Device Busy würde ich dir raten dein System mal zut Sicherheit neuzustarten

alles neu gestartet, keine Änderung.

Bist du sicher, du schickst das "vers=1.0" für die SMB Version mit? müsste ja nach "dir_mode=0777" im ersten Versuch stehen?
Im log hier sehe ich das nicht:

2021-04-11 01:30:22.007  - debug: backitup.0 (25174) [ccu/mount] first mount attempt with smb option failed. try next mount attempt without smb option ...
2021-04-11 01:30:22.514  - debug: backitup.0 (25174) [ccu/mount] [undefined Error: Command failed: sudo mount -t cifs -o username=xxx,password=****,rw,file_mode=0777,dir_mode=0777 //192.168.xx.xx/LiveSystem_Espressobin /opt/iobroker/backups
2021-04-11 01:30:22.522  - debug: backitup.0 (25174) [ccu/mount] mount error(112): Host is down
2021-04-11 01:30:22.524  - debug: backitup.0 (25174) [ccu/mount] Refer to the mount.cifs(8) manual page (e.g. man mount.cifs)
2021-04-11 01:30:22.530  - debug: backitup.0 (25174) [ccu/mount] [IGNORED] Error: Command failed: sudo mount -t cifs -o username=xxx,password=****,rw,file_mode=0777,dir_mode=0777 //192.168.xx.xx/LiveSystem_Espressobin /opt/iobroker/backups
2021-04-11 01:30:22.532  - debug: backitup.0 (25174) [ccu/mount] mount error(112): Host is down
2021-04-11 01:30:22.537  - debug: backitup.0 (25174) [ccu/mount] Refer to the mount.cifs(8) manual page (e.g. man mount.cifs)

[simatec]

@rene_hm
Es wird zuerst mit smb Option versucht den mount zu setzen

[simatec]

@rene_hm
Hast du deine FB in letzter Zeit aktualisiert? Ich weiß, dass es da einige Probleme mit smb gab

[simatec]

@rene_hm sagte in Test Adapter Backitup v2.1.x:

welche config meinst da damit?

Die Config deiner FB im speziellen NAS