INFO: starting new backup job: vzdump 102 --compress gzip --remove 0 --storage backupproxmox --mode snapshot --node pve1
INFO: Starting Backup of VM 102 (qemu)
INFO: status = running
INFO: update VM 102: -lock backup
INFO: VM Name: Dati-PDC
INFO: include disk 'virtio0' 'tankC_vm:vm-102-disk-1' 436G
INFO: backup mode: snapshot
INFO: ionice priority: 7
INFO: creating archive '/mnt/pve/backupproxmox/dump/vzdump-qemu-102-2017_11_30-22_40_38.vma.gz'
INFO: started backup task '0a2f3f71-0b7d-4f80-ae1c-276ef5a05741'
INFO: status: 0% (79691776/468151435264), sparse 0% (2179072), duration 3, read/write 26/25 MB/s
INFO: status: 1% (4689231872/468151435264), sparse 0% (99622912), duration 226, read/write 20/20 MB/s
INFO: status: 2% (9378463744/468151435264), sparse 0% (212942848), duration 397, read/write 27/26 MB/s
INFO: status: 3% (14080278528/468151435264), sparse 0% (619089920), duration 546, read/write 31/28 MB/s
INFO: status: 4% (18754568192/468151435264), sparse 0% (3953807360), duration 649, read/write 45/13 MB/s
INFO: status: 5% (23425187840/468151435264), sparse 0% (4053245952), duration 807, read/write 29/28 MB/s
INFO: status: 6% (28105244672/468151435264), sparse 0% (4195348480), duration 980, read/write 27/26 MB/s
INFO: status: 7% (32795262976/468151435264), sparse 0% (4412133376), duration 1141, read/write 29/27 MB/s
INFO: status: 8% (37455134720/468151435264), sparse 0% (4563718144), duration 1300, read/write 29/28 MB/s
INFO: status: 9% (42144366592/468151435264), sparse 1% (4714651648), duration 1455, read/write 30/29 MB/s
INFO: status: 10% (46850375680/468151435264), sparse 1% (4905521152), duration 1597, read/write 33/31 MB/s
INFO: status: 11% (51506053120/468151435264), sparse 1% (5254848512), duration 1749, read/write 30/28 MB/s
INFO: status: 12% (56191483904/468151435264), sparse 1% (5415575552), duration 1908, read/write 29/28 MB/s
INFO: status: 13% (60901031936/468151435264), sparse 1% (6436130816), duration 2043, read/write 34/27 MB/s
INFO: status: 14% (65576370176/468151435264), sparse 1% (7021178880), duration 2188, read/write 32/28 MB/s
INFO: status: 15% (70233620480/468151435264), sparse 1% (7281709056), duration 2323, read/write 34/32 MB/s
INFO: status: 16% (74948018176/468151435264), sparse 1% (7478743040), duration 2468, read/write 32/31 MB/s
INFO: status: 17% (79586918400/468151435264), sparse 1% (7556464640), duration 2618, read/write 30/30 MB/s
INFO: status: 18% (84281524224/468151435264), sparse 1% (7649583104), duration 2760, read/write 33/32 MB/s
INFO: status: 19% (88994742272/468151435264), sparse 1% (7754764288), duration 2911, read/write 31/30 MB/s
INFO: status: 20% (93658808320/468151435264), sparse 1% (7957606400), duration 3048, read/write 34/32 MB/s
INFO: status: 21% (98318942208/468151435264), sparse 1% (8089743360), duration 3193, read/write 32/31 MB/s
INFO: status: 22% (103024689152/468151435264), sparse 1% (8280485888), duration 3338, read/write 32/31 MB/s
INFO: status: 23% (107692949504/468151435264), sparse 1% (8424222720), duration 3478, read/write 33/32 MB/s
INFO: status: 24% (112403152896/468151435264), sparse 1% (8640598016), duration 3634, read/write 30/28 MB/s
INFO: status: 25% (117063024640/468151435264), sparse 1% (8863641600), duration 3781, read/write 31/30 MB/s
INFO: status: 26% (121769033728/468151435264), sparse 2% (9459040256), duration 3909, read/write 36/32 MB/s
INFO: status: 27% (126424711168/468151435264), sparse 2% (10143039488), duration 4018, read/write 42/36 MB/s
INFO: status: 28% (131101360128/468151435264), sparse 2% (10809589760), duration 4143, read/write 37/32 MB/s
INFO: status: 29% (135811563520/468151435264), sparse 2% (11438690304), duration 4264, read/write 38/33 MB/s
INFO: status: 30% (140471435264/468151435264), sparse 2% (12876460032), duration 4374, read/write 42/29 MB/s
INFO: status: 31% (145148084224/468151435264), sparse 2% (13202776064), duration 4501, read/write 36/34 MB/s
INFO: status: 32% (149820538880/468151435264), sparse 2% (14033166336), duration 4686, read/write 25/20 MB/s
INFO: status: 33% (154497187840/468151435264), sparse 3% (17178628096), duration 4774, read/write 53/17 MB/s
INFO: status: 34% (159199002624/468151435264), sparse 3% (17607106560), duration 4934, read/write 29/26 MB/s
INFO: status: 35% (163867262976/468151435264), sparse 3% (17994698752), duration 5092, read/write 29/27 MB/s
INFO: status: 36% (168569077760/468151435264), sparse 3% (18311147520), duration 5283, read/write 24/22 MB/s
INFO: status: 37% (173258309632/468151435264), sparse 3% (18366320640), duration 5478, read/write 24/23 MB/s
INFO: status: 38% (177918181376/468151435264), sparse 3% (18588598272), duration 5689, read/write 22/21 MB/s
INFO: status: 39% (182615670784/468151435264), sparse 4% (18827579392), duration 5881, read/write 24/23 MB/s
INFO: status: 40% (187275804672/468151435264), sparse 4% (19054723072), duration 6080, read/write 23/22 MB/s
INFO: status: 41% (191956516864/468151435264), sparse 4% (19364823040), duration 6284, read/write 22/21 MB/s
INFO: status: 42% (196630282240/468151435264), sparse 4% (19584491520), duration 6483, read/write 23/22 MB/s
INFO: status: 43% (201314009088/468151435264), sparse 4% (19843452928), duration 6696, read/write 21/20 MB/s
INFO: status: 44% (206015823872/468151435264), sparse 4% (20050599936), duration 6907, read/write 22/21 MB/s
INFO: status: 45% (210692472832/468151435264), sparse 4% (20823302144), duration 7086, read/write 26/21 MB/s
INFO: status: 46% (215358242816/468151435264), sparse 4% (21585588224), duration 7253, read/write 27/23 MB/s
INFO: status: 47% (220075130880/468151435264), sparse 4% (21944467456), duration 7438, read/write 25/23 MB/s
INFO: status: 48% (224726614016/468151435264), sparse 4% (22371872768), duration 7601, read/write 28/25 MB/s
INFO: status: 49% (229420040192/468151435264), sparse 4% (22794182656), duration 7784, read/write 25/23 MB/s
INFO: status: 50% (234086203392/468151435264), sparse 5% (26869133312), duration 7957, read/write 26/3 MB/s
INFO: status: 51% (238790115328/468151435264), sparse 5% (27205136384), duration 8126, read/write 27/25 MB/s
INFO: status: 52% (243479347200/468151435264), sparse 5% (27275993088), duration 8313, read/write 25/24 MB/s
INFO: status: 53% (248151801856/468151435264), sparse 5% (27665752064), duration 8505, read/write 24/22 MB/s
INFO: status: 54% (252817965056/468151435264), sparse 5% (27733467136), duration 8708, read/write 22/22 MB/s
INFO: status: 55% (257521876992/468151435264), sparse 5% (27889000448), duration 8872, read/write 28/27 MB/s
INFO: status: 56% (262177554432/468151435264), sparse 6% (28424269824), duration 9050, read/write 26/23 MB/s
INFO: status: 57% (266850009088/468151435264), sparse 6% (28647444480), duration 9233, read/write 25/24 MB/s
INFO: status: 58% (271564406784/468151435264), sparse 6% (28904194048), duration 9439, read/write 22/21 MB/s
INFO: status: 59% (276221263872/468151435264), sparse 6% (29134483456), duration 9615, read/write 26/25 MB/s
INFO: status: 60% (280917704704/468151435264), sparse 6% (29456986112), duration 9782, read/write 28/26 MB/s
INFO: status: 61% (285613752320/468151435264), sparse 6% (29854695424), duration 9970, read/write 24/22 MB/s
INFO: status: 62% (290254225408/468151435264), sparse 6% (30082412544), duration 10154, read/write 25/23 MB/s
INFO: status: 63% (294972817408/468151435264), sparse 6% (30665699328), duration 10290, read/write 34/30 MB/s
INFO: status: 64% (299628494848/468151435264), sparse 7% (35321376768), duration 10374, read/write 55/0 MB/s
INFO: status: 65% (304313532416/468151435264), sparse 8% (40006414336), duration 10526, read/write 30/0 MB/s
INFO: status: 66% (309002764288/468151435264), sparse 9% (44695646208), duration 10605, read/write 59/0 MB/s
INFO: status: 67% (313717161984/468151435264), sparse 10% (49410043904), duration 10686, read/write 58/0 MB/s
INFO: status: 68% (318381228032/468151435264), sparse 11% (54074109952), duration 10772, read/write 54/0 MB/s
INFO: status: 69% (323062071296/468151435264), sparse 12% (58754953216), duration 10854, read/write 57/0 MB/s
INFO: status: 70% (327772274688/468151435264), sparse 13% (63465156608), duration 10935, read/write 58/0 MB/s
INFO: status: 71% (332411174912/468151435264), sparse 14% (68104056832), duration 11013, read/write 59/0 MB/s
INFO: status: 72% (337125572608/468151435264), sparse 15% (72818454528), duration 11092, read/write 59/0 MB/s
INFO: status: 73% (341751889920/468151435264), sparse 16% (77444771840), duration 11173, read/write 57/0 MB/s
INFO: status: 74% (346436927488/468151435264), sparse 17% (82129809408), duration 11245, read/write 65/0 MB/s
INFO: status: 75% (351142936576/468151435264), sparse 18% (86835818496), duration 11376, read/write 35/0 MB/s
INFO: status: 76% (355819585536/468151435264), sparse 19% (91512467456), duration 11611, read/write 19/0 MB/s
INFO: status: 77% (360521400320/468151435264), sparse 20% (96214282240), duration 11700, read/write 52/0 MB/s
INFO: status: 78% (365202243584/468151435264), sparse 21% (100895125504), duration 11780, read/write 58/0 MB/s
INFO: status: 79% (369883086848/468151435264), sparse 22% (105575968768), duration 11861, read/write 57/0 MB/s
INFO: status: 80% (374589095936/468151435264), sparse 23% (110281977856), duration 11941, read/write 58/0 MB/s
INFO: status: 81% (379240579072/468151435264), sparse 24% (114933460992), duration 12024, read/write 56/0 MB/s
INFO: status: 82% (383917228032/468151435264), sparse 25% (119610109952), duration 12105, read/write 57/0 MB/s
INFO: status: 83% (388606459904/468151435264), sparse 26% (124299341824), duration 12184, read/write 59/0 MB/s
INFO: status: 84% (393257943040/468151435264), sparse 27% (128950824960), duration 12247, read/write 73/0 MB/s
INFO: status: 85% (397993312256/468151435264), sparse 28% (133686194176), duration 12312, read/write 72/0 MB/s
INFO: status: 86% (402632212480/468151435264), sparse 29% (138325094400), duration 12376, read/write 72/0 MB/s
INFO: status: 87% (407350804480/468151435264), sparse 30% (143043686400), duration 12442, read/write 71/0 MB/s
INFO: status: 88% (412006481920/468151435264), sparse 31% (147699363840), duration 12506, read/write 72/0 MB/s
INFO: status: 89% (416691519488/468151435264), sparse 32% (152384401408), duration 12572, read/write 70/0 MB/s
INFO: status: 90% (421343002624/468151435264), sparse 33% (157035884544), duration 12637, read/write 71/0 MB/s
INFO: status: 91% (426061594624/468151435264), sparse 34% (161754476544), duration 12703, read/write 71/0 MB/s
INFO: status: 92% (430759215104/468151435264), sparse 35% (166452097024), duration 12768, read/write 72/0 MB/s
INFO: status: 93% (435406503936/468151435264), sparse 36% (171099385856), duration 12835, read/write 69/0 MB/s
INFO: status: 94% (440087347200/468151435264), sparse 37% (175780229120), duration 12901, read/write 70/0 MB/s
INFO: status: 95% (444784967680/468151435264), sparse 38% (180477849600), duration 12969, read/write 69/0 MB/s
INFO: status: 96% (449499365376/468151435264), sparse 39% (185192247296), duration 13037, read/write 69/0 MB/s
INFO: status: 97% (454176014336/468151435264), sparse 40% (189868896256), duration 13104, read/write 69/0 MB/s
INFO: status: 98% (458810720256/468151435264), sparse 41% (194503602176), duration 13172, read/write 68/0 MB/s
INFO: status: 99% (463483174912/468151435264), sparse 42% (199176056832), duration 13245, read/write 64/0 MB/s
INFO: status: 100% (468151435264/468151435264), sparse 43% (203844313088), duration 13320, read/write 62/0 MB/s
INFO: transferred 468151 MB in 13320 seconds (35 MB/s)
INFO: archive file size: 165.43GB
INFO: Finished Backup of VM 102 (03:42:03)
INFO: Backup job finished successfully
TASK OK