Jun 30 14:43:24 systemd[1]: xo-server.service: Consumed 24min 5.144s CPU time. -- Boot 7d7933549e404f709cdb1eb0156bf1a5 -- Jun 30 14:45:29 systemd[1]: Started xo-server.service - XO Server. Jun 30 14:46:17 xo-server[804]: 2025-06-30T13:46:17.238Z xo:main INFO Configuration loaded. Jun 30 14:46:17 xo-server[804]: 2025-06-30T13:46:17.359Z xo:main INFO Web server listening on https://[::]:443 Jun 30 14:46:17 xo-server[804]: 2025-06-30T13:46:17.976Z xo:mixins:hooks WARN start failure { Jun 30 14:46:17 xo-server[804]: error: Error: Command failed with exit code 5: vgchange -an Jun 30 14:46:17 xo-server[804]: Logical volume -vg/root contains a filesystem in use. Jun 30 14:46:17 xo-server[804]: Can't deactivate volume group "-vg" with 2 open logical volume(s) Jun 30 14:46:17 xo-server[804]: at makeError (file:///opt/xo/xo-builds/xen-orchestra-202506301106/packages/xo-server/node_modules/execa/lib/error.js:60:11) Jun 30 14:46:17 xo-server[804]: at handlePromise (file:///opt/xo/xo-builds/xen-orchestra-202506301106/packages/xo-server/node_modules/execa/index.js:124:26) Jun 30 14:46:17 xo-server[804]: at runNextTicks (node:internal/process/task_queues:65:5) Jun 30 14:46:17 xo-server[804]: at processImmediate (node:internal/timers:453:9) Jun 30 14:46:17 xo-server[804]: at process.callbackTrampoline (node:internal/async_hooks:130:17) { Jun 30 14:46:17 xo-server[804]: shortMessage: 'Command failed with exit code 5: vgchange -an', Jun 30 14:46:17 xo-server[804]: command: 'vgchange -an', Jun 30 14:46:17 xo-server[804]: escapedCommand: 'vgchange -an', Jun 30 14:46:17 xo-server[804]: exitCode: 5, Jun 30 14:46:17 xo-server[804]: signal: undefined, Jun 30 14:46:17 xo-server[804]: signalDescription: undefined, Jun 30 14:46:17 xo-server[804]: stdout: '', Jun 30 14:46:17 xo-server[804]: stderr: ' Logical volume -vg/root contains a filesystem in use.\n' + Jun 30 14:46:17 xo-server[804]: ` Can't deactivate volume group "-vg" with 2 open logical volume(s)`, Jun 30 14:46:17 xo-server[804]: cwd: '/opt/xo/xo-builds/xen-orchestra-202506301106/packages/xo-server', Jun 30 14:46:17 xo-server[804]: failed: true, Jun 30 14:46:17 xo-server[804]: timedOut: false, Jun 30 14:46:17 xo-server[804]: isCanceled: false, Jun 30 14:46:17 xo-server[804]: killed: false Jun 30 14:46:17 xo-server[804]: } Jun 30 14:46:17 xo-server[804]: } Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.053Z xo:main INFO Setting up /robots.txt → /opt/xo/xo-builds/xen-orchestra-202506301106/packages/xo-server/robots.txt Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.169Z xo:main INFO Setting up / → /opt/xo/xo-web/dist/ Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.169Z xo:main INFO Setting up /v6 → /opt/xo/xo-builds/xen-orchestra-202506301106/@xen-orchestra/web/dist Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.175Z xo:plugin INFO register audit Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.183Z xo:plugin INFO register auth-github Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.248Z xo:plugin INFO register auth-google Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.269Z xo:plugin INFO register auth-ldap Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.282Z xo:plugin INFO register auth-oidc Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.285Z xo:plugin INFO register auth-saml Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.304Z xo:plugin INFO register backup-reports Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.309Z xo:plugin INFO register load-balancer Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.343Z xo:plugin INFO register netbox Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.345Z xo:plugin INFO register perf-alert Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.346Z xo:plugin INFO register sdn-controller Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.348Z xo:plugin INFO register transport-email Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.363Z xo:plugin INFO register transport-icinga2 Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.365Z xo:plugin INFO register transport-nagios Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.366Z xo:plugin INFO register transport-slack Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.368Z xo:plugin INFO register transport-xmpp Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.370Z xo:plugin INFO register usage-report Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.372Z xo:plugin INFO register web-hooks Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.374Z xo:plugin INFO register test Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.374Z xo:plugin INFO register test-plugin Jun 30 14:46:19 xo-server[804]: 2025-06-30T13:46:19.428Z xo:xo-mixins:xen-servers WARN failed to connect to XenServer { Jun 30 14:46:19 xo-server[804]: host: '', Jun 30 14:46:19 xo-server[804]: error: PoolAlreadyConnected: this pool is already connected Jun 30 14:46:19 xo-server[804]: at XenServers.connectXenServer (file:///opt/xo/xo-builds/xen-orchestra-202506301106/packages/xo-server/src/xo-mixins/xen-servers.mjs:364:15) { Jun 30 14:46:19 xo-server[804]: poolId: 'dbe4dd00-0fbe-9cd3-9ab5-375f43582614', Jun 30 14:46:19 xo-server[804]: connectedServerId: '92e337bf-70e8-48d0-b804-6cf833d44264', Jun 30 14:46:19 xo-server[804]: connectingServerId: '0d370794-b7a5-47a2-9195-1cfad5e11de8' Jun 30 14:46:19 xo-server[804]: } Jun 30 14:46:19 xo-server[804]: } Jun 30 14:46:20 xo-server[804]: 2025-06-30T13:46:20.186Z xo:xo-mixins:xen-servers WARN failed to connect to XenServer { Jun 30 14:46:20 xo-server[804]: host: '', Jun 30 14:46:20 xo-server[804]: error: PoolAlreadyConnected: this pool is already connected Jun 30 14:46:20 xo-server[804]: at XenServers.connectXenServer (file:///opt/xo/xo-builds/xen-orchestra-202506301106/packages/xo-server/src/xo-mixins/xen-servers.mjs:364:15) Jun 30 14:46:20 xo-server[804]: at runNextTicks (node:internal/process/task_queues:65:5) Jun 30 14:46:20 xo-server[804]: at processImmediate (node:internal/timers:453:9) Jun 30 14:46:20 xo-server[804]: at process.callbackTrampoline (node:internal/async_hooks:130:17) { Jun 30 14:46:20 xo-server[804]: poolId: 'dbe4dd00-0fbe-9cd3-9ab5-375f43582614', Jun 30 14:46:20 xo-server[804]: connectedServerId: '92e337bf-70e8-48d0-b804-6cf833d44264', Jun 30 14:46:20 xo-server[804]: connectingServerId: 'b75674ce-f126-4bb2-930a-0ce7008557fb' Jun 30 14:46:20 xo-server[804]: } Jun 30 14:46:20 xo-server[804]: } Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.731Z xo:plugin INFO failed register test Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.731Z xo:plugin INFO Cannot read properties of undefined (reading 'default') { Jun 30 14:46:27 xo-server[804]: error: TypeError: Cannot read properties of undefined (reading 'default') Jun 30 14:46:27 xo-server[804]: at Xo.registerPlugin (file:///opt/xo/xo-builds/xen-orchestra-202506301106/packages/xo-server/src/index.mjs:369:18) Jun 30 14:46:27 xo-server[804]: } Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.837Z xo:plugin INFO successfully register auth-github Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.837Z xo:plugin INFO successfully register auth-google Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.838Z xo:plugin INFO successfully register auth-ldap Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.911Z xo:plugin INFO successfully register audit Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.912Z xo:plugin INFO successfully register auth-oidc Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.912Z xo:plugin INFO successfully register auth-saml Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.912Z xo:plugin INFO successfully register netbox Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.912Z xo:plugin INFO successfully register transport-icinga2 Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.912Z xo:plugin INFO successfully register transport-xmpp Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.912Z xo:plugin INFO successfully register transport-slack Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.912Z xo:plugin INFO successfully register transport-nagios Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.912Z xo:plugin INFO successfully register usage-report Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.912Z xo:plugin INFO successfully register web-hooks Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.912Z xo:plugin INFO successfully register test-plugin Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.912Z xo:plugin INFO successfully register backup-reports Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.912Z xo:plugin INFO successfully register load-balancer Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.912Z xo:plugin INFO successfully register transport-email Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.913Z xo:plugin INFO successfully register perf-alert Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.946Z xo:xo-server:sdn-controller ERROR Error while installing SDN controller CA certificate { Jun 30 14:46:27 xo-server[804]: error: XapiError: CERTIFICATE_ALREADY_EXISTS(sdn-controller-ca.pem) Jun 30 14:46:27 xo-server[804]: at Function.wrap (file:///opt/xo/xo-builds/xen-orchestra-202506301106/packages/xen-api/_XapiError.mjs:16:12) Jun 30 14:46:27 xo-server[804]: at file:///opt/xo/xo-builds/xen-orchestra-202506301106/packages/xen-api/transports/json-rpc.mjs:38:21 Jun 30 14:46:27 xo-server[804]: at runNextTicks (node:internal/process/task_queues:65:5) Jun 30 14:46:27 xo-server[804]: at processImmediate (node:internal/timers:453:9) Jun 30 14:46:27 xo-server[804]: at process.callbackTrampoline (node:internal/async_hooks:130:17) { Jun 30 14:46:27 xo-server[804]: code: 'CERTIFICATE_ALREADY_EXISTS', Jun 30 14:46:27 xo-server[804]: params: [ 'sdn-controller-ca.pem' ], Jun 30 14:46:27 xo-server[804]: call: { Jun 30 14:46:27 xo-server[804]: duration: 3, Jun 30 14:46:27 xo-server[804]: method: 'pool.certificate_install', Jun 30 14:46:27 xo-server[804]: params: [Array] Jun 30 14:46:27 xo-server[804]: }, Jun 30 14:46:27 xo-server[804]: url: undefined, Jun 30 14:46:27 xo-server[804]: task: undefined Jun 30 14:46:27 xo-server[804]: }, Jun 30 14:46:27 xo-server[804]: pool: 'primary' Jun 30 14:46:27 xo-server[804]: } Jun 30 14:46:27 xo-server[804]: 2025-06-30T13:46:27.956Z xo:plugin INFO successfully register sdn-controller Jun 30 14:47:28 xo-server[1584]: 2025-06-30T13:47:28.294Z xo:backups:worker INFO starting backup Jun 30 14:47:30 xo-server[1584]: 2025-06-30T13:47:30.825Z xo:backups:MixinBackupWriter INFO deleting temporary VHD { Jun 30 14:47:30 xo-server[1584]: path: '/xo-vm-backups/9e78d70b-8dcf-dd06-e05e-de2ce1f7053d/vdis/1e6645ae-4742-46d7-bc17-c3c0fd94e680/faab9264-aafd-46e3-ac03-4315ef16786d/.20250630T110327Z.vhd' Jun 30 14:47:30 xo-server[1584]: } Jun 30 14:47:30 xo-server[1584]: 2025-06-30T13:47:30.904Z xo:backups:MixinBackupWriter INFO deleting unused VHD { Jun 30 14:47:30 xo-server[1584]: path: '/xo-vm-backups/9e78d70b-8dcf-dd06-e05e-de2ce1f7053d/vdis/1e6645ae-4742-46d7-bc17-c3c0fd94e680/faab9264-aafd-46e3-ac03-4315ef16786d/.20250630T110327Z.vhd' Jun 30 14:47:30 xo-server[1584]: } Jun 30 14:47:39 xo-server[1584]: 2025-06-30T13:47:39.324Z @xen-orchestra/xapi/disks/Xapi WARN can't connect through NBD, fallback to stream export Jun 30 14:47:39 xo-server[1584]: 2025-06-30T13:47:39.342Z xo:backups:worker WARN possibly unhandled rejection { Jun 30 14:47:39 xo-server[1584]: error: RequestAbortedError [AbortError]: Request aborted Jun 30 14:47:39 xo-server[1584]: at BodyReadable.destroy (/opt/xo/xo-builds/xen-orchestra-202506301106/node_modules/undici/lib/api/readable.js:51:13) Jun 30 14:47:39 xo-server[1584]: at XapiVhdStreamSource.close (file:///opt/xo/xo-builds/xen-orchestra-202506301106/@xen-orchestra/xapi/disks/XapiVhdStreamSource.mjs:160:22) Jun 30 14:47:39 xo-server[1584]: at XapiStreamNbdSource.close (file:///opt/xo/xo-builds/xen-orchestra-202506301106/@xen-orchestra/disk-transform/dist/DiskPassthrough.mjs:34:29) Jun 30 14:47:39 xo-server[1584]: at XapiStreamNbdSource.close (file:///opt/xo/xo-builds/xen-orchestra-202506301106/@xen-orchestra/xapi/disks/XapiStreamNbd.mjs:81:19) Jun 30 14:47:39 xo-server[1584]: at #openNbdStream (file:///opt/xo/xo-builds/xen-orchestra-202506301106/@xen-orchestra/xapi/disks/Xapi.mjs:92:21) Jun 30 14:47:39 xo-server[1584]: at process.processTicksAndRejections (node:internal/process/task_queues:105:5) Jun 30 14:47:39 xo-server[1584]: at async XapiDiskSource.openSource (file:///opt/xo/xo-builds/xen-orchestra-202506301106/@xen-orchestra/xapi/disks/Xapi.mjs:198:18) Jun 30 14:47:39 xo-server[1584]: at async XapiDiskSource.init (file:///opt/xo/xo-builds/xen-orchestra-202506301106/@xen-orchestra/disk-transform/dist/DiskPassthrough.mjs:28:41) Jun 30 14:47:39 xo-server[1584]: at async file:///opt/xo/xo-builds/xen-orchestra-202506301106/@xen-orchestra/backups/_incrementalVm.mjs:67:5