PVE-2.3: New backup of CT on NFS fails

mir

Famous Member
Apr 14, 2012
3,576
136
133
Copenhagen, Denmark
Hi all,

The new backup functionality in 2.3 seems to fail backing up of CT's on NFS.

VMID STATUS TIME SIZE FILENAME
101 err 00:08:19 0.00MB -
112 err 00:11:54 0.00MB -
115 ok 00:15:15 14.87GB /mnt/pve/qnap_nfs/dump/vzdump-qemu-115-2013_03_09-05_35_15.vma.lzo

As can be seen above the NFS works with VM so a bad NFS can be excluded.
vzdump 109 114 115 112 117 101 --quiet 1 --mailto x@y.z --mode snapshot --compress lzo --storage qnap_nfs

101: Mar 09 05:15:02 INFO: Starting Backup of VM 101 (openvz)
101: Mar 09 05:15:02 INFO: CTID 101 exist mounted running
101: Mar 09 05:15:02 INFO: status = running
101: Mar 09 05:15:02 INFO: mode failure - unable to detect lvm volume group
101: Mar 09 05:15:02 INFO: trying 'suspend' mode instead
101: Mar 09 05:15:02 INFO: backup mode: suspend
101: Mar 09 05:15:02 INFO: ionice priority: 7
101: Mar 09 05:15:02 INFO: starting first sync /mnt/pve/qnap_nfs/private/101/ to /mnt/pve/qnap_nfs/dump/vzdump-openvz-101-2013_03_09-05_15_02.tmp
101: Mar 09 05:19:32 INFO: Number of files: 26778
101: Mar 09 05:19:32 INFO: Number of files transferred: 21817
101: Mar 09 05:19:32 INFO: Total file size: 674049885 bytes
101: Mar 09 05:19:32 INFO: Total transferred file size: 562334881 bytes
101: Mar 09 05:19:32 INFO: Literal data: 562340001 bytes
101: Mar 09 05:19:32 INFO: Matched data: 0 bytes
101: Mar 09 05:19:32 INFO: File list size: 589679
101: Mar 09 05:19:32 INFO: File list generation time: 0.001 seconds
101: Mar 09 05:19:32 INFO: File list transfer time: 0.000 seconds
101: Mar 09 05:19:32 INFO: Total bytes sent: 563959316
101: Mar 09 05:19:32 INFO: Total bytes received: 451411
101: Mar 09 05:19:32 INFO: sent 563959316 bytes received 451411 bytes 2086546.13 bytes/sec
101: Mar 09 05:19:32 INFO: total size is 674049885 speedup is 1.19
101: Mar 09 05:19:32 INFO: first sync finished (270 seconds)
101: Mar 09 05:19:32 INFO: suspend vm
101: Mar 09 05:19:32 INFO: Setting up checkpoint...
101: Mar 09 05:19:32 INFO: suspend...
101: Mar 09 05:19:32 INFO: get context...
101: Mar 09 05:19:32 INFO: Checkpointing completed successfully
101: Mar 09 05:19:32 INFO: starting final sync /mnt/pve/qnap_nfs/private/101/ to /mnt/pve/qnap_nfs/dump/vzdump-openvz-101-2013_03_09-05_15_02.tmp
101: Mar 09 05:19:57 INFO: Number of files: 26778
101: Mar 09 05:19:57 INFO: Number of files transferred: 4
101: Mar 09 05:19:57 INFO: Total file size: 674055325 bytes
101: Mar 09 05:19:57 INFO: Total transferred file size: 281305 bytes
101: Mar 09 05:19:57 INFO: Literal data: 600 bytes
101: Mar 09 05:19:57 INFO: Matched data: 280705 bytes
101: Mar 09 05:19:57 INFO: File list size: 589679
101: Mar 09 05:19:57 INFO: File list generation time: 0.026 seconds
101: Mar 09 05:19:57 INFO: File list transfer time: 0.000 seconds
101: Mar 09 05:19:57 INFO: Total bytes sent: 594075
101: Mar 09 05:19:57 INFO: Total bytes received: 4523
101: Mar 09 05:19:57 INFO: sent 594075 bytes received 4523 bytes 23474.43 bytes/sec
101: Mar 09 05:19:57 INFO: total size is 674055325 speedup is 1126.06
101: Mar 09 05:19:57 INFO: final sync finished (25 seconds)
101: Mar 09 05:19:57 INFO: resume vm
101: Mar 09 05:19:57 INFO: Resuming...
101: Mar 09 05:19:57 INFO: vm is online again after 25 seconds
101: Mar 09 05:19:57 INFO: creating archive '/mnt/pve/qnap_nfs/dump/vzdump-openvz-101-2013_03_09-05_15_02.tar.lzo'
101: Mar 09 05:20:53 INFO: tar: ./usr/share/terminfo/v: file changed as we read it
101: Mar 09 05:21:59 INFO: Total bytes written: 581734400 (555MiB, 5.1MiB/s)
101: Mar 09 05:23:21 ERROR: Backup of VM 101 failed - command '(cd /mnt/pve/qnap_nfs/dump/vzdump-openvz-101-2013_03_09-05_15_02.tmp;find . '(' -regex '^\.$' ')' -o '(' -type 's' -prune ')' -o -print0|sed 's/\\/\\\\/g'|tar cpf - --totals --sparse --numeric-owner --no-recursion --one-file-system --null -T -|lzop) >/mnt/pve/qnap_nfs/dump/vzdump-openvz-101-2013_03_09-05_15_02.tar.dat' failed: exit code 1


112: Mar 09 05:23:21 INFO: Starting Backup of VM 112 (openvz)
112: Mar 09 05:23:21 INFO: CTID 112 exist mounted running
112: Mar 09 05:23:21 INFO: status = running
112: Mar 09 05:23:21 INFO: mode failure - unable to detect lvm volume group
112: Mar 09 05:23:21 INFO: trying 'suspend' mode instead
112: Mar 09 05:23:21 INFO: backup mode: suspend
112: Mar 09 05:23:21 INFO: ionice priority: 7
112: Mar 09 05:23:21 INFO: starting first sync /mnt/pve/qnap_nfs/private/112/ to /mnt/pve/qnap_nfs/dump/vzdump-openvz-112-2013_03_09-05_23_21.tmp
112: Mar 09 05:31:09 INFO: Number of files: 36133
112: Mar 09 05:31:09 INFO: Number of files transferred: 28663
112: Mar 09 05:31:09 INFO: Total file size: 1447300562 bytes
112: Mar 09 05:31:09 INFO: Total transferred file size: 1443877571 bytes
112: Mar 09 05:31:09 INFO: Literal data: 1443877571 bytes
112: Mar 09 05:31:09 INFO: Matched data: 0 bytes
112: Mar 09 05:31:09 INFO: File list size: 835869
112: Mar 09 05:31:09 INFO: File list generation time: 0.018 seconds
112: Mar 09 05:31:09 INFO: File list transfer time: 0.000 seconds
112: Mar 09 05:31:09 INFO: Total bytes sent: 1446145798
112: Mar 09 05:31:09 INFO: Total bytes received: 585789
112: Mar 09 05:31:09 INFO: sent 1446145798 bytes received 585789 bytes 3088007.66 bytes/sec
112: Mar 09 05:31:09 INFO: total size is 1447300562 speedup is 1.00
112: Mar 09 05:31:09 INFO: first sync finished (468 seconds)
112: Mar 09 05:31:09 INFO: suspend vm
112: Mar 09 05:31:09 INFO: Setting up checkpoint...
112: Mar 09 05:31:09 INFO: suspend...
112: Mar 09 05:31:09 INFO: get context...
112: Mar 09 05:31:09 INFO: Checkpointing completed successfully
112: Mar 09 05:31:09 INFO: starting final sync /mnt/pve/qnap_nfs/private/112/ to /mnt/pve/qnap_nfs/dump/vzdump-openvz-112-2013_03_09-05_23_21.tmp
112: Mar 09 05:31:54 INFO: Number of files: 36133
112: Mar 09 05:31:54 INFO: Number of files transferred: 0
112: Mar 09 05:31:54 INFO: Total file size: 1447300562 bytes
112: Mar 09 05:31:54 INFO: Total transferred file size: 0 bytes
112: Mar 09 05:31:54 INFO: Literal data: 0 bytes
112: Mar 09 05:31:54 INFO: Matched data: 0 bytes
112: Mar 09 05:31:54 INFO: File list size: 835869
112: Mar 09 05:31:54 INFO: File list generation time: 0.055 seconds
112: Mar 09 05:31:54 INFO: File list transfer time: 0.000 seconds
112: Mar 09 05:31:54 INFO: Total bytes sent: 838515
112: Mar 09 05:31:54 INFO: Total bytes received: 2645
112: Mar 09 05:31:54 INFO: sent 838515 bytes received 2645 bytes 18487.03 bytes/sec
112: Mar 09 05:31:54 INFO: total size is 1447300562 speedup is 1720.60
112: Mar 09 05:31:54 INFO: final sync finished (45 seconds)
112: Mar 09 05:31:54 INFO: resume vm
112: Mar 09 05:31:54 INFO: Resuming...
112: Mar 09 05:31:54 INFO: vm is online again after 45 seconds
112: Mar 09 05:31:54 INFO: creating archive '/mnt/pve/qnap_nfs/dump/vzdump-openvz-112-2013_03_09-05_23_21.tar.lzo'
112: Mar 09 05:33:05 INFO: tar: ./usr/share/doc/xz-utils/extra: file changed as we read it
112: Mar 09 05:33:06 INFO: tar: ./usr/share/doc/libonig2: file changed as we read it
112: Mar 09 05:34:25 INFO: Total bytes written: 1469849600 (1.4GiB, 12MiB/s)
112: Mar 09 05:35:15 ERROR: Backup of VM 112 failed - command '(cd /mnt/pve/qnap_nfs/dump/vzdump-openvz-112-2013_03_09-05_23_21.tmp;find . '(' -regex '^\.$' ')' -o '(' -type 's' -prune ')' -o -print0|sed 's/\\/\\\\/g'|tar cpf - --totals --sparse --numeric-owner --no-recursion --one-file-system --null -T -|lzop) >/mnt/pve/qnap_nfs/dump/vzdump-openvz-112-2013_03_09-05_23_21.tar.dat' failed: exit code 1
 
Hi all,

The new backup functionality in 2.3 seems to fail backing up of CT's on NFS.

..

I doubt that the changes in the KVM backup affects container.

your log shows that you try LVM snapshot backup on NFS - this cannot work by design.

does it work before you upgrade to 2.3?
 
your log shows that you try LVM snapshot backup on NFS - this cannot work by design.
This is the automatic backup scheduler and not me making this decision. Could it be an idea to split the backup job in two separate schedules?

does it work before you upgrade to 2.3?
Before upgrade it was only CT 112 that failed, now it is every CT that fails.