Backup hangs on successful transfer

C

Chiaki

Renowned Member
Jun 20, 2015
18
1
68
Hello everyone.

When manually backing up I sometimes get this:

Code: 
[COLOR=#000000][FONT=tahoma]INFO: starting new backup job: vzdump 100 --remove 0 --mode snapshot --compress gzip --storage ftpbackup --node ns335677[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: Starting Backup of VM 100 (qemu)[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status = running[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: update VM 100: -lock backup[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: backup mode: snapshot[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: ionice priority: 7[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: creating archive '/mnt/ftp-backup/dump/vzdump-qemu-100-2015_06_21-02_07_08.vma.gz'[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: started backup task '685bff14-ab2d-4d70-8080-4498f8896860'[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 0% (178651136/42949672960), sparse 0% (125730816), duration 3, 59/17 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 1% (433324032/42949672960), sparse 0% (151310336), duration 25, 11/10 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 2% (859045888/42949672960), sparse 0% (182665216), duration 65, 10/9 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 3% (1288568832/42949672960), sparse 0% (248954880), duration 97, 13/11 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 4% (1725693952/42949672960), sparse 0% (302653440), duration 139, 10/9 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 5% (2193227776/42949672960), sparse 0% (421228544), duration 171, 14/10 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 6% (2577137664/42949672960), sparse 1% (531222528), duration 206, 10/7 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 8% (3722641408/42949672960), sparse 3% (1422209024), duration 250, 26/5 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 10% (4492886016/42949672960), sparse 4% (2128969728), duration 253, 256/21 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 15% (6702956544/42949672960), sparse 10% (4295217152), duration 256, 736/14 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 20% (8784314368/42949672960), sparse 14% (6314479616), duration 259, 693/20 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 25% (10892017664/42949672960), sparse 19% (8392560640), duration 262, 702/9 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 26% (11361189888/42949672960), sparse 20% (8792731648), duration 266, 117/17 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 30% (13071941632/42949672960), sparse 24% (10446118912), duration 269, 570/19 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 35% (15078916096/42949672960), sparse 28% (12414099456), duration 272, 668/12 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 39% (16986013696/42949672960), sparse 32% (14135218176), duration 279, 272/26 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 40% (17332961280/42949672960), sparse 33% (14456766464), duration 282, 115/8 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 44% (18932891648/42949672960), sparse 37% (15984414720), duration 298, 99/4 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 45% (19499515904/42949672960), sparse 38% (16506306560), duration 301, 188/14 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 50% (21483749376/42949672960), sparse 42% (18334117888), duration 314, 152/12 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 51% (22032744448/42949672960), sparse 43% (18772062208), duration 319, 109/22 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 55% (23787208704/42949672960), sparse 47% (20491984896), duration 322, 584/11 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 56% (24057085952/42949672960), sparse 47% (20514455552), duration 349, 9/9 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 57% (24490409984/42949672960), sparse 47% (20542722048), duration 400, 8/7 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 58% (25161629696/42949672960), sparse 48% (20976160768), duration 429, 23/8 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 65% (28059631616/42949672960), sparse 55% (23867703296), duration 432, 966/2 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 75% (32252231680/42949672960), sparse 65% (28048490496), duration 435, 1397/3 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 78% (33546240000/42949672960), sparse 67% (29179117568), duration 470, 36/4 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 91% (39222575104/42949672960), sparse 81% (34855444480), duration 473, 1892/0 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: status: 100% (42949672960/42949672960), sparse 89% (38582542336), duration 475, 1863/0 MB/s[/FONT][/COLOR]
[COLOR=#000000][FONT=tahoma]INFO: transferred 42949 MB in 475 seconds (90 MB/s)[/FONT][/COLOR]

So it says everything is transferred and the dump is also complete and usable for a restore but the job doesn't finish.
I don't know how to kill it and I need to restart the whole server together with all the VMs that are running and doing their job. This is not good.

Any ideas how I can resolve this? I didn't encounter this problem for scheduled backups yet.

I use gzip compression and a locally mounted ftp-drive which is on the same server rack. (No other protocol availiable for the backup-space)

Thanks for reading.

EDIT: I stand corrected. THIS time the backup file doesn't appear in the web interface and the backup file isn't complete. It says .vma.dat instead of .vma.gz but it reached a file size that should be appropriate. Is there some way to debug the problem? I can't find any hint in syslog.
 
Last edited:
Doesn't anyone have an idea what the cause might be? Maybe it's the curl ftp mount solution?
 
You must log in or register to reply here.
Top Bottom
Back