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

Sun Aug 30 11:52:53 UTC 2015

On Fri, Aug 28, 2015 at 3:07 PM, Christian Rebel <christian.rebel at 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* <https://bugzilla.redhat.com/show_bug.cgi?id=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 at 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 at ovirt.org
> http://lists.ovirt.org/mailman/listinfo/users
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.ovirt.org/pipermail/users/attachments/20150830/9f707f82/attachment-0001.html>