Re: [ovirt-users] oVirt 3.5.3.1 - Clone_VM Process deleted Source-VM and the the Clone-VM does not contain any disk anymore

Dear all, I have started a Clone_VM over the GUI, but now the Source-VM has been deleted and the Target-VM does not contain any disk! The Task is displaying that “Copying Image” and “ Finalize” has been failed, I hope there is a way to restore the VM somehow – please help me…

From the Logfile: 2015-08-28 12:47:20,950 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-7) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: VM Katello is down. Exit message: User shut down from within the guest 2015-08-28 12:47:20,955 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-7) VM Katello (9013e3c2-3cd7-4eae-a3e6-f5e83a64db87) is running in db and not running in VDS itsatltovirtaio.domain.local 2015-08-28 12:47:20,957 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand] (DefaultQuartzScheduler_Worker-7) START, FullListVdsCommand(HostName = itsatltovirtaio.domain.local, HostId = b783a2ee-4a63-46ca-9afc-b3b74f0e10ce, vds=Host[itsatltovirtaio.domain.local,b783a2ee-4a63-46ca-9afc-b3b74f0e10ce], vmIds=[9013e3c2-3cd7-4eae-a3e6-f5e83a64db87]), log id: 39590448 2015-08-28 12:47:20,966 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand] (DefaultQuartzScheduler_Worker-7) FINISH, FullListVdsCommand, return: [], log id: 39590448 2015-08-28 12:47:21,046 INFO [org.ovirt.engine.core.bll.ProcessDownVmCommand] (org.ovirt.thread.pool-8-thread-17) [82bee5d] Running command: ProcessDownVmCommand internal: true. 2015-08-28 12:47:24,589 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (DefaultQuartzScheduler_Worker-3) Polling and updating Async Tasks: 2 tasks, 2 tasks to poll now 2015-08-28 12:47:24,600 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler_Worker-3) SPMAsyncTask::PollTask: Polling task 037b2c85-68d2-4159-8310-91c472038b5b (Parent Command ProcessOvfUpdateForStorageDomain, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) returned status finished, result 'success'. 2015-08-28 12:47:24,603 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler_Worker-3) BaseAsyncTask::onTaskEndSuccess: Task 037b2c85-68d2-4159-8310-91c472038b5b (Parent Command ProcessOvfUpdateForStorageDomain, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) ended successfully. 2015-08-28 12:47:24,604 INFO [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (DefaultQuartzScheduler_Worker-3) Task with DB Task ID 0e6a6d72-0cea-41aa-8fe9-9262bc53d558 and VDSM Task ID cd125365-3344-4f45-b67a-39c2fa5112ab is in state Polling. End action for command e9edfed0-915a-4534-b774-c07682bafa59 will proceed when all the entitys tasks are completed. 2015-08-28 12:47:24,605 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler_Worker-3) SPMAsyncTask::PollTask: Polling task cd125365-3344-4f45-b67a-39c2fa5112ab (Parent Command ProcessOvfUpdateForStorageDomain, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) returned status finished, result 'success'. 2015-08-28 12:47:24,606 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler_Worker-3) BaseAsyncTask::onTaskEndSuccess: Task cd125365-3344-4f45-b67a-39c2fa5112ab (Parent Command ProcessOvfUpdateForStorageDomain, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) ended successfully. 2015-08-28 12:47:24,606 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (DefaultQuartzScheduler_Worker-3) CommandAsyncTask::endActionIfNecessary: All tasks of command e9edfed0-915a-4534-b774-c07682bafa59 has ended -> executing endAction 2015-08-28 12:47:24,607 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (DefaultQuartzScheduler_Worker-3) CommandAsyncTask::endAction: Ending action for 2 tasks (command ID: e9edfed0-915a-4534-b774-c07682bafa59): calling endAction . 2015-08-28 12:47:24,607 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-33) CommandAsyncTask::endCommandAction [within thread] context: Attempting to endAction ProcessOvfUpdateForStorageDomain, executionIndex: 0 2015-08-28 12:47:24,668 INFO [org.ovirt.engine.core.bll.ProcessOvfUpdateForStorageDomainCommand] (org.ovirt.thread.pool-8-thread-33) [484cded8] Ending command successfully: org.ovirt.engine.core.bll.ProcessOvfUpdateForStorageDomainCommand 2015-08-28 12:47:24,669 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-33) [484cded8] CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type ProcessOvfUpdateForStorageDomain completed, handling the result. 2015-08-28 12:47:24,670 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-33) [484cded8] CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type ProcessOvfUpdateForStorageDomain succeeded, clearing tasks. 2015-08-28 12:47:24,671 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-8-thread-33) [484cded8] SPMAsyncTask::ClearAsyncTask: Attempting to clear task cd125365-3344-4f45-b67a-39c2fa5112ab 2015-08-28 12:47:24,671 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-33) [484cded8] START, SPMClearTaskVDSCommand( storagePoolId = 00000002-0002-0002-0002-000000000021, ignoreFailoverLimit = false, taskId = cd125365-3344-4f45-b67a-39c2fa5112ab), log id: 73f5ca79 2015-08-28 12:47:24,700 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-33) [484cded8] START, HSMClearTaskVDSCommand(HostName = itsatltovirtaio.domain.local, HostId = b783a2ee-4a63-46ca-9afc-b3b74f0e10ce, taskId=cd125365-3344-4f45-b67a-39c2fa5112ab), log id: dc00969 2015-08-28 12:47:24,726 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-33) [484cded8] FINISH, HSMClearTaskVDSCommand, log id: dc00969 2015-08-28 12:47:24,728 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-33) [484cded8] FINISH, SPMClearTaskVDSCommand, log id: 73f5ca79 2015-08-28 12:47:24,742 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-8-thread-33) [484cded8] BaseAsyncTask::removeTaskFromDB: Removed task cd125365-3344-4f45-b67a-39c2fa5112ab from DataBase 2015-08-28 12:47:24,744 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-8-thread-33) [484cded8] SPMAsyncTask::ClearAsyncTask: Attempting to clear task 037b2c85-68d2-4159-8310-91c472038b5b 2015-08-28 12:47:24,745 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-33) [484cded8] START, SPMClearTaskVDSCommand( storagePoolId = 00000002-0002-0002-0002-000000000021, ignoreFailoverLimit = false, taskId = 037b2c85-68d2-4159-8310-91c472038b5b), log id: 3b75651d 2015-08-28 12:47:24,776 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-33) [484cded8] START, HSMClearTaskVDSCommand(HostName = itsatltovirtaio.domain.local, HostId = b783a2ee-4a63-46ca-9afc-b3b74f0e10ce, taskId=037b2c85-68d2-4159-8310-91c472038b5b), log id: 1841716a 2015-08-28 12:47:24,793 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-33) [484cded8] FINISH, HSMClearTaskVDSCommand, log id: 1841716a 2015-08-28 12:47:24,795 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-33) [484cded8] FINISH, SPMClearTaskVDSCommand, log id: 3b75651d 2015-08-28 12:47:24,808 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-8-thread-33) [484cded8] BaseAsyncTask::removeTaskFromDB: Removed task 037b2c85-68d2-4159-8310-91c472038b5b from DataBase 2015-08-28 12:47:24,810 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-33) [484cded8] CommandAsyncTask::HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks object for entity e9edfed0-915a-4534-b774-c07682bafa59 2015-08-28 12:48:09,771 WARN [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (ajp--127.0.0.1-8702-9) [c1d5ad4] The message key CloneVm is missing from bundles/ExecutionMessages 2015-08-28 12:48:09,966 INFO [org.ovirt.engine.core.bll.CloneVmCommand] (ajp--127.0.0.1-8702-9) [c1d5ad4] Lock Acquired to object EngineLock [exclusiveLocks= key: Katello_2.3 value: VM_NAME , sharedLocks= key: e7e99288-ad83-406e-9cb6-7a5aa443de9b value: DISK key: 6281b597-020d-4ea7-a954-bb798a0ca4f1 value: DISK key: 9013e3c2-3cd7-4eae-a3e6-f5e83a64db87 value: VM ] 2015-08-28 12:48:10,691 INFO [org.ovirt.engine.core.bll.CloneVmCommand] (ajp--127.0.0.1-8702-9) [c1d5ad4] Running command: CloneVmCommand internal: false. Entities affected : ID: 9013e3c2-3cd7-4eae-a3e6-f5e83a64db87 Type: VMAction group CREATE_VM with role type USER 2015-08-28 12:48:11,370 INFO [org.ovirt.engine.core.bll.CopyImageGroupCommand] (ajp--127.0.0.1-8702-9) [7bfcbcdd] Running command: CopyImageGroupCommand internal: true. Entities affected : ID: 937822d9-8a59-490f-95b7-48371ae32253 Type: Storage 2015-08-28 12:48:11,529 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CopyImageVDSCommand] (ajp--127.0.0.1-8702-9) [7bfcbcdd] START, CopyImageVDSCommand( storagePoolId = 00000002-0002-0002-0002-000000000021, ignoreFailoverLimit = false, storageDomainId = 937822d9-8a59-490f-95b7-48371ae32253, imageGroupId = 6281b597-020d-4ea7-a954-bb798a0ca4f1, imageId = 2a2015a1-f62c-4e32-8b04-77ece2ba4cc1, dstImageGroupId = e64d7be5-7643-4ba1-b347-80c923f130e6, vmId = ee2ea036-2af3-4a18-9329-08a7b0e7ce7c, dstImageId = 6364bb72-8cb6-49c0-9673-f01ec49b88f2, imageDescription = , dstStorageDomainId = 937822d9-8a59-490f-95b7-48371ae32253, copyVolumeType = LeafVol, volumeFormat = RAW, preallocate = Sparse, postZero = false, force = false), log id: 3caf0bb2 2015-08-28 12:48:11,537 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CopyImageVDSCommand] (ajp--127.0.0.1-8702-9) [7bfcbcdd] -- executeIrsBrokerCommand: calling 'copyImage' with two new parameters: description and UUID 2015-08-28 12:48:11,539 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CopyImageVDSCommand] (ajp--127.0.0.1-8702-9) [7bfcbcdd] -- copyImage parameters: sdUUID=937822d9-8a59-490f-95b7-48371ae32253 spUUID=00000002-0002-0002-0002-000000000021 vmGUID=ee2ea036-2af3-4a18-9329-08a7b0e7ce7c srcImageGUID=6281b597-020d-4ea7-a954-bb798a0ca4f1 srcVolUUID=2a2015a1-f62c-4e32-8b04-77ece2ba4cc1 dstImageGUID=e64d7be5-7643-4ba1-b347-80c923f130e6 dstVolUUID=6364bb72-8cb6-49c0-9673-f01ec49b88f2 descr= dstSdUUID=937822d9-8a59-490f-95b7-48371ae32253 2015-08-28 12:48:13,882 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CopyImageVDSCommand] (ajp--127.0.0.1-8702-9) [7bfcbcdd] FINISH, CopyImageVDSCommand, return: 00000000-0000-0000-0000-000000000000, log id: 3caf0bb2 2015-08-28 12:48:13,909 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (ajp--127.0.0.1-8702-9) [7bfcbcdd] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command f81024b3-e534-4df4-907b-91e690bf049c 2015-08-28 12:48:13,912 INFO [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (ajp--127.0.0.1-8702-9) [7bfcbcdd] CommandMultiAsyncTasks::AttachTask: Attaching task 11079859-f235-4227-b2ba-b51f88a0f9cd to command f81024b3-e534-4df4-907b-91e690bf049c. 2015-08-28 12:48:13,941 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (ajp--127.0.0.1-8702-9) [7bfcbcdd] Adding task 11079859-f235-4227-b2ba-b51f88a0f9cd (Parent Command CloneVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters), polling hasn't started yet.. 2015-08-28 12:48:14,043 INFO [org.ovirt.engine.core.bll.CopyImageGroupCommand] (ajp--127.0.0.1-8702-9) [89f7645] Running command: CopyImageGroupCommand internal: true. Entities affected : ID: 937822d9-8a59-490f-95b7-48371ae32253 Type: Storage 2015-08-28 12:48:14,083 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CopyImageVDSCommand] (ajp--127.0.0.1-8702-9) [89f7645] START, CopyImageVDSCommand( storagePoolId = 00000002-0002-0002-0002-000000000021, ignoreFailoverLimit = false, storageDomainId = 937822d9-8a59-490f-95b7-48371ae32253, imageGroupId = e7e99288-ad83-406e-9cb6-7a5aa443de9b, imageId = c5762dec-d9d1-4842-84d1-05896d4d27fb, dstImageGroupId = 7f5dd048-048f-49c1-9589-c935fcdccfdd, vmId = ee2ea036-2af3-4a18-9329-08a7b0e7ce7c, dstImageId = f57531cf-fb00-4a4d-9aad-c3ffa01f58ce, imageDescription = , dstStorageDomainId = 937822d9-8a59-490f-95b7-48371ae32253, copyVolumeType = LeafVol, volumeFormat = RAW, preallocate = Sparse, postZero = false, force = false), log id: 11b82b6e 2015-08-28 12:48:14,086 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CopyImageVDSCommand] (ajp--127.0.0.1-8702-9) [89f7645] -- executeIrsBrokerCommand: calling 'copyImage' with two new parameters: description and UUID 2015-08-28 12:48:14,087 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CopyImageVDSCommand] (ajp--127.0.0.1-8702-9) [89f7645] -- copyImage parameters: sdUUID=937822d9-8a59-490f-95b7-48371ae32253 spUUID=00000002-0002-0002-0002-000000000021 vmGUID=ee2ea036-2af3-4a18-9329-08a7b0e7ce7c srcImageGUID=e7e99288-ad83-406e-9cb6-7a5aa443de9b srcVolUUID=c5762dec-d9d1-4842-84d1-05896d4d27fb dstImageGUID=

descr= dstSdUUID=937822d9-8a59-490f-95b7-48371ae32253 2015-08-28 12:48:17,722 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CopyImageVDSCommand] (ajp--127.0.0.1-8702-9) [89f7645] FINISH, CopyImageVDSCommand, return: 00000000-0000-0000-0000-000000000000, log id: 11b82b6e 2015-08-28 12:48:17,753 INFO [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (ajp--127.0.0.1-8702-9) [89f7645] CommandMultiAsyncTasks::AttachTask: Attaching task a961301c-0da0-49b6-a2e7-787de9ea8fe6 to command f81024b3-e534-4df4-907b-91e690bf049c. 2015-08-28 12:48:17,785 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (ajp--127.0.0.1-8702-9) [89f7645] Adding task a961301c-0da0-49b6-a2e7-787de9ea8fe6 (Parent Command CloneVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters), polling hasn't started yet.. 2015-08-28 12:48:18,136 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-9) [89f7645] Correlation ID: c1d5ad4, Job ID: e36f06d1-3c60-4b4c-86db-0ba5f903b254, Call Stack: null, Custom Event ID: -1, Message: VM Katello_2.3 creation was initiated by admin@internal. 2015-08-28 12:48:18,138 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (ajp--127.0.0.1-8702-9) [89f7645] BaseAsyncTask::startPollingTask: Starting to poll task 11079859-f235-4227-b2ba-b51f88a0f9cd. 2015-08-28 12:48:18,140 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (ajp--127.0.0.1-8702-9) [89f7645] BaseAsyncTask::startPollingTask: Starting to poll task a961301c-0da0-49b6-a2e7-787de9ea8fe6. 2015-08-28 12:48:24,607 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (DefaultQuartzScheduler_Worker-61) Polling and updating Async Tasks: 4 tasks, 2 tasks to poll now 2015-08-28 12:48:24,621 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksStatusesVDSCommand] (DefaultQuartzScheduler_Worker-61) Failed in HSMGetAllTasksStatusesVDS method 2015-08-28 12:48:24,622 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksStatusesVDSCommand] (DefaultQuartzScheduler_Worker-61) Failed in HSMGetAllTasksStatusesVDS method 2015-08-28 12:48:24,624 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler_Worker-61) SPMAsyncTask::PollTask: Polling task a961301c-0da0-49b6-a2e7-787de9ea8fe6 (Parent Command CloneVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) returned status finished, result 'cleanSuccess'. 2015-08-28 12:48:24,635 ERROR [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler_Worker-61) BaseAsyncTask::logEndTaskFailure: Task a961301c-0da0-49b6-a2e7-787de9ea8fe6 (Parent Command CloneVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) ended with failure: -- Result: cleanSuccess -- Message: VDSGenericException: VDSErrorException: Failed to HSMGetAllTasksStatusesVDS, error = Volume does not exist, code = 201, -- Exception: VDSGenericException: VDSErrorException: Failed to HSMGetAllTasksStatusesVDS, error = Volume does not exist, code = 201 2015-08-28 12:48:24,640 INFO [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (DefaultQuartzScheduler_Worker-61) Task with DB Task ID ed763e40-d1e9-4c36-8822-e6b232a864b0 and VDSM Task ID 11079859-f235-4227-b2ba-b51f88a0f9cd is in state Polling. End action for command f81024b3-e534-4df4-907b-91e690bf049c will proceed when all the entitys tasks are completed. 2015-08-28 12:48:24,643 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler_Worker-61) SPMAsyncTask::PollTask: Polling task 11079859-f235-4227-b2ba-b51f88a0f9cd (Parent Command CloneVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) returned status finished, result 'cleanSuccess'. 2015-08-28 12:48:24,652 ERROR [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler_Worker-61) BaseAsyncTask::logEndTaskFailure: Task 11079859-f235-4227-b2ba-b51f88a0f9cd (Parent Command CloneVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) ended with failure: -- Result: cleanSuccess -- Message: VDSGenericException: VDSErrorException: Failed to HSMGetAllTasksStatusesVDS, error = Volume does not exist, code = 201, -- Exception: VDSGenericException: VDSErrorException: Failed to HSMGetAllTasksStatusesVDS, error = Volume does not exist, code = 201 2015-08-28 12:48:24,659 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (DefaultQuartzScheduler_Worker-61) CommandAsyncTask::endActionIfNecessary: All tasks of command f81024b3-e534-4df4-907b-91e690bf049c has ended -> executing endAction 2015-08-28 12:48:24,662 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (DefaultQuartzScheduler_Worker-61) CommandAsyncTask::endAction: Ending action for 2 tasks (command ID: f81024b3-e534-4df4-907b-91e690bf049c): calling endAction . 2015-08-28 12:48:24,664 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-2) CommandAsyncTask::endCommandAction [within thread] context: Attempting to endAction CloneVm, executionIndex: 0 2015-08-28 12:48:24,827 ERROR [org.ovirt.engine.core.bll.CloneVmCommand] (org.ovirt.thread.pool-8-thread-2) [c1d5ad4] Ending command with failure: org.ovirt.engine.core.bll.CloneVmCommand 2015-08-28 12:48:24,844 ERROR [org.ovirt.engine.core.bll.CopyImageGroupCommand] (org.ovirt.thread.pool-8-thread-2) [89f7645] Ending command with failure: org.ovirt.engine.core.bll.CopyImageGroupCommand 2015-08-28 12:48:24,853 INFO [org.ovirt.engine.core.bll.RemoveImageCommand] (org.ovirt.thread.pool-8-thread-2) [779578db] Running command: RemoveImageCommand internal: true. Entities affected : ID: 937822d9-8a59-490f-95b7-48371ae32253 Type: Storage 2015-08-28 12:48:24,913 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (org.ovirt.thread.pool-8-thread-2) [779578db] START, DeleteImageGroupVDSCommand( storagePoolId = 00000002-0002-0002-0002-000000000021, ignoreFailoverLimit = false, storageDomainId = 937822d9-8a59-490f-95b7-48371ae32253, imageGroupId = 7f5dd048-048f-49c1-9589-c935fcdccfdd, postZeros = false, forceDelete = false), log id: 6bc5ac77 2015-08-28 12:48:24,979 ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (org.ovirt.thread.pool-8-thread-2) [779578db] Command DeleteImageGroupVDSCommand( storagePoolId = 00000002-0002-0002-0002-000000000021, ignoreFailoverLimit = false, storageDomainId = 937822d9-8a59-490f-95b7-48371ae32253, imageGroupId = 7f5dd048-048f-49c1-9589-c935fcdccfdd, postZeros = false, forceDelete = false) execution failed. Exception: IrsOperationFailedNoFailoverException: IRSGenericException: IRSErrorException: Image does not exist in domain: u'image=7f5dd048-048f-49c1-9589-c935fcdccfdd, domain=937822d9-8a59-490f-95b7-48371ae32253' 2015-08-28 12:48:24,984 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (org.ovirt.thread.pool-8-thread-2) [779578db] FINISH, DeleteImageGroupVDSCommand, log id: 6bc5ac77 2015-08-28 12:48:24,986 INFO [org.ovirt.engine.core.bll.RemoveImageCommand] (org.ovirt.thread.pool-8-thread-2) [779578db] Disk 7f5dd048-048f-49c1-9589-c935fcdccfdd doesnt exist on storage domain 937822d9-8a59-490f-95b7-48371ae32253, rolling forward 2015-08-28 12:48:25,126 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (org.ovirt.thread.pool-8-thread-2) [779578db] Removed task da4b9e1f-43f3-4de0-8f38-bdc5bc8ebaae from DataBase 2015-08-28 12:48:25,144 ERROR [org.ovirt.engine.core.bll.CopyImageGroupCommand] (org.ovirt.thread.pool-8-thread-2) [7bfcbcdd] Ending command with failure: org.ovirt.engine.core.bll.CopyImageGroupCommand 2015-08-28 12:48:25,152 INFO [org.ovirt.engine.core.bll.RemoveImageCommand] (org.ovirt.thread.pool-8-thread-2) [2a0d85fe] Running command: RemoveImageCommand internal: true. Entities affected : ID: 937822d9-8a59-490f-95b7-48371ae32253 Type: Storage 2015-08-28 12:48:25,203 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (org.ovirt.thread.pool-8-thread-2) [2a0d85fe] START, DeleteImageGroupVDSCommand( storagePoolId = 00000002-0002-0002-0002-000000000021, ignoreFailoverLimit = false, storageDomainId = 937822d9-8a59-490f-95b7-48371ae32253, imageGroupId = e64d7be5-7643-4ba1-b347-80c923f130e6, postZeros = false, forceDelete = false), log id: ff00a91 2015-08-28 12:48:25,283 ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (org.ovirt.thread.pool-8-thread-2) [2a0d85fe] Command DeleteImageGroupVDSCommand( storagePoolId = 00000002-0002-0002-0002-000000000021, ignoreFailoverLimit = false, storageDomainId = 937822d9-8a59-490f-95b7-48371ae32253, imageGroupId = e64d7be5-7643-4ba1-b347-80c923f130e6, postZeros = false, forceDelete = false) execution failed. Exception: IrsOperationFailedNoFailoverException: IRSGenericException: IRSErrorException: Image does not exist in domain: u'image=e64d7be5-7643-4ba1-b347-80c923f130e6, domain=937822d9-8a59-490f-95b7-48371ae32253' 2015-08-28 12:48:25,290 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (org.ovirt.thread.pool-8-thread-2) [2a0d85fe] FINISH, DeleteImageGroupVDSCommand, log id: ff00a91 2015-08-28 12:48:25,292 INFO [org.ovirt.engine.core.bll.RemoveImageCommand] (org.ovirt.thread.pool-8-thread-2) [2a0d85fe] Disk e64d7be5-7643-4ba1-b347-80c923f130e6 doesnt exist on storage domain 937822d9-8a59-490f-95b7-48371ae32253, rolling forward 2015-08-28 12:48:25,406 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (org.ovirt.thread.pool-8-thread-2) [2a0d85fe] Removed task 8ad7c433-a77f-4003-a11e-f061ca6cf844 from DataBase 2015-08-28 12:48:25,613 INFO [org.ovirt.engine.core.bll.CloneVmCommand] (org.ovirt.thread.pool-8-thread-2) Lock freed to object EngineLock [exclusiveLocks= key: Katello_2.3 value: VM_NAME , sharedLocks= key: e7e99288-ad83-406e-9cb6-7a5aa443de9b value: DISK key: 6281b597-020d-4ea7-a954-bb798a0ca4f1 value: DISK key: 9013e3c2-3cd7-4eae-a3e6-f5e83a64db87 value: VM ] 2015-08-28 12:48:25,676 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogableBase] (org.ovirt.thread.pool-8-thread-2) Error during log command: org.ovirt.engine.core.bll.CloneVmCommand. Exception java.lang.NullPointerException: java.lang.NullPointerException at org.ovirt.engine.core.bll.CloneVmCommand.getVm(CloneVmCommand.java:140) [bll.jar:] at org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogableBase.getVds(AuditLogableBase.java:353) [dal.jar:] at org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogableBase.getVdsIdRef(AuditLogableBase.java:237) [dal.jar:] at org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector.saveToDb(AuditLogDirector.java:140) [dal.jar:] at org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector.log(AuditLogDirector.java:107) [dal.jar:] at org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector.log(AuditLogDirector.java:100) [dal.jar:] at org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector.log(AuditLogDirector.java:96) [dal.jar:] at org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogableBase.log(AuditLogableBase.java:459) [dal.jar:] at org.ovirt.engine.core.bll.CommandBase.logCommand(CommandBase.java:1447) [bll.jar:] at org.ovirt.engine.core.bll.CommandBase.endAction(CommandBase.java:513) [bll.jar:] at org.ovirt.engine.core.bll.tasks.DecoratedCommand.endAction(DecoratedCommand.java:17) [bll.jar:] at org.ovirt.engine.core.bll.tasks.CoCoAsyncTaskHelper.endAction(CoCoAsyncTaskHelper.java:337) [bll.jar:] at org.ovirt.engine.core.bll.tasks.CommandCoordinatorImpl.endAction(CommandCoordinatorImpl.java:383) [bll.jar:] at org.ovirt.engine.core.bll.tasks.CommandAsyncTask.endCommandAction(CommandAsyncTask.java:149) [bll.jar:] at org.ovirt.engine.core.bll.tasks.CommandAsyncTask.access$000(CommandAsyncTask.java:28) [bll.jar:] at org.ovirt.engine.core.bll.tasks.CommandAsyncTask$1.run(CommandAsyncTask.java:109) [bll.jar:] at org.ovirt.engine.core.utils.threadpool.ThreadPoolUtil$InternalWrapperRunnable.run(ThreadPoolUtil.java:90) [utils.jar:] at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) [rt.jar:1.7.0_79] at java.util.concurrent.FutureTask.run(FutureTask.java:262) [rt.jar:1.7.0_79] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_79] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_79] at java.lang.Thread.run(Thread.java:745) [rt.jar:1.7.0_79] 2015-08-28 12:48:25,700 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-2) CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type CloneVm completed, handling the result. 2015-08-28 12:48:25,703 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-2) CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type CloneVm succeeded, clearing tasks. 2015-08-28 12:48:25,714 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-8-thread-2) SPMAsyncTask::ClearAsyncTask: Attempting to clear task a961301c-0da0-49b6-a2e7-787de9ea8fe6 2015-08-28 12:48:25,715 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-2) START, SPMClearTaskVDSCommand( storagePoolId = 00000002-0002-0002-0002-000000000021, ignoreFailoverLimit = false, taskId = a961301c-0da0-49b6-a2e7-787de9ea8fe6), log id: 4852f196 2015-08-28 12:48:25,745 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-2) START, HSMClearTaskVDSCommand(HostName = itsatltovirtaio.domain.local, HostId = b783a2ee-4a63-46ca-9afc-b3b74f0e10ce, taskId=a961301c-0da0-49b6-a2e7-787de9ea8fe6), log id: 3d72d3f2 2015-08-28 12:48:25,766 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-2) FINISH, HSMClearTaskVDSCommand, log id: 3d72d3f2 2015-08-28 12:48:25,767 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-2) FINISH, SPMClearTaskVDSCommand, log id: 4852f196 2015-08-28 12:48:25,780 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-8-thread-2) BaseAsyncTask::removeTaskFromDB: Removed task a961301c-0da0-49b6-a2e7-787de9ea8fe6 from DataBase 2015-08-28 12:48:25,782 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-8-thread-2) SPMAsyncTask::ClearAsyncTask: Attempting to clear task 11079859-f235-4227-b2ba-b51f88a0f9cd 2015-08-28 12:48:25,784 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-2) START, SPMClearTaskVDSCommand( storagePoolId = 00000002-0002-0002-0002-000000000021, ignoreFailoverLimit = false, taskId = 11079859-f235-4227-b2ba-b51f88a0f9cd), log id: 13acb232 2015-08-28 12:48:25,821 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-2) START, HSMClearTaskVDSCommand(HostName = itsatltovirtaio.domain.local, HostId = b783a2ee-4a63-46ca-9afc-b3b74f0e10ce, taskId=11079859-f235-4227-b2ba-b51f88a0f9cd), log id: 2ee6fab5 2015-08-28 12:48:25,842 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-2) FINISH, HSMClearTaskVDSCommand, log id: 2ee6fab5 2015-08-28 12:48:25,844 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-2) FINISH, SPMClearTaskVDSCommand, log id: 13acb232 2015-08-28 12:48:25,855 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-8-thread-2) BaseAsyncTask::removeTaskFromDB: Removed task 11079859-f235-4227-b2ba-b51f88a0f9cd from DataBase 2015-08-28 12:48:25,857 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-2) CommandAsyncTask::HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks object for entity f81024b3-e534-4df4-907b-91e690bf049c 2015-08-28 12:48:41,695 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (DefaultQuartzScheduler_Worker-99) Setting new tasks map. The map contains now 2 tasks 2015-08-28 12:49:41,697 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (DefaultQuartzScheduler_Worker-49) Setting new tasks map. The map contains now 0 tasks 2015-08-28 12:49:41,697 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (DefaultQuartzScheduler_Worker-49) Cleared all tasks of pool 00000002-0002-0002-0002-000000000021. _______________________________________________ Users mailing list Users(a)ovirt.org http://lists.ovirt.org/mailman/listinfo/users