Hi All, after adding an oVirt node as a local storage machine I am unable to
upload a disk to the datastore. The button "test connection" shows:
"Connection to ovirt-imageio was successful.".
Version: 4.5.4-1.el8
OS: AlmaLinux 8.9 (Midnight Oncilla)
Below a excerpt from the engine.log showing the entire upload session.
Note 1: The machine "kvm-sandbox-qm7" is the machine for the
localstorage cluster. The machine "kvm-sandbox-gcz" is a machine from
the other "default cluster" and I was under the impression that the two
clusters would be completely separate things and should not interfere
with each other. But I am not sure about that.
--- snip ---
2024-01-03 10:05:26,898Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(default task-1) [7855db64-635d-430f-9de8-21b1983e43a0] Lock Acquired to object
'EngineLock:{exclusiveLocks='[]', sharedLocks='[]'}'
2024-01-03 10:05:26,938Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(default task-1) [7855db64-635d-430f-9de8-21b1983e43a0] Running command:
TransferDiskImageCommand internal: false. Entities affected : ID:
95dfc5bc-2a31-405c-ada0-6015edd281da Type: StorageAction group CREATE_DISK with
role type USER
2024-01-03 10:05:26,938Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(default task-1) [7855db64-635d-430f-9de8-21b1983e43a0] Creating ImageTransfer
entity for command 'ec704c40-89bc-4fdf-a44a-607dd7b9b2f7', proxyEnabled: true
2024-01-03 10:05:26,940Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(default task-1) [7855db64-635d-430f-9de8-21b1983e43a0] Starting image
transfer: ImageTransfer:{id='ec704c40-89bc-4fdf-a44a-607dd7b9b2f7',
phase='Initializing', type='Upload', active='false', lastUpdated='Wed Jan 03
10:05:26 UTC 2024', message='null', vdsId='null', diskId='null',
imagedTicketId='null', proxyUri='null', bytesSent='null',
bytesTotal='697434112', clientInactivityTimeout='60', timeoutPolicy='legacy',
imageFormat='COW', transferClientType='Transfer via browser', shallow='false'}
2024-01-03 10:05:26,940Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(default task-1) [7855db64-635d-430f-9de8-21b1983e43a0] Creating disk image
2024-01-03 10:05:26,953Z INFO
[org.ovirt.engine.core.bll.storage.disk.AddDiskCommand] (default task-1)
[7855db64-635d-430f-9de8-21b1983e43a0] Running command: AddDiskCommand
internal: true. Entities affected : ID: 95dfc5bc-2a31-405c-ada0-6015edd281da
Type: StorageAction group CREATE_DISK with role type USER
2024-01-03 10:05:26,961Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand]
(default task-1) [7855db64-635d-430f-9de8-21b1983e43a0] Running command:
AddImageFromScratchCommand internal: true. Entities affected : ID:
95dfc5bc-2a31-405c-ada0-6015edd281da Type: Storage
2024-01-03 10:05:26,981Z INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.CreateVolumeVDSCommand] (default
task-1) [7855db64-635d-430f-9de8-21b1983e43a0] START, CreateVolumeVDSCommand(
CreateVolumeVDSCommandParameters:{storagePoolId='4c5f1e92-239b-471c-9db0-970029129a62',
ignoreFailoverLimit='false',
storageDomainId='95dfc5bc-2a31-405c-ada0-6015edd281da',
imageGroupId='13dcaf25-6b58-4c79-85a7-0aecd153fb59',
imageSizeInBytes='10737418240', volumeFormat='COW',
newImageId='6b80fba5-c2ae-4b68-a24d-21d7f657da8f', imageType='Sparse',
newImageDescription='{"DiskAlias":"aaa","DiskDescription":""}',
imageInitialSizeInBytes='0', imageId='00000000-0000-0000-0000-000000000000',
sourceImageGroupId='00000000-0000-0000-0000-000000000000',
shouldAddBitmaps='false', legal='true', sequenceNumber='1', bitmap='null'}),
log id: b4c79ef
2024-01-03 10:05:27,406Z INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.CreateVolumeVDSCommand] (default
task-1) [7855db64-635d-430f-9de8-21b1983e43a0] FINISH, CreateVolumeVDSCommand,
return: 6b80fba5-c2ae-4b68-a24d-21d7f657da8f, log id: b4c79ef
2024-01-03 10:05:27,409Z INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (default task-1)
[7855db64-635d-430f-9de8-21b1983e43a0] CommandAsyncTask::Adding
CommandMultiAsyncTasks object for command 'a6f3ff83-daa4-4799-908a-07029ff8f6ef'
2024-01-03 10:05:27,410Z INFO
[org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (default task-1)
[7855db64-635d-430f-9de8-21b1983e43a0] CommandMultiAsyncTasks::attachTask:
Attaching task '5a29a235-b61c-4efb-959a-f29ae7f863be' to command
'a6f3ff83-daa4-4799-908a-07029ff8f6ef'.
2024-01-03 10:05:27,427Z INFO
[org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (default task-1)
[7855db64-635d-430f-9de8-21b1983e43a0] Adding task
'5a29a235-b61c-4efb-959a-f29ae7f863be' (Parent Command 'AddImageFromScratch',
Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters'),
polling hasn't started yet..
2024-01-03 10:05:27,435Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(default task-1) [7855db64-635d-430f-9de8-21b1983e43a0]
BaseAsyncTask::startPollingTask: Starting to poll task
'5a29a235-b61c-4efb-959a-f29ae7f863be'.
2024-01-03 10:05:27,449Z INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default
task-1) [7855db64-635d-430f-9de8-21b1983e43a0] EVENT_ID:
ADD_DISK_INTERNAL(2,036), Add-Disk operation of 'aaa' was initiated by the
system.
2024-01-03 10:05:27,457Z INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default
task-1) [7855db64-635d-430f-9de8-21b1983e43a0] EVENT_ID:
TRANSFER_IMAGE_INITIATED(1,031), Image Upload with disk aaa was initiated by
[[redacted user]]@[[redacted]]@[[redacted]].
2024-01-03 10:05:27,866Z INFO
[org.ovirt.engine.core.bll.storage.disk.AddDiskCommandCallback]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-95)
[7855db64-635d-430f-9de8-21b1983e43a0] Command 'AddDisk' (id:
'dfe023fa-0a96-40e8-9934-fb94a156bff6') waiting on child command id:
'a6f3ff83-daa4-4799-908a-07029ff8f6ef' type:'AddImageFromScratch' to complete
2024-01-03 10:05:27,869Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-95)
[7855db64-635d-430f-9de8-21b1983e43a0] Waiting for disk to be added for image
transfer 'ec704c40-89bc-4fdf-a44a-607dd7b9b2f7'
2024-01-03 10:05:29,872Z INFO
[org.ovirt.engine.core.bll.storage.disk.AddDiskCommandCallback]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-16)
[7855db64-635d-430f-9de8-21b1983e43a0] Command 'AddDisk' (id:
'dfe023fa-0a96-40e8-9934-fb94a156bff6') waiting on child command id:
'a6f3ff83-daa4-4799-908a-07029ff8f6ef' type:'AddImageFromScratch' to complete
2024-01-03 10:05:29,875Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-16)
[7855db64-635d-430f-9de8-21b1983e43a0] Waiting for disk to be added for image
transfer 'ec704c40-89bc-4fdf-a44a-607dd7b9b2f7'
2024-01-03 10:05:30,014Z INFO
[org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-46) []
Polling and updating Async Tasks: 1 tasks, 1 tasks to poll now
2024-01-03 10:05:30,019Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-46) []
SPMAsyncTask::PollTask: Polling task '5a29a235-b61c-4efb-959a-f29ae7f863be'
(Parent Command 'AddImageFromScratch', Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned status
'finished', result 'success'.
2024-01-03 10:05:30,019Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-46) []
BaseAsyncTask::onTaskEndSuccess: Task '5a29a235-b61c-4efb-959a-f29ae7f863be'
(Parent Command 'AddImageFromScratch', Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') ended
successfully.
2024-01-03 10:05:30,021Z INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-46) []
CommandAsyncTask::endActionIfNecessary: All tasks of command
'a6f3ff83-daa4-4799-908a-07029ff8f6ef' has ended -> executing 'endAction'
2024-01-03 10:05:30,022Z INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-46) []
CommandAsyncTask::endAction: Ending action for '1' tasks (command ID:
'a6f3ff83-daa4-4799-908a-07029ff8f6ef'): calling endAction '.
2024-01-03 10:05:30,022Z INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-2956) []
CommandAsyncTask::endCommandAction [within thread] context: Attempting to
endAction 'AddImageFromScratch',
2024-01-03 10:05:30,027Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand]
(EE-ManagedThreadFactory-engine-Thread-2956)
[7855db64-635d-430f-9de8-21b1983e43a0] Command
[id=a6f3ff83-daa4-4799-908a-07029ff8f6ef]: Updating status to 'SUCCEEDED', The
command end method logic will be executed by one of its parent commands.
2024-01-03 10:05:30,027Z INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-2956)
[7855db64-635d-430f-9de8-21b1983e43a0] CommandAsyncTask::HandleEndActionResult
[within thread]: endAction for action type 'AddImageFromScratch' completed,
handling the result.
2024-01-03 10:05:30,027Z INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-2956)
[7855db64-635d-430f-9de8-21b1983e43a0] CommandAsyncTask::HandleEndActionResult
[within thread]: endAction for action type 'AddImageFromScratch' succeeded,
clearing tasks.
2024-01-03 10:05:30,027Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-2956)
[7855db64-635d-430f-9de8-21b1983e43a0] SPMAsyncTask::ClearAsyncTask: Attempting
to clear task '5a29a235-b61c-4efb-959a-f29ae7f863be'
2024-01-03 10:05:30,028Z INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-2956)
[7855db64-635d-430f-9de8-21b1983e43a0] START, SPMClearTaskVDSCommand(
SPMTaskGuidBaseVDSCommandParameters:{storagePoolId='4c5f1e92-239b-471c-9db0-970029129a62',
ignoreFailoverLimit='false', taskId='5a29a235-b61c-4efb-959a-f29ae7f863be'}),
log id: af95363
2024-01-03 10:05:30,028Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-2956)
[7855db64-635d-430f-9de8-21b1983e43a0] START, HSMClearTaskVDSCommand(HostName =
kvm-sandbox-qm7,
HSMTaskGuidBaseVDSCommandParameters:{hostId='9fb846b0-58cf-41ab-875c-3e3118a24b89',
taskId='5a29a235-b61c-4efb-959a-f29ae7f863be'}), log id: 52de524b
2024-01-03 10:05:30,044Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-2956)
[7855db64-635d-430f-9de8-21b1983e43a0] FINISH, HSMClearTaskVDSCommand, return:
, log id: 52de524b
2024-01-03 10:05:30,044Z INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-2956)
[7855db64-635d-430f-9de8-21b1983e43a0] FINISH, SPMClearTaskVDSCommand, return:
, log id: af95363
2024-01-03 10:05:30,050Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-2956)
[7855db64-635d-430f-9de8-21b1983e43a0] BaseAsyncTask::removeTaskFromDB: Removed
task '5a29a235-b61c-4efb-959a-f29ae7f863be' from DataBase
2024-01-03 10:05:30,050Z INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-2956)
[7855db64-635d-430f-9de8-21b1983e43a0] CommandAsyncTask::HandleEndActionResult
[within thread]: Removing CommandMultiAsyncTasks object for entity
'a6f3ff83-daa4-4799-908a-07029ff8f6ef'
2024-01-03 10:05:31,567Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand]
(default task-6) [1ab78812-4bb8-4889-bea0-d2f2a82d52af] Running command:
TransferImageStatusCommand internal: false. Entities affected : ID:
95dfc5bc-2a31-405c-ada0-6015edd281da Type: SystemAction group CREATE_DISK with
role type USER
2024-01-03 10:05:33,877Z INFO
[org.ovirt.engine.core.bll.storage.disk.AddDiskCommandCallback]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-68)
[7855db64-635d-430f-9de8-21b1983e43a0] Getting volume info for image
'13dcaf25-6b58-4c79-85a7-0aecd153fb59/6b80fba5-c2ae-4b68-a24d-21d7f657da8f'
2024-01-03 10:05:33,894Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-68)
[7855db64-635d-430f-9de8-21b1983e43a0] START, GetVolumeInfoVDSCommand(HostName
= kvm-sandbox-qm7,
GetVolumeInfoVDSCommandParameters:{hostId='9fb846b0-58cf-41ab-875c-3e3118a24b89',
storagePoolId='4c5f1e92-239b-471c-9db0-970029129a62',
storageDomainId='95dfc5bc-2a31-405c-ada0-6015edd281da',
imageGroupId='13dcaf25-6b58-4c79-85a7-0aecd153fb59',
imageId='6b80fba5-c2ae-4b68-a24d-21d7f657da8f'}), log id: 78edc340
2024-01-03 10:05:33,908Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-68)
[7855db64-635d-430f-9de8-21b1983e43a0] FINISH, GetVolumeInfoVDSCommand, return:
org.ovirt.engine.core.common.businessentities.storage.DiskImage@14184952, log
id: 78edc340
2024-01-03 10:05:33,908Z INFO
[org.ovirt.engine.core.bll.storage.disk.AddDiskCommandCallback]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-68)
[7855db64-635d-430f-9de8-21b1983e43a0] Command 'AddDisk' id:
'dfe023fa-0a96-40e8-9934-fb94a156bff6' child commands
'[a6f3ff83-daa4-4799-908a-07029ff8f6ef]' executions were completed, status
'SUCCEEDED'
2024-01-03 10:05:33,967Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-68)
[7855db64-635d-430f-9de8-21b1983e43a0] Successfully added Upload disk 'aaa'
(disk id: '13dcaf25-6b58-4c79-85a7-0aecd153fb59', image id:
'6b80fba5-c2ae-4b68-a24d-21d7f657da8f') for image transfer
'ec704c40-89bc-4fdf-a44a-607dd7b9b2f7'
2024-01-03 10:05:33,978Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-68)
[7855db64-635d-430f-9de8-21b1983e43a0] START, PrepareImageVDSCommand(HostName =
kvm-sandbox-gcz,
PrepareImageVDSCommandParameters:{hostId='059c7eaf-da39-41f2-bb61-659ab3bd1b61'}),
log id: 104764a4
2024-01-03 10:05:33,981Z ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-68)
[7855db64-635d-430f-9de8-21b1983e43a0] Failed in 'PrepareImageVDS' method, for
vds: 'kvm-sandbox-gcz'; host: 'kvm-sandbox-gcz.hprvsr.infra.pdc.[[redacted]]':
null
2024-01-03 10:05:33,982Z ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-68)
[7855db64-635d-430f-9de8-21b1983e43a0] Command 'PrepareImageVDSCommand(HostName
= kvm-sandbox-gcz,
PrepareImageVDSCommandParameters:{hostId='059c7eaf-da39-41f2-bb61-659ab3bd1b61'})'
execution failed: null
2024-01-03 10:05:33,982Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-68)
[7855db64-635d-430f-9de8-21b1983e43a0] FINISH, PrepareImageVDSCommand, return:
, log id: 104764a4
2024-01-03 10:05:33,982Z ERROR
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-68)
[7855db64-635d-430f-9de8-21b1983e43a0] Failed to prepare image for image
transfer 'ec704c40-89bc-4fdf-a44a-607dd7b9b2f7': {}:
org.ovirt.engine.core.common.errors.EngineException: EngineException:
java.lang.NullPointerException (Failed with error ENGINE and code 5001)
at
deployment.engine.ear.bll.jar//org.ovirt.engine.core.bll.VdsHandler.handleVdsResult(VdsHandler.java:114)
at
deployment.engine.ear.bll.jar//org.ovirt.engine.core.bll.VDSBrokerFrontendImpl.runVdsCommand(VDSBrokerFrontendImpl.java:33)
at
deployment.engine.ear.bll.jar//org.ovirt.engine.core.bll.CommandBase.runVdsCommand(CommandBase.java:2121)
at
deployment.engine.ear.bll.jar//org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.prepareImage(TransferDiskImageCommand.java:188)
at
deployment.engine.ear.bll.jar//org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.startImageTransferSession(TransferDiskImageCommand.java:1064)
at
deployment.engine.ear.bll.jar//org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.handleImageIsReadyForTransfer(TransferDiskImageCommand.java:681)
at
deployment.engine.ear.bll.jar//org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.handleInitializing(TransferDiskImageCommand.java:654)
at
deployment.engine.ear.bll.jar//org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.executeStateHandler(TransferDiskImageCommand.java:587)
at
deployment.engine.ear.bll.jar//org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.proceedCommandExecution(TransferDiskImageCommand.java:574)
at
deployment.engine.ear.bll.jar//org.ovirt.engine.core.bll.storage.disk.image.TransferImageCommandCallback.doPolling(TransferImageCommandCallback.java:21)
at
deployment.engine.ear.bll.jar//org.ovirt.engine.core.bll.tasks.CommandCallbacksPoller.invokeCallbackMethodsImpl(CommandCallbacksPoller.java:175)
at
deployment.engine.ear.bll.jar//org.ovirt.engine.core.bll.tasks.CommandCallbacksPoller.invokeCallbackMethods(CommandCallbacksPoller.java:109)
at
java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
at
java.base/java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305)
at
org.glassfish.javax.enterprise.concurrent//org.glassfish.enterprise.concurrent.internal.ManagedScheduledThreadPoolExecutor$ManagedScheduledFutureTask.access$201(ManagedScheduledThreadPoolExecutor.java:360)
at
org.glassfish.javax.enterprise.concurrent//org.glassfish.enterprise.concurrent.internal.ManagedScheduledThreadPoolExecutor$ManagedScheduledFutureTask.run(ManagedScheduledThreadPoolExecutor.java:511)
at
java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at
java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at java.base/java.lang.Thread.run(Thread.java:829)
at
org.glassfish.javax.enterprise.concurrent//org.glassfish.enterprise.concurrent.ManagedThreadFactoryImpl$ManagedThread.run(ManagedThreadFactoryImpl.java:227)
Caused by: java.lang.NullPointerException
at
deployment.engine.ear//org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageReturn.<init>(PrepareImageReturn.java:15)
at
deployment.engine.ear//org.ovirt.engine.core.vdsbroker.jsonrpc.JsonRpcVdsServer.prepareImage(JsonRpcVdsServer.java:1947)
at
deployment.engine.ear//org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand.executeImageActionVdsBrokerCommand(PrepareImageVDSCommand.java:18)
at
deployment.engine.ear//org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand.executeImageActionVdsBrokerCommand(PrepareImageVDSCommand.java:5)
at
deployment.engine.ear//org.ovirt.engine.core.vdsbroker.vdsbroker.ImageActionsVDSCommandBase.executeVdsBrokerCommand(ImageActionsVDSCommandBase.java:14)
at
deployment.engine.ear//org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand.executeVdsCommandWithNetworkEvent(VdsBrokerCommand.java:123)
at
deployment.engine.ear//org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand.executeVDSCommand(VdsBrokerCommand.java:111)
at
deployment.engine.ear//org.ovirt.engine.core.vdsbroker.VDSCommandBase.executeCommand(VDSCommandBase.java:65)
at
org.ovirt.engine.core.dal//org.ovirt.engine.core.dal.VdcCommandBase.execute(VdcCommandBase.java:31)
at
deployment.engine.ear//org.ovirt.engine.core.vdsbroker.vdsbroker.DefaultVdsCommandExecutor.execute(DefaultVdsCommandExecutor.java:14)
at
deployment.engine.ear//org.ovirt.engine.core.vdsbroker.ResourceManager.runVdsCommand(ResourceManager.java:410)
at
deployment.engine.ear//org.ovirt.engine.core.vdsbroker.ResourceManager$Proxy$_$$_WeldSubclass.runVdsCommand$$super(Unknown
Source)
at jdk.internal.reflect.GeneratedMethodAccessor87.invoke(Unknown Source)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
at
[email protected]//org.jboss.weld.interceptor.proxy.TerminalAroundInvokeInvocationContext.proceedInternal(TerminalAroundInvokeInvocationContext.java:51)
at
[email protected]//org.jboss.weld.interceptor.proxy.AroundInvokeInvocationContext.proceed(AroundInvokeInvocationContext.java:78)
at
org.ovirt.engine.core.common//org.ovirt.engine.core.common.di.interceptor.LoggingInterceptor.apply(LoggingInterceptor.java:12)
at jdk.internal.reflect.GeneratedMethodAccessor80.invoke(Unknown Source)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
at
[email protected]//org.jboss.weld.interceptor.reader.SimpleInterceptorInvocation$SimpleMethodInvocation.invoke(SimpleInterceptorInvocation.java:73)
at
[email protected]//org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.executeAroundInvoke(InterceptorMethodHandler.java:84)
at
[email protected]//org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.executeInterception(InterceptorMethodHandler.java:72)
at
[email protected]//org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.invoke(InterceptorMethodHandler.java:56)
at
[email protected]//org.jboss.weld.bean.proxy.CombinedInterceptorAndDecoratorStackMethodHandler.invoke(CombinedInterceptorAndDecoratorStackMethodHandler.java:79)
at
[email protected]//org.jboss.weld.bean.proxy.CombinedInterceptorAndDecoratorStackMethodHandler.invoke(CombinedInterceptorAndDecoratorStackMethodHandler.java:68)
at
deployment.engine.ear//org.ovirt.engine.core.vdsbroker.ResourceManager$Proxy$_$$_WeldSubclass.runVdsCommand(Unknown
Source)
... 19 more
2024-01-03 10:05:34,991Z INFO
[org.ovirt.engine.core.bll.storage.disk.AddDiskCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[7855db64-635d-430f-9de8-21b1983e43a0] Ending command
'org.ovirt.engine.core.bll.storage.disk.AddDiskCommand' successfully.
2024-01-03 10:05:34,997Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[7855db64-635d-430f-9de8-21b1983e43a0] Ending command
'org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand'
successfully.
2024-01-03 10:05:35,010Z INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[7855db64-635d-430f-9de8-21b1983e43a0] START, GetImageInfoVDSCommand(
GetImageInfoVDSCommandParameters:{storagePoolId='4c5f1e92-239b-471c-9db0-970029129a62',
ignoreFailoverLimit='false',
storageDomainId='95dfc5bc-2a31-405c-ada0-6015edd281da',
imageGroupId='13dcaf25-6b58-4c79-85a7-0aecd153fb59',
imageId='6b80fba5-c2ae-4b68-a24d-21d7f657da8f'}), log id: 127cba80
2024-01-03 10:05:35,011Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[7855db64-635d-430f-9de8-21b1983e43a0] START, GetVolumeInfoVDSCommand(HostName
= kvm-sandbox-qm7,
GetVolumeInfoVDSCommandParameters:{hostId='9fb846b0-58cf-41ab-875c-3e3118a24b89',
storagePoolId='4c5f1e92-239b-471c-9db0-970029129a62',
storageDomainId='95dfc5bc-2a31-405c-ada0-6015edd281da',
imageGroupId='13dcaf25-6b58-4c79-85a7-0aecd153fb59',
imageId='6b80fba5-c2ae-4b68-a24d-21d7f657da8f'}), log id: 1f0ed2a8
2024-01-03 10:05:35,024Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[7855db64-635d-430f-9de8-21b1983e43a0] FINISH, GetVolumeInfoVDSCommand, return:
org.ovirt.engine.core.common.businessentities.storage.DiskImage@14184952, log
id: 1f0ed2a8
2024-01-03 10:05:35,024Z INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[7855db64-635d-430f-9de8-21b1983e43a0] FINISH, GetImageInfoVDSCommand, return:
org.ovirt.engine.core.common.businessentities.storage.DiskImage@14184952, log
id: 127cba80
2024-01-03 10:05:35,046Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[7855db64-635d-430f-9de8-21b1983e43a0] START, PrepareImageVDSCommand(HostName =
kvm-sandbox-qm7,
PrepareImageVDSCommandParameters:{hostId='9fb846b0-58cf-41ab-875c-3e3118a24b89'}),
log id: 39df22a1
2024-01-03 10:05:35,076Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[7855db64-635d-430f-9de8-21b1983e43a0] FINISH, PrepareImageVDSCommand, return:
PrepareImageReturn:{status='Status [code=0, message=Done]'}, log id: 39df22a1
2024-01-03 10:05:35,077Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetQemuImageInfoVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[7855db64-635d-430f-9de8-21b1983e43a0] START,
GetQemuImageInfoVDSCommand(HostName = kvm-sandbox-qm7,
GetVolumeInfoVDSCommandParameters:{hostId='9fb846b0-58cf-41ab-875c-3e3118a24b89',
storagePoolId='4c5f1e92-239b-471c-9db0-970029129a62',
storageDomainId='95dfc5bc-2a31-405c-ada0-6015edd281da',
imageGroupId='13dcaf25-6b58-4c79-85a7-0aecd153fb59',
imageId='6b80fba5-c2ae-4b68-a24d-21d7f657da8f'}), log id: 59083d66
2024-01-03 10:05:35,093Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetQemuImageInfoVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[7855db64-635d-430f-9de8-21b1983e43a0] FINISH, GetQemuImageInfoVDSCommand,
return:
org.ovirt.engine.core.common.businessentities.storage.QemuImageInfo@12025249,
log id: 59083d66
2024-01-03 10:05:35,095Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.TeardownImageVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[7855db64-635d-430f-9de8-21b1983e43a0] START, TeardownImageVDSCommand(HostName
= kvm-sandbox-qm7,
ImageActionsVDSCommandParameters:{hostId='9fb846b0-58cf-41ab-875c-3e3118a24b89'}),
log id: 2c3b32ab
2024-01-03 10:05:35,097Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.TeardownImageVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[7855db64-635d-430f-9de8-21b1983e43a0] FINISH, TeardownImageVDSCommand, return:
StatusReturn:{status='Status [code=0, message=Done]'}, log id: 2c3b32ab
2024-01-03 10:05:35,106Z WARN
[org.ovirt.engine.core.bll.storage.disk.AddDiskCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47) [] VM
is null - no unlocking
2024-01-03 10:05:35,132Z INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47) []
EVENT_ID: USER_ADD_DISK_FINISHED_SUCCESS(2,021), The disk 'aaa' was
successfully added.
2024-01-03 10:05:35,134Z ERROR
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[7855db64-635d-430f-9de8-21b1983e43a0] Ending command
'org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand' with
failure.
2024-01-03 10:05:35,134Z ERROR
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[7855db64-635d-430f-9de8-21b1983e43a0] Failed to transfer disk
'00000000-0000-0000-0000-000000000000' for image transfer
'ec704c40-89bc-4fdf-a44a-607dd7b9b2f7'
2024-01-03 10:05:35,157Z INFO
[org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[5871c85c] Running command: RemoveDiskCommand internal: true. Entities affected
: ID: 13dcaf25-6b58-4c79-85a7-0aecd153fb59 Type: DiskAction group DELETE_DISK
with role type USER
2024-01-03 10:05:35,176Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[5871c85c] Running command: RemoveImageCommand internal: true. Entities
affected : ID: 95dfc5bc-2a31-405c-ada0-6015edd281da Type: Storage
2024-01-03 10:05:35,202Z INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[5871c85c] START, DeleteImageGroupVDSCommand(
DeleteImageGroupVDSCommandParameters:{storagePoolId='4c5f1e92-239b-471c-9db0-970029129a62',
ignoreFailoverLimit='false',
storageDomainId='95dfc5bc-2a31-405c-ada0-6015edd281da',
imageGroupId='13dcaf25-6b58-4c79-85a7-0aecd153fb59', postZeros='false',
discard='false', forceDelete='false'}), log id: 10fab46b
2024-01-03 10:05:35,449Z INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[5871c85c] FINISH, DeleteImageGroupVDSCommand, return: , log id: 10fab46b
2024-01-03 10:05:35,451Z INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[5871c85c] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command
'8640049f-0ead-486a-93b4-dcbbaa353294'
2024-01-03 10:05:35,451Z INFO
[org.ovirt.engine.core.bll.CommandMultiAsyncTasks]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[5871c85c] CommandMultiAsyncTasks::attachTask: Attaching task
'b51f31d8-944b-4539-beb6-a0ab995073c6' to command
'8640049f-0ead-486a-93b4-dcbbaa353294'.
2024-01-03 10:05:35,463Z INFO
[org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[5871c85c] Adding task 'b51f31d8-944b-4539-beb6-a0ab995073c6' (Parent Command
'RemoveImage', Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters'), polling hasn't
started yet..
2024-01-03 10:05:35,468Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[5871c85c] BaseAsyncTask::startPollingTask: Starting to poll task
'b51f31d8-944b-4539-beb6-a0ab995073c6'.
2024-01-03 10:05:35,468Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[5871c85c] BaseAsyncTask::startPollingTask: Starting to poll task
'b51f31d8-944b-4539-beb6-a0ab995073c6'.
2024-01-03 10:05:35,533Z INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[5871c85c] EVENT_ID: USER_FINISHED_REMOVE_DISK(2,014), Disk aaa was
successfully removed from domain localstorage (User [[redacted
user]]@[[redacted]]@[[redacted]]).
2024-01-03 10:05:35,534Z INFO
[org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[5871c85c] Lock freed to object 'EngineLock:{exclusiveLocks='[]',
sharedLocks='[]'}'
2024-01-03 10:05:35,534Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[5871c85c] Lock freed to object 'EngineLock:{exclusiveLocks='[]',
sharedLocks='[]'}'
2024-01-03 10:05:35,535Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.ImageTransferUpdater]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[5871c85c] Updating image transfer 'ec704c40-89bc-4fdf-a44a-607dd7b9b2f7' phase
from 'Initializing' to 'Finished Failure'
2024-01-03 10:05:35,547Z ERROR
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-47)
[5871c85c] EVENT_ID: TRANSFER_IMAGE_FAILED(1,034), Image Upload with disk aaa
failed.
2024-01-03 10:05:35,646Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand]
(default task-1) [d4821bf6-c786-4129-a3b0-4a79fc2d61d7] Running command:
TransferImageStatusCommand internal: false. Entities affected : ID:
95dfc5bc-2a31-405c-ada0-6015edd281da Type: SystemAction group CREATE_DISK with
role type USER
2024-01-03 10:05:36,562Z INFO
[org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-62)
[5871c85c] Command 'RemoveDisk' (id: 'b01c95d8-b3c3-40db-9a41-6fe1e817fe5a')
waiting on child command id: '8640049f-0ead-486a-93b4-dcbbaa353294'
type:'RemoveImage' to complete
2024-01-03 10:05:36,565Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-62)
[5871c85c] Waiting on remove image command to complete the task
'b51f31d8-944b-4539-beb6-a0ab995073c6'
2024-01-03 10:05:38,569Z INFO
[org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-32)
[5871c85c] Command 'RemoveDisk' (id: 'b01c95d8-b3c3-40db-9a41-6fe1e817fe5a')
waiting on child command id: '8640049f-0ead-486a-93b4-dcbbaa353294'
type:'RemoveImage' to complete
2024-01-03 10:05:38,573Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-32)
[5871c85c] Waiting on remove image command to complete the task
'b51f31d8-944b-4539-beb6-a0ab995073c6'
2024-01-03 10:05:39,645Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.TransferImageStatusCommand]
(default task-1) [95e8a4ca-324f-4f9e-86a0-ef324383ca64] Running command:
TransferImageStatusCommand internal: false. Entities affected : ID:
95dfc5bc-2a31-405c-ada0-6015edd281da Type: SystemAction group CREATE_DISK with
role type USER
2024-01-03 10:05:40,022Z INFO
[org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-40) []
Polling and updating Async Tasks: 2 tasks, 1 tasks to poll now
2024-01-03 10:05:40,027Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-40) []
SPMAsyncTask::PollTask: Polling task 'b51f31d8-944b-4539-beb6-a0ab995073c6'
(Parent Command 'RemoveImage', Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned status
'finished', result 'success'.
2024-01-03 10:05:40,027Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-40) []
BaseAsyncTask::onTaskEndSuccess: Task 'b51f31d8-944b-4539-beb6-a0ab995073c6'
(Parent Command 'RemoveImage', Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') ended
successfully.
2024-01-03 10:05:40,030Z INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-40) []
CommandAsyncTask::endActionIfNecessary: All tasks of command
'8640049f-0ead-486a-93b4-dcbbaa353294' has ended -> executing 'endAction'
2024-01-03 10:05:40,030Z INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-40) []
CommandAsyncTask::endAction: Ending action for '1' tasks (command ID:
'8640049f-0ead-486a-93b4-dcbbaa353294'): calling endAction '.
2024-01-03 10:05:40,031Z INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-2965) []
CommandAsyncTask::endCommandAction [within thread] context: Attempting to
endAction 'RemoveImage',
2024-01-03 10:05:40,033Z INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-2965) [5871c85c]
CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action
type 'RemoveImage' completed, handling the result.
2024-01-03 10:05:40,034Z INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-2965) [5871c85c]
CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action
type 'RemoveImage' succeeded, clearing tasks.
2024-01-03 10:05:40,034Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-2965) [5871c85c]
SPMAsyncTask::ClearAsyncTask: Attempting to clear task
'b51f31d8-944b-4539-beb6-a0ab995073c6'
2024-01-03 10:05:40,034Z INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-2965) [5871c85c] START,
SPMClearTaskVDSCommand(
SPMTaskGuidBaseVDSCommandParameters:{storagePoolId='4c5f1e92-239b-471c-9db0-970029129a62',
ignoreFailoverLimit='false', taskId='b51f31d8-944b-4539-beb6-a0ab995073c6'}),
log id: 7535a00c
2024-01-03 10:05:40,035Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-2965) [5871c85c] START,
HSMClearTaskVDSCommand(HostName = kvm-sandbox-qm7,
HSMTaskGuidBaseVDSCommandParameters:{hostId='9fb846b0-58cf-41ab-875c-3e3118a24b89',
taskId='b51f31d8-944b-4539-beb6-a0ab995073c6'}), log id: 3522ca07
2024-01-03 10:05:40,046Z INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-2965) [5871c85c] FINISH,
HSMClearTaskVDSCommand, return: , log id: 3522ca07
2024-01-03 10:05:40,046Z INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-2965) [5871c85c] FINISH,
SPMClearTaskVDSCommand, return: , log id: 7535a00c
2024-01-03 10:05:40,050Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-2965) [5871c85c]
BaseAsyncTask::removeTaskFromDB: Removed task
'b51f31d8-944b-4539-beb6-a0ab995073c6' from DataBase
2024-01-03 10:05:40,050Z INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-2965) [5871c85c]
CommandAsyncTask::HandleEndActionResult [within thread]: Removing
CommandMultiAsyncTasks object for entity '8640049f-0ead-486a-93b4-dcbbaa353294'
2024-01-03 10:05:42,583Z INFO
[org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-11)
[5871c85c] Command 'RemoveDisk' (id: 'b01c95d8-b3c3-40db-9a41-6fe1e817fe5a')
waiting on child command id: '8640049f-0ead-486a-93b4-dcbbaa353294'
type:'RemoveImage' to complete
2024-01-03 10:05:42,593Z INFO
[org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-11)
[5871c85c] Remove image command has completed successfully for disk
'13dcaf25-6b58-4c79-85a7-0aecd153fb59' with async task(s)
'[b51f31d8-944b-4539-beb6-a0ab995073c6]'.
2024-01-03 10:05:44,692Z INFO
[org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-39)
[5871c85c] Command 'RemoveDisk' id: 'b01c95d8-b3c3-40db-9a41-6fe1e817fe5a'
child commands '[8640049f-0ead-486a-93b4-dcbbaa353294]' executions were
completed, status 'SUCCEEDED'
2024-01-03 10:05:45,719Z INFO
[org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand]
(EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-26)
[5871c85c] Ending command
'org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand' successfully.
--- /snip ---
Please let me know if I can supply additional information which could be
relevant.
Kind Regards,
Justin Zandbergen.
_______________________________________________
Users mailing list -- [email protected]
To unsubscribe send an email to [email protected]
Privacy Statement: https://www.ovirt.org/privacy-policy.html
oVirt Code of Conduct:
https://www.ovirt.org/community/about/community-guidelines/
List Archives:
https://lists.ovirt.org/archives/list/[email protected]/message/7XB6WAMIJVQRZ4FZTK6ITQNMTLV5222N/
