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
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