Backups servers Loops

H

hemant

Member
Feb 28, 2022
9
0
6
52
Hi All,

I installed a fresh server in proxmox 7 VE with a VM. Addes my storage (NFS on synology) and scheduled a backup.
My schedule is Mon-Friday @ 14:00 and retention is set to last 2 backups.

When the backup starts (takes about 5 min) it restarts again once backup is completed while Next run is scheduled for the next they it continuously backups my VM.
While I don't have a job that backups constantly but only once a days.

Does anyone know why is?

Hemant
 
ok looks normal enough, can you also post the task logs of some of those backup jobs? (the first few lines (~10-20) each should be enough)
 
no i meant the content of the task logs. please double click on a task and copy the first few lines
please post those of 2 or 3 tasks

also what i just noticed:

hemant said:
I installed a fresh server in proxmox 7 VE with a VM.
Click to expand...
can you show the output of 'pveversion -v' ? maybe do an upgrade to the latest 7.0 version?
 
ok her tasklog:

Initial job:
INFO: starting new backup job: vzdump 100 --mailnotification always --node proxmox --compress zstd --mode snapshot --mailto XXX --all 0 --storage HAGPAZ1-S-10
INFO: Starting Backup of VM 100 (qemu)
INFO: Backup started at 2022-02-28 16:02:51
INFO: status = running
INFO: VM Name: HAGPAZ1-S-07
INFO: include disk 'sata0' 'local:100/vm-100-disk-0.raw' 52M
INFO: include disk 'sata1' 'local:100/vm-100-disk-1.raw' 25G
INFO: backup mode: snapshot
INFO: ionice priority: 7
INFO: creating vzdump archive '/mnt/pve/HAGPAZ1-S-10/dump/vzdump-qemu-100-2022_02_28-16_02_51.vma.zst'
INFO: started backup task 'fa8b001d-b440-40ff-b680-4f5238ffd017'
INFO: resuming VM again
INFO: backup is sparse: 17.56 GiB (70%) total zero data
INFO: transferred 25.05 GiB in 222 seconds (115.5 MiB/s)
INFO: archive file size: 2.90GB
INFO: prune older backups with retention: keep-last=2
INFO: removing backup 'HAGPAZ1-S-10:backup/vzdump-qemu-100-2022_02_28-16_02_51.vma.zst'
INFO: pruned 1 backup(s) not covered by keep-retention policy
INFO: Finished Backup of VM 100 (00:03:44)
INFO: Backup finished at 2022-02-28 16:15:02
INFO: Backup job finished successfully
TASK OK

Once finished restarts:
INFO: starting new backup job: vzdump 100 --storage HAGPAZ1-S-10 --compress zstd --quiet 1 --mailto xxx --node proxmox --prune-backups 'keep-last=2' --mode snapshot --mailnotification always
INFO: Starting Backup of VM 100 (qemu)
INFO: Backup started at 2022-02-28 16:07:19
INFO: status = running
INFO: VM Name: HAGPAZ1-S-07
INFO: include disk 'sata0' 'local:100/vm-100-disk-0.raw' 52M
INFO: include disk 'sata1' 'local:100/vm-100-disk-1.raw' 25G
INFO: backup mode: snapshot
INFO: ionice priority: 7
INFO: creating vzdump archive '/mnt/pve/HAGPAZ1-S-10/dump/vzdump-qemu-100-2022_02_28-16_07_19.vma.zst'
INFO: started backup task '4bbd0b5d-775f-40e5-b110-1a12d6d02355'
INFO: resuming VM again
INFO: backup is sparse: 17.56 GiB (70%) total zero data
INFO: transferred 25.05 GiB in 220 seconds (116.6 MiB/s)
INFO: archive file size: 2.91GB
INFO: prune older backups with retention: keep-last=2
INFO: removing backup 'HAGPAZ1-S-10:backup/vzdump-qemu-100-2022_02_28-15_00_04.vma.zst'
INFO: removing backup 'HAGPAZ1-S-10:backup/vzdump-qemu-100-2022_02_28-15_04_04.vma.zst'
INFO: removing backup 'HAGPAZ1-S-10:backup/vzdump-qemu-100-2022_02_28-15_08_29.vma.zst'
INFO: removing backup 'HAGPAZ1-S-10:backup/vzdump-qemu-100-2022_02_28-15_17_03.vma.zst'
INFO: removing backup 'HAGPAZ1-S-10:backup/vzdump-qemu-100-2022_02_28-15_36_17.vma.zst'
INFO: pruned 5 backup(s) not covered by keep-retention policy
INFO: Finished Backup of VM 100 (00:03:50)
INFO: Backup finished at 2022-02-28 16:11:09
INFO: Backup job finished successfully
TASK OK

And again:
INFO: starting new backup job: vzdump 100 --quiet 1 --storage HAGPAZ1-S-10 --compress zstd --prune-backups 'keep-last=2' --mode snapshot --mailnotification always --mailto xxx --node proxmox
INFO: Starting Backup of VM 100 (qemu)
INFO: Backup started at 2022-02-28 16:11:18
INFO: status = running
INFO: VM Name: HAGPAZ1-S-07
INFO: include disk 'sata0' 'local:100/vm-100-disk-0.raw' 52M
INFO: include disk 'sata1' 'local:100/vm-100-disk-1.raw' 25G
INFO: backup mode: snapshot
INFO: ionice priority: 7
INFO: creating vzdump archive '/mnt/pve/HAGPAZ1-S-10/dump/vzdump-qemu-100-2022_02_28-16_11_18.vma.zst'
INFO: started backup task 'abde2b00-b957-48c0-8acb-e7134e6de2d1'
INFO: resuming VM again
INFO: backup is sparse: 17.56 GiB (70%) total zero data
INFO: transferred 25.05 GiB in 213 seconds (120.4 MiB/s)
INFO: archive file size: 2.90GB
INFO: Finished Backup of VM 100 (00:03:34)
INFO: Backup finished at 2022-02-28 16:06:25
INFO: Backup job finished successfully
TASK OK


Currently disabled the job
 
Last edited:
can you post the output of
Code: 
cat /etc/pve/jobs.cfg
cat /var/lib/pve-manager/jobs/vzdump-backup-*.json
 
Hi Sure:

vzdump: backup-adce29aa-699b
schedule mon..fri 14:00
compress zstd
enabled 0
mailnotification always
mailto xxxxxxx
mode snapshot
node proxmox
prune-backups keep-last=2
storage HAGPAZ1-S-10
vmid 100

and:

{"msg":"OK","state":"stopped","upid":"UPID:proxmox:000E2B95:0295E20C:621CEBF3:vzdump:100:root@pam:","updated":1646064327}root@proxmox:~



Job is disabled at the moment.

Cheers,
Hemant
 
looks all normal... can you post the journal from a time where it ran multiple times? maybe there is something useful in there...
 
you can print the journal with 'journalctl' and can limit it to a timeframe with the '--since' and '--until' options
 
thanks!

Here you go!

Feb 28 14:00:02 proxmox pvescheduler[904827]: <root@pam> starting task UPID:proxmox:000DCE7C:02879306:621CC752:vzdump:100:root@pam:
Feb 28 14:00:02 proxmox pvescheduler[904828]: INFO: starting new backup job: vzdump 100 --prune-backups 'keep-last=2' --mailnotificati>
Feb 28 14:00:03 proxmox pvescheduler[904828]: INFO: Starting Backup of VM 100 (qemu)
Feb 28 14:02:31 proxmox postfix/qmgr[1398]: 4052315FCAE: from=<root@mail.@xxxxxxxx.net>, size=12969, nrcpt=1 (queue active)
Feb 28 14:02:31 proxmox postfix/smtp[905224]: warning: relayhost configuration problem
Feb 28 14:02:31 proxmox postfix/smtp[905224]: 4052315FCAE: to=<xxxxx@@xxxxxxxx.net>, relay=none, delay=323943, delays=323943/0.38/0.01/0,>
Feb 28 14:04:08 proxmox pvescheduler[904828]: INFO: Finished Backup of VM 100 (00:04:05)
Feb 28 14:04:08 proxmox pvescheduler[904828]: INFO: Backup job finished successfully
Feb 28 14:04:08 proxmox postfix/pickup[894493]: 83FB515FCC7: uid=0 from=<root>
Feb 28 14:04:08 proxmox postfix/cleanup[905475]: 83FB515FCC7: message-id=<20220228130408.83FB515FCC7@proxmox.@xxxxxxxx.net>
Feb 28 14:04:08 proxmox postfix/qmgr[1398]: 83FB515FCC7: from=<root@mail.@xxxxxxxx.net>, size=13599, nrcpt=1 (queue active)
Feb 28 14:04:08 proxmox postfix/smtp[905224]: warning: relayhost configuration problem
Feb 28 14:04:08 proxmox postfix/smtp[905224]: 83FB515FCC7: to=<xxxxx@@xxxxxxxx.net>, relay=none, delay=0.06, delays=0.05/0/0/0, dsn=4.3.5>
Feb 28 14:04:41 proxmox pvedaemon[1434]: <root@pam> successful auth for user 'root@pam'
Feb 28 14:05:02 proxmox pvescheduler[905589]: <root@pam> starting task UPID:proxmox:000DD176:0288083C:621CC87E:vzdump:100:root@pam:
Feb 28 14:05:02 proxmox pvescheduler[905590]: INFO: starting new backup job: vzdump 100 --mode snapshot --mailnotification always --pr>
Feb 28 14:05:02 proxmox pvescheduler[905590]: INFO: Starting Backup of VM 100 (qemu)
Feb 28 14:09:09 proxmox pvescheduler[905590]: INFO: Finished Backup of VM 100 (00:04:07)
Feb 28 14:09:09 proxmox pvescheduler[905590]: INFO: Backup job finished successfully
Feb 28 14:09:09 proxmox postfix/pickup[894493]: DF5BF15FCCC: uid=0 from=<root>
Feb 28 14:09:09 proxmox postfix/cleanup[906220]: DF5BF15FCCC: message-id=<20220228130909.DF5BF15FCCC@proxmox.@xxxxxxxx.net>
Feb 28 14:09:09 proxmox postfix/qmgr[1398]: DF5BF15FCCC: from=<root@mail.@xxxxxxxx.net>, size=13603, nrcpt=1 (queue active)
Feb 28 14:09:09 proxmox postfix/smtp[906222]: warning: relayhost configuration problem
Feb 28 14:09:09 proxmox postfix/smtp[906222]: DF5BF15FCCC: to=<xxxxx@@xxxxxxxx.net>, relay=none, delay=0.08, delays=0.05/0.03/0.01/0, dsn>
Feb 28 14:10:02 proxmox pvescheduler[906336]: <root@pam> starting task UPID:proxmox:000DD461:02887D85:621CC9AA:vzdump:100:root@pam:
Feb 28 14:10:02 proxmox pvescheduler[906337]: INFO: starting new backup job: vzdump 100 --mailnotification always --mode snapshot --pr>
Feb 28 14:10:03 proxmox pvescheduler[906337]: INFO: Starting Backup of VM 100 (qemu)
Feb 28 14:12:31 proxmox postfix/qmgr[1398]: 83FB515FCC7: from=<root@mail.@xxxxxxxx.net>, size=13599, nrcpt=1 (queue active)
Feb 28 14:12:31 proxmox postfix/smtp[906722]: warning: relayhost configuration problem
Feb 28 14:12:31 proxmox postfix/smtp[906722]: 83FB515FCC7: to=<xxxxx@xxxx>, relay=none, delay=503, delays=503/0.2/0.01/0, dsn=4.>
Feb 28 14:14:00 proxmox pvescheduler[906337]: INFO: Finished Backup of VM 100 (00:03:57)
 
mhmm nothing out of the ordinary here (beside that it runs every 5 min...)
does the 'next run' column in the backup list work correctly ? (as in, what is the next time it shows?)

i really have no idea whats going wrong here, it's like the calculation of the next event is broken somehow...
can you post the full output of 'pveversion -v' maybe?
 
You must log in or register to reply here.

About

The Proxmox community has been around for many years and offers help and support for Proxmox VE, Proxmox Backup Server, and Proxmox Mail Gateway.
We think our community is one of the best thanks to people like you!

Quick Navigation

Home Get Subscription Wiki Downloads Proxmox Customer Portal About

Get your subscription!

The Proxmox team works very hard to make sure you are running the best software and getting stable updates and security enhancements, as well as quick enterprise support. Tens of thousands of happy customers have a Proxmox subscription. Get yours easily in our online shop.

Buy now!
Community platform by XenForo® © 2010-2024 XenForo Ltd.
Top Bottom