write_date upload error: timed out

muelli75

Member
Oct 2, 2021
10
0
21
50
Since a few days, my backup onyl work on approx 2 of 5 days. The Backup stops on the very end of the backup-process. II back up a few VMs, but only one at a time. There is at least a 1-hour break between backups.

The source is on a SSD (PVE 8.4.14), the destination is an a harddisk (PBS 3.4.0).

Please see the log:

Code:
Details
VMID     Name     Status     Time     Size     Filename
112     BMD-Win11     err     18m 1s     0 B     

Total running time: 18m 1s
Total size: 0 B
Logs

vzdump 112 --mode suspend --notes-template '{{guestname}}' --node promox --quiet 1 --mailto office@mydomain.at --fleecing 0 --storage pbs01 --prune-backups 'keep-daily=1,keep-last=3,keep-monthly=1' --mailnotification failure


112: 2025-11-15 23:35:01 INFO: Starting Backup of VM 112 (qemu)
112: 2025-11-15 23:35:01 INFO: status = running
112: 2025-11-15 23:35:01 INFO: backup mode: suspend
112: 2025-11-15 23:35:01 INFO: ionice priority: 7
112: 2025-11-15 23:35:01 INFO: VM Name: BMD-Win11
112: 2025-11-15 23:35:01 INFO: include disk 'ide0' 'zfsdatap4m:vm-112-disk-1' 500G
112: 2025-11-15 23:35:01 INFO: include disk 'efidisk0' 'zfsdatap4m:vm-112-disk-0' 1M
112: 2025-11-15 23:35:01 INFO: include disk 'tpmstate0' 'zfsdatap4m:vm-112-disk-2' 4M
112: 2025-11-15 23:35:01 INFO: suspending guest
112: 2025-11-15 23:35:01 INFO: snapshots found (not included into backup)
112: 2025-11-15 23:35:01 INFO: creating Proxmox Backup Server archive 'vm/112/2025-11-15T22:35:01Z'
112: 2025-11-15 23:35:01 INFO: attaching TPM drive to QEMU for backup
112: 2025-11-15 23:35:04 INFO: skipping guest-agent 'fs-freeze', agent configured but not running?
112: 2025-11-15 23:35:05 INFO: started backup task '6929bf3e-50f9-4ed5-92e4-bae27204ac7d'
112: 2025-11-15 23:35:05 INFO: resuming VM again after 4 seconds
112: 2025-11-15 23:35:05 INFO: efidisk0: dirty-bitmap status: OK (drive clean)
112: 2025-11-15 23:35:05 INFO: ide0: dirty-bitmap status: OK (23.1 GiB of 500.0 GiB dirty)
112: 2025-11-15 23:35:05 INFO: tpmstate0-backup: dirty-bitmap status: created new
112: 2025-11-15 23:35:05 INFO: using fast incremental mode (dirty-bitmap), 23.1 GiB dirty of 500.0 GiB total
112: 2025-11-15 23:35:08 INFO:   2% (660.0 MiB of 23.1 GiB) in 3s, read: 220.0 MiB/s, write: 213.3 MiB/s
112: 2025-11-15 23:35:11 INFO:   5% (1.4 GiB of 23.1 GiB) in 6s, read: 252.0 MiB/s, write: 250.7 MiB/s
112: 2025-11-15 23:35:14 INFO:   7% (1.8 GiB of 23.1 GiB) in 9s, read: 137.3 MiB/s, write: 137.3 MiB/s
112: 2025-11-15 23:35:17 INFO:  10% (2.4 GiB of 23.1 GiB) in 12s, read: 213.3 MiB/s, write: 213.3 MiB/s
112: 2025-11-15 23:35:20 INFO:  12% (3.0 GiB of 23.1 GiB) in 15s, read: 188.0 MiB/s, write: 188.0 MiB/s
112: 2025-11-15 23:35:23 INFO:  14% (3.4 GiB of 23.1 GiB) in 18s, read: 161.3 MiB/s, write: 161.3 MiB/s
112: 2025-11-15 23:35:26 INFO:  16% (3.9 GiB of 23.1 GiB) in 21s, read: 161.3 MiB/s, write: 160.0 MiB/s
112: 2025-11-15 23:35:29 INFO:  19% (4.4 GiB of 23.1 GiB) in 24s, read: 174.7 MiB/s, write: 172.0 MiB/s
112: 2025-11-15 23:35:32 INFO:  20% (4.6 GiB of 23.1 GiB) in 27s, read: 74.7 MiB/s, write: 74.7 MiB/s
112: 2025-11-15 23:35:35 INFO:  23% (5.3 GiB of 23.1 GiB) in 30s, read: 241.3 MiB/s, write: 241.3 MiB/s
112: 2025-11-15 23:35:38 INFO:  25% (5.8 GiB of 23.1 GiB) in 33s, read: 160.0 MiB/s, write: 160.0 MiB/s
112: 2025-11-15 23:35:41 INFO:  27% (6.3 GiB of 23.1 GiB) in 36s, read: 165.3 MiB/s, write: 164.0 MiB/s
112: 2025-11-15 23:35:44 INFO:  29% (6.9 GiB of 23.1 GiB) in 39s, read: 204.0 MiB/s, write: 204.0 MiB/s
112: 2025-11-15 23:35:47 INFO:  31% (7.3 GiB of 23.1 GiB) in 42s, read: 132.0 MiB/s, write: 132.0 MiB/s
112: 2025-11-15 23:35:50 INFO:  34% (8.0 GiB of 23.1 GiB) in 45s, read: 249.3 MiB/s, write: 249.3 MiB/s
112: 2025-11-15 23:35:53 INFO:  36% (8.4 GiB of 23.1 GiB) in 48s, read: 133.3 MiB/s, write: 133.3 MiB/s
112: 2025-11-15 23:35:56 INFO:  38% (9.0 GiB of 23.1 GiB) in 51s, read: 193.3 MiB/s, write: 193.3 MiB/s
112: 2025-11-15 23:35:59 INFO:  41% (9.5 GiB of 23.1 GiB) in 54s, read: 192.0 MiB/s, write: 192.0 MiB/s
112: 2025-11-15 23:36:02 INFO:  43% (10.1 GiB of 23.1 GiB) in 57s, read: 189.3 MiB/s, write: 184.0 MiB/s
112: 2025-11-15 23:36:05 INFO:  45% (10.6 GiB of 23.1 GiB) in 1m, read: 177.3 MiB/s, write: 177.3 MiB/s
112: 2025-11-15 23:36:08 INFO:  48% (11.3 GiB of 23.1 GiB) in 1m 3s, read: 230.7 MiB/s, write: 230.7 MiB/s
112: 2025-11-15 23:36:11 INFO:  49% (11.5 GiB of 23.1 GiB) in 1m 6s, read: 69.3 MiB/s, write: 69.3 MiB/s
112: 2025-11-15 23:36:14 INFO:  52% (12.1 GiB of 23.1 GiB) in 1m 9s, read: 218.7 MiB/s, write: 218.7 MiB/s
112: 2025-11-15 23:36:17 INFO:  54% (12.6 GiB of 23.1 GiB) in 1m 12s, read: 165.3 MiB/s, write: 165.3 MiB/s
112: 2025-11-15 23:36:20 INFO:  56% (13.0 GiB of 23.1 GiB) in 1m 15s, read: 122.7 MiB/s, write: 122.7 MiB/s
112: 2025-11-15 23:36:23 INFO:  57% (13.4 GiB of 23.1 GiB) in 1m 18s, read: 144.0 MiB/s, write: 144.0 MiB/s
112: 2025-11-15 23:36:26 INFO:  59% (13.8 GiB of 23.1 GiB) in 1m 21s, read: 138.7 MiB/s, write: 138.7 MiB/s
112: 2025-11-15 23:36:29 INFO:  61% (14.2 GiB of 23.1 GiB) in 1m 24s, read: 125.3 MiB/s, write: 125.3 MiB/s
112: 2025-11-15 23:36:32 INFO:  62% (14.5 GiB of 23.1 GiB) in 1m 27s, read: 128.0 MiB/s, write: 128.0 MiB/s
112: 2025-11-15 23:36:35 INFO:  64% (14.9 GiB of 23.1 GiB) in 1m 30s, read: 126.7 MiB/s, write: 126.7 MiB/s
112: 2025-11-15 23:36:38 INFO:  66% (15.3 GiB of 23.1 GiB) in 1m 33s, read: 125.3 MiB/s, write: 125.3 MiB/s
112: 2025-11-15 23:36:41 INFO:  67% (15.7 GiB of 23.1 GiB) in 1m 36s, read: 133.3 MiB/s, write: 133.3 MiB/s
112: 2025-11-15 23:36:44 INFO:  69% (16.1 GiB of 23.1 GiB) in 1m 39s, read: 130.7 MiB/s, write: 130.7 MiB/s
112: 2025-11-15 23:36:47 INFO:  71% (16.4 GiB of 23.1 GiB) in 1m 42s, read: 132.0 MiB/s, write: 132.0 MiB/s
112: 2025-11-15 23:36:50 INFO:  72% (16.8 GiB of 23.1 GiB) in 1m 45s, read: 129.3 MiB/s, write: 129.3 MiB/s
112: 2025-11-15 23:36:53 INFO:  75% (17.5 GiB of 23.1 GiB) in 1m 48s, read: 228.0 MiB/s, write: 228.0 MiB/s
112: 2025-11-15 23:36:56 INFO:  78% (18.0 GiB of 23.1 GiB) in 1m 51s, read: 188.0 MiB/s, write: 188.0 MiB/s
112: 2025-11-15 23:36:59 INFO:  81% (18.9 GiB of 23.1 GiB) in 1m 54s, read: 293.3 MiB/s, write: 293.3 MiB/s
112: 2025-11-15 23:37:02 INFO:  85% (19.8 GiB of 23.1 GiB) in 1m 57s, read: 298.7 MiB/s, write: 298.7 MiB/s
112: 2025-11-15 23:37:05 INFO:  89% (20.8 GiB of 23.1 GiB) in 2m, read: 334.7 MiB/s, write: 334.7 MiB/s
112: 2025-11-15 23:37:08 INFO:  94% (21.8 GiB of 23.1 GiB) in 2m 3s, read: 352.0 MiB/s, write: 352.0 MiB/s
112: 2025-11-15 23:37:11 INFO:  96% (22.4 GiB of 23.1 GiB) in 2m 6s, read: 209.3 MiB/s, write: 209.3 MiB/s
112: 2025-11-15 23:53:01 INFO:  96% (22.4 GiB of 23.1 GiB) in 17m 56s, read: 0 B/s, write: 0 B/s
112: 2025-11-15 23:53:01 ERROR: backup write data failed: command error: write_data upload error: timed out
112: 2025-11-15 23:53:01 INFO: aborting backup job
112: 2025-11-15 23:53:01 INFO: resuming VM again
112: 2025-11-15 23:53:01 INFO: resume vm
112: 2025-11-15 23:53:02 ERROR: Backup of VM 112 failed - backup write data failed: command error: write_data upload error: timed out

Any ideas how to fix this?
 
112: 2025-11-15 23:37:11 INFO: 96% (22.4 GiB of 23.1 GiB) in 2m 6s, read: 209.3 MiB/s, write: 209.3 MiB/s 112: 2025-11-15 23:53:01 INFO: 96% (22.4 GiB of 23.1 GiB) in 17m 56s, read: 0 B/s, write: 0 B/s 112: 2025-11-15 23:53:01 ERROR: backup write data failed: command error: write_data upload error: timed out
Looks like a destination disk problem or maybe using a smr drive ?