On Fri, Aug 28, 2015 at 3:07 PM, Christian Rebel <christian.rebel@gmx.at> wrote:

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…

this bug was fixed in 3.5.4:
Bug 1236608 - Source VM is deleted after failed cloning attempt

unfortunately there is no easy way to recover this vm, first check if the disk are somehow still in the storage (maybe the copy went through and the dest disk is there):

disk 1:

src - /rhev/data-center/00000002-0002-0002-0002-000000000021/937822d9-8a59-490f-95b7-48371ae32253/6281b597-020d-4ea7-a954-bb798a0ca4f1/

dst -

/rhev/data-center/00000002-0002-0002-0002-000000000021/937822d9-8a59-490f-95b7-48371ae32253/e64d7be5-7643-4ba1-b347-80c923f130e6

disk 2:

src - /rhev/data-center/00000002-0002-0002-0002-000000000021/937822d9-8a59-490f-95b7-48371ae32253/e7e99288-ad83-406e-9cb6-7a5aa443de9b

dst -

/rhev/data-center/00000002-0002-0002-0002-000000000021/937822d9-8a59-490f-95b7-48371ae32253/7f5dd048-048f-49c1-9589-c935fcdccfdd

if the disks are there, maybe it would be possible to recover them manually using the image uploader

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=

                dstVolUUID=f57531cf-fb00-4a4d-9aad-c3ffa01f58ce
                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@ovirt.org
http://lists.ovirt.org/mailman/listinfo/users