2026-01-22 21:12:47.1268 00007 [16319] INFO | [SshClientUtils]: Start executing ssh command "pvesh get storage/local --output json"
2026-01-22 21:12:48.0492 00007 [16319] INFO | [SshClientUtils]: The SSH command has been executed: status Code 0, result: "{"content":"vztmpl,backup,iso","digest":"3fab4365849627e3a0f96d3bde0e05dd73b9345c","path":"/var/lib/vz","storage":"local","type":"dir"}
", error: ""
2026-01-22 21:12:48.1136 00007 [16319] INFO | [SshClientUtils]: Start executing ssh command "qemu-img create -F qcow2 -b "/dev/proxmox_cluster1_1/vm-112-disk-1.qcow2" -f qcow2 /var/lib/vz/VeeamTmp_112_drv-scsi0_66fa7254-bd42-420b-acee-4c99e02cebc9.qcow2"
2026-01-22 21:12:48.2073 00007 [16319] INFO | [SshClientUtils]: The SSH command has been executed: status Code 0, result: "Formatting '/var/lib/vz/VeeamTmp_112_drv-scsi0_66fa7254-bd42-420b-acee-4c99e02cebc9.qcow2', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=128849018880 backing_file=/dev/proxmox_cluster1_1/vm-112-disk-1.qcow2 backing_fmt=qcow2 lazy_refcounts=off refcount_bits=16
", error: ""
2026-01-22 21:12:48.2073 00007 [16319] INFO | [VmbApiExtensions]: Checking available space on the snapshot storage...
2026-01-22 21:12:48.2073 00007 [16319] INFO | [VmbApiExtensions]: Snapshot storage on VeeamTmp_112_drv-scsi0 has 65% free space
2026-01-22 21:12:48.2073 00007 [16319] INFO | [NbdEngine]: Successfully prepared snapshot information for the disk "proxmox_cluster1_1:vm-112-disk-1.qcow2". The snapshot file path is "/var/lib/vz/VeeamTmp_112_drv-scsi0_66fa7254-bd42-420b-acee-4c99e02cebc9.qcow2"
2026-01-22 21:12:48.2256 00007 [16319] INFO | [NbdEngine]: The previous CBT tag (vmb): "{"checkpoint_id":"VeeamTmp_6923045e-dac9-425d-b57f-8f5b1ad5801f_4c7261fa-49ea-43cf-ad7c-bd7b3ce93667","version":"2.0","disk_format":null,"custom_values":{}}"
2026-01-22 21:12:48.2256 00007 [16319] INFO | [BackupUtils]: CBT tag has version "2.0"
2026-01-22 21:12:48.2256 00007 [16319] INFO | [DirtyBitmapUtils]: Skipping the bitmap "VeeamTmp_VeeamZIP_00000000-0000-0000-0000-000000000000" from processing: System.Exception: The bitmap VeeamTmp_VeeamZIP_00000000-0000-0000-0000-000000000000 belongs to another job
2026-01-22 21:12:48.2256 00007 [16319] INFO | [DirtyBitmapUtils]: at Veeam.Vbf.BackupAgent.BackupProxmox.Utils.DirtyBitmapUtils.PrepareCurrentBitmapAsync(QmpCommands qmpCommands, BlockDevice device, String currentJobId, String previousCheckpointId, CancellationToken cancellationToken)
2026-01-22 21:12:48.2256 00007 [16319] INFO | [QmpCommands]: Removing the bitmap "VeeamTmp_6923045e-dac9-425d-b57f-8f5b1ad5801f_4c7261fa-49ea-43cf-ad7c-bd7b3ce93667"...
2026-01-22 21:12:48.2256 00007 [16319] INFO | [QmpClient]: Executing the QMP command...
2026-01-22 21:12:48.2256 00007 [16319] INFO | [SshQmpSocket]: Text sent to the QMP device:
"{
"arguments": {
"node": "f9c7d8ab4d8eee1df874a157afa51fa",
"name": "VeeamTmp_6923045e-dac9-425d-b57f-8f5b1ad5801f_4c7261fa-49ea-43cf-ad7c-bd7b3ce93667"
},
"execute": "block-dirty-bitmap-remove"
}"
2026-01-22 21:12:48.3682 00007 [16319] INFO | [SshQmpSocket]: Text received from QMP device:
"{"return": {}}"
2026-01-22 21:12:48.3683 00007 [16319] INFO | [QmpClient]: Received the next QMP response: "{"return": {}}"
2026-01-22 21:12:48.3683 00007 [16319] INFO | [QmpCommands]: Successfully the removed bitmap "VeeamTmp_6923045e-dac9-425d-b57f-8f5b1ad5801f_4c7261fa-49ea-43cf-ad7c-bd7b3ce93667"
2026-01-22 21:12:48.3683 00007 [16319] INFO | [NbdEngine]: Successfully added the snapshot: Snapshot { DeviceName = drive-scsi0, DeviceNodeName = f9c7d8ab4d8eee1df874a157afa51fa, SnapshotName = VeeamTmp_112_drv-scsi0, BitmapName = VeeamTmp_6923045e-dac9-425d-b57f-8f5b1ad5801f_66fa7254-bd42-420b-acee-4c99e02cebc9, DisabledBitmapName = , DeviceFormat = qcow2, FilePath = /var/lib/vz/VeeamTmp_112_drv-scsi0_66fa7254-bd42-420b-acee-4c99e02cebc9.qcow2 }