Can't backup 1 VM to Proxmox Backup Server

D

DarkJackal87

New Member
Apr 20, 2025
11
0
1
Hello everyone,

I'm running into a strange issue, i'm trying to backup my VM's to a remote PBS, everything it's fine, except for 1 machine, here is the log

Code: 
100: 2025-10-28 00:50:37 INFO: Starting Backup of VM 100 (qemu)
100: 2025-10-28 00:50:37 INFO: status = running
100: 2025-10-28 00:50:37 INFO: VM Name: Alpine1-Headless-Docker-Server
100: 2025-10-28 00:50:37 INFO: include disk 'sata0' 'local-lvm:vm-100-disk-0' 20G
100: 2025-10-28 00:50:37 INFO: backup mode: snapshot
100: 2025-10-28 00:50:37 INFO: ionice priority: 7
100: 2025-10-28 00:50:37 INFO: creating Proxmox Backup Server archive 'vm/100/2025-10-27T23:50:37Z'
100: 2025-10-28 00:50:37 INFO: enabling encryption
100: 2025-10-28 00:50:37 INFO: issuing guest-agent 'fs-freeze' command
100: 2025-10-28 00:50:57 INFO: issuing guest-agent 'fs-thaw' command
100: 2025-10-28 00:50:57 ERROR: VM 100 qmp command 'backup' failed - backup connect failed: command error: client error (Connect)
100: 2025-10-28 00:50:57 INFO: aborting backup job
100: 2025-10-28 00:50:57 INFO: resuming VM again
100: 2025-10-28 00:50:57 ERROR: Backup of VM 100 failed - VM 100 qmp command 'backup' failed - backup connect failed: command error: client error (Connect)

Please note that i have three istances of Alpine linux, all identical.... the other VM's backup just fine

Code: 
101: 2025-10-28 00:50:57 INFO: Starting Backup of VM 101 (qemu)
101: 2025-10-28 00:50:57 INFO: status = running
101: 2025-10-28 00:50:57 INFO: VM Name: Alpine2-Headless-Docker-Server
101: 2025-10-28 00:50:57 INFO: include disk 'sata0' 'local-lvm:vm-101-disk-0' 70G
101: 2025-10-28 00:50:57 INFO: backup mode: snapshot
101: 2025-10-28 00:50:57 INFO: ionice priority: 7
101: 2025-10-28 00:50:57 INFO: creating Proxmox Backup Server archive 'vm/101/2025-10-27T23:50:57Z'
101: 2025-10-28 00:50:57 INFO: enabling encryption
101: 2025-10-28 00:50:58 INFO: issuing guest-agent 'fs-freeze' command
101: 2025-10-28 00:50:58 INFO: issuing guest-agent 'fs-thaw' command
101: 2025-10-28 00:50:59 INFO: started backup task '249cfccf-ea3a-4e11-9948-62f903625f9a'
101: 2025-10-28 00:50:59 INFO: resuming VM again
101: 2025-10-28 00:50:59 INFO: sata0: dirty-bitmap status: created new
101: 2025-10-28 00:51:02 INFO:   0% (236.0 MiB of 70.0 GiB) in 3s, read: 78.7 MiB/s, write: 78.7 MiB/s
101: 2025-10-28 00:51:07 INFO:   1% (748.0 MiB of 70.0 GiB) in 8s, read: 102.4 MiB/s, write: 102.4 MiB/s
101: 2025-10-28 00:51:16 INFO:   2% (1.4 GiB of 70.0 GiB) in 17s, read: 76.4 MiB/s, write: 76.4 MiB/s
101: 2025-10-28 00:51:25 INFO:   3% (2.2 GiB of 70.0 GiB) in 26s, read: 85.8 MiB/s, write: 85.8 MiB/s
101: 2025-10-28 00:51:35 INFO:   4% (2.9 GiB of 70.0 GiB) in 36s, read: 72.0 MiB/s, write: 72.0 MiB/s
101: 2025-10-28 00:51:50 INFO:   5% (3.5 GiB of 70.0 GiB) in 51s, read: 46.7 MiB/s, write: 45.1 MiB/s
101: 2025-10-28 00:52:06 INFO:   6% (4.2 GiB of 70.0 GiB) in 1m 7s, read: 42.5 MiB/s, write: 42.5 MiB/s
101: 2025-10-28 00:52:20 INFO:   7% (4.9 GiB of 70.0 GiB) in 1m 21s, read: 51.4 MiB/s, write: 51.4 MiB/s
101: 2025-10-28 00:52:36 INFO:   8% (5.7 GiB of 70.0 GiB) in 1m 37s, read: 47.5 MiB/s, write: 46.0 MiB/s
101: 2025-10-28 00:52:50 INFO:   9% (6.3 GiB of 70.0 GiB) in 1m 51s, read: 48.6 MiB/s, write: 48.6 MiB/s
101: 2025-10-28 00:53:05 INFO:  10% (7.0 GiB of 70.0 GiB) in 2m 6s, read: 48.3 MiB/s, write: 48.3 MiB/s
101: 2025-10-28 00:53:21 INFO:  11% (7.7 GiB of 70.0 GiB) in 2m 22s, read: 44.0 MiB/s, write: 42.8 MiB/s
101: 2025-10-28 00:53:38 INFO:  12% (8.4 GiB of 70.0 GiB) in 2m 39s, read: 42.6 MiB/s, write: 42.6 MiB/s
101: 2025-10-28 00:53:57 INFO:  13% (9.2 GiB of 70.0 GiB) in 2m 58s, read: 39.6 MiB/s, write: 39.6 MiB/s
101: 2025-10-28 00:54:10 INFO:  14% (9.8 GiB of 70.0 GiB) in 3m 11s, read: 53.2 MiB/s, write: 52.3 MiB/s
101: 2025-10-28 00:54:24 INFO:  15% (10.5 GiB of 70.0 GiB) in 3m 25s, read: 50.0 MiB/s, write: 50.0 MiB/s
101: 2025-10-28 00:54:39 INFO:  16% (11.2 GiB of 70.0 GiB) in 3m 40s, read: 48.8 MiB/s, write: 48.0 MiB/s
101: 2025-10-28 00:54:48 INFO:  17% (11.9 GiB of 70.0 GiB) in 3m 49s, read: 80.4 MiB/s, write: 80.4 MiB/s
101: 2025-10-28 00:55:13 INFO:  18% (12.6 GiB of 70.0 GiB) in 4m 14s, read: 27.4 MiB/s, write: 27.4 MiB/s
101: 2025-10-28 00:55:34 INFO:  19% (13.3 GiB of 70.0 GiB) in 4m 35s, read: 36.4 MiB/s, write: 35.4 MiB/s
101: 2025-10-28 00:55:46 INFO:  20% (14.1 GiB of 70.0 GiB) in 4m 47s, read: 61.7 MiB/s, write: 61.7 MiB/s
101: 2025-10-28 00:56:00 INFO:  21% (14.8 GiB of 70.0 GiB) in 5m 1s, read: 50.6 MiB/s, write: 50.0 MiB/s
101: 2025-10-28 00:56:14 INFO:  22% (15.4 GiB of 70.0 GiB) in 5m 15s, read: 48.9 MiB/s, write: 46.6 MiB/s
101: 2025-10-28 00:56:32 INFO:  23% (16.1 GiB of 70.0 GiB) in 5m 33s, read: 40.0 MiB/s, write: 38.4 MiB/s
101: 2025-10-28 00:56:44 INFO:  24% (16.8 GiB of 70.0 GiB) in 5m 45s, read: 59.0 MiB/s, write: 59.0 MiB/s
101: 2025-10-28 00:56:56 INFO:  25% (17.5 GiB of 70.0 GiB) in 5m 57s, read: 57.7 MiB/s, write: 56.0 MiB/s
101: 2025-10-28 00:57:11 INFO:  26% (18.2 GiB of 70.0 GiB) in 6m 12s, read: 50.1 MiB/s, write: 50.1 MiB/s
101: 2025-10-28 00:57:30 INFO:  27% (19.0 GiB of 70.0 GiB) in 6m 31s, read: 40.0 MiB/s, write: 40.0 MiB/s
101: 2025-10-28 00:57:42 INFO:  28% (19.6 GiB of 70.0 GiB) in 6m 43s, read: 54.0 MiB/s, write: 54.0 MiB/s
101: 2025-10-28 00:57:58 INFO:  29% (20.3 GiB of 70.0 GiB) in 6m 59s, read: 45.8 MiB/s, write: 45.2 MiB/s
101: 2025-10-28 00:58:20 INFO:  30% (21.0 GiB of 70.0 GiB) in 7m 21s, read: 32.0 MiB/s, write: 32.0 MiB/s
101: 2025-10-28 00:58:33 INFO:  31% (21.7 GiB of 70.0 GiB) in 7m 34s, read: 54.5 MiB/s, write: 53.5 MiB/s
101: 2025-10-28 00:58:49 INFO:  32% (22.4 GiB of 70.0 GiB) in 7m 50s, read: 44.8 MiB/s, write: 43.8 MiB/s
101: 2025-10-28 00:59:04 INFO:  33% (23.2 GiB of 70.0 GiB) in 8m 5s, read: 53.1 MiB/s, write: 51.2 MiB/s
101: 2025-10-28 00:59:16 INFO:  34% (23.9 GiB of 70.0 GiB) in 8m 17s, read: 58.7 MiB/s, write: 58.0 MiB/s
101: 2025-10-28 00:59:35 INFO:  35% (24.5 GiB of 70.0 GiB) in 8m 36s, read: 34.3 MiB/s, write: 34.3 MiB/s
101: 2025-10-28 00:59:47 INFO:  36% (25.2 GiB of 70.0 GiB) in 8m 48s, read: 61.7 MiB/s, write: 59.7 MiB/s
101: 2025-10-28 01:00:16 INFO:  37% (26.0 GiB of 70.0 GiB) in 9m 17s, read: 26.1 MiB/s, write: 26.1 MiB/s
101: 2025-10-28 01:00:30 INFO:  38% (26.7 GiB of 70.0 GiB) in 9m 31s, read: 50.6 MiB/s, write: 41.1 MiB/s
101: 2025-10-28 01:00:48 INFO:  39% (27.3 GiB of 70.0 GiB) in 9m 49s, read: 38.2 MiB/s, write: 36.7 MiB/s
101: 2025-10-28 01:00:58 INFO:  40% (28.0 GiB of 70.0 GiB) in 9m 59s, read: 70.8 MiB/s, write: 69.6 MiB/s
101: 2025-10-28 01:01:19 INFO:  41% (28.7 GiB of 70.0 GiB) in 10m 20s, read: 35.2 MiB/s, write: 35.2 MiB/s
101: 2025-10-28 01:01:35 INFO:  42% (29.4 GiB of 70.0 GiB) in 10m 36s, read: 44.5 MiB/s, write: 43.8 MiB/s
101: 2025-10-28 01:02:01 INFO:  43% (30.1 GiB of 70.0 GiB) in 11m 2s, read: 26.8 MiB/s, write: 26.8 MiB/s
101: 2025-10-28 01:02:18 INFO:  44% (30.8 GiB of 70.0 GiB) in 11m 19s, read: 41.9 MiB/s, write: 41.6 MiB/s
101: 2025-10-28 01:02:33 INFO:  45% (31.6 GiB of 70.0 GiB) in 11m 34s, read: 51.2 MiB/s, write: 50.4 MiB/s
101: 2025-10-28 01:02:49 INFO:  46% (32.2 GiB of 70.0 GiB) in 11m 50s, read: 41.5 MiB/s, write: 40.0 MiB/s
101: 2025-10-28 01:03:06 INFO:  47% (32.9 GiB of 70.0 GiB) in 12m 7s, read: 41.9 MiB/s, write: 40.5 MiB/s
101: 2025-10-28 01:03:27 INFO:  48% (33.7 GiB of 70.0 GiB) in 12m 28s, read: 37.7 MiB/s, write: 37.0 MiB/s
101: 2025-10-28 01:03:44 INFO:  49% (34.3 GiB of 70.0 GiB) in 12m 45s, read: 39.5 MiB/s, write: 39.5 MiB/s
101: 2025-10-28 01:04:03 INFO:  50% (35.0 GiB of 70.0 GiB) in 13m 4s, read: 37.7 MiB/s, write: 37.5 MiB/s
101: 2025-10-28 01:04:24 INFO:  51% (35.8 GiB of 70.0 GiB) in 13m 25s, read: 35.6 MiB/s, write: 33.7 MiB/s
101: 2025-10-28 01:04:45 INFO:  52% (36.5 GiB of 70.0 GiB) in 13m 46s, read: 34.1 MiB/s, write: 33.3 MiB/s
101: 2025-10-28 01:05:07 INFO:  53% (37.1 GiB of 70.0 GiB) in 14m 8s, read: 29.6 MiB/s, write: 24.5 MiB/s
101: 2025-10-28 01:05:27 INFO:  54% (37.8 GiB of 70.0 GiB) in 14m 28s, read: 36.0 MiB/s, write: 35.0 MiB/s
101: 2025-10-28 01:05:45 INFO:  55% (38.5 GiB of 70.0 GiB) in 14m 46s, read: 40.4 MiB/s, write: 36.4 MiB/s
101: 2025-10-28 01:06:14 INFO:  56% (39.2 GiB of 70.0 GiB) in 15m 15s, read: 24.4 MiB/s, write: 24.0 MiB/s
101: 2025-10-28 01:06:30 INFO:  57% (40.0 GiB of 70.0 GiB) in 15m 31s, read: 49.2 MiB/s, write: 49.2 MiB/s
101: 2025-10-28 01:06:53 INFO:  58% (40.7 GiB of 70.0 GiB) in 15m 54s, read: 30.3 MiB/s, write: 27.3 MiB/s
101: 2025-10-28 01:07:16 INFO:  59% (41.3 GiB of 70.0 GiB) in 16m 17s, read: 29.9 MiB/s, write: 29.4 MiB/s
101: 2025-10-28 01:07:38 INFO:  60% (42.0 GiB of 70.0 GiB) in 16m 39s, read: 33.3 MiB/s, write: 33.1 MiB/s
101: 2025-10-28 01:07:58 INFO:  61% (42.7 GiB of 70.0 GiB) in 16m 59s, read: 34.4 MiB/s, write: 27.8 MiB/s
101: 2025-10-28 01:08:12 INFO:  62% (43.4 GiB of 70.0 GiB) in 17m 13s, read: 50.6 MiB/s, write: 36.0 MiB/s
101: 2025-10-28 01:08:34 INFO:  63% (44.2 GiB of 70.0 GiB) in 17m 35s, read: 35.8 MiB/s, write: 34.0 MiB/s
101: 2025-10-28 01:09:02 INFO:  64% (44.8 GiB of 70.0 GiB) in 18m 3s, read: 24.4 MiB/s, write: 24.4 MiB/s
101: 2025-10-28 01:09:30 INFO:  65% (45.5 GiB of 70.0 GiB) in 18m 31s, read: 24.6 MiB/s, write: 24.1 MiB/s
101: 2025-10-28 01:09:57 INFO:  66% (46.2 GiB of 70.0 GiB) in 18m 58s, read: 26.5 MiB/s, write: 26.5 MiB/s
101: 2025-10-28 01:10:26 INFO:  67% (46.9 GiB of 70.0 GiB) in 19m 27s, read: 25.1 MiB/s, write: 25.0 MiB/s
101: 2025-10-28 01:10:45 INFO:  68% (47.6 GiB of 70.0 GiB) in 19m 46s, read: 38.7 MiB/s, write: 38.1 MiB/s
101: 2025-10-28 01:10:56 INFO:  69% (48.3 GiB of 70.0 GiB) in 19m 57s, read: 64.4 MiB/s, write: 60.4 MiB/s
101: 2025-10-28 01:11:18 INFO:  70% (49.1 GiB of 70.0 GiB) in 20m 19s, read: 33.6 MiB/s, write: 33.3 MiB/s
101: 2025-10-28 01:11:37 INFO:  71% (49.8 GiB of 70.0 GiB) in 20m 38s, read: 37.7 MiB/s, write: 35.8 MiB/s
101: 2025-10-28 01:11:47 INFO:  72% (50.4 GiB of 70.0 GiB) in 20m 48s, read: 68.8 MiB/s, write: 50.0 MiB/s
101: 2025-10-28 01:11:56 INFO:  73% (51.1 GiB of 70.0 GiB) in 20m 57s, read: 80.0 MiB/s, write: 59.1 MiB/s
101: 2025-10-28 01:12:11 INFO:  74% (52.0 GiB of 70.0 GiB) in 21m 12s, read: 56.5 MiB/s, write: 44.8 MiB/s
101: 2025-10-28 01:12:19 INFO:  75% (52.5 GiB of 70.0 GiB) in 21m 20s, read: 73.5 MiB/s, write: 50.5 MiB/s
101: 2025-10-28 01:12:30 INFO:  76% (53.2 GiB of 70.0 GiB) in 21m 31s, read: 63.3 MiB/s, write: 60.0 MiB/s
101: 2025-10-28 01:12:42 INFO:  77% (53.9 GiB of 70.0 GiB) in 21m 43s, read: 62.0 MiB/s, write: 55.0 MiB/s
101: 2025-10-28 01:12:51 INFO:  78% (54.7 GiB of 70.0 GiB) in 21m 52s, read: 83.6 MiB/s, write: 52.0 MiB/s
101: 2025-10-28 01:13:05 INFO:  79% (55.3 GiB of 70.0 GiB) in 22m 6s, read: 46.3 MiB/s, write: 43.7 MiB/s
101: 2025-10-28 01:13:24 INFO:  80% (56.0 GiB of 70.0 GiB) in 22m 25s, read: 37.3 MiB/s, write: 37.1 MiB/s
101: 2025-10-28 01:13:40 INFO:  81% (56.7 GiB of 70.0 GiB) in 22m 41s, read: 47.8 MiB/s, write: 41.2 MiB/s
101: 2025-10-28 01:13:54 INFO:  82% (57.4 GiB of 70.0 GiB) in 22m 55s, read: 49.4 MiB/s, write: 34.9 MiB/s
101: 2025-10-28 01:14:12 INFO:  83% (58.1 GiB of 70.0 GiB) in 23m 13s, read: 40.4 MiB/s, write: 31.6 MiB/s
101: 2025-10-28 01:14:28 INFO:  84% (58.9 GiB of 70.0 GiB) in 23m 29s, read: 51.0 MiB/s, write: 30.8 MiB/s
101: 2025-10-28 01:14:44 INFO:  85% (59.5 GiB of 70.0 GiB) in 23m 45s, read: 37.0 MiB/s, write: 30.5 MiB/s
101: 2025-10-28 01:15:14 INFO:  86% (60.3 GiB of 70.0 GiB) in 24m 15s, read: 25.6 MiB/s, write: 25.6 MiB/s
101: 2025-10-28 01:15:52 INFO:  87% (60.9 GiB of 70.0 GiB) in 24m 53s, read: 18.6 MiB/s, write: 18.6 MiB/s
101: 2025-10-28 01:16:26 INFO:  88% (61.6 GiB of 70.0 GiB) in 25m 27s, read: 19.6 MiB/s, write: 18.8 MiB/s
101: 2025-10-28 01:16:55 INFO:  89% (62.3 GiB of 70.0 GiB) in 25m 56s, read: 25.1 MiB/s, write: 25.1 MiB/s
101: 2025-10-28 01:17:27 INFO:  90% (63.0 GiB of 70.0 GiB) in 26m 28s, read: 23.1 MiB/s, write: 22.2 MiB/s
101: 2025-10-28 01:17:48 INFO:  91% (63.7 GiB of 70.0 GiB) in 26m 49s, read: 34.5 MiB/s, write: 34.3 MiB/s
101: 2025-10-28 01:18:14 INFO:  92% (64.4 GiB of 70.0 GiB) in 27m 15s, read: 27.5 MiB/s, write: 26.6 MiB/s
101: 2025-10-28 01:18:41 INFO:  93% (65.1 GiB of 70.0 GiB) in 27m 42s, read: 25.3 MiB/s, write: 24.3 MiB/s
101: 2025-10-28 01:19:04 INFO:  94% (65.9 GiB of 70.0 GiB) in 28m 5s, read: 33.4 MiB/s, write: 31.5 MiB/s
101: 2025-10-28 01:19:21 INFO:  95% (66.5 GiB of 70.0 GiB) in 28m 22s, read: 40.5 MiB/s, write: 39.5 MiB/s
101: 2025-10-28 01:19:46 INFO:  96% (67.2 GiB of 70.0 GiB) in 28m 47s, read: 28.5 MiB/s, write: 27.0 MiB/s
101: 2025-10-28 01:20:04 INFO:  97% (68.0 GiB of 70.0 GiB) in 29m 5s, read: 42.0 MiB/s, write: 30.9 MiB/s
101: 2025-10-28 01:20:12 INFO:  98% (68.7 GiB of 70.0 GiB) in 29m 13s, read: 99.5 MiB/s, write: 43.5 MiB/s
101: 2025-10-28 01:20:31 INFO:  99% (69.3 GiB of 70.0 GiB) in 29m 32s, read: 32.6 MiB/s, write: 29.3 MiB/s
101: 2025-10-28 01:20:58 INFO: 100% (70.0 GiB of 70.0 GiB) in 29m 59s, read: 24.7 MiB/s, write: 24.6 MiB/s
101: 2025-10-28 01:21:00 INFO: backup is sparse: 716.00 MiB (0%) total zero data
101: 2025-10-28 01:21:00 INFO: backup was done incrementally, reused 4.31 GiB (6%)
101: 2025-10-28 01:21:00 INFO: transferred 70.00 GiB in 1801 seconds (39.8 MiB/s)
101: 2025-10-28 01:21:00 INFO: adding notes to backup
101: 2025-10-28 01:21:00 INFO: Finished Backup of VM 101 (00:30:03)

i'm using PBS version 3.4.7, and i can't really find what's wrong with it.....

Anyone have some ideas? Consider that the same machine on a USB drive backup just fine.....
 
Last edited:
shanv said:
Hi @DarkJackal87 , Could you please run the backup again and then share the output of the following command?

Code: 
journalctl -u pvedaemon -u pveproxy --since <time>
Click to expand...
Code: 
Oct 28 17:38:20 proxmox1 pvedaemon[240813]: <root@pam> successful auth for user 'root@pam'
Oct 28 17:40:36 proxmox1 pveproxy[236355]: worker exit
Oct 28 17:40:36 proxmox1 pveproxy[1163]: worker 236355 finished
Oct 28 17:40:36 proxmox1 pveproxy[1163]: starting 1 worker(s)
Oct 28 17:40:36 proxmox1 pveproxy[1163]: worker 253800 started
Oct 28 17:41:06 proxmox1 pveproxy[232864]: worker exit
Oct 28 17:41:06 proxmox1 pveproxy[1163]: worker 232864 finished
Oct 28 17:41:06 proxmox1 pveproxy[1163]: starting 1 worker(s)
Oct 28 17:41:06 proxmox1 pveproxy[1163]: worker 253939 started
Oct 28 17:53:21 proxmox1 pvedaemon[234620]: <root@pam> successful auth for user 'root@pam'
Oct 28 18:03:57 proxmox1 pvedaemon[233132]: <root@pam> successful auth for user 'homeassistant@pve'
Oct 28 18:03:57 proxmox1 pvedaemon[233132]: <root@pam> successful auth for user 'homeassistant@pve'
Oct 28 18:34:36 proxmox1 pvedaemon[233132]: <root@pam> successful auth for user 'root@pam'
Oct 28 18:36:13 proxmox1 pvedaemon[240813]: <root@pam> starting task UPID:proxmox1:000415AE:00622148:6900FF0D:vzdump:100:root@pam:
Oct 28 18:36:13 proxmox1 pvedaemon[267694]: INFO: starting new backup job: vzdump 100 --notification-mode notification-system --storage VPSBackup --notes-template '{{guestname>
Oct 28 18:36:13 proxmox1 pvedaemon[267694]: INFO: Starting Backup of VM 100 (qemu)
Oct 28 18:36:34 proxmox1 pvedaemon[267694]: VM 100 qmp command failed - VM 100 qmp command 'backup' failed - backup connect failed: command error: client error (Connect)
Oct 28 18:36:34 proxmox1 pvedaemon[267694]: ERROR: Backup of VM 100 failed - VM 100 qmp command 'backup' failed - backup connect failed: command error: client error (Connect)
Oct 28 18:36:34 proxmox1 pvedaemon[267694]: INFO: Backup job finished with errors
Oct 28 18:36:35 proxmox1 perl[267694]: notified via target `Gmail`
Oct 28 18:36:35 proxmox1 pvedaemon[267694]: job errors
Oct 28 18:36:35 proxmox1 pvedaemon[240813]: <root@pam> end task UPID:proxmox1:000415AE:00622148:6900FF0D:vzdump:100:root@pam: job errors
Oct 28 18:36:50 proxmox1 pvedaemon[267877]: starting termproxy UPID:proxmox1:00041665:00622FE8:6900FF32:vncshell::root@pam:
Oct 28 18:36:50 proxmox1 pvedaemon[234620]: <root@pam> starting task UPID:proxmox1:00041665:00622FE8:6900FF32:vncshell::root@pam:
Oct 28 18:36:50 proxmox1 pvedaemon[240813]: <root@pam> successful auth for user 'root@pam'
Oct 28 18:36:50 proxmox1 login[267883]: pam_unix(login:session): session opened for user root(uid=0) by root(uid=0)
Oct 28 18:36:51 proxmox1 login[267883]: ROOT LOGIN ON pts/0

Here it is
 
Little update, if i stop the machine and try to backup it, it works....

Code: 
INFO: starting new backup job: vzdump 100 --node proxmox1 --all 0 --storage VPSBackup --notes-template '{{guestname}}' --mode snapshot --fleecing 0 --notification-mode notification-system
INFO: Starting Backup of VM 100 (qemu)
INFO: Backup started at 2025-10-28 18:49:54
INFO: status = stopped
INFO: backup mode: stop
INFO: ionice priority: 7
INFO: VM Name: Alpine1-Headless-Docker-Server
INFO: include disk 'sata0' 'local-lvm:vm-100-disk-0' 20G
INFO: creating Proxmox Backup Server archive 'vm/100/2025-10-28T17:49:54Z'
INFO: enabling encryption
INFO: starting kvm to execute backup task
INFO: started backup task '8e7b670c-1faf-4a70-9c0b-38c89c3b9579'
INFO: sata0: dirty-bitmap status: created new
INFO:   1% (236.0 MiB of 20.0 GiB) in 3s, read: 78.7 MiB/s, write: 78.7 MiB/s
INFO:  11% (2.3 GiB of 20.0 GiB) in 6s, read: 701.3 MiB/s, write: 113.3 MiB/s
INFO:  13% (2.7 GiB of 20.0 GiB) in 9s, read: 126.7 MiB/s, write: 126.7 MiB/s
INFO:  14% (2.8 GiB of 20.0 GiB) in 12s, read: 61.3 MiB/s, write: 61.3 MiB/s
INFO:  15% (3.2 GiB of 20.0 GiB) in 15s, read: 108.0 MiB/s, write: 108.0 MiB/s
INFO:  16% (3.3 GiB of 20.0 GiB) in 18s, read: 66.7 MiB/s, write: 66.7 MiB/s
INFO:  17% (3.5 GiB of 20.0 GiB) in 21s, read: 42.7 MiB/s, write: 42.7 MiB/s
INFO:  18% (3.7 GiB of 20.0 GiB) in 25s, read: 51.0 MiB/s, write: 51.0 MiB/s
INFO:  19% (3.8 GiB of 20.0 GiB) in 28s, read: 60.0 MiB/s, write: 60.0 MiB/s
INFO:  20% (4.2 GiB of 20.0 GiB) in 31s, read: 104.0 MiB/s, write: 90.7 MiB/s
INFO:  21% (4.3 GiB of 20.0 GiB) in 34s, read: 53.3 MiB/s, write: 53.3 MiB/s
INFO:  22% (4.5 GiB of 20.0 GiB) in 37s, read: 76.0 MiB/s, write: 76.0 MiB/s
INFO:  23% (4.8 GiB of 20.0 GiB) in 40s, read: 77.3 MiB/s, write: 77.3 MiB/s
INFO:  25% (5.1 GiB of 20.0 GiB) in 43s, read: 104.0 MiB/s, write: 85.3 MiB/s
INFO:  26% (5.3 GiB of 20.0 GiB) in 46s, read: 86.7 MiB/s, write: 82.7 MiB/s
INFO:  28% (5.7 GiB of 20.0 GiB) in 49s, read: 116.0 MiB/s, write: 70.7 MiB/s
INFO:  29% (5.8 GiB of 20.0 GiB) in 52s, read: 57.3 MiB/s, write: 49.3 MiB/s
INFO:  30% (6.1 GiB of 20.0 GiB) in 56s, read: 80.0 MiB/s, write: 66.0 MiB/s
INFO:  31% (6.3 GiB of 20.0 GiB) in 59s, read: 58.7 MiB/s, write: 58.7 MiB/s
INFO:  33% (6.6 GiB of 20.0 GiB) in 1m 2s, read: 108.0 MiB/s, write: 106.7 MiB/s
INFO:  34% (6.8 GiB of 20.0 GiB) in 1m 5s, read: 65.3 MiB/s, write: 65.3 MiB/s
INFO:  35% (7.1 GiB of 20.0 GiB) in 1m 11s, read: 43.3 MiB/s, write: 42.0 MiB/s
INFO:  36% (7.3 GiB of 20.0 GiB) in 1m 14s, read: 73.3 MiB/s, write: 73.3 MiB/s
INFO:  37% (7.5 GiB of 20.0 GiB) in 1m 17s, read: 82.7 MiB/s, write: 82.7 MiB/s
INFO:  38% (7.7 GiB of 20.0 GiB) in 1m 20s, read: 54.7 MiB/s, write: 54.7 MiB/s
INFO:  39% (7.9 GiB of 20.0 GiB) in 1m 23s, read: 61.3 MiB/s, write: 61.3 MiB/s
INFO:  40% (8.2 GiB of 20.0 GiB) in 1m 26s, read: 113.3 MiB/s, write: 100.0 MiB/s
INFO:  41% (8.4 GiB of 20.0 GiB) in 1m 29s, read: 58.7 MiB/s, write: 58.7 MiB/s
INFO:  42% (8.5 GiB of 20.0 GiB) in 1m 32s, read: 54.7 MiB/s, write: 54.7 MiB/s
INFO:  45% (9.1 GiB of 20.0 GiB) in 1m 35s, read: 184.0 MiB/s, write: 76.0 MiB/s
INFO:  53% (10.8 GiB of 20.0 GiB) in 1m 38s, read: 584.0 MiB/s, write: 157.3 MiB/s
INFO:  56% (11.3 GiB of 20.0 GiB) in 1m 41s, read: 169.3 MiB/s, write: 53.3 MiB/s
INFO:  61% (12.3 GiB of 20.0 GiB) in 1m 44s, read: 352.0 MiB/s, write: 72.0 MiB/s
INFO:  62% (12.5 GiB of 20.0 GiB) in 1m 47s, read: 53.3 MiB/s, write: 53.3 MiB/s
INFO:  63% (12.6 GiB of 20.0 GiB) in 1m 50s, read: 61.3 MiB/s, write: 54.7 MiB/s
INFO:  65% (13.1 GiB of 20.0 GiB) in 1m 53s, read: 140.0 MiB/s, write: 129.3 MiB/s
INFO:  66% (13.3 GiB of 20.0 GiB) in 1m 56s, read: 92.0 MiB/s, write: 82.7 MiB/s
INFO:  67% (13.5 GiB of 20.0 GiB) in 1m 59s, read: 65.3 MiB/s, write: 65.3 MiB/s
INFO:  69% (13.9 GiB of 20.0 GiB) in 2m 2s, read: 116.0 MiB/s, write: 116.0 MiB/s
INFO:  70% (14.1 GiB of 20.0 GiB) in 2m 5s, read: 96.0 MiB/s, write: 85.3 MiB/s
INFO:  72% (14.4 GiB of 20.0 GiB) in 2m 8s, read: 102.7 MiB/s, write: 102.7 MiB/s
INFO:  73% (14.7 GiB of 20.0 GiB) in 2m 11s, read: 84.0 MiB/s, write: 84.0 MiB/s
INFO:  74% (14.8 GiB of 20.0 GiB) in 2m 14s, read: 49.3 MiB/s, write: 49.3 MiB/s
INFO:  75% (15.0 GiB of 20.0 GiB) in 2m 17s, read: 73.3 MiB/s, write: 72.0 MiB/s
INFO:  76% (15.2 GiB of 20.0 GiB) in 2m 20s, read: 57.3 MiB/s, write: 57.3 MiB/s
INFO:  77% (15.5 GiB of 20.0 GiB) in 2m 23s, read: 92.0 MiB/s, write: 88.0 MiB/s
INFO:  78% (15.7 GiB of 20.0 GiB) in 2m 26s, read: 68.0 MiB/s, write: 66.7 MiB/s
INFO:  80% (16.1 GiB of 20.0 GiB) in 2m 29s, read: 128.0 MiB/s, write: 121.3 MiB/s
INFO:  82% (16.5 GiB of 20.0 GiB) in 2m 32s, read: 142.7 MiB/s, write: 142.7 MiB/s
INFO:  83% (16.8 GiB of 20.0 GiB) in 2m 35s, read: 102.7 MiB/s, write: 102.7 MiB/s
INFO:  86% (17.2 GiB of 20.0 GiB) in 2m 38s, read: 152.0 MiB/s, write: 72.0 MiB/s
INFO:  87% (17.6 GiB of 20.0 GiB) in 2m 41s, read: 116.0 MiB/s, write: 106.7 MiB/s
INFO:  89% (18.0 GiB of 20.0 GiB) in 2m 44s, read: 138.7 MiB/s, write: 128.0 MiB/s
INFO:  90% (18.1 GiB of 20.0 GiB) in 2m 47s, read: 61.3 MiB/s, write: 56.0 MiB/s
INFO:  92% (18.5 GiB of 20.0 GiB) in 2m 50s, read: 126.7 MiB/s, write: 120.0 MiB/s
INFO:  93% (18.8 GiB of 20.0 GiB) in 2m 53s, read: 86.7 MiB/s, write: 80.0 MiB/s
INFO:  94% (18.9 GiB of 20.0 GiB) in 2m 56s, read: 53.3 MiB/s, write: 52.0 MiB/s
INFO:  96% (19.2 GiB of 20.0 GiB) in 2m 59s, read: 94.7 MiB/s, write: 84.0 MiB/s
INFO:  97% (19.4 GiB of 20.0 GiB) in 3m 3s, read: 62.0 MiB/s, write: 51.0 MiB/s
INFO:  98% (19.7 GiB of 20.0 GiB) in 3m 6s, read: 94.7 MiB/s, write: 76.0 MiB/s
INFO:  99% (19.8 GiB of 20.0 GiB) in 3m 9s, read: 40.0 MiB/s, write: 38.7 MiB/s
INFO: 100% (20.0 GiB of 20.0 GiB) in 3m 12s, read: 54.7 MiB/s, write: 54.7 MiB/s
INFO: backup is sparse: 4.98 GiB (24%) total zero data
INFO: backup was done incrementally, reused 5.45 GiB (27%)
INFO: transferred 20.00 GiB in 192 seconds (106.7 MiB/s)
INFO: stopping kvm after backup task
INFO: adding notes to backup
INFO: Finished Backup of VM 100 (00:03:14)
INFO: Backup finished at 2025-10-28 18:53:08
INFO: Backup job finished successfully
INFO: notified via target `Gmail`
TASK OK
 
Hello

Sorry to bring this topic back, but i really can't solve the problem, i've also reinstalled qemu agent to no avail, anyone?
 
Hi,

I also had a similar problem and did not find the solution at first.

For testing I disabled fs-freeze flag (uncheck "Freeze/thaw guest filesystems on backup for consistency" in QEMU Guest agent section of VM options). Backup went well.

Then I tried to rule out what is different at this VM compared to other ones. After a few hours I found out that the error comes up because DNS resolution is not working while VM is frozen. The VM is my DNS resolver in my homelab.

And PVE is using a DNS name for reaching PBS, see excerpt from /etc/pve/storage.cfg

Code: 
pbs: pbs-02.int
    datastore p-int-syno
    server pbs-02.xx
    content backup
    fingerprint a2:xxx
    namespace xxx
    prune-backups keep-all=1
    username xxx-push@pbs

I now added an entry in /etc/hosts of all my pve nodes, which looks like this:
Code: 
1.2.3.4 pbs-02.xx

After that everything worked properly. As a long-term solution i should add another DNS resolver for redundancy.

Maybe you also have some similar dependency to your VM?
 
Last edited:
  • Like
Reactions: Chris and Onslow
Unsubtle9244 said:
Hi,

I also had a similar problem and did not find the solution at first.

For testing I disabled fs-freeze flag (uncheck "Freeze/thaw guest filesystems on backup for consistency" in QEMU Guest agent section of VM options). Backup went well.

Then I tried to rule out what is different at this VM compared to other ones. After a few hours I found out that the error comes up because DNS resolution is not working while VM is frozen. The VM is my DNS resolver in my homelab.

And PVE is using a DNS name for reaching PBS, see excerpt from /etc/pve/storage.cfg

Code: 
pbs: pbs-02.int
    datastore p-int-syno
    server pbs-02.xx
    content backup
    fingerprint a2:xxx
    namespace xxx
    prune-backups keep-all=1
    username xxx-push@pbs

I now added an entry in /etc/hosts of all my pve nodes, which looks like this:
Code: 
1.2.3.4 pbs-02.xx

After that everything worked properly. As a long-term solution i should add another DNS resolver for redundancy.

Maybe you also have some similar dependency to your VM?
Click to expand...
Hello!

Sorry for the late reply, yeah you were right, that VM host pi-hole which is my main DNS resolver, i've switched the Proxmox DNS server to the Google ones to test and it works flawlessly

Sorry! It was under my nose but i didn't found it after hours of tests :) you've saved my day!
 
Hi,

Since other VMs back up fine to the same PBS, this looks VM-specific, not a PBS issue.

The error happens before the backup task starts, which often points to:
  • Corrupted incremental / dirty bitmap state
  • Snapshot issue on that VM
  • Small config difference compared to the working VMs
Things to try:
  • Remove any snapshots and retry
  • Delete existing backups for VM 100 on PBS and force a full backup
  • Disable incremental backup for this VM
  • Temporarily disable the guest agent and test
  • Compare qm config 100 with a working VM
If it still fails, try a stop-mode backup or clone the VM and test the clone.

USB backup working confirms storage + VM data are OK.
 
You must log in or register to reply here.
Top Bottom