Backup results...

nick

Renowned Member
Mar 28, 2007
364
1
83
Hi all,

I look to the mail that I receive after a backup procedure for a Windows SBS 2008 64bit and the results are:

Code:
105: Aug 17 20:00:02 INFO: Starting Backup of VM 105 (qemu)
105: Aug 17 20:00:02 INFO: status = running
105: Aug 17 20:00:03 INFO: trying to remove stale snapshot '/dev/pve/vzsnap'
105: Aug 17 20:00:03 INFO: umount: /mnt/vzsnap: not mounted
105: Aug 17 20:00:03 INFO: command 'umount /mnt/vzsnap' failed with exit code 1
105: Aug 17 20:00:03 INFO:   /dev/dm-5: read failed after 0 of 4096 at 0: Input/output error
105: Aug 17 20:00:03 INFO:   Logical volume "vzsnap" successfully removed
105: Aug 17 20:00:03 INFO: creating lvm snapshot of /dev/mapper/pve-data ('/dev/pve/vzsnap')
105: Aug 17 20:00:03 INFO:   /dev/dm-2: stat failed: No such file or directory
105: Aug 17 20:00:03 INFO:   Path /dev/dm-2 no longer valid for device(254,2)
105: Aug 17 20:00:03 INFO:   /dev/disk/by-id/dm-name-pve-data-real: stat failed: No such file or directory
105: Aug 17 20:00:03 INFO:   Path /dev/disk/by-id/dm-name-pve-data-real no longer valid for device(254,2)
105: Aug 17 20:00:03 INFO:   /dev/disk/by-id/dm-uuid-LVM-aiwaGYnsA5CQmgbL1CsjOdAbf9GUyZQDfISBli3DmDWYpj1WCI1uXvgjdQb0kZE6-real: stat failed: No such file or directory
105: Aug 17 20:00:03 INFO:   Path /dev/disk/by-id/dm-uuid-LVM-aiwaGYnsA5CQmgbL1CsjOdAbf9GUyZQDfISBli3DmDWYpj1WCI1uXvgjdQb0kZE6-real no longer valid for device(254,2)
105: Aug 17 20:00:04 INFO:   Logical volume "vzsnap" created
105: Aug 17 20:00:04 INFO: mounting lvm snapshot
105: Aug 17 20:00:04 INFO: creating archive '/backup/SBS/vzdump-105.dat' (/mnt/vzsnap/images/105)
105: Aug 17 20:00:04 INFO: qemu-server.conf
105: Aug 17 20:00:04 INFO: vm-105-disk.qcow2
105: Aug 17 20:45:22 INFO: tar: vm-105-disk.qcow2: File shrank by 37829197824 bytes; padding with zeros
105: Aug 17 20:58:08 INFO: Total bytes written: 67318016000 (63GiB, 19MiB/s)
105: Aug 17 20:58:08 INFO: file size 14.51GB
105: Aug 17 20:58:19 INFO:   /dev/dm-2: read failed after 0 of 4096 at 0: Input/output error
105: Aug 17 20:58:20 INFO:   Logical volume "vzsnap" successfully removed
105: Aug 17 20:58:20 INFO: Finished Backup of VM 105 (00:58:18)
This is normal? All the time I receive a succesful backup...but I'm not 100% sure about this!

Thnak you!
 
What is the output of

# vgs

and

# lvs

Please can you post that?

Is that a standard install or did you modify something?
 
Code:
 vgs
  VG   #PV #LV #SN Attr   VSize   VFree
  pve    1   3   0 wz--n- 465.26G 4.00G
Code:
lvs
  LV   VG   Attr   LSize   Origin Snap%  Move Log Copy%  Convert
  data pve  -wi-ao 352.26G
  root pve  -wi-ao  96.00G
  swap pve  -wi-ao  13.00G
Code:
 pveversion
pve-manager/1.3/4023
It's a standard instalation from 0.9 (or 1.0 I think) updated all the time.

For backup I have mounted another 250GB disk.
 
Other backups are OK (for 2 XP 1 Vista and 1 Windows 2003 SBS). Only for this machine I receive these messages.

The disk is OK...in logs I don't see anything

How I can check the disk? Any advice?
 
Last edited:
Other backups are OK (for 2 XP 1 Vista and 1 Windows 2003 SBS). Only for this machine I receive these messages.

The disk is OK...in logs I don't see anything

How I can check the disk? Any advice?

use a hard disk diagnostic tool (see the website form seagate or whatever you got) - or third party, using a live-boot-cd.
 
this is a backup result for onother machine on the same server:

Code:
101: Aug 20 01:00:01 INFO: Starting Backup of VM 101 (qemu)
101: Aug 20 01:00:02 INFO: status = running
101: Aug 20 01:00:03 INFO: creating lvm snapshot of /dev/mapper/pve-data ('/dev/pve/vzsnap')
101: Aug 20 01:00:04 INFO:   Logical volume "vzsnap" created
101: Aug 20 01:00:04 INFO: mounting lvm snapshot
101: Aug 20 01:00:04 INFO: creating archive '/backup/zimbra/vzdump-101.dat' (/mnt/vzsnap/images/101)
101: Aug 20 01:00:05 INFO: qemu-server.conf
101: Aug 20 01:00:05 INFO: vm-101-disk.qcow2
101: Aug 20 01:19:14 INFO: Total bytes written: 12050862080 (12GiB, 10MiB/s)
101: Aug 20 01:19:14 INFO: file size 11.22GB
101: Aug 20 01:20:48 INFO:   Logical volume "vzsnap" successfully removed
101: Aug 20 01:20:49 INFO: Finished Backup of VM 101 (00:20:48)
no errors....

Maybe it's a size error? The SBS2008 machine have more then 75GB...
 
Hi All,

I come back with my fisrt conclusions; I make some investigations on both Hard Disk's but no errors found. Then I see that on backup disk was available less then 75GB. I delete some old backups from other machines and now the backup finish normaly.

Code:
105: Aug 26 20:00:03 INFO: Starting Backup of VM 105 (qemu)
105: Aug 26 20:00:03 INFO: status = running
105: Aug 26 20:00:03 INFO: creating lvm snapshot of /dev/mapper/pve-data ('/dev/pve/vzsnap')
105: Aug 26 20:00:04 INFO:   Logical volume "vzsnap" created
105: Aug 26 20:00:04 INFO: mounting lvm snapshot
105: Aug 26 20:00:05 INFO: creating archive '/backup/SBS/vzdump-105.dat' (/mnt/vzsnap/images/105)
105: Aug 26 20:00:05 INFO: qemu-server.conf
105: Aug 26 20:00:05 INFO: vm-105-disk.qcow2
105: Aug 26 21:27:21 INFO: Total bytes written: 67537838080 (63GiB, 13MiB/s)
105: Aug 26 21:27:21 INFO: file size 29.47GB
105: Aug 26 21:28:11 INFO:   Logical volume "vzsnap" successfully removed
105: Aug 26 21:28:11 INFO: Finished Backup of VM 105 (01:28:08)
So, for people who receive simillar errors these was a first sollution. Check the free space on backup disk or backup partition.
 
HI All,

I come back with problems on backup for SBS 2008 64bit;

I present last 2 backup logs:

Backup 1:
Code:
VMIDNAMESTATUSTIMESIZEFILENAME 105SBS2008OK02:26:3633.41GB/backup/SBS/vzdump-qemu-105-2009_11_01-09_10_02.tgz TOTAL02:26:3733.41GB


Detailed backup logs:

vzdump --quiet --snapshot --compress --storage SBS2008 --mailto xxxx@xxxx.com --mailto xxxx@xxx.com 105

105: Nov 01 09:10:02 INFO: Starting Backup of VM 105 (qemu)
105: Nov 01 09:10:02 INFO: running
105: Nov 01 09:10:02 INFO: status = running
105: Nov 01 09:10:03 INFO: backup mode: snapshot
105: Nov 01 09:10:03 INFO: bandwidth limit: 10240 KB/s
105: Nov 01 09:10:03 INFO:   Logical volume "vzsnap-veCallatis-0" created
105: Nov 01 09:10:04 INFO: creating archive '/backup/SBS/vzdump-qemu-105-2009_11_01-09_10_02.tgz'
105: Nov 01 09:10:04 INFO: adding '/backup/SBS/vzdump-qemu-105-2009_11_01-09_10_02.tmp/qemu-server.conf' to archive ('qemu-server.conf')
105: Nov 01 09:10:04 INFO: adding '/mnt/vzsnap0/images/105/vm-105-disk.qcow2' to archive ('vm-disk-ide0.qcow2')
105: Nov 01 11:36:36 INFO: Total bytes written: 73555982336 (7.98 MiB/s)
105: Nov 01 11:36:36 INFO: archive file size: 33.41GB
105: Nov 01 11:36:38 INFO:   Logical volume "vzsnap-veCallatis-0" successfully removed
105: Nov 01 11:36:38 INFO: Finished Backup of VM 105 (02:26:36)
Now the last backup:

Code:
VMIDNAMESTATUSTIMESIZEFILENAME 105SBS2008[COLOR=red]FAILED[/COLOR]27:03:06command '/usr/lib/qemu-server/vmtar '/backup/SBS/vzdump-qemu-105-2009_11_04-02_00_05.tmp/qemu-server.conf' 'qemu-server.conf' '/mnt/vzsnap0/images/105/vm-105-disk.qcow2' 'vm-disk-ide0.qcow2' |gzip |cstream -t 10485760 >/backup/SBS/vzdump-qemu-105-2009_11_04-02_00_05.dat' failed with exit code 2 TOTAL27:03:060KB


Detailed backup logs:

vzdump --quiet --snapshot --compress --storage SBS2008 --mailto xxx@xxx.com --mailto xxx@xxx.com 105

105: Nov 04 02:00:05 INFO: Starting Backup of VM 105 (qemu)
105: Nov 04 02:00:05 INFO: running
105: Nov 04 02:00:05 INFO: status = running
105: Nov 04 02:00:07 INFO: backup mode: snapshot
105: Nov 04 02:00:07 INFO: bandwidth limit: 10240 KB/s
105: Nov 04 02:00:09 INFO:   Logical volume "vzsnap-veCallatis-0" created
105: Nov 04 02:00:09 INFO: creating archive '/backup/SBS/vzdump-qemu-105-2009_11_04-02_00_05.tgz'
105: Nov 04 02:00:09 INFO: adding '/backup/SBS/vzdump-qemu-105-2009_11_04-02_00_05.tmp/qemu-server.conf' to archive ('qemu-server.conf')
105: Nov 04 02:00:09 INFO: adding '/mnt/vzsnap0/images/105/vm-105-disk.qcow2' to archive ('vm-disk-ide0.qcow2')
105: Nov 05 04:59:00 INFO: 141798834176 B 132.1 GB 97130.5 s (26:58 h) 1459880 B/s 1.39 MB/s
105: Nov 05 04:59:00 INFO: write: No space left on device
105: Nov 05 04:59:00 INFO: received signal - terminate process
105: Nov 05 04:59:04 INFO:   Logical volume "vzsnap-veCallatis-0" successfully removed
105: [COLOR=red]Nov 05 05:03:11 ERROR: Backup of VM 105 failed - command '/usr/lib/qemu-server/vmtar '/backup/SBS/vzdump-qemu-105-2009_11_04-02_00_05.tmp/qemu-server.conf' 'qemu-server.conf' '/mnt/vzsnap0/images/105/vm-105-disk.qcow2' 'vm-disk-ide0.qcow2' |gzip |cstream -t 10485760 >/backup/SBS/vzdump-qemu-105-2009_11_04-02_00_05.dat' failed with exit code 2
[/COLOR]
I realy don't understand what happen here! Why 3 days ago the backup was OK and after that...with error!
The hardware it's OK!
 
yes...but the error appear after 25 hours....this is the reason that I'm worry about the situation! Why?
 
Maybe the disk is full and totally fragmented?

but why one time work correct and after that not...the disk is the same...and the space not change...

Now I will add another disk special for this backup...500GB...I hope will be OK.
I will post the results!