VM 101 qmp command 'query-backup' failed - got wrong command id '1445:1533386' (expected 1820:323758)

skmdab

New Member
Feb 27, 2022
9
0
1
33
Detailed backup logs:



101: 2022-05-03 10:35:22 INFO: Starting Backup of VM 101 (qemu)
101: 2022-05-03 10:35:22 INFO: status = stopped
101: 2022-05-03 10:35:22 INFO: backup mode: stop
101: 2022-05-03 10:35:22 INFO: ionice priority: 7
101: 2022-05-03 10:35:22 INFO: VM Name: NAS
101: 2022-05-03 10:35:22 INFO: include disk 'ide0' 'SSD:101/vm-101-disk-0.raw' 100G
101: 2022-05-03 10:35:22 INFO: exclude disk 'ide1' 'SSD:101/vm-101-disk-1.qcow2' (backup=no)
101: 2022-05-03 10:35:22 INFO: include disk 'ide2' 'HDD:101/vm-101-disk-0.qcow2' 7T
101: 2022-05-03 10:35:22 INFO: creating vzdump archive '/mnt/pve/bkp-NAS/dump/vzdump-qemu-101-2022_05_03-10_35_22.vma.zst'
101: 2022-05-03 10:35:22 INFO: starting kvm to execute backup task
101: 2022-05-03 10:35:24 INFO: started backup task '51ad836b-3cb5-45b9-b895-3a8e90f651b9'
101: 2022-05-03 10:35:27 INFO: 0% (0.0 B of 7.1 TiB) in 3s, read: 0 B/s, write: 0 B/s
101: 2022-05-03 11:08:21 INFO: 1% (72.7 GiB of 7.1 TiB) in 32m 57s, read: 37.7 MiB/s, write: 36.8 MiB/s
101: 2022-05-03 11:22:27 INFO: 2% (145.5 GiB of 7.1 TiB) in 47m 3s, read: 88.0 MiB/s, write: 87.9 MiB/s
101: 2022-05-03 12:58:45 INFO: 3% (218.0 GiB of 7.1 TiB) in 2h 23m 21s, read: 12.9 MiB/s, write: 12.8 MiB/s
101: 2022-05-03 14:54:24 INFO: 4% (290.7 GiB of 7.1 TiB) in 4h 19m, read: 10.7 MiB/s, write: 10.7 MiB/s
101: 2022-05-03 16:58:04 INFO: 5% (363.4 GiB of 7.1 TiB) in 6h 22m 40s, read: 10.0 MiB/s, write: 10.0 MiB/s
101: 2022-05-03 19:18:52 INFO: 6% (436.1 GiB of 7.1 TiB) in 8h 43m 28s, read: 8.8 MiB/s, write: 8.8 MiB/s
101: 2022-05-03 20:29:55 INFO: 7% (508.8 GiB of 7.1 TiB) in 9h 54m 31s, read: 17.5 MiB/s, write: 17.4 MiB/s
101: 2022-05-03 22:08:37 INFO: 8% (581.4 GiB of 7.1 TiB) in 11h 33m 13s, read: 12.6 MiB/s, write: 12.5 MiB/s
101: 2022-05-04 00:17:12 INFO: 9% (654.1 GiB of 7.1 TiB) in 13h 41m 48s, read: 9.6 MiB/s, write: 9.6 MiB/s
101: 2022-05-04 01:30:34 INFO: 10% (726.8 GiB of 7.1 TiB) in 14h 55m 10s, read: 16.9 MiB/s, write: 16.9 MiB/s
101: 2022-05-04 02:33:11 INFO: 11% (799.5 GiB of 7.1 TiB) in 15h 57m 47s, read: 19.8 MiB/s, write: 19.8 MiB/s
101: 2022-05-04 04:55:35 INFO: 12% (872.2 GiB of 7.1 TiB) in 18h 20m 11s, read: 8.7 MiB/s, write: 8.7 MiB/s
101: 2022-05-04 06:22:58 INFO: 13% (944.9 GiB of 7.1 TiB) in 19h 47m 34s, read: 14.2 MiB/s, write: 14.2 MiB/s
101: 2022-05-04 07:38:35 INFO: 14% (1017.5 GiB of 7.1 TiB) in 21h 3m 11s, read: 16.4 MiB/s, write: 16.4 MiB/s
101: 2022-05-04 10:02:03 INFO: 15% (1.1 TiB of 7.1 TiB) in 23h 26m 39s, read: 8.6 MiB/s, write: 8.6 MiB/s
101: 2022-05-04 12:28:44 INFO: 16% (1.1 TiB of 7.1 TiB) in 1d 1h 53m 20s, read: 8.5 MiB/s, write: 8.4 MiB/s
101: 2022-05-04 14:10:33 INFO: 17% (1.2 TiB of 7.1 TiB) in 1d 3h 35m 9s, read: 12.2 MiB/s, write: 12.2 MiB/s
101: 2022-05-04 15:31:51 INFO: 18% (1.3 TiB of 7.1 TiB) in 1d 4h 56m 27s, read: 15.3 MiB/s, write: 15.2 MiB/s
101: 2022-05-04 16:53:12 INFO: 19% (1.3 TiB of 7.1 TiB) in 1d 6h 17m 48s, read: 15.3 MiB/s, write: 15.2 MiB/s
101: 2022-05-04 18:05:22 INFO: 20% (1.4 TiB of 7.1 TiB) in 1d 7h 29m 58s, read: 17.2 MiB/s, write: 17.1 MiB/s
101: 2022-05-04 19:16:07 INFO: 21% (1.5 TiB of 7.1 TiB) in 1d 8h 40m 43s, read: 17.5 MiB/s, write: 17.5 MiB/s
101: 2022-05-04 20:26:40 INFO: 22% (1.6 TiB of 7.1 TiB) in 1d 9h 51m 16s, read: 17.6 MiB/s, write: 17.6 MiB/s
101: 2022-05-04 22:20:54 INFO: 23% (1.6 TiB of 7.1 TiB) in 1d 11h 45m 30s, read: 10.9 MiB/s, write: 10.8 MiB/s
101: 2022-05-05 00:59:44 INFO: 24% (1.7 TiB of 7.1 TiB) in 1d 14h 24m 20s, read: 7.8 MiB/s, write: 7.8 MiB/s
101: 2022-05-05 04:05:36 INFO: 25% (1.8 TiB of 7.1 TiB) in 1d 17h 30m 12s, read: 6.7 MiB/s, write: 6.7 MiB/s
101: 2022-05-05 06:40:52 INFO: 26% (1.8 TiB of 7.1 TiB) in 1d 20h 5m 28s, read: 8.0 MiB/s, write: 8.0 MiB/s
101: 2022-05-05 09:42:37 ERROR: VM 101 qmp command 'query-backup' failed - got wrong command id '1445:1533386' (expected 1820:323758)
101: 2022-05-05 09:42:37 INFO: aborting backup job
101: 2022-05-05 09:42:38 INFO: stopping kvm after backup task
101: 2022-05-05 09:54:19 ERROR: Backup of VM 101 failed - VM 101 qmp command 'query-backup' failed - got wrong command id '1445:1533386' (expected 1820:323758)
 
Detailed backup logs:



101: 2022-05-03 10:35:22 INFO: Starting Backup of VM 101 (qemu)
101: 2022-05-03 10:35:22 INFO: status = stopped
101: 2022-05-03 10:35:22 INFO: backup mode: stop
101: 2022-05-03 10:35:22 INFO: ionice priority: 7
101: 2022-05-03 10:35:22 INFO: VM Name: NAS
101: 2022-05-03 10:35:22 INFO: include disk 'ide0' 'SSD:101/vm-101-disk-0.raw' 100G
101: 2022-05-03 10:35:22 INFO: exclude disk 'ide1' 'SSD:101/vm-101-disk-1.qcow2' (backup=no)
101: 2022-05-03 10:35:22 INFO: include disk 'ide2' 'HDD:101/vm-101-disk-0.qcow2' 7T
101: 2022-05-03 10:35:22 INFO: creating vzdump archive '/mnt/pve/bkp-NAS/dump/vzdump-qemu-101-2022_05_03-10_35_22.vma.zst'
101: 2022-05-03 10:35:22 INFO: starting kvm to execute backup task
101: 2022-05-03 10:35:24 INFO: started backup task '51ad836b-3cb5-45b9-b895-3a8e90f651b9'
101: 2022-05-03 10:35:27 INFO: 0% (0.0 B of 7.1 TiB) in 3s, read: 0 B/s, write: 0 B/s
101: 2022-05-03 11:08:21 INFO: 1% (72.7 GiB of 7.1 TiB) in 32m 57s, read: 37.7 MiB/s, write: 36.8 MiB/s
101: 2022-05-03 11:22:27 INFO: 2% (145.5 GiB of 7.1 TiB) in 47m 3s, read: 88.0 MiB/s, write: 87.9 MiB/s
101: 2022-05-03 12:58:45 INFO: 3% (218.0 GiB of 7.1 TiB) in 2h 23m 21s, read: 12.9 MiB/s, write: 12.8 MiB/s
101: 2022-05-03 14:54:24 INFO: 4% (290.7 GiB of 7.1 TiB) in 4h 19m, read: 10.7 MiB/s, write: 10.7 MiB/s
101: 2022-05-03 16:58:04 INFO: 5% (363.4 GiB of 7.1 TiB) in 6h 22m 40s, read: 10.0 MiB/s, write: 10.0 MiB/s
101: 2022-05-03 19:18:52 INFO: 6% (436.1 GiB of 7.1 TiB) in 8h 43m 28s, read: 8.8 MiB/s, write: 8.8 MiB/s
101: 2022-05-03 20:29:55 INFO: 7% (508.8 GiB of 7.1 TiB) in 9h 54m 31s, read: 17.5 MiB/s, write: 17.4 MiB/s
101: 2022-05-03 22:08:37 INFO: 8% (581.4 GiB of 7.1 TiB) in 11h 33m 13s, read: 12.6 MiB/s, write: 12.5 MiB/s
101: 2022-05-04 00:17:12 INFO: 9% (654.1 GiB of 7.1 TiB) in 13h 41m 48s, read: 9.6 MiB/s, write: 9.6 MiB/s
101: 2022-05-04 01:30:34 INFO: 10% (726.8 GiB of 7.1 TiB) in 14h 55m 10s, read: 16.9 MiB/s, write: 16.9 MiB/s
101: 2022-05-04 02:33:11 INFO: 11% (799.5 GiB of 7.1 TiB) in 15h 57m 47s, read: 19.8 MiB/s, write: 19.8 MiB/s
101: 2022-05-04 04:55:35 INFO: 12% (872.2 GiB of 7.1 TiB) in 18h 20m 11s, read: 8.7 MiB/s, write: 8.7 MiB/s
101: 2022-05-04 06:22:58 INFO: 13% (944.9 GiB of 7.1 TiB) in 19h 47m 34s, read: 14.2 MiB/s, write: 14.2 MiB/s
101: 2022-05-04 07:38:35 INFO: 14% (1017.5 GiB of 7.1 TiB) in 21h 3m 11s, read: 16.4 MiB/s, write: 16.4 MiB/s
101: 2022-05-04 10:02:03 INFO: 15% (1.1 TiB of 7.1 TiB) in 23h 26m 39s, read: 8.6 MiB/s, write: 8.6 MiB/s
101: 2022-05-04 12:28:44 INFO: 16% (1.1 TiB of 7.1 TiB) in 1d 1h 53m 20s, read: 8.5 MiB/s, write: 8.4 MiB/s
101: 2022-05-04 14:10:33 INFO: 17% (1.2 TiB of 7.1 TiB) in 1d 3h 35m 9s, read: 12.2 MiB/s, write: 12.2 MiB/s
101: 2022-05-04 15:31:51 INFO: 18% (1.3 TiB of 7.1 TiB) in 1d 4h 56m 27s, read: 15.3 MiB/s, write: 15.2 MiB/s
101: 2022-05-04 16:53:12 INFO: 19% (1.3 TiB of 7.1 TiB) in 1d 6h 17m 48s, read: 15.3 MiB/s, write: 15.2 MiB/s
101: 2022-05-04 18:05:22 INFO: 20% (1.4 TiB of 7.1 TiB) in 1d 7h 29m 58s, read: 17.2 MiB/s, write: 17.1 MiB/s
101: 2022-05-04 19:16:07 INFO: 21% (1.5 TiB of 7.1 TiB) in 1d 8h 40m 43s, read: 17.5 MiB/s, write: 17.5 MiB/s
101: 2022-05-04 20:26:40 INFO: 22% (1.6 TiB of 7.1 TiB) in 1d 9h 51m 16s, read: 17.6 MiB/s, write: 17.6 MiB/s
101: 2022-05-04 22:20:54 INFO: 23% (1.6 TiB of 7.1 TiB) in 1d 11h 45m 30s, read: 10.9 MiB/s, write: 10.8 MiB/s
101: 2022-05-05 00:59:44 INFO: 24% (1.7 TiB of 7.1 TiB) in 1d 14h 24m 20s, read: 7.8 MiB/s, write: 7.8 MiB/s
101: 2022-05-05 04:05:36 INFO: 25% (1.8 TiB of 7.1 TiB) in 1d 17h 30m 12s, read: 6.7 MiB/s, write: 6.7 MiB/s
101: 2022-05-05 06:40:52 INFO: 26% (1.8 TiB of 7.1 TiB) in 1d 20h 5m 28s, read: 8.0 MiB/s, write: 8.0 MiB/s
101: 2022-05-05 09:42:37 ERROR: VM 101 qmp command 'query-backup' failed - got wrong command id '1445:1533386' (expected 1820:323758)
101: 2022-05-05 09:42:37 INFO: aborting backup job
101: 2022-05-05 09:42:38 INFO: stopping kvm after backup task
101: 2022-05-05 09:54:19 ERROR: Backup of VM 101 failed - VM 101 qmp command 'query-backup' failed - got wrong command id '1445:1533386' (expected 1820:323758)

seems this was an issue for some before. could you read this and see if it might help you.


https://forum.proxmox.com/threads/e...ckup-failed-got-wrong-command-id.88017/page-3
 

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!

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!