Concurrent backup is running

backup
v7

(Shiena) #1

NethServer Version: NethServer release 7.6.1810 (final)

Hello,

We have NS were we keep receiving a report that says:

Backup: backup-data
Backup started at 2019-01-08 20:00:01
Pre backup scripts status: SKIPPED (concurrent backup is running)
Another duplicity instance is already running with this archive directory

Duplicity backup failed
Action 'backup-data-duplicity ': FAIL
Backup status: FAIL

On messages log, it’s complaining about the interval time (below).
I disabled the backup and enabled back today, so not sure if that fixes the error for tonight’s backup.
Any idea, how we can fix this error.
Thank you

Jan 9 07:59:26 srv collectd[4558]: plugin_read_thread: read-function of the `df' plugin took 51.856 seconds, which is above its read interval (10.000 seconds). You might want to adjust the `Interval' or `ReadThreads' settings. Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-mnt-backup-backup-data/df_complex-free.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-mnt-backup-backup-data/df_complex-free.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-mnt-backup-backup-data/df_complex-used.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-mnt-backup-backup-data/df_complex-used.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-mnt-backup-backup-data/df_complex-reserved.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-mnt-backup-backup-data/df_complex-reserved.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401118/df_complex-reserved.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401118/df_complex-reserved.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401118/df_complex-used.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401118/df_complex-used.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401118/df_complex-free.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401118/df_complex-free.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401123/df_complex-reserved.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401123/df_complex-reserved.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401123/df_complex-used.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401123/df_complex-used.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401123/df_complex-free.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401123/df_complex-free.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401121/df_complex-free.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401121/df_complex-free.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401121/df_complex-reserved.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401121/df_complex-reserved.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401137/df_complex-reserved.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401137/df_complex-reserved.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401125/df_complex-free.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401125/df_complex-free.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401137/df_complex-free.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401137/df_complex-free.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401146/df_complex-used.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401146/df_complex-used.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step) Jan 9 07:59:26 srv collectd[4558]: rrdtool plugin: rrd_update_r (/var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401121/df_complex-used.rrd) failed: /var/lib/collectd/rrd/srv.placidpools.com.au/df-run-user-1157401121/df_complex-used.rrd: illegal attempt to update using time 1546984684 when last update time is 1546984684 (minimum one second step)

(HF) #2

I believe there is nothing to fix. The running backup takes a long time. Let it finisch and set incrimental…


(Shiena) #3

Hello LayLow,

Incremental is set and full backup is scheduled every Saturday only.
Error has been like that every day during Christmas break.
Thanks


(HF) #4

This is the issue


(Michael Träumner) #5

Please have also a look at the backup logs:

/var/log/backup-config.log
/var/log/backup-data.log
/var/log/backup/backup-backup-data-(newestDate).log


(Shiena) #6

Fix for the issue was to kill all backup-data-dup processes by issuing:

ps -A | grep dup

Then go to /var/lib/nethserver/backup/duplicity/backup-data/ and delete the lockfile.

We were backing up to NAS via CIFS, but we also sometimes get an error on messages file such as “CIFS VFS: Server has not responded in 120 seconds. Reconnecting…”, hence the reason why the backup would not finish even though it’s only incremental, so we had to change the Nethserver backup to NFS.


Stop backup in progress