Attachment 868462 Details for Bug 1070678 – engine log

engine log

enginelog (text/plain), 22.11 KB, created by Frantisek Kobzik on 2014-02-27 11:00:48 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Frantisek Kobzik

Created: 2014-02-27 11:00:48 UTC

Size: 22.11 KB

patch

obsolete

>2014-02-27 11:58:12,472 INFO  [org.ovirt.engine.core.bll.MultipleActionsRunner] (org.ovirt.thread.pool-6-thread-39) [717e04a2] Start running CanDoAction for command number 1/2 (Command type: AddVmPoolWithVms)
>2014-02-27 11:58:12,472 INFO  [org.ovirt.engine.core.bll.MultipleActionsRunner] (org.ovirt.thread.pool-6-thread-40) [11669a7b] Start running CanDoAction for command number 2/2 (Command type: AddVmPoolWithVms)
>2014-02-27 11:58:12,487 INFO  [org.ovirt.engine.core.bll.MultipleActionsRunner] (org.ovirt.thread.pool-6-thread-40) [11669a7b] Finish handling CanDoAction for command number 2/2 (Command type: AddVmPoolWithVms)
>2014-02-27 11:58:12,487 INFO  [org.ovirt.engine.core.bll.MultipleActionsRunner] (org.ovirt.thread.pool-6-thread-39) [717e04a2] Finish handling CanDoAction for command number 1/2 (Command type: AddVmPoolWithVms)
>2014-02-27 11:58:12,524 INFO  [org.ovirt.engine.core.bll.AddVmPoolWithVmsCommand] (org.ovirt.thread.pool-6-thread-43) [717e04a2] Running command: AddVmPoolWithVmsCommand internal: false. Entities affected :  ID: 1865ef8a-bf19-4d2d-aa95-8e176c67ddcb Type: VdsGroups,  ID: 9618d841-186f-4e1f-bde2-80aa8cabb84e Type: VmTemplate
>2014-02-27 11:58:12,624 INFO  [org.ovirt.engine.core.bll.AddVmAndAttachToPoolCommand] (org.ovirt.thread.pool-6-thread-43) [72c0513] Running command: AddVmAndAttachToPoolCommand internal: true. Entities affected :  ID: 1865ef8a-bf19-4d2d-aa95-8e176c67ddcb Type: VdsGroups,  ID: 9618d841-186f-4e1f-bde2-80aa8cabb84e Type: VmTemplate,  ID: cc7eebfe-3d4d-4398-82fc-5c919faaad2b Type: Storage,  ID: 1865ef8a-bf19-4d2d-aa95-8e176c67ddcb Type: VdsGroups
>2014-02-27 11:58:12,634 INFO  [org.ovirt.engine.core.bll.AddVmCommand] (org.ovirt.thread.pool-6-thread-43) [2a039e92] Lock Acquired to object EngineLock [exclusiveLocks= key: DoublePool2-1 value: VM_NAME
>, sharedLocks= key: 52ed5557-43c1-4a3d-b517-eb764fbf046e value: DISK
>key: 9618d841-186f-4e1f-bde2-80aa8cabb84e value: TEMPLATE
>]
>2014-02-27 11:58:12,671 INFO  [org.ovirt.engine.core.bll.AddVmCommand] (org.ovirt.thread.pool-6-thread-43) [2a039e92] Running command: AddVmCommand internal: true. Entities affected :  ID: 1865ef8a-bf19-4d2d-aa95-8e176c67ddcb Type: VdsGroups,  ID: 9618d841-186f-4e1f-bde2-80aa8cabb84e Type: VmTemplate,  ID: cc7eebfe-3d4d-4398-82fc-5c919faaad2b Type: Storage,  ID: 1865ef8a-bf19-4d2d-aa95-8e176c67ddcb Type: VdsGroups
>2014-02-27 11:58:12,715 INFO  [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (org.ovirt.thread.pool-6-thread-43) [2a039e92] START, SetVmStatusVDSCommand( vmId = 75f39d80-bf2d-44c5-a2d1-8497a04ad3b8, status = ImageLocked), log id: 212ae754
>2014-02-27 11:58:12,732 INFO  [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (org.ovirt.thread.pool-6-thread-43) [2a039e92] FINISH, SetVmStatusVDSCommand, log id: 212ae754
>2014-02-27 11:58:12,743 INFO  [org.ovirt.engine.core.bll.CreateSnapshotFromTemplateCommand] (org.ovirt.thread.pool-6-thread-43) [14ce0f7c] Running command: CreateSnapshotFromTemplateCommand internal: true. Entities affected :  ID: cc7eebfe-3d4d-4398-82fc-5c919faaad2b Type: Storage
>2014-02-27 11:58:12,749 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateSnapshotVDSCommand] (org.ovirt.thread.pool-6-thread-43) [14ce0f7c] START, CreateSnapshotVDSCommand( storagePoolId = 9f4d2fc1-87cd-470b-b4f5-a5666a41875b, ignoreFailoverLimit = false, storageDomainId = cc7eebfe-3d4d-4398-82fc-5c919faaad2b, imageGroupId = e2428ad1-e3c0-4e97-bb24-8fccf1a63ad5, imageSizeInBytes = 1073741824, volumeFormat = COW, newImageId = c758d394-3e4f-41b2-9819-87f45404e96f, newImageDescription = , imageId = 13d28746-4428-4dbd-ae4f-460b3a30d6d0, sourceImageGroupId = 52ed5557-43c1-4a3d-b517-eb764fbf046e), log id: 4c2d5fc5
>2014-02-27 11:58:12,751 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateSnapshotVDSCommand] (org.ovirt.thread.pool-6-thread-43) [14ce0f7c] -- executeIrsBrokerCommand: calling 'createVolume' with two new parameters: description and UUID
>2014-02-27 11:58:12,885 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateSnapshotVDSCommand] (org.ovirt.thread.pool-6-thread-43) [14ce0f7c] FINISH, CreateSnapshotVDSCommand, return: c758d394-3e4f-41b2-9819-87f45404e96f, log id: 4c2d5fc5
>2014-02-27 11:58:12,917 INFO  [org.ovirt.engine.core.bll.CommandAsyncTask] (org.ovirt.thread.pool-6-thread-43) [14ce0f7c] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command 590398ec-2294-4df5-861d-9785af309cc9
>2014-02-27 11:58:12,917 INFO  [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (org.ovirt.thread.pool-6-thread-43) [14ce0f7c] CommandMultiAsyncTasks::AttachTask: Attaching task e9850524-42bc-4de4-889a-a4fe6900136b to command 590398ec-2294-4df5-861d-9785af309cc9.
>2014-02-27 11:58:12,931 INFO  [org.ovirt.engine.core.bll.AsyncTaskManager] (org.ovirt.thread.pool-6-thread-43) [14ce0f7c] Adding task e9850524-42bc-4de4-889a-a4fe6900136b (Parent Command AddVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters), polling hasn't started yet..
>2014-02-27 11:58:13,138 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-6-thread-43) [14ce0f7c] Correlation ID: 2a039e92, Call Stack: null, Custom Event ID: -1, Message: VM DoublePool2-1 creation was initiated by admin.
>2014-02-27 11:58:13,139 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (org.ovirt.thread.pool-6-thread-43) [14ce0f7c] BaseAsyncTask::startPollingTask: Starting to poll task e9850524-42bc-4de4-889a-a4fe6900136b.
>2014-02-27 11:58:13,161 INFO  [org.ovirt.engine.core.bll.AddVmToPoolCommand] (org.ovirt.thread.pool-6-thread-43) [59fe44e8] Running command: AddVmToPoolCommand internal: true. Entities affected :  ID: cdc19f2d-5499-4fbc-96a6-4936b2101751 Type: VmPool
>2014-02-27 11:58:13,263 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-6-thread-43) [59fe44e8] Correlation ID: 717e04a2, Job ID: 80ca6e55-3289-46e1-935e-d06ba42ce774, Call Stack: null, Custom Event ID: -1, Message: VM Pool DoublePool2 (containing 1 VMs) was created by admin.
>2014-02-27 11:58:13,412 INFO  [org.ovirt.engine.core.bll.AddVmPoolWithVmsCommand] (org.ovirt.thread.pool-6-thread-43) [11669a7b] Running command: AddVmPoolWithVmsCommand internal: false. Entities affected :  ID: 1865ef8a-bf19-4d2d-aa95-8e176c67ddcb Type: VdsGroups,  ID: 9618d841-186f-4e1f-bde2-80aa8cabb84e Type: VmTemplate
>2014-02-27 11:58:13,668 INFO  [org.ovirt.engine.core.bll.AddVmAndAttachToPoolCommand] (org.ovirt.thread.pool-6-thread-43) [47bb299c] Running command: AddVmAndAttachToPoolCommand internal: true. Entities affected :  ID: 1865ef8a-bf19-4d2d-aa95-8e176c67ddcb Type: VdsGroups,  ID: 9618d841-186f-4e1f-bde2-80aa8cabb84e Type: VmTemplate,  ID: cc7eebfe-3d4d-4398-82fc-5c919faaad2b Type: Storage,  ID: 1865ef8a-bf19-4d2d-aa95-8e176c67ddcb Type: VdsGroups
>2014-02-27 11:58:13,677 INFO  [org.ovirt.engine.core.bll.AddVmCommand] (org.ovirt.thread.pool-6-thread-43) [9858864] Lock Acquired to object EngineLock [exclusiveLocks= key: DoublePool2-2 value: VM_NAME
>, sharedLocks= key: 52ed5557-43c1-4a3d-b517-eb764fbf046e value: DISK
>key: 9618d841-186f-4e1f-bde2-80aa8cabb84e value: TEMPLATE
>]
>2014-02-27 11:58:13,698 INFO  [org.ovirt.engine.core.bll.AddVmCommand] (org.ovirt.thread.pool-6-thread-43) [9858864] Running command: AddVmCommand internal: true. Entities affected :  ID: 1865ef8a-bf19-4d2d-aa95-8e176c67ddcb Type: VdsGroups,  ID: 9618d841-186f-4e1f-bde2-80aa8cabb84e Type: VmTemplate,  ID: cc7eebfe-3d4d-4398-82fc-5c919faaad2b Type: Storage,  ID: 1865ef8a-bf19-4d2d-aa95-8e176c67ddcb Type: VdsGroups
>2014-02-27 11:58:13,726 INFO  [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (org.ovirt.thread.pool-6-thread-43) [9858864] START, SetVmStatusVDSCommand( vmId = b2c97b16-638a-4508-a7b1-60dcdfb0bfc8, status = ImageLocked), log id: 37c70b5b
>2014-02-27 11:58:13,743 INFO  [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (org.ovirt.thread.pool-6-thread-43) [9858864] FINISH, SetVmStatusVDSCommand, log id: 37c70b5b
>2014-02-27 11:58:13,751 INFO  [org.ovirt.engine.core.bll.CreateSnapshotFromTemplateCommand] (org.ovirt.thread.pool-6-thread-43) [7c0effde] Running command: CreateSnapshotFromTemplateCommand internal: true. Entities affected :  ID: cc7eebfe-3d4d-4398-82fc-5c919faaad2b Type: Storage
>2014-02-27 11:58:13,755 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateSnapshotVDSCommand] (org.ovirt.thread.pool-6-thread-43) [7c0effde] START, CreateSnapshotVDSCommand( storagePoolId = 9f4d2fc1-87cd-470b-b4f5-a5666a41875b, ignoreFailoverLimit = false, storageDomainId = cc7eebfe-3d4d-4398-82fc-5c919faaad2b, imageGroupId = 31c2ff02-8e88-4580-94a4-0a8948dea66f, imageSizeInBytes = 1073741824, volumeFormat = COW, newImageId = 1954b5ac-5b02-4d9d-9a4e-9d409a598ba9, newImageDescription = , imageId = 13d28746-4428-4dbd-ae4f-460b3a30d6d0, sourceImageGroupId = 52ed5557-43c1-4a3d-b517-eb764fbf046e), log id: 1caf570a
>2014-02-27 11:58:13,756 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateSnapshotVDSCommand] (org.ovirt.thread.pool-6-thread-43) [7c0effde] -- executeIrsBrokerCommand: calling 'createVolume' with two new parameters: description and UUID
>2014-02-27 11:58:13,836 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateSnapshotVDSCommand] (org.ovirt.thread.pool-6-thread-43) [7c0effde] FINISH, CreateSnapshotVDSCommand, return: 1954b5ac-5b02-4d9d-9a4e-9d409a598ba9, log id: 1caf570a
>2014-02-27 11:58:13,869 INFO  [org.ovirt.engine.core.bll.CommandAsyncTask] (org.ovirt.thread.pool-6-thread-43) [7c0effde] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command e3cfb49a-e9bd-4ad1-8b3a-aca0020f02a0
>2014-02-27 11:58:13,869 INFO  [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (org.ovirt.thread.pool-6-thread-43) [7c0effde] CommandMultiAsyncTasks::AttachTask: Attaching task 8434cadc-0ef8-4389-a468-6a9fc532beca to command e3cfb49a-e9bd-4ad1-8b3a-aca0020f02a0.
>2014-02-27 11:58:13,900 INFO  [org.ovirt.engine.core.bll.AsyncTaskManager] (org.ovirt.thread.pool-6-thread-43) [7c0effde] Adding task 8434cadc-0ef8-4389-a468-6a9fc532beca (Parent Command AddVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters), polling hasn't started yet..
>2014-02-27 11:58:14,004 INFO  [org.ovirt.engine.core.bll.AsyncTaskManager] (DefaultQuartzScheduler_Worker-75) Polling and updating Async Tasks: 3 tasks, 1 tasks to poll now
>2014-02-27 11:58:14,010 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (DefaultQuartzScheduler_Worker-75) SPMAsyncTask::PollTask: Polling task e9850524-42bc-4de4-889a-a4fe6900136b (Parent Command AddVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) returned status finished, result 'success'.
>2014-02-27 11:58:14,052 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (DefaultQuartzScheduler_Worker-75) BaseAsyncTask::OnTaskEndSuccess: Task e9850524-42bc-4de4-889a-a4fe6900136b (Parent Command AddVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) ended successfully.
>2014-02-27 11:58:14,053 INFO  [org.ovirt.engine.core.bll.CommandAsyncTask] (DefaultQuartzScheduler_Worker-75) CommandAsyncTask::EndActionIfNecessary: All tasks of command 590398ec-2294-4df5-861d-9785af309cc9 has ended -> executing endAction
>2014-02-27 11:58:14,054 INFO  [org.ovirt.engine.core.bll.CommandAsyncTask] (DefaultQuartzScheduler_Worker-75) CommandAsyncTask::endAction: Ending action for 1 tasks (command ID: 590398ec-2294-4df5-861d-9785af309cc9): calling endAction .
>2014-02-27 11:58:14,054 INFO  [org.ovirt.engine.core.bll.CommandAsyncTask] (org.ovirt.thread.pool-6-thread-46) CommandAsyncTask::EndCommandAction [within thread] context: Attempting to endAction AddVm, executionIndex: 0
>2014-02-27 11:58:14,118 INFO  [org.ovirt.engine.core.bll.AddVmCommand] (org.ovirt.thread.pool-6-thread-46) [2a039e92] Ending command successfully: org.ovirt.engine.core.bll.AddVmCommand
>2014-02-27 11:58:14,149 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-6-thread-43) [7c0effde] Correlation ID: 9858864, Call Stack: null, Custom Event ID: -1, Message: VM DoublePool2-2 creation was initiated by admin.
>2014-02-27 11:58:14,150 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (org.ovirt.thread.pool-6-thread-43) [7c0effde] BaseAsyncTask::startPollingTask: Starting to poll task 8434cadc-0ef8-4389-a468-6a9fc532beca.
>2014-02-27 11:58:14,157 INFO  [org.ovirt.engine.core.bll.CreateSnapshotFromTemplateCommand] (org.ovirt.thread.pool-6-thread-46) [14ce0f7c] Ending command successfully: org.ovirt.engine.core.bll.CreateSnapshotFromTemplateCommand
>2014-02-27 11:58:14,159 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand] (org.ovirt.thread.pool-6-thread-46) [14ce0f7c] START, GetImageInfoVDSCommand( storagePoolId = 9f4d2fc1-87cd-470b-b4f5-a5666a41875b, ignoreFailoverLimit = false, storageDomainId = cc7eebfe-3d4d-4398-82fc-5c919faaad2b, imageGroupId = e2428ad1-e3c0-4e97-bb24-8fccf1a63ad5, imageId = c758d394-3e4f-41b2-9819-87f45404e96f), log id: 698a19ea
>2014-02-27 11:58:14,159 INFO  [org.ovirt.engine.core.bll.AddVmToPoolCommand] (org.ovirt.thread.pool-6-thread-43) [277b5f3e] Running command: AddVmToPoolCommand internal: true. Entities affected :  ID: 19df17cd-5bbf-4da1-aebd-285643191c1e Type: VmPool
>2014-02-27 11:58:14,177 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand] (org.ovirt.thread.pool-6-thread-46) [14ce0f7c] FINISH, GetImageInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.DiskImage@d4177946, log id: 698a19ea
>2014-02-27 11:58:14,231 INFO  [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (org.ovirt.thread.pool-6-thread-46) START, SetVmStatusVDSCommand( vmId = 75f39d80-bf2d-44c5-a2d1-8497a04ad3b8, status = Down), log id: 644e08c7
>2014-02-27 11:58:14,233 INFO  [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (org.ovirt.thread.pool-6-thread-46) FINISH, SetVmStatusVDSCommand, log id: 644e08c7
>2014-02-27 11:58:14,282 INFO  [org.ovirt.engine.core.bll.AddVmCommand] (org.ovirt.thread.pool-6-thread-46) Lock freed to object EngineLock [exclusiveLocks= key: DoublePool2-1 value: VM_NAME
>, sharedLocks= key: 52ed5557-43c1-4a3d-b517-eb764fbf046e value: DISK
>key: 9618d841-186f-4e1f-bde2-80aa8cabb84e value: TEMPLATE
>]
>2014-02-27 11:58:14,314 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-6-thread-46) Correlation ID: 2a039e92, Job ID: 80ca6e55-3289-46e1-935e-d06ba42ce774, Call Stack: null, Custom Event ID: -1, Message: VM DoublePool2-1 creation has been completed.
>2014-02-27 11:58:14,315 INFO  [org.ovirt.engine.core.bll.CommandAsyncTask] (org.ovirt.thread.pool-6-thread-46) CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type AddVm completed, handling the result.
>2014-02-27 11:58:14,316 INFO  [org.ovirt.engine.core.bll.CommandAsyncTask] (org.ovirt.thread.pool-6-thread-46) CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type AddVm succeeded, clearing tasks.
>2014-02-27 11:58:14,322 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-6-thread-43) [277b5f3e] Correlation ID: 11669a7b, Job ID: e30468c6-04c6-49b5-a62d-ad34a53b30d4, Call Stack: null, Custom Event ID: -1, Message: VM Pool DoublePool2 (containing 1 VMs) was created by admin.
>2014-02-27 11:58:14,347 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (org.ovirt.thread.pool-6-thread-46) SPMAsyncTask::ClearAsyncTask: Attempting to clear task e9850524-42bc-4de4-889a-a4fe6900136b
>2014-02-27 11:58:14,348 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-6-thread-46) START, SPMClearTaskVDSCommand( storagePoolId = 9f4d2fc1-87cd-470b-b4f5-a5666a41875b, ignoreFailoverLimit = false, taskId = e9850524-42bc-4de4-889a-a4fe6900136b), log id: 6763acdf
>2014-02-27 11:58:14,349 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-6-thread-46) START, HSMClearTaskVDSCommand(HostName = aoeu, HostId = f4533df8-fd3c-4d50-b6d7-ea83414fce38, taskId=e9850524-42bc-4de4-889a-a4fe6900136b), log id: 40ea9980
>2014-02-27 11:58:14,354 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-6-thread-46) FINISH, HSMClearTaskVDSCommand, log id: 40ea9980
>2014-02-27 11:58:14,354 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-6-thread-46) FINISH, SPMClearTaskVDSCommand, log id: 6763acdf
>2014-02-27 11:58:14,422 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (org.ovirt.thread.pool-6-thread-46) BaseAsyncTask::RemoveTaskFromDB: Removed task e9850524-42bc-4de4-889a-a4fe6900136b from DataBase
>2014-02-27 11:58:14,422 INFO  [org.ovirt.engine.core.bll.CommandAsyncTask] (org.ovirt.thread.pool-6-thread-46) CommandAsyncTask::HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks object for entity 590398ec-2294-4df5-861d-9785af309cc9
>2014-02-27 11:58:24,054 INFO  [org.ovirt.engine.core.bll.AsyncTaskManager] (DefaultQuartzScheduler_Worker-83) Polling and updating Async Tasks: 3 tasks, 1 tasks to poll now
>2014-02-27 11:58:24,060 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (DefaultQuartzScheduler_Worker-83) SPMAsyncTask::PollTask: Polling task 8434cadc-0ef8-4389-a468-6a9fc532beca (Parent Command AddVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) returned status finished, result 'success'.
>2014-02-27 11:58:24,078 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (DefaultQuartzScheduler_Worker-83) BaseAsyncTask::OnTaskEndSuccess: Task 8434cadc-0ef8-4389-a468-6a9fc532beca (Parent Command AddVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) ended successfully.
>2014-02-27 11:58:24,079 INFO  [org.ovirt.engine.core.bll.CommandAsyncTask] (DefaultQuartzScheduler_Worker-83) CommandAsyncTask::EndActionIfNecessary: All tasks of command e3cfb49a-e9bd-4ad1-8b3a-aca0020f02a0 has ended -> executing endAction
>2014-02-27 11:58:24,080 INFO  [org.ovirt.engine.core.bll.CommandAsyncTask] (DefaultQuartzScheduler_Worker-83) CommandAsyncTask::endAction: Ending action for 1 tasks (command ID: e3cfb49a-e9bd-4ad1-8b3a-aca0020f02a0): calling endAction .
>2014-02-27 11:58:24,081 INFO  [org.ovirt.engine.core.bll.CommandAsyncTask] (org.ovirt.thread.pool-6-thread-5) CommandAsyncTask::EndCommandAction [within thread] context: Attempting to endAction AddVm, executionIndex: 0
>2014-02-27 11:58:24,103 INFO  [org.ovirt.engine.core.bll.AddVmCommand] (org.ovirt.thread.pool-6-thread-5) [9858864] Ending command successfully: org.ovirt.engine.core.bll.AddVmCommand
>2014-02-27 11:58:24,111 INFO  [org.ovirt.engine.core.bll.CreateSnapshotFromTemplateCommand] (org.ovirt.thread.pool-6-thread-5) [7c0effde] Ending command successfully: org.ovirt.engine.core.bll.CreateSnapshotFromTemplateCommand
>2014-02-27 11:58:24,114 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand] (org.ovirt.thread.pool-6-thread-5) [7c0effde] START, GetImageInfoVDSCommand( storagePoolId = 9f4d2fc1-87cd-470b-b4f5-a5666a41875b, ignoreFailoverLimit = false, storageDomainId = cc7eebfe-3d4d-4398-82fc-5c919faaad2b, imageGroupId = 31c2ff02-8e88-4580-94a4-0a8948dea66f, imageId = 1954b5ac-5b02-4d9d-9a4e-9d409a598ba9), log id: 45b7c724
>2014-02-27 11:58:24,135 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand] (org.ovirt.thread.pool-6-thread-5) [7c0effde] FINISH, GetImageInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.DiskImage@97544b26, log id: 45b7c724
>2014-02-27 11:58:24,145 INFO  [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (org.ovirt.thread.pool-6-thread-5) START, SetVmStatusVDSCommand( vmId = b2c97b16-638a-4508-a7b1-60dcdfb0bfc8, status = Down), log id: 5a82efa9
>2014-02-27 11:58:24,147 INFO  [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (org.ovirt.thread.pool-6-thread-5) FINISH, SetVmStatusVDSCommand, log id: 5a82efa9
>2014-02-27 11:58:24,153 INFO  [org.ovirt.engine.core.bll.AddVmCommand] (org.ovirt.thread.pool-6-thread-5) Lock freed to object EngineLock [exclusiveLocks= key: DoublePool2-2 value: VM_NAME
>, sharedLocks= key: 52ed5557-43c1-4a3d-b517-eb764fbf046e value: DISK
>key: 9618d841-186f-4e1f-bde2-80aa8cabb84e value: TEMPLATE
>]
>2014-02-27 11:58:24,161 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-6-thread-5) Correlation ID: 9858864, Job ID: e30468c6-04c6-49b5-a62d-ad34a53b30d4, Call Stack: null, Custom Event ID: -1, Message: VM DoublePool2-2 creation has been completed.
>2014-02-27 11:58:24,162 INFO  [org.ovirt.engine.core.bll.CommandAsyncTask] (org.ovirt.thread.pool-6-thread-5) CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type AddVm completed, handling the result.
>2014-02-27 11:58:24,162 INFO  [org.ovirt.engine.core.bll.CommandAsyncTask] (org.ovirt.thread.pool-6-thread-5) CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type AddVm succeeded, clearing tasks.
>2014-02-27 11:58:24,186 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (org.ovirt.thread.pool-6-thread-5) SPMAsyncTask::ClearAsyncTask: Attempting to clear task 8434cadc-0ef8-4389-a468-6a9fc532beca
>2014-02-27 11:58:24,186 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-6-thread-5) START, SPMClearTaskVDSCommand( storagePoolId = 9f4d2fc1-87cd-470b-b4f5-a5666a41875b, ignoreFailoverLimit = false, taskId = 8434cadc-0ef8-4389-a468-6a9fc532beca), log id: 4cd8436e
>2014-02-27 11:58:24,188 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-6-thread-5) START, HSMClearTaskVDSCommand(HostName = aoeu, HostId = f4533df8-fd3c-4d50-b6d7-ea83414fce38, taskId=8434cadc-0ef8-4389-a468-6a9fc532beca), log id: a33122c
>2014-02-27 11:58:24,192 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-6-thread-5) FINISH, HSMClearTaskVDSCommand, log id: a33122c
>2014-02-27 11:58:24,192 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-6-thread-5) FINISH, SPMClearTaskVDSCommand, log id: 4cd8436e
>2014-02-27 11:58:24,202 INFO  [org.ovirt.engine.core.bll.SPMAsyncTask] (org.ovirt.thread.pool-6-thread-5) BaseAsyncTask::RemoveTaskFromDB: Removed task 8434cadc-0ef8-4389-a468-6a9fc532beca from DataBase
>2014-02-27 11:58:24,203 INFO  [org.ovirt.engine.core.bll.CommandAsyncTask] (org.ovirt.thread.pool-6-thread-5) CommandAsyncTask::HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks object for entity e3cfb49a-e9bd-4ad1-8b3a-aca0020f02a0
>

Actions: View

Attachments on bug 1070678: 868462