Login
[x]
Log in using an account from:
Fedora Account System
Red Hat Associate
Red Hat Customer
Or login using a Red Hat Bugzilla account
Forgot Password
Login:
Hide Forgot
Create an Account
Red Hat Bugzilla – Attachment 1455546 Details for
Bug 1596810
Transfer fails if local host belongs to another DC
[?]
New
Simple Search
Advanced Search
My Links
Browse
Requests
Reports
Current State
Search
Tabular reports
Graphical reports
Duplicates
Other Reports
User Changes
Plotly Reports
Bug Status
Bug Severity
Non-Defaults
|
Product Dashboard
Help
Page Help!
Bug Writing Guidelines
What's new
Browser Support Policy
5.0.4.rh83 Release notes
FAQ
Guides index
User guide
Web Services
Contact
Legal
This site requires JavaScript to be enabled to function correctly, please enable it.
ovirt engine log
engine.log (text/plain), 60.30 KB, created by
Nir Soffer
on 2018-06-29 18:25:53 UTC
(
hide
)
Description:
ovirt engine log
Filename:
MIME Type:
Creator:
Nir Soffer
Created:
2018-06-29 18:25:53 UTC
Size:
60.30 KB
patch
obsolete
>2018-06-29 20:33:18,239+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-58) [c6cbc1db-9a7e-4fd6-bb8b-bffb4e559c21] EVENT_ID: USER_VDS_MAINTENANCE_WITHOUT_REASON(620), Host voodoo1 was switched to Maintenance mode by admin@internal-authz. >2018-06-29 20:33:19,640+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.HostMonitoring] (EE-ManagedThreadFactory-engineScheduled-Thread-56) [] Updated host status from 'Preparing for Maintenance' to 'Maintenance' in database, host 'voodoo1'(b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9) >2018-06-29 20:33:19,723+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engine-Thread-21399) [] Clearing cache of pool: 'd8c8ae56-74dc-11e8-826c-525400de233d' for problematic entities of VDS: 'voodoo1'. >2018-06-29 20:33:19,723+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engine-Thread-21399) [] Removing vds '[b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9]' from the domain in maintenance cache >2018-06-29 20:33:19,723+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engine-Thread-21399) [] Removing host(s) '[b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9]' from hosts unseen domain report cache >2018-06-29 20:33:40,852+03 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (default task-118) [42653418-a5ff-4f42-b5cc-92383a1d3e92] Lock Acquired to object 'EngineLock:{exclusiveLocks='[b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9=VDS]', sharedLocks=''}' >2018-06-29 20:33:40,975+03 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engine-Thread-21402) [42653418-a5ff-4f42-b5cc-92383a1d3e92] Running command: ActivateVdsCommand internal: false. Entities affected : ID: b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9 Type: VDSAction group MANIPULATE_HOST with role type ADMIN >2018-06-29 20:33:40,975+03 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engine-Thread-21402) [42653418-a5ff-4f42-b5cc-92383a1d3e92] Before acquiring lock in order to prevent monitoring for host 'voodoo1' from data-center 'Default' >2018-06-29 20:33:40,976+03 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engine-Thread-21402) [42653418-a5ff-4f42-b5cc-92383a1d3e92] Lock acquired, from now a monitoring of host will be skipped for host 'voodoo1' from data-center 'Default' >2018-06-29 20:33:40,986+03 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engine-Thread-21402) [42653418-a5ff-4f42-b5cc-92383a1d3e92] START, SetVdsStatusVDSCommand(HostName = voodoo1, SetVdsStatusVDSCommandParameters:{hostId='b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9', status='Unassigned', nonOperationalReason='NONE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 45f90078 >2018-06-29 20:33:40,991+03 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engine-Thread-21402) [42653418-a5ff-4f42-b5cc-92383a1d3e92] FINISH, SetVdsStatusVDSCommand, return: , log id: 45f90078 >2018-06-29 20:33:40,994+03 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engine-Thread-21402) [42653418-a5ff-4f42-b5cc-92383a1d3e92] Activate host finished. Lock released. Monitoring can run now for host 'voodoo1' from data-center 'Default' >2018-06-29 20:33:41,000+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engine-Thread-21402) [42653418-a5ff-4f42-b5cc-92383a1d3e92] EVENT_ID: VDS_ACTIVATE(16), Activation of host voodoo1 initiated by admin@internal-authz. >2018-06-29 20:33:41,008+03 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engine-Thread-21402) [42653418-a5ff-4f42-b5cc-92383a1d3e92] Lock freed to object 'EngineLock:{exclusiveLocks='[b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9=VDS]', sharedLocks=''}' >2018-06-29 20:33:44,509+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoAsyncVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-78) [] START, GetHardwareInfoAsyncVDSCommand(HostName = voodoo1, VdsIdAndVdsVDSCommandParametersBase:{hostId='b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9', vds='Host[voodoo1,b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9]'}), log id: dd7f90 >2018-06-29 20:33:44,509+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoAsyncVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-78) [] FINISH, GetHardwareInfoAsyncVDSCommand, return: , log id: dd7f90 >2018-06-29 20:33:44,548+03 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-78) [2a6130a8] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9 Type: VDS >2018-06-29 20:33:44,785+03 INFO [org.ovirt.engine.core.bll.InitVdsOnUpCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-85) [5dce3180] Running command: InitVdsOnUpCommand internal: true. Entities affected : ID: d8c8ae56-74dc-11e8-826c-525400de233d Type: StoragePool >2018-06-29 20:33:44,832+03 ERROR [org.ovirt.engine.core.bll.pm.FenceProxyLocator] (EE-ManagedThreadFactory-engineScheduled-Thread-85) [5dce3180] Can not run fence action on host 'voodoo1', no suitable proxy host was found. >2018-06-29 20:33:44,834+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetMOMPolicyParametersVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-85) [5dce3180] START, SetMOMPolicyParametersVDSCommand(HostName = voodoo1, MomPolicyVDSParameters:{hostId='b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9'}), log id: 54898b71 >2018-06-29 20:33:44,877+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetMOMPolicyParametersVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-85) [5dce3180] FINISH, SetMOMPolicyParametersVDSCommand, return: , log id: 54898b71 >2018-06-29 20:33:44,901+03 INFO [org.ovirt.engine.core.bll.hostdev.RefreshHostDevicesCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-85) [439abbb4] Running command: RefreshHostDevicesCommand internal: true. Entities affected : ID: b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9 Type: VDSAction group MANIPULATE_HOST with role type ADMIN >2018-06-29 20:33:44,967+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-85) [439abbb4] EVENT_ID: VDS_DETECTED(13), Status of host voodoo1 was set to Up. >2018-06-29 20:33:44,971+03 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-85) [439abbb4] EVENT_ID: VDS_ALERT_FENCE_IS_NOT_CONFIGURED(9,000), Failed to verify Power Management configuration for Host voodoo1. >2018-06-29 20:33:45,032+03 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-85) [770a984b] Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9 Type: VDS >2018-06-29 20:35:29,075+03 INFO [org.ovirt.engine.core.sso.utils.AuthenticationUtils] (default task-27) [] User admin@internal successfully logged in with scopes: ovirt-app-api ovirt-ext=token-info:authz-search ovirt-ext=token-info:public-authz-search ovirt-ext=token-info:validate ovirt-ext=token:password-access >2018-06-29 20:35:29,104+03 INFO [org.ovirt.engine.core.bll.aaa.CreateUserSessionCommand] (default task-22) [7570a4a2] Running command: CreateUserSessionCommand internal: false. >2018-06-29 20:35:29,120+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-22) [7570a4a2] EVENT_ID: USER_VDC_LOGIN(30), User admin@internal-authz connecting from '10.35.0.100' using session 'Ej2gaZFcX9ZOm0AEg9FM0QMW+4mQqPA8ZkVCOeW1xmiqQmyj+/gHpDdtrdOd5EQe7LtpdpNTNcTnBWfnVRBroQ==' logged in. >2018-06-29 20:36:38,235+03 INFO [org.ovirt.engine.core.sso.utils.AuthenticationUtils] (default task-38) [] User admin@internal successfully logged in with scopes: ovirt-app-api ovirt-ext=token-info:authz-search ovirt-ext=token-info:public-authz-search ovirt-ext=token-info:validate ovirt-ext=token:password-access >2018-06-29 20:36:38,264+03 INFO [org.ovirt.engine.core.bll.aaa.CreateUserSessionCommand] (default task-35) [14860aab] Running command: CreateUserSessionCommand internal: false. >2018-06-29 20:36:38,277+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-35) [14860aab] EVENT_ID: USER_VDC_LOGIN(30), User admin@internal-authz connecting from '10.35.0.100' using session 'lE8qDdG+D2S+4VKoKZ8Ew2HR7xXzjWFDYQExkGunzk8CO1few8gnfPn/Wa7Nok5Lv9pn1yLzaXsG13tqOcKEJg==' logged in. >2018-06-29 20:36:38,346+03 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommand] (default task-35) [2790b102-363e-46a7-8839-b1e70d212f33] Running command: AddDiskCommand internal: false. Entities affected : ID: 27837a03-64f9-4f2b-abb0-daa2195b01ae Type: StorageAction group CREATE_DISK with role type USER >2018-06-29 20:36:38,397+03 INFO [org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand] (default task-35) [2790b102-363e-46a7-8839-b1e70d212f33] Running command: AddImageFromScratchCommand internal: true. Entities affected : ID: 27837a03-64f9-4f2b-abb0-daa2195b01ae Type: Storage >2018-06-29 20:36:38,439+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (default task-35) [2790b102-363e-46a7-8839-b1e70d212f33] START, CreateImageVDSCommand( CreateImageVDSCommandParameters:{storagePoolId='a0011271-88a4-491f-a566-aec38b2000e9', ignoreFailoverLimit='false', storageDomainId='27837a03-64f9-4f2b-abb0-daa2195b01ae', imageGroupId='ba390f85-2d45-4ea1-8e29-96020c4ba416', imageSizeInBytes='6442450944', volumeFormat='RAW', newImageId='55fb99f5-c2a3-4894-9942-400de5595531', imageType='Preallocated', newImageDescription='{"DiskAlias":"fedora-27-000","DiskDescription":"Uploaded by virt-v2v"}', imageInitialSizeInBytes='0'}), log id: 7d050b9a >2018-06-29 20:36:38,440+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (default task-35) [2790b102-363e-46a7-8839-b1e70d212f33] -- executeIrsBrokerCommand: calling 'createVolume' with two new parameters: description and UUID >2018-06-29 20:36:38,937+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (default task-35) [2790b102-363e-46a7-8839-b1e70d212f33] FINISH, CreateImageVDSCommand, return: 55fb99f5-c2a3-4894-9942-400de5595531, log id: 7d050b9a >2018-06-29 20:36:38,961+03 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (default task-35) [2790b102-363e-46a7-8839-b1e70d212f33] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command '3e358335-cbb9-4454-9984-774109f4f7f3' >2018-06-29 20:36:38,961+03 INFO [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (default task-35) [2790b102-363e-46a7-8839-b1e70d212f33] CommandMultiAsyncTasks::attachTask: Attaching task 'dc0d6f17-5d63-4fb7-914c-4f70f67b94b6' to command '3e358335-cbb9-4454-9984-774109f4f7f3'. >2018-06-29 20:36:39,136+03 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (default task-35) [2790b102-363e-46a7-8839-b1e70d212f33] Adding task 'dc0d6f17-5d63-4fb7-914c-4f70f67b94b6' (Parent Command 'AddImageFromScratch', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters'), polling hasn't started yet.. >2018-06-29 20:36:39,311+03 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (default task-35) [2790b102-363e-46a7-8839-b1e70d212f33] BaseAsyncTask::startPollingTask: Starting to poll task 'dc0d6f17-5d63-4fb7-914c-4f70f67b94b6'. >2018-06-29 20:36:39,486+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-35) [2790b102-363e-46a7-8839-b1e70d212f33] EVENT_ID: USER_ADD_DISK(2,020), Add-Disk operation of 'fedora-27-000' was initiated by admin@internal-authz. >2018-06-29 20:36:39,873+03 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory-engineScheduled-Thread-52) [] Polling and updating Async Tasks: 1 tasks, 1 tasks to poll now >2018-06-29 20:36:39,883+03 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engineScheduled-Thread-52) [] SPMAsyncTask::PollTask: Polling task 'dc0d6f17-5d63-4fb7-914c-4f70f67b94b6' (Parent Command 'AddImageFromScratch', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned status 'running'. >2018-06-29 20:36:39,883+03 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory-engineScheduled-Thread-52) [] Finished polling Tasks, will poll again in 10 seconds. >2018-06-29 20:36:40,641+03 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-65) [2790b102-363e-46a7-8839-b1e70d212f33] Command 'AddDisk' (id: 'ab486e33-8c37-427a-a7b4-71eabf02d907') waiting on child command id: '3e358335-cbb9-4454-9984-774109f4f7f3' type:'AddImageFromScratch' to complete >2018-06-29 20:36:44,645+03 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-36) [2790b102-363e-46a7-8839-b1e70d212f33] Command 'AddDisk' (id: 'ab486e33-8c37-427a-a7b4-71eabf02d907') waiting on child command id: '3e358335-cbb9-4454-9984-774109f4f7f3' type:'AddImageFromScratch' to complete >2018-06-29 20:36:49,894+03 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engineScheduled-Thread-93) [] SPMAsyncTask::PollTask: Polling task 'dc0d6f17-5d63-4fb7-914c-4f70f67b94b6' (Parent Command 'AddImageFromScratch', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned status 'finished', result 'success'. >2018-06-29 20:36:49,913+03 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engineScheduled-Thread-93) [] BaseAsyncTask::onTaskEndSuccess: Task 'dc0d6f17-5d63-4fb7-914c-4f70f67b94b6' (Parent Command 'AddImageFromScratch', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') ended successfully. >2018-06-29 20:36:49,914+03 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engineScheduled-Thread-93) [] CommandAsyncTask::endActionIfNecessary: All tasks of command '3e358335-cbb9-4454-9984-774109f4f7f3' has ended -> executing 'endAction' >2018-06-29 20:36:49,914+03 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engineScheduled-Thread-93) [] CommandAsyncTask::endAction: Ending action for '1' tasks (command ID: '3e358335-cbb9-4454-9984-774109f4f7f3'): calling endAction '. >2018-06-29 20:36:49,914+03 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-21430) [] CommandAsyncTask::endCommandAction [within thread] context: Attempting to endAction 'AddImageFromScratch', >2018-06-29 20:36:49,929+03 INFO [org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand] (EE-ManagedThreadFactory-engine-Thread-21430) [2790b102-363e-46a7-8839-b1e70d212f33] Command [id=3e358335-cbb9-4454-9984-774109f4f7f3]: Updating status to 'SUCCEEDED', The command end method logic will be executed by one of its parent commands. >2018-06-29 20:36:49,929+03 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-21430) [2790b102-363e-46a7-8839-b1e70d212f33] CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type 'AddImageFromScratch' completed, handling the result. >2018-06-29 20:36:49,929+03 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-21430) [2790b102-363e-46a7-8839-b1e70d212f33] CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type 'AddImageFromScratch' succeeded, clearing tasks. >2018-06-29 20:36:49,929+03 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engine-Thread-21430) [2790b102-363e-46a7-8839-b1e70d212f33] SPMAsyncTask::ClearAsyncTask: Attempting to clear task 'dc0d6f17-5d63-4fb7-914c-4f70f67b94b6' >2018-06-29 20:36:49,930+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-21430) [2790b102-363e-46a7-8839-b1e70d212f33] START, SPMClearTaskVDSCommand( SPMTaskGuidBaseVDSCommandParameters:{storagePoolId='a0011271-88a4-491f-a566-aec38b2000e9', ignoreFailoverLimit='false', taskId='dc0d6f17-5d63-4fb7-914c-4f70f67b94b6'}), log id: 43e6cc78 >2018-06-29 20:36:49,931+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-21430) [2790b102-363e-46a7-8839-b1e70d212f33] START, HSMClearTaskVDSCommand(HostName = voodoo2, HSMTaskGuidBaseVDSCommandParameters:{hostId='5fbd71dd-5aed-48a0-92da-b4de36e7dff1', taskId='dc0d6f17-5d63-4fb7-914c-4f70f67b94b6'}), log id: 2edabc0d >2018-06-29 20:36:50,005+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-21430) [2790b102-363e-46a7-8839-b1e70d212f33] FINISH, HSMClearTaskVDSCommand, return: , log id: 2edabc0d >2018-06-29 20:36:50,005+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-21430) [2790b102-363e-46a7-8839-b1e70d212f33] FINISH, SPMClearTaskVDSCommand, return: , log id: 43e6cc78 >2018-06-29 20:36:50,038+03 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engine-Thread-21430) [2790b102-363e-46a7-8839-b1e70d212f33] BaseAsyncTask::removeTaskFromDB: Removed task 'dc0d6f17-5d63-4fb7-914c-4f70f67b94b6' from DataBase >2018-06-29 20:36:50,038+03 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-21430) [2790b102-363e-46a7-8839-b1e70d212f33] CommandAsyncTask::HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks object for entity '3e358335-cbb9-4454-9984-774109f4f7f3' >2018-06-29 20:36:52,648+03 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-30) [2790b102-363e-46a7-8839-b1e70d212f33] Command 'AddDisk' id: 'ab486e33-8c37-427a-a7b4-71eabf02d907' child commands '[3e358335-cbb9-4454-9984-774109f4f7f3]' executions were completed, status 'SUCCEEDED' >2018-06-29 20:36:53,698+03 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-49) [2790b102-363e-46a7-8839-b1e70d212f33] Ending command 'org.ovirt.engine.core.bll.storage.disk.AddDiskCommand' successfully. >2018-06-29 20:36:53,714+03 INFO [org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-49) [2790b102-363e-46a7-8839-b1e70d212f33] Ending command 'org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand' successfully. >2018-06-29 20:36:53,722+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-49) [2790b102-363e-46a7-8839-b1e70d212f33] START, GetImageInfoVDSCommand( GetImageInfoVDSCommandParameters:{storagePoolId='a0011271-88a4-491f-a566-aec38b2000e9', ignoreFailoverLimit='false', storageDomainId='27837a03-64f9-4f2b-abb0-daa2195b01ae', imageGroupId='ba390f85-2d45-4ea1-8e29-96020c4ba416', imageId='55fb99f5-c2a3-4894-9942-400de5595531'}), log id: 58ce6447 >2018-06-29 20:36:53,723+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-49) [2790b102-363e-46a7-8839-b1e70d212f33] START, GetVolumeInfoVDSCommand(HostName = voodoo2, GetVolumeInfoVDSCommandParameters:{hostId='5fbd71dd-5aed-48a0-92da-b4de36e7dff1', storagePoolId='a0011271-88a4-491f-a566-aec38b2000e9', storageDomainId='27837a03-64f9-4f2b-abb0-daa2195b01ae', imageGroupId='ba390f85-2d45-4ea1-8e29-96020c4ba416', imageId='55fb99f5-c2a3-4894-9942-400de5595531'}), log id: 1d90a2c6 >2018-06-29 20:36:53,757+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-49) [2790b102-363e-46a7-8839-b1e70d212f33] FINISH, GetVolumeInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.storage.DiskImage@801c021c, log id: 1d90a2c6 >2018-06-29 20:36:53,757+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-49) [2790b102-363e-46a7-8839-b1e70d212f33] FINISH, GetImageInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.storage.DiskImage@801c021c, log id: 58ce6447 >2018-06-29 20:36:53,772+03 WARN [org.ovirt.engine.core.bll.storage.disk.AddDiskCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-49) [] VM is null - no unlocking >2018-06-29 20:36:53,805+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-49) [] EVENT_ID: USER_ADD_DISK_FINISHED_SUCCESS(2,021), The disk 'fedora-27-000' was successfully added. >2018-06-29 20:36:54,647+03 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (default task-47) [b8987959-81ea-432e-9300-a3c449512693] Lock Acquired to object 'EngineLock:{exclusiveLocks='', sharedLocks='[ba390f85-2d45-4ea1-8e29-96020c4ba416=DISK]'}' >2018-06-29 20:36:54,674+03 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (default task-47) [b8987959-81ea-432e-9300-a3c449512693] Running command: TransferDiskImageCommand internal: false. Entities affected : ID: ba390f85-2d45-4ea1-8e29-96020c4ba416 Type: DiskAction group EDIT_DISK_PROPERTIES with role type USER >2018-06-29 20:36:54,674+03 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (default task-47) [b8987959-81ea-432e-9300-a3c449512693] Creating ImageTransfer entity for command 'c4d1cee1-7117-42e8-b3f9-146a9749fdb2' >2018-06-29 20:36:54,715+03 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (default task-47) [b8987959-81ea-432e-9300-a3c449512693] Successfully added Upload disk 'fedora-27-000' (disk id: 'ba390f85-2d45-4ea1-8e29-96020c4ba416', image id: '55fb99f5-c2a3-4894-9942-400de5595531') for image transfer command 'c4d1cee1-7117-42e8-b3f9-146a9749fdb2' >2018-06-29 20:36:54,793+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand] (default task-47) [b8987959-81ea-432e-9300-a3c449512693] START, PrepareImageVDSCommand(HostName = voodoo1, PrepareImageVDSCommandParameters:{hostId='b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9'}), log id: 1c41b9bd >2018-06-29 20:36:54,798+03 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand] (default task-47) [b8987959-81ea-432e-9300-a3c449512693] Failed in 'PrepareImageVDS' method, for vds: 'voodoo1'; host: 'voodoo1.tlv.redhat.com': null >2018-06-29 20:36:54,798+03 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand] (default task-47) [b8987959-81ea-432e-9300-a3c449512693] Command 'PrepareImageVDSCommand(HostName = voodoo1, PrepareImageVDSCommandParameters:{hostId='b9c45d66-2067-4cd9-a9f2-d24a6f7a0fd9'})' execution failed: null >2018-06-29 20:36:54,798+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand] (default task-47) [b8987959-81ea-432e-9300-a3c449512693] FINISH, PrepareImageVDSCommand, return: , log id: 1c41b9bd >2018-06-29 20:36:54,798+03 ERROR [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (default task-47) [b8987959-81ea-432e-9300-a3c449512693] Failed to prepare image for transfer session: {}: org.ovirt.engine.core.common.errors.EngineException: EngineException: java.lang.NullPointerException (Failed with error ENGINE and code 5001) > at org.ovirt.engine.core.bll.VdsHandler.handleVdsResult(VdsHandler.java:118) [bll.jar:] > at org.ovirt.engine.core.bll.VDSBrokerFrontendImpl.runVdsCommand(VDSBrokerFrontendImpl.java:33) [bll.jar:] > at org.ovirt.engine.core.bll.CommandBase.runVdsCommand(CommandBase.java:2046) [bll.jar:] > at org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.prepareImage(TransferDiskImageCommand.java:144) [bll.jar:] > at org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.addImageTicketToDaemon(TransferDiskImageCommand.java:777) [bll.jar:] > at org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.startImageTransferSession(TransferDiskImageCommand.java:749) [bll.jar:] > at org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.handleImageIsReadyForTransfer(TransferDiskImageCommand.java:451) [bll.jar:] > at org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand.executeCommand(TransferDiskImageCommand.java:309) [bll.jar:] > at org.ovirt.engine.core.bll.CommandBase.executeWithoutTransaction(CommandBase.java:1133) [bll.jar:] > at org.ovirt.engine.core.bll.CommandBase.executeActionInTransactionScope(CommandBase.java:1286) [bll.jar:] > at org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1935) [bll.jar:] > at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInSuppressed(TransactionSupport.java:164) [utils.jar:] > at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInScope(TransactionSupport.java:103) [utils.jar:] > at org.ovirt.engine.core.bll.CommandBase.execute(CommandBase.java:1346) [bll.jar:] > at org.ovirt.engine.core.bll.CommandBase.executeAction(CommandBase.java:400) [bll.jar:] > at org.ovirt.engine.core.bll.executor.DefaultBackendActionExecutor.execute(DefaultBackendActionExecutor.java:13) [bll.jar:] > at org.ovirt.engine.core.bll.Backend.runAction(Backend.java:450) [bll.jar:] > at org.ovirt.engine.core.bll.Backend.runActionImpl(Backend.java:432) [bll.jar:] > at org.ovirt.engine.core.bll.Backend.runAction(Backend.java:387) [bll.jar:] > at sun.reflect.GeneratedMethodAccessor250.invoke(Unknown Source) [:1.8.0_171] > at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_171] > at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_171] > at org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.java:52) > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:509) > at org.jboss.as.weld.ejb.DelegatingInterceptorInvocationContext.proceed(DelegatingInterceptorInvocationContext.java:92) [wildfly-weld-ejb-11.0.0.Final.jar:11.0.0.Final] > at org.jboss.weld.interceptor.proxy.WeldInvocationContext.interceptorChainCompleted(WeldInvocationContext.java:98) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.jboss.weld.interceptor.proxy.WeldInvocationContext.proceed(WeldInvocationContext.java:117) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.ovirt.engine.core.common.di.interceptor.LoggingInterceptor.apply(LoggingInterceptor.java:12) [common.jar:] > at sun.reflect.GeneratedMethodAccessor64.invoke(Unknown Source) [:1.8.0_171] > at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_171] > at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_171] > at org.jboss.weld.interceptor.reader.SimpleInterceptorInvocation$SimpleMethodInvocation.invoke(SimpleInterceptorInvocation.java:73) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.jboss.weld.interceptor.proxy.WeldInvocationContext.invokeNext(WeldInvocationContext.java:83) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.jboss.weld.interceptor.proxy.WeldInvocationContext.proceed(WeldInvocationContext.java:115) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.jboss.weld.bean.InterceptorImpl.intercept(InterceptorImpl.java:108) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.jboss.as.weld.ejb.DelegatingInterceptorInvocationContext.proceed(DelegatingInterceptorInvocationContext.java:82) [wildfly-weld-ejb-11.0.0.Final.jar:11.0.0.Final] > at org.jboss.as.weld.interceptors.EjbComponentInterceptorSupport.delegateInterception(EjbComponentInterceptorSupport.java:60) > at org.jboss.as.weld.interceptors.Jsr299BindingsInterceptor.delegateInterception(Jsr299BindingsInterceptor.java:76) > at org.jboss.as.weld.interceptors.Jsr299BindingsInterceptor.doMethodInterception(Jsr299BindingsInterceptor.java:88) > at org.jboss.as.weld.interceptors.Jsr299BindingsInterceptor.processInvocation(Jsr299BindingsInterceptor.java:101) > at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63) > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:509) > at org.ovirt.engine.core.bll.interceptors.CorrelationIdTrackerInterceptor.aroundInvoke(CorrelationIdTrackerInterceptor.java:13) [bll.jar:] > at sun.reflect.GeneratedMethodAccessor73.invoke(Unknown Source) [:1.8.0_171] > at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_171] > at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_171] > at org.jboss.as.ee.component.ManagedReferenceLifecycleMethodInterceptor.processInvocation(ManagedReferenceLifecycleMethodInterceptor.java:89) > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.as.ejb3.component.invocationmetrics.ExecutionTimeInterceptor.processInvocation(ExecutionTimeInterceptor.java:43) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.as.ee.concurrent.ConcurrentContextInterceptor.processInvocation(ConcurrentContextInterceptor.java:45) [wildfly-ee-11.0.0.Final.jar:11.0.0.Final] > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:40) > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:53) > at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:52) > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.as.ejb3.component.singleton.SingletonComponentInstanceAssociationInterceptor.processInvocation(SingletonComponentInstanceAssociationInterceptor.java:53) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInNoTx(CMTTxInterceptor.java:264) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] > at org.jboss.as.ejb3.tx.CMTTxInterceptor.supports(CMTTxInterceptor.java:379) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] > at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:244) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:509) > at org.jboss.weld.ejb.AbstractEJBRequestScopeActivationInterceptor.aroundInvoke(AbstractEJBRequestScopeActivationInterceptor.java:73) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.jboss.as.weld.ejb.EjbRequestScopeActivationInterceptor.processInvocation(EjbRequestScopeActivationInterceptor.java:89) > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.as.ejb3.component.invocationmetrics.WaitTimeInterceptor.processInvocation(WaitTimeInterceptor.java:47) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.as.ejb3.security.SecurityContextInterceptor.processInvocation(SecurityContextInterceptor.java:100) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.as.ejb3.deployment.processors.StartupAwaitInterceptor.processInvocation(StartupAwaitInterceptor.java:22) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.as.ejb3.component.interceptors.ShutDownInterceptorFactory$1.processInvocation(ShutDownInterceptorFactory.java:64) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:67) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.invocation.ContextClassLoaderInterceptor.processInvocation(ContextClassLoaderInterceptor.java:60) > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.invocation.InterceptorContext.run(InterceptorContext.java:438) > at org.wildfly.security.manager.WildFlySecurityManager.doChecked(WildFlySecurityManager.java:609) > at org.jboss.invocation.AccessCheckingInterceptor.processInvocation(AccessCheckingInterceptor.java:57) > at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) > at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:53) > at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:198) > at org.jboss.as.ee.component.ViewDescription$1.processInvocation(ViewDescription.java:185) > at org.jboss.as.ee.component.ProxyInvocationHandler.invoke(ProxyInvocationHandler.java:81) > at org.ovirt.engine.core.common.interfaces.BackendLocal$$$view2.runAction(Unknown Source) [common.jar:] > at org.ovirt.engine.api.restapi.resource.BackendResource.doAction(BackendResource.java:250) > at org.ovirt.engine.api.restapi.resource.AbstractBackendCollectionResource.doCreateEntity(AbstractBackendCollectionResource.java:233) > at org.ovirt.engine.api.restapi.resource.AbstractBackendCollectionResource.performCreate(AbstractBackendCollectionResource.java:144) > at org.ovirt.engine.api.restapi.resource.AbstractBackendCollectionResource.performCreate(AbstractBackendCollectionResource.java:134) > at org.ovirt.engine.api.restapi.resource.AbstractBackendCollectionResource.performCreate(AbstractBackendCollectionResource.java:153) > at org.ovirt.engine.api.restapi.resource.BackendImageTransfersResource.performCreate(BackendImageTransfersResource.java:63) > at org.ovirt.engine.api.restapi.resource.BackendImageTransfersResource.addForDisk(BackendImageTransfersResource.java:45) > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.8.0_171] > at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [rt.jar:1.8.0_171] > at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_171] > at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_171] > at org.ovirt.engine.api.resource.ImageTransfersResource.add(ImageTransfersResource.java:101) > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.8.0_171] > at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [rt.jar:1.8.0_171] > at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_171] > at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_171] > at org.jboss.resteasy.core.MethodInjectorImpl.invoke(MethodInjectorImpl.java:140) [resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final] > at org.jboss.resteasy.core.ResourceMethodInvoker.invokeOnTarget(ResourceMethodInvoker.java:295) [resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final] > at org.jboss.resteasy.core.ResourceMethodInvoker.invoke(ResourceMethodInvoker.java:249) [resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final] > at org.jboss.resteasy.core.ResourceLocatorInvoker.invokeOnTargetObject(ResourceLocatorInvoker.java:138) [resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final] > at org.jboss.resteasy.core.ResourceLocatorInvoker.invoke(ResourceLocatorInvoker.java:101) [resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final] > at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:406) [resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final] > at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:213) [resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final] > at org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.service(ServletContainerDispatcher.java:228) [resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final] > at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:56) [resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final] > at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:51) [resteasy-jaxrs-3.0.24.Final.jar:3.0.24.Final] > at javax.servlet.http.HttpServlet.service(HttpServlet.java:790) [jboss-servlet-api_3.1_spec-1.0.0.Final.jar:1.0.0.Final] > at io.undertow.servlet.handlers.ServletHandler.handleRequest(ServletHandler.java:85) > at io.undertow.servlet.handlers.FilterHandler.handleRequest(FilterHandler.java:81) > at io.undertow.servlet.handlers.security.ServletSecurityRoleHandler.handleRequest(ServletSecurityRoleHandler.java:62) > at io.undertow.servlet.handlers.ServletDispatchingHandler.handleRequest(ServletDispatchingHandler.java:36) > at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) > at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) > at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) > at io.undertow.servlet.handlers.ServletInitialHandler.dispatchRequest(ServletInitialHandler.java:274) > at io.undertow.servlet.handlers.ServletInitialHandler.dispatchToPath(ServletInitialHandler.java:209) > at io.undertow.servlet.spec.RequestDispatcherImpl.forwardImpl(RequestDispatcherImpl.java:221) > at io.undertow.servlet.spec.RequestDispatcherImpl.forwardImplSetup(RequestDispatcherImpl.java:147) > at io.undertow.servlet.spec.RequestDispatcherImpl.forward(RequestDispatcherImpl.java:111) > at org.ovirt.engine.api.restapi.invocation.VersionFilter.doFilter(VersionFilter.java:178) > at org.ovirt.engine.api.restapi.invocation.VersionFilter.doFilter(VersionFilter.java:98) > at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61) > at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) > at org.ovirt.engine.api.restapi.invocation.CurrentFilter.doFilter(CurrentFilter.java:117) > at org.ovirt.engine.api.restapi.invocation.CurrentFilter.doFilter(CurrentFilter.java:72) > at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61) > at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) > at org.ovirt.engine.core.aaa.filters.RestApiSessionMgmtFilter.doFilter(RestApiSessionMgmtFilter.java:78) [aaa.jar:] > at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61) > at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) > at org.ovirt.engine.core.aaa.filters.EnforceAuthFilter.doFilter(EnforceAuthFilter.java:42) [aaa.jar:] > at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61) > at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) > at org.ovirt.engine.core.aaa.filters.SsoRestApiNegotiationFilter.doFilter(SsoRestApiNegotiationFilter.java:84) [aaa.jar:] > at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61) > at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) > at org.ovirt.engine.core.aaa.filters.SsoRestApiAuthFilter.doFilter(SsoRestApiAuthFilter.java:47) [aaa.jar:] > at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61) > at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) > at org.ovirt.engine.core.aaa.filters.SessionValidationFilter.doFilter(SessionValidationFilter.java:59) [aaa.jar:] > at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61) > at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) > at org.ovirt.engine.core.aaa.filters.RestApiSessionValidationFilter.doFilter(RestApiSessionValidationFilter.java:35) [aaa.jar:] > at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61) > at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) > at org.ovirt.engine.api.restapi.security.CSRFProtectionFilter.doFilter(CSRFProtectionFilter.java:111) > at org.ovirt.engine.api.restapi.security.CSRFProtectionFilter.doFilter(CSRFProtectionFilter.java:102) > at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61) > at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) > at org.ovirt.engine.core.utils.servlet.CORSSupportFilter.doFilter(CORSSupportFilter.java:283) [utils.jar:] > at io.undertow.servlet.core.ManagedFilter.doFilter(ManagedFilter.java:61) > at io.undertow.servlet.handlers.FilterHandler$FilterChainImpl.doFilter(FilterHandler.java:131) > at io.undertow.servlet.handlers.FilterHandler.handleRequest(FilterHandler.java:84) > at io.undertow.servlet.handlers.security.ServletSecurityRoleHandler.handleRequest(ServletSecurityRoleHandler.java:62) > at io.undertow.servlet.handlers.ServletDispatchingHandler.handleRequest(ServletDispatchingHandler.java:36) > at org.wildfly.extension.undertow.security.SecurityContextAssociationHandler.handleRequest(SecurityContextAssociationHandler.java:78) > at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) > at io.undertow.servlet.handlers.security.SSLInformationAssociationHandler.handleRequest(SSLInformationAssociationHandler.java:131) > at io.undertow.servlet.handlers.security.ServletAuthenticationCallHandler.handleRequest(ServletAuthenticationCallHandler.java:57) > at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) > at io.undertow.security.handlers.AuthenticationConstraintHandler.handleRequest(AuthenticationConstraintHandler.java:53) > at io.undertow.security.handlers.AbstractConfidentialityHandler.handleRequest(AbstractConfidentialityHandler.java:46) > at io.undertow.servlet.handlers.security.ServletConfidentialityConstraintHandler.handleRequest(ServletConfidentialityConstraintHandler.java:64) > at io.undertow.servlet.handlers.security.ServletSecurityConstraintHandler.handleRequest(ServletSecurityConstraintHandler.java:59) > at io.undertow.security.handlers.AuthenticationMechanismsHandler.handleRequest(AuthenticationMechanismsHandler.java:60) > at io.undertow.servlet.handlers.security.CachedAuthenticatedSessionHandler.handleRequest(CachedAuthenticatedSessionHandler.java:77) > at io.undertow.security.handlers.NotificationReceiverHandler.handleRequest(NotificationReceiverHandler.java:50) > at io.undertow.security.handlers.AbstractSecurityContextAssociationHandler.handleRequest(AbstractSecurityContextAssociationHandler.java:43) > at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) > at org.wildfly.extension.undertow.security.jacc.JACCContextIdHandler.handleRequest(JACCContextIdHandler.java:61) > at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) > at io.undertow.server.handlers.PredicateHandler.handleRequest(PredicateHandler.java:43) > at io.undertow.servlet.handlers.ServletInitialHandler.handleFirstRequest(ServletInitialHandler.java:292) > at io.undertow.servlet.handlers.ServletInitialHandler.access$100(ServletInitialHandler.java:81) > at io.undertow.servlet.handlers.ServletInitialHandler$2.call(ServletInitialHandler.java:138) > at io.undertow.servlet.handlers.ServletInitialHandler$2.call(ServletInitialHandler.java:135) > at io.undertow.servlet.core.ServletRequestContextThreadSetupAction$1.call(ServletRequestContextThreadSetupAction.java:48) > at io.undertow.servlet.core.ContextClassLoaderSetupAction$1.call(ContextClassLoaderSetupAction.java:43) > at org.wildfly.extension.undertow.security.SecurityContextThreadSetupAction.lambda$create$0(SecurityContextThreadSetupAction.java:105) > at org.wildfly.extension.undertow.deployment.UndertowDeploymentInfoService$UndertowThreadSetupAction.lambda$create$0(UndertowDeploymentInfoService.java:1508) > at org.wildfly.extension.undertow.deployment.UndertowDeploymentInfoService$UndertowThreadSetupAction.lambda$create$0(UndertowDeploymentInfoService.java:1508) > at org.wildfly.extension.undertow.deployment.UndertowDeploymentInfoService$UndertowThreadSetupAction.lambda$create$0(UndertowDeploymentInfoService.java:1508) > at io.undertow.servlet.handlers.ServletInitialHandler.dispatchRequest(ServletInitialHandler.java:272) > at io.undertow.servlet.handlers.ServletInitialHandler.access$000(ServletInitialHandler.java:81) > at io.undertow.servlet.handlers.ServletInitialHandler$1.handleRequest(ServletInitialHandler.java:104) > at io.undertow.server.Connectors.executeRootHandler(Connectors.java:326) > at io.undertow.server.HttpServerExchange$1.run(HttpServerExchange.java:812) > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [rt.jar:1.8.0_171] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [rt.jar:1.8.0_171] > at java.lang.Thread.run(Thread.java:748) [rt.jar:1.8.0_171] >Caused by: java.lang.NullPointerException > at org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageReturn.<init>(PrepareImageReturn.java:15) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.jsonrpc.JsonRpcVdsServer.prepareImage(JsonRpcVdsServer.java:1898) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand.executeImageActionVdsBrokerCommand(PrepareImageVDSCommand.java:18) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand.executeImageActionVdsBrokerCommand(PrepareImageVDSCommand.java:5) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.vdsbroker.ImageActionsVDSCommandBase.executeVdsBrokerCommand(ImageActionsVDSCommandBase.java:14) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand.executeVdsCommandWithNetworkEvent(VdsBrokerCommand.java:123) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand.executeVDSCommand(VdsBrokerCommand.java:111) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.VDSCommandBase.executeCommand(VDSCommandBase.java:65) [vdsbroker.jar:] > at org.ovirt.engine.core.dal.VdcCommandBase.execute(VdcCommandBase.java:31) [dal.jar:] > at org.ovirt.engine.core.vdsbroker.vdsbroker.DefaultVdsCommandExecutor.execute(DefaultVdsCommandExecutor.java:14) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.ResourceManager.runVdsCommand(ResourceManager.java:399) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.ResourceManager$Proxy$_$$_WeldSubclass.runVdsCommand$$super(Unknown Source) [vdsbroker.jar:] > at sun.reflect.GeneratedMethodAccessor87.invoke(Unknown Source) [:1.8.0_171] > at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_171] > at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_171] > at org.jboss.weld.interceptor.proxy.TerminalAroundInvokeInvocationContext.proceedInternal(TerminalAroundInvokeInvocationContext.java:49) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.jboss.weld.interceptor.proxy.AroundInvokeInvocationContext.proceed(AroundInvokeInvocationContext.java:77) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.ovirt.engine.core.common.di.interceptor.LoggingInterceptor.apply(LoggingInterceptor.java:12) [common.jar:] > at sun.reflect.GeneratedMethodAccessor64.invoke(Unknown Source) [:1.8.0_171] > at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_171] > at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_171] > at org.jboss.weld.interceptor.reader.SimpleInterceptorInvocation$SimpleMethodInvocation.invoke(SimpleInterceptorInvocation.java:73) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.executeAroundInvoke(InterceptorMethodHandler.java:84) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.executeInterception(InterceptorMethodHandler.java:72) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.invoke(InterceptorMethodHandler.java:56) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.jboss.weld.bean.proxy.CombinedInterceptorAndDecoratorStackMethodHandler.invoke(CombinedInterceptorAndDecoratorStackMethodHandler.java:79) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.jboss.weld.bean.proxy.CombinedInterceptorAndDecoratorStackMethodHandler.invoke(CombinedInterceptorAndDecoratorStackMethodHandler.java:68) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] > at org.ovirt.engine.core.vdsbroker.ResourceManager$Proxy$_$$_WeldSubclass.runVdsCommand(Unknown Source) [vdsbroker.jar:] > ... 203 more > >2018-06-29 20:36:54,818+03 ERROR [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (default task-47) [b8987959-81ea-432e-9300-a3c449512693] Failed to add image ticket to ovirt-imageio-daemon >2018-06-29 20:36:54,830+03 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-47) [b8987959-81ea-432e-9300-a3c449512693] EVENT_ID: TRANSFER_IMAGE_STOPPED_BY_SYSTEM_FAILED_TO_ADD_TICKET_TO_DAEMON(1,069), Transfer was stopped by system. Reason: failed to add image ticket to ovirt-imageio-daemon. >2018-06-29 20:36:54,831+03 INFO [org.ovirt.engine.core.bll.storage.disk.image.ImageTransferUpdater] (default task-47) [b8987959-81ea-432e-9300-a3c449512693] Updating image transfer c4d1cee1-7117-42e8-b3f9-146a9749fdb2 (image ba390f85-2d45-4ea1-8e29-96020c4ba416) phase to Paused by System >2018-06-29 20:36:54,847+03 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (default task-47) [b8987959-81ea-432e-9300-a3c449512693] Returning from proceedCommandExecution after starting transfer session for image transfer command 'c4d1cee1-7117-42e8-b3f9-146a9749fdb2' >2018-06-29 20:36:54,888+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-47) [b8987959-81ea-432e-9300-a3c449512693] EVENT_ID: TRANSFER_IMAGE_INITIATED(1,031), Image Upload with disk fedora-27-000 was initiated by admin@internal-authz. >2018-06-29 20:36:56,842+03 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-1) [b8987959-81ea-432e-9300-a3c449512693] Transfer was paused by system. Upload disk 'fedora-27-000' (disk id: 'ba390f85-2d45-4ea1-8e29-96020c4ba416', image id: '55fb99f5-c2a3-4894-9942-400de5595531') >2018-06-29 20:37:32,594+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engine' is using 0 threads out of 500, 9 threads waiting for tasks and 0 tasks in queue. >2018-06-29 20:37:32,594+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineScheduled' is using 0 threads out of 100, 100 threads waiting for tasks. >2018-06-29 20:37:32,594+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineThreadMonitoring' is using 1 threads out of 1, 0 threads waiting for tasks. >2018-06-29 20:37:32,594+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'hostUpdatesChecker' is using 0 threads out of 5, 3 threads waiting for tasks. >2018-06-29 20:38:07,294+03 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory-engineScheduled-Thread-14) [] Setting new tasks map. The map contains now 0 tasks >2018-06-29 20:38:07,294+03 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory-engineScheduled-Thread-14) [] Cleared all tasks of pool 'a0011271-88a4-491f-a566-aec38b2000e9'. >2018-06-29 20:47:32,596+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engine' is using 0 threads out of 500, 8 threads waiting for tasks and 0 tasks in queue. >2018-06-29 20:47:32,596+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineScheduled' is using 0 threads out of 100, 100 threads waiting for tasks. >2018-06-29 20:47:32,596+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineThreadMonitoring' is using 1 threads out of 1, 0 threads waiting for tasks. >2018-06-29 20:47:32,597+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'hostUpdatesChecker' is using 0 threads out of 5, 3 threads waiting for tasks. >2018-06-29 20:50:31,844+03 INFO [org.ovirt.engine.core.sso.servlets.OAuthRevokeServlet] (default task-99) [] User admin@internal successfully logged out >2018-06-29 20:50:31,855+03 INFO [org.ovirt.engine.core.bll.aaa.TerminateSessionsForTokenCommand] (default task-105) [75dca4c] Running command: TerminateSessionsForTokenCommand internal: true. >2018-06-29 20:50:31,881+03 INFO [org.ovirt.engine.core.sso.servlets.OAuthRevokeServlet] (default task-106) [] User admin@internal successfully logged out >2018-06-29 20:50:31,883+03 INFO [org.ovirt.engine.core.bll.aaa.TerminateSessionsForTokenCommand] (default task-108) [286f8265] Running command: TerminateSessionsForTokenCommand internal: true. >2018-06-29 20:55:31,845+03 INFO [org.ovirt.engine.core.sso.servlets.OAuthRevokeServlet] (default task-1) [] User admin@internal successfully logged out >2018-06-29 20:55:31,854+03 INFO [org.ovirt.engine.core.bll.aaa.TerminateSessionsForTokenCommand] (default task-6) [42657266] Running command: TerminateSessionsForTokenCommand internal: true. >2018-06-29 20:57:32,598+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engine' is using 0 threads out of 500, 8 threads waiting for tasks and 0 tasks in queue. >2018-06-29 20:57:32,598+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineScheduled' is using 0 threads out of 100, 100 threads waiting for tasks. >2018-06-29 20:57:32,598+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineThreadMonitoring' is using 1 threads out of 1, 0 threads waiting for tasks. >2018-06-29 20:57:32,598+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'hostUpdatesChecker' is using 0 threads out of 5, 3 threads waiting for tasks. >2018-06-29 21:04:31,858+03 INFO [org.ovirt.engine.core.sso.servlets.OAuthRevokeServlet] (default task-42) [] User admin@internal successfully logged out >2018-06-29 21:04:31,867+03 INFO [org.ovirt.engine.core.bll.aaa.TerminateSessionsForTokenCommand] (default task-47) [6b8267db] Running command: TerminateSessionsForTokenCommand internal: true. >2018-06-29 21:05:31,851+03 INFO [org.ovirt.engine.core.sso.servlets.OAuthRevokeServlet] (default task-56) [] User admin@internal successfully logged out >2018-06-29 21:05:31,855+03 INFO [org.ovirt.engine.core.bll.aaa.TerminateSessionsForTokenCommand] (default task-55) [7a656a58] Running command: TerminateSessionsForTokenCommand internal: true. >2018-06-29 21:07:00,167+03 INFO [org.ovirt.engine.core.bll.storage.disk.image.TransferDiskImageCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-33) [b8987959-81ea-432e-9300-a3c449512693] Transfer was paused by system. Upload disk 'fedora-27-000' (disk id: 'ba390f85-2d45-4ea1-8e29-96020c4ba416', image id: '55fb99f5-c2a3-4894-9942-400de5595531') >2018-06-29 21:07:32,601+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engine' is using 0 threads out of 500, 8 threads waiting for tasks and 0 tasks in queue. >2018-06-29 21:07:32,601+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineScheduled' is using 0 threads out of 100, 100 threads waiting for tasks. >2018-06-29 21:07:32,601+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineThreadMonitoring' is using 1 threads out of 1, 0 threads waiting for tasks. >2018-06-29 21:07:32,601+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'hostUpdatesChecker' is using 0 threads out of 5, 3 threads waiting for tasks. >2018-06-29 21:17:32,605+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engine' is using 0 threads out of 500, 8 threads waiting for tasks and 0 tasks in queue. >2018-06-29 21:17:32,605+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineScheduled' is using 0 threads out of 100, 100 threads waiting for tasks. >2018-06-29 21:17:32,605+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineThreadMonitoring' is using 1 threads out of 1, 0 threads waiting for tasks. >2018-06-29 21:17:32,605+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'hostUpdatesChecker' is using 0 threads out of 5, 3 threads waiting for tasks. >2018-06-29 21:17:34,304+03 INFO [org.ovirt.engine.core.bll.storage.ovfstore.OvfDataUpdater] (EE-ManagedThreadFactory-engineScheduled-Thread-82) [] Attempting to update VMs/Templates Ovf. >2018-06-29 21:17:34,306+03 INFO [org.ovirt.engine.core.bll.storage.ovfstore.ProcessOvfUpdateForStoragePoolCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-82) [7d3320b4] Before acquiring and wait lock 'EngineLock:{exclusiveLocks='[a0011271-88a4-491f-a566-aec38b2000e9=OVF_UPDATE]', sharedLocks=''}' >2018-06-29 21:17:34,306+03 INFO [org.ovirt.engine.core.bll.storage.ovfstore.ProcessOvfUpdateForStoragePoolCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-82) [7d3320b4] Lock-wait acquired to object 'EngineLock:{exclusiveLocks='[a0011271-88a4-491f-a566-aec38b2000e9=OVF_UPDATE]', sharedLocks=''}' >2018-06-29 21:17:34,308+03 INFO [org.ovirt.engine.core.bll.storage.ovfstore.ProcessOvfUpdateForStoragePoolCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-82) [7d3320b4] Running command: ProcessOvfUpdateForStoragePoolCommand internal: true. Entities affected : ID: a0011271-88a4-491f-a566-aec38b2000e9 Type: StoragePool >2018-06-29 21:17:34,313+03 INFO [org.ovirt.engine.core.bll.storage.ovfstore.ProcessOvfUpdateForStoragePoolCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-82) [7d3320b4] Attempting to update VM OVFs in Data Center 'v43' >2018-06-29 21:17:34,314+03 INFO [org.ovirt.engine.core.bll.storage.ovfstore.ProcessOvfUpdateForStoragePoolCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-82) [7d3320b4] Successfully updated VM OVFs in Data Center 'v43' >2018-06-29 21:17:34,314+03 INFO [org.ovirt.engine.core.bll.storage.ovfstore.ProcessOvfUpdateForStoragePoolCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-82) [7d3320b4] Attempting to update template OVFs in Data Center 'v43' >2018-06-29 21:17:34,314+03 INFO [org.ovirt.engine.core.bll.storage.ovfstore.ProcessOvfUpdateForStoragePoolCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-82) [7d3320b4] Successfully updated templates OVFs in Data Center 'v43' >2018-06-29 21:17:34,314+03 INFO [org.ovirt.engine.core.bll.storage.ovfstore.ProcessOvfUpdateForStoragePoolCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-82) [7d3320b4] Attempting to remove unneeded template/vm OVFs in Data Center 'v43' >2018-06-29 21:17:34,315+03 INFO [org.ovirt.engine.core.bll.storage.ovfstore.ProcessOvfUpdateForStoragePoolCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-82) [7d3320b4] Successfully removed unneeded template/vm OVFs in Data Center 'v43' >2018-06-29 21:17:34,316+03 INFO [org.ovirt.engine.core.bll.storage.ovfstore.ProcessOvfUpdateForStoragePoolCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-82) [7d3320b4] Lock freed to object 'EngineLock:{exclusiveLocks='[a0011271-88a4-491f-a566-aec38b2000e9=OVF_UPDATE]', sharedLocks=''}'
You cannot view the attachment while viewing its details because your browser does not support IFRAMEs.
View the attachment on a separate page
.
View Attachment As Raw
Actions:
View
Attachments on
bug 1596810
:
1455544
| 1455546