@florent as described by myself and others in this thread the error occurs only when "Purge snapshot data when using CBT" is enabled.
As expected, it runs fine (every time) when "Use NBT+CBT if available" is disabled, which also disables "Purge snapshot data when using CBT".
Jun 25 06:58:25 xoa xo-server[2661108]: 2025-06-25T10:58:25.998Z xo:backups:worker INFO starting backup
Jun 25 06:58:26 xoa nfsrahead[2661133]: setting /run/xo-server/mounts/2ad70aa9-8f27-4353-8dde-5623f31cd49f readahead to 128
Jun 25 06:59:03 xoa xo-server[2661108]: 2025-06-25T10:59:03.721Z @xen-orchestra/xapi/disks/Xapi WARN can't connect through NBD, fallback to stream export
Jun 25 06:59:03 xoa xo-server[2661108]: 2025-06-25T10:59:03.798Z @xen-orchestra/xapi/disks/Xapi WARN can't connect through NBD, fallback to stream export
Jun 25 06:59:03 xoa xo-server[2661108]: 2025-06-25T10:59:03.822Z @xen-orchestra/xapi/disks/Xapi WARN can't connect through NBD, fallback to stream export
Jun 25 06:59:03 xoa xo-server[2661108]: 2025-06-25T10:59:03.952Z @xen-orchestra/xapi/disks/Xapi WARN can't connect through NBD, fallback to stream export
Jun 25 06:59:04 xoa xo-server[2661108]: 2025-06-25T10:59:04.031Z @xen-orchestra/xapi/disks/Xapi WARN can't connect through NBD, fallback to stream export
Jun 25 07:01:37 xoa xo-server[2661108]: 2025-06-25T11:01:37.465Z xo:backups:MixinBackupWriter WARN cleanVm: incorrect backup size in metadata {
Jun 25 07:01:37 xoa xo-server[2661108]: path: '/xo-vm-backups/30db3746-fecc-4b49-e7af-8f15d13d573c/20250625T105907Z.json',
Jun 25 07:01:37 xoa xo-server[2661108]: actual: 10166992896,
Jun 25 07:01:37 xoa xo-server[2661108]: expected: 10169530368
Jun 25 07:01:37 xoa xo-server[2661108]: }
Jun 25 07:01:37 xoa xo-server[2661108]: 2025-06-25T11:01:37.555Z xo:backups:worker INFO backup has ended
Jun 25 07:01:37 xoa xo-server[2661108]: 2025-06-25T11:01:37.607Z xo:backups:worker INFO process will exit {
Jun 25 07:01:37 xoa xo-server[2661108]: duration: 191607947,
Jun 25 07:01:37 xoa xo-server[2661108]: exitCode: 0,
Jun 25 07:01:37 xoa xo-server[2661108]: resourceUsage: {
Jun 25 07:01:37 xoa xo-server[2661108]: userCPUTime: 122499805,
Jun 25 07:01:37 xoa xo-server[2661108]: systemCPUTime: 32534032,
Jun 25 07:01:37 xoa xo-server[2661108]: maxRSS: 125060,
Jun 25 07:01:37 xoa xo-server[2661108]: sharedMemorySize: 0,
Jun 25 07:01:37 xoa xo-server[2661108]: unsharedDataSize: 0,
Jun 25 07:01:37 xoa xo-server[2661108]: unsharedStackSize: 0,
Jun 25 07:01:37 xoa xo-server[2661108]: minorPageFault: 585389,
Jun 25 07:01:37 xoa xo-server[2661108]: majorPageFault: 0,
Jun 25 07:01:37 xoa xo-server[2661108]: swappedOut: 0,
Jun 25 07:01:37 xoa xo-server[2661108]: fsRead: 2056,
Jun 25 07:01:37 xoa xo-server[2661108]: fsWrite: 19863128,
Jun 25 07:01:37 xoa xo-server[2661108]: ipcSent: 0,
Jun 25 07:01:37 xoa xo-server[2661108]: ipcReceived: 0,
Jun 25 07:01:37 xoa xo-server[2661108]: signalsCount: 0,
Jun 25 07:01:37 xoa xo-server[2661108]: voluntaryContextSwitches: 112269,
Jun 25 07:01:37 xoa xo-server[2661108]: involuntaryContextSwitches: 90074
Jun 25 07:01:37 xoa xo-server[2661108]: },
Jun 25 07:01:37 xoa xo-server[2661108]: summary: { duration: '3m', cpuUsage: '81%', memoryUsage: '122.13 MiB' }
Jun 25 07:01:37 xoa xo-server[2661108]: }
Jun 25 07:01:58 xoa xo-server[2661382]: 2025-06-25T11:01:58.035Z xo:backups:worker INFO starting backup
Jun 25 07:02:23 xoa xo-server[2661382]: 2025-06-25T11:02:23.856Z @xen-orchestra/xapi/disks/Xapi WARN openNbdCBT Error: can't connect to any nbd client
Jun 25 07:02:23 xoa xo-server[2661382]: at connectNbdClientIfPossible (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/xapi/disks/utils.mjs:23:19)
Jun 25 07:02:23 xoa xo-server[2661382]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
Jun 25 07:02:23 xoa xo-server[2661382]: at async XapiVhdCbtSource.init (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/xapi/disks/XapiVhdCbt.mjs:75:20)
Jun 25 07:02:23 xoa xo-server[2661382]: at async #openNbdCbt (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/xapi/disks/Xapi.mjs:129:7)
Jun 25 07:02:23 xoa xo-server[2661382]: at async XapiDiskSource.init (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/disk-transform/dist/DiskPassthrough.mjs:28:41)
Jun 25 07:02:23 xoa xo-server[2661382]: at async file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/backups/_incrementalVm.mjs:65:5
Jun 25 07:02:23 xoa xo-server[2661382]: at async Promise.all (index 0)
Jun 25 07:02:23 xoa xo-server[2661382]: at async cancelableMap (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/backups/_cancelableMap.mjs:11:12)
Jun 25 07:02:23 xoa xo-server[2661382]: at async exportIncrementalVm (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/backups/_incrementalVm.mjs:28:3)
Jun 25 07:02:23 xoa xo-server[2661382]: at async IncrementalXapiVmBackupRunner._copy (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/backups/_runners/_vmRunners/IncrementalXapi.mjs:38:25) {
Jun 25 07:02:23 xoa xo-server[2661382]: code: 'NO_NBD_AVAILABLE'
Jun 25 07:02:23 xoa xo-server[2661382]: }
Jun 25 07:02:27 xoa xo-server[2661382]: 2025-06-25T11:02:27.312Z xo:xapi:vdi WARN invalid HTTP header in response body {
Jun 25 07:02:27 xoa xo-server[2661382]: body: 'HTTP/1.1 500 Internal Error\r\n' +
Jun 25 07:02:27 xoa xo-server[2661382]: 'content-length: 318\r\n' +
Jun 25 07:02:27 xoa xo-server[2661382]: 'content-type: text/html\r\n' +
Jun 25 07:02:27 xoa xo-server[2661382]: 'connection: close\r\n' +
Jun 25 07:02:27 xoa xo-server[2661382]: 'cache-control: no-cache, no-store\r\n' +
Jun 25 07:02:27 xoa xo-server[2661382]: '\r\n' +
Jun 25 07:02:27 xoa xo-server[2661382]: '<html><body><h1>HTTP 500 internal server error</h1>An unexpected error occurred; please wait a while and try again. If the problem persists, please contact your support representative.<h1> Additional information </h1>VDI_INCOMPATIBLE_TYPE: [ OpaqueRef:31a2142e-c677-6c86-e916-0ac19ffbe40f; CBT metadata ]</body></html>'
Jun 25 07:02:27 xoa xo-server[2661382]: }
Jun 25 07:02:39 xoa xo-server[2661382]: 2025-06-25T11:02:39.117Z @xen-orchestra/xapi/disks/Xapi WARN openNbdCBT Error: can't connect to any nbd client
Jun 25 07:02:39 xoa xo-server[2661382]: at connectNbdClientIfPossible (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/xapi/disks/utils.mjs:23:19)
Jun 25 07:02:39 xoa xo-server[2661382]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
Jun 25 07:02:39 xoa xo-server[2661382]: at async XapiVhdCbtSource.init (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/xapi/disks/XapiVhdCbt.mjs:75:20)
Jun 25 07:02:39 xoa xo-server[2661382]: at async #openNbdCbt (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/xapi/disks/Xapi.mjs:129:7)
Jun 25 07:02:39 xoa xo-server[2661382]: at async XapiDiskSource.init (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/disk-transform/dist/DiskPassthrough.mjs:28:41)
Jun 25 07:02:39 xoa xo-server[2661382]: at async file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/backups/_incrementalVm.mjs:65:5
Jun 25 07:02:39 xoa xo-server[2661382]: at async Promise.all (index 3) {
Jun 25 07:02:39 xoa xo-server[2661382]: code: 'NO_NBD_AVAILABLE'
Jun 25 07:02:39 xoa xo-server[2661382]: }
Jun 25 07:02:39 xoa xo-server[2661382]: 2025-06-25T11:02:39.539Z @xen-orchestra/xapi/disks/Xapi WARN openNbdCBT Error: can't connect to any nbd client
Jun 25 07:02:39 xoa xo-server[2661382]: at connectNbdClientIfPossible (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/xapi/disks/utils.mjs:23:19)
Jun 25 07:02:39 xoa xo-server[2661382]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
Jun 25 07:02:39 xoa xo-server[2661382]: at async XapiVhdCbtSource.init (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/xapi/disks/XapiVhdCbt.mjs:75:20)
Jun 25 07:02:39 xoa xo-server[2661382]: at async #openNbdCbt (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/xapi/disks/Xapi.mjs:129:7)
Jun 25 07:02:39 xoa xo-server[2661382]: at async XapiDiskSource.init (file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/disk-transform/dist/DiskPassthrough.mjs:28:41)
Jun 25 07:02:39 xoa xo-server[2661382]: at async file:///usr/local/lib/node_modules/xo-server/node_modules/@xen-orchestra/backups/_incrementalVm.mjs:65:5
Jun 25 07:02:39 xoa xo-server[2661382]: at async Promise.all (index 2) {
Jun 25 07:02:39 xoa xo-server[2661382]: code: 'NO_NBD_AVAILABLE'
Jun 25 07:02:39 xoa xo-server[2661382]: }
Jun 25 07:02:42 xoa xo-server[2661382]: 2025-06-25T11:02:42.588Z xo:xapi:vdi WARN invalid HTTP header in response body {
Jun 25 07:02:42 xoa xo-server[2661382]: body: 'HTTP/1.1 500 Internal Error\r\n' +
Jun 25 07:02:42 xoa xo-server[2661382]: 'content-length: 318\r\n' +
Jun 25 07:02:42 xoa xo-server[2661382]: 'content-type: text/html\r\n' +
Jun 25 07:02:42 xoa xo-server[2661382]: 'connection: close\r\n' +
Jun 25 07:02:42 xoa xo-server[2661382]: 'cache-control: no-cache, no-store\r\n' +
Jun 25 07:02:42 xoa xo-server[2661382]: '\r\n' +
Jun 25 07:02:42 xoa xo-server[2661382]: '<html><body><h1>HTTP 500 internal server error</h1>An unexpected error occurred; please wait a while and try again. If the problem persists, please contact your support representative.<h1> Additional information </h1>VDI_INCOMPATIBLE_TYPE: [ OpaqueRef:f0379a82-6fce-c6fa-a4c7-b7b6dcc5df26; CBT metadata ]</body></html>'
Jun 25 07:02:42 xoa xo-server[2661382]: }
Jun 25 07:02:42 xoa xo-server[2661382]: 2025-06-25T11:02:42.950Z xo:xapi:vdi WARN invalid HTTP header in response body {
Jun 25 07:02:42 xoa xo-server[2661382]: body: 'HTTP/1.1 500 Internal Error\r\n' +
Jun 25 07:02:42 xoa xo-server[2661382]: 'content-length: 318\r\n' +
Jun 25 07:02:42 xoa xo-server[2661382]: 'content-type: text/html\r\n' +
Jun 25 07:02:42 xoa xo-server[2661382]: 'connection: close\r\n' +
Jun 25 07:02:42 xoa xo-server[2661382]: 'cache-control: no-cache, no-store\r\n' +
Jun 25 07:02:42 xoa xo-server[2661382]: '\r\n' +
Jun 25 07:02:42 xoa xo-server[2661382]: '<html><body><h1>HTTP 500 internal server error</h1>An unexpected error occurred; please wait a while and try again. If the problem persists, please contact your support representative.<h1> Additional information </h1>VDI_INCOMPATIBLE_TYPE: [ OpaqueRef:85222592-ba8f-e189-8389-6cb4d8dd038b; CBT metadata ]</body></html>'
Jun 25 07:02:42 xoa xo-server[2661382]: }
Jun 25 07:02:43 xoa xo-server[2661382]: 2025-06-25T11:02:43.467Z @xen-orchestra/xapi/disks/Xapi WARN openNbdCBT XapiError: HANDLE_INVALID(VDI, OpaqueRef:0671251f-d1f0-2a16-53c8-125f2b357e0d)
Jun 25 07:02:43 xoa xo-server[2661382]: at XapiError.wrap (file:///usr/local/lib/node_modules/xo-server/node_modules/xen-api/_XapiError.mjs:16:12)
Jun 25 07:02:43 xoa xo-server[2661382]: at default (file:///usr/local/lib/node_modules/xo-server/node_modules/xen-api/_getTaskResult.mjs:13:29)
Jun 25 07:02:43 xoa xo-server[2661382]: at Xapi._addRecordToCache (file:///usr/local/lib/node_modules/xo-server/node_modules/xen-api/index.mjs:1072:24)
Jun 25 07:02:43 xoa xo-server[2661382]: at file:///usr/local/lib/node_modules/xo-server/node_modules/xen-api/index.mjs:1106:14
Jun 25 07:02:43 xoa xo-server[2661382]: at Array.forEach (<anonymous>)
Jun 25 07:02:43 xoa xo-server[2661382]: at Xapi._processEvents (file:///usr/local/lib/node_modules/xo-server/node_modules/xen-api/index.mjs:1096:12)
Jun 25 07:02:43 xoa xo-server[2661382]: at Xapi._watchEvents (file:///usr/local/lib/node_modules/xo-server/node_modules/xen-api/index.mjs:1269:14)
Jun 25 07:02:43 xoa xo-server[2661382]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) {
Jun 25 07:02:43 xoa xo-server[2661382]: code: 'HANDLE_INVALID',
Jun 25 07:02:43 xoa xo-server[2661382]: params: [ 'VDI', 'OpaqueRef:0671251f-d1f0-2a16-53c8-125f2b357e0d' ],
Jun 25 07:02:43 xoa xo-server[2661382]: call: undefined,
Jun 25 07:02:43 xoa xo-server[2661382]: url: undefined,
Jun 25 07:02:43 xoa xo-server[2661382]: task: task {
Jun 25 07:02:43 xoa xo-server[2661382]: uuid: '19892e76-0681-defa-7d86-8adff4c519df',
Jun 25 07:02:43 xoa xo-server[2661382]: name_label: 'Async.VDI.list_changed_blocks',
Jun 25 07:02:43 xoa xo-server[2661382]: name_description: '',
Jun 25 07:02:43 xoa xo-server[2661382]: allowed_operations: [],
Jun 25 07:02:43 xoa xo-server[2661382]: current_operations: {},
Jun 25 07:02:43 xoa xo-server[2661382]: created: '20250625T11:02:23Z',
Jun 25 07:02:43 xoa xo-server[2661382]: finished: '20250625T11:02:43Z',
Jun 25 07:02:43 xoa xo-server[2661382]: status: 'failure',
Jun 25 07:02:43 xoa xo-server[2661382]: resident_on: 'OpaqueRef:38c38c49-d15f-e42a-7aca-ae093fca92c6',
Jun 25 07:02:43 xoa xo-server[2661382]: progress: 1,
Jun 25 07:02:43 xoa xo-server[2661382]: type: '<none/>',
Jun 25 07:02:43 xoa xo-server[2661382]: result: '',
Jun 25 07:02:43 xoa xo-server[2661382]: error_info: [
Jun 25 07:02:43 xoa xo-server[2661382]: 'HANDLE_INVALID',
Jun 25 07:02:43 xoa xo-server[2661382]: 'VDI',
Jun 25 07:02:43 xoa xo-server[2661382]: 'OpaqueRef:0671251f-d1f0-2a16-53c8-125f2b357e0d'
Jun 25 07:02:43 xoa xo-server[2661382]: ],
Jun 25 07:02:43 xoa xo-server[2661382]: other_config: {},
Jun 25 07:02:43 xoa xo-server[2661382]: subtask_of: 'OpaqueRef:NULL',
Jun 25 07:02:43 xoa xo-server[2661382]: subtasks: [],
Jun 25 07:02:43 xoa xo-server[2661382]: backtrace: '(((process xapi)(filename ocaml/xapi-client/client.ml)(line 7))((process xapi)(filename ocaml/xapi-client/client.ml)(line 19))((process xapi)(filename ocaml/xapi-client/client.ml)(line 11643))((process xapi)(filename ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml)(line 24))((process xapi)(filename ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml)(line 39))((process xapi)(filename ocaml/xapi/message_forwarding.ml)(line 144))((process xapi)(filename ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml)(line 24))((process xapi)(filename ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml)(line 39))((process xapi)(filename ocaml/xapi/rbac.ml)(line 188))((process xapi)(filename ocaml/xapi/rbac.ml)(line 197))((process xapi)(filename ocaml/xapi/server_helpers.ml)(line 77)))'
Jun 25 07:02:43 xoa xo-server[2661382]: }
Jun 25 07:02:43 xoa xo-server[2661382]: }
Jun 25 07:02:46 xoa xo-server[2661382]: 2025-06-25T11:02:46.867Z xo:xapi:vdi WARN invalid HTTP header in response body {
Jun 25 07:02:46 xoa xo-server[2661382]: body: 'HTTP/1.1 500 Internal Error\r\n' +
Jun 25 07:02:46 xoa xo-server[2661382]: 'content-length: 346\r\n' +
Jun 25 07:02:46 xoa xo-server[2661382]: 'content-type: text/html\r\n' +
Jun 25 07:02:46 xoa xo-server[2661382]: 'connection: close\r\n' +
Jun 25 07:02:46 xoa xo-server[2661382]: 'cache-control: no-cache, no-store\r\n' +
Jun 25 07:02:46 xoa xo-server[2661382]: '\r\n' +
Jun 25 07:02:46 xoa xo-server[2661382]: '<html><body><h1>HTTP 500 internal server error</h1>An unexpected error occurred; please wait a while and try again. If the problem persists, please contact your support representative.<h1> Additional information </h1>Db_exn.Read_missing_uuid("VDI", "", "OpaqueRef:0671251f-d1f0-2a16-53c8-125f2b357e0d")</body></html>'
Jun 25 07:02:46 xoa xo-server[2661382]: }
Jun 25 07:02:52 xoa xo-server[2661382]: 2025-06-25T11:02:52.120Z xo:backups:worker INFO backup has ended
Jun 25 07:02:52 xoa xo-server[2661382]: 2025-06-25T11:02:52.133Z xo:backups:worker INFO process will exit {
Jun 25 07:02:52 xoa xo-server[2661382]: duration: 54097776,
Jun 25 07:02:52 xoa xo-server[2661382]: exitCode: 0,
Jun 25 07:02:52 xoa xo-server[2661382]: resourceUsage: {
Jun 25 07:02:52 xoa xo-server[2661382]: userCPUTime: 2370678,
Jun 25 07:02:52 xoa xo-server[2661382]: systemCPUTime: 266735,
Jun 25 07:02:52 xoa xo-server[2661382]: maxRSS: 37208,
Jun 25 07:02:52 xoa xo-server[2661382]: sharedMemorySize: 0,
Jun 25 07:02:52 xoa xo-server[2661382]: unsharedDataSize: 0,
Jun 25 07:02:52 xoa xo-server[2661382]: unsharedStackSize: 0,
Jun 25 07:02:52 xoa xo-server[2661382]: minorPageFault: 22126,
Jun 25 07:02:52 xoa xo-server[2661382]: majorPageFault: 0,
Jun 25 07:02:52 xoa xo-server[2661382]: swappedOut: 0,
Jun 25 07:02:52 xoa xo-server[2661382]: fsRead: 0,
Jun 25 07:02:52 xoa xo-server[2661382]: fsWrite: 0,
Jun 25 07:02:52 xoa xo-server[2661382]: ipcSent: 0,
Jun 25 07:02:52 xoa xo-server[2661382]: ipcReceived: 0,
Jun 25 07:02:52 xoa xo-server[2661382]: signalsCount: 0,
Jun 25 07:02:52 xoa xo-server[2661382]: voluntaryContextSwitches: 2163,
Jun 25 07:02:52 xoa xo-server[2661382]: involuntaryContextSwitches: 658
Jun 25 07:02:52 xoa xo-server[2661382]: },
Jun 25 07:02:52 xoa xo-server[2661382]: summary: { duration: '54s', cpuUsage: '5%', memoryUsage: '36.34 MiB' }
Jun 25 07:02:52 xoa xo-server[2661382]: }