6:13 p.m.
Was it caused by windows hibernation?
Not a fix, but work around, can you disable hibernation? Not sure if it's
needed in a virtual environment.
powercfg.exe /*hibernate* off
In cmd
On Tue, Aug 14, 2018, 7:11 PM <liug74(a)sina.com> wrote:
> Please attach any exceptions you see in engine.log and
vdsm.log.
>
> Best wishes,
> Greg
>
There has same question when stared Win10_liug
Thanks
2018-08-15 06:27:04,202+08 INFO
[org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService]
(EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool
'default' is using 0 threads out of 1, 5 threads waiting for tasks.
2018-08-15 06:27:04,202+08 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-08-15 06:27:04,202+08 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-08-15 06:27:04,202+08 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-08-15 06:27:04,202+08 INFO
[org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService]
(EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool
'hostUpdatesChecker' is using 0 threads out of 5, 1 threads waiting for
tasks.
2018-08-15 06:27:43,300+08 INFO
[org.ovirt.engine.core.bll.provider.network.SyncNetworkProviderCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-17) [2e149598] Lock
Acquired to object
'EngineLock:{exclusiveLocks='[182dd9de-fbd0-432a-992f-ea3cf8fcb365=PROVIDER]',
sharedLocks=''}'
2018-08-15 06:27:43,310+08 INFO
[org.ovirt.engine.core.bll.provider.network.SyncNetworkProviderCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-17) [2e149598] Running
command: SyncNetworkProviderCommand internal: true.
2018-08-15 06:27:43,421+08 INFO
[org.ovirt.engine.core.sso.utils.AuthenticationUtils] (default task-80) []
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-08-15 06:27:43,572+08 INFO
[org.ovirt.engine.core.bll.provider.network.SyncNetworkProviderCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-17) [2e149598] Lock freed
to object
'EngineLock:{exclusiveLocks='[182dd9de-fbd0-432a-992f-ea3cf8fcb365=PROVIDER]',
sharedLocks=''}'
2018-08-15 06:28:18,377+08 INFO
[org.ovirt.engine.core.sso.utils.AuthenticationUtils] (default task-80) []
User admin@internal successfully logged in with scopes: ovirt-app-admin
ovirt-app-api ovirt-app-portal ovirt-ext=auth:sequence-priority=~
ovirt-ext=revoke:revoke-all ovirt-ext=token-info:authz-search
ovirt-ext=token-info:public-authz-search ovirt-ext=token-info:validate
ovirt-ext=token:password-access
2018-08-15 06:28:18,447+08 INFO
[org.ovirt.engine.core.bll.aaa.CreateUserSessionCommand] (default task-80)
[29a87bce] Running command: CreateUserSessionCommand internal: false.
2018-08-15 06:28:18,454+08 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(default task-80) [29a87bce] EVENT_ID: USER_VDC_LOGIN(30), User
admin@internal-authz connecting from '172.21.137.229' using session
'oCxyNNW8A2141gvHc8tLY1ye0UMyPv9Q446Cd/64r6YvPv5zsP40t5A/yBBWoyGwEi+NF26cqxMWWKAgcYoywQ=='
logged in.
2018-08-15 06:29:00,033+08 INFO
[org.ovirt.engine.core.bll.SetVmTicketCommand] (default task-80) [6cce3ceb]
Running command: SetVmTicketCommand internal: false. Entities affected :
ID: 3157ba6d-2758-4052-8d29-c3e0d2cb53eb Type: VMAction group CONNECT_TO_VM
with role type USER
2018-08-15 06:29:00,041+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SetVmTicketVDSCommand] (default
task-80) [6cce3ceb] START, SetVmTicketVDSCommand(HostName = h4,
SetVmTicketVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
vmId='3157ba6d-2758-4052-8d29-c3e0d2cb53eb', protocol='VNC',
ticket='aiq/vTbB7kJM', validTime='120', userName='admin',
userId='6303e0de-9faf-11e8-b20b-00163e6e2f69',
disconnectAction='NONE'}),
log id: 6fbb73b0
2018-08-15 06:29:00,072+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SetVmTicketVDSCommand] (default
task-80) [6cce3ceb] FINISH, SetVmTicketVDSCommand, log id: 6fbb73b0
2018-08-15 06:29:00,082+08 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(default task-80) [6cce3ceb] EVENT_ID: VM_SET_TICKET(164), User
admin@internal-authz initiated console session for VM win10_admin2
2018-08-15 06:29:10,961+08 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedThreadFactory-engineScheduled-Thread-35) [] EVENT_ID:
VM_CONSOLE_CONNECTED(167), User admin@internal-authz is connected to VM
win10_admin2.
2018-08-15 06:29:26,057+08 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedThreadFactory-engineScheduled-Thread-6) [] EVENT_ID:
VM_CONSOLE_DISCONNECTED(168), User admin@internal-authz got disconnected
from VM win10_admin2.
2018-08-15 06:29:34,487+08 INFO
[org.ovirt.engine.core.bll.HibernateVmCommand] (default task-80)
[2fa69451-4baf-44b1-8a8b-e948b88346db] Lock Acquired to object
'EngineLock:{exclusiveLocks='[3157ba6d-2758-4052-8d29-c3e0d2cb53eb=VM]',
sharedLocks=''}'
2018-08-15 06:29:34,565+08 INFO
[org.ovirt.engine.core.bll.memory.MemoryStorageHandler] (default task-80)
[2fa69451-4baf-44b1-8a8b-e948b88346db] The memory volumes of VM (name
'win10_admin2', id '3157ba6d-2758-4052-8d29-c3e0d2cb53eb') will be
stored
in storage domain (name 'uos', id
'de72f436-2d2f-4478-b962-fcae0070d400')
2018-08-15 06:29:34,577+08 INFO
[org.ovirt.engine.core.bll.HibernateVmCommand]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] Running command: HibernateVmCommand
internal: false. Entities affected : ID:
3157ba6d-2758-4052-8d29-c3e0d2cb53eb Type: VMAction group HIBERNATE_VM with
role type USER
2018-08-15 06:29:34,607+08 INFO
[org.ovirt.engine.core.bll.storage.disk.AddDiskCommand]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] Running command: AddDiskCommand
internal: true. Entities affected : ID:
de72f436-2d2f-4478-b962-fcae0070d400 Type: StorageAction group CREATE_DISK
with role type USER
2018-08-15 06:29:34,611+08 INFO
[org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] Running command:
AddImageFromScratchCommand internal: true. Entities affected : ID:
de72f436-2d2f-4478-b962-fcae0070d400 Type: Storage
2018-08-15 06:29:34,635+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] START, CreateImageVDSCommand(
CreateImageVDSCommandParameters:{storagePoolId='4e05a820-9faf-11e8-ad4e-00163e6e2f69',
ignoreFailoverLimit='false',
storageDomainId='de72f436-2d2f-4478-b962-fcae0070d400',
imageGroupId='17ebb2d8-41d5-4a64-a5ea-5bf590cfd6a0',
imageSizeInBytes='3506438144', volumeFormat='RAW',
newImageId='e182ef47-5583-4616-94ba-c6806ec8e462',
imageType='Preallocated',
newImageDescription='{"DiskAlias":"win10_admin2_hibernation_memory","DiskDescription":"memory
dump for VM hibernation"}', imageInitialSizeInBytes='0'}), log id:
5aad5b27
2018-08-15 06:29:34,635+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] -- executeIrsBrokerCommand: calling
'createVolume' with two new parameters: description and UUID
2018-08-15 06:29:34,723+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] FINISH, CreateImageVDSCommand,
return: e182ef47-5583-4616-94ba-c6806ec8e462, log id: 5aad5b27
2018-08-15 06:29:34,727+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] CommandAsyncTask::Adding
CommandMultiAsyncTasks object for command
'a931a16a-993a-48a1-bb44-3f00c6bf81b6'
2018-08-15 06:29:34,727+08 INFO
[org.ovirt.engine.core.bll.CommandMultiAsyncTasks]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] CommandMultiAsyncTasks::attachTask:
Attaching task '636308af-8d23-4e25-8fa5-bceb20355da6' to command
'a931a16a-993a-48a1-bb44-3f00c6bf81b6'.
2018-08-15 06:29:34,735+08 INFO
[org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] Adding task
'636308af-8d23-4e25-8fa5-bceb20355da6' (Parent Command 'HibernateVm',
Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters'), polling
hasn't started yet..
2018-08-15 06:29:34,756+08 INFO
[org.ovirt.engine.core.bll.storage.disk.AddDiskCommand]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] Running command: AddDiskCommand
internal: true. Entities affected : ID:
de72f436-2d2f-4478-b962-fcae0070d400 Type: StorageAction group CREATE_DISK
with role type USER
2018-08-15 06:29:34,760+08 INFO
[org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] Running command:
AddImageFromScratchCommand internal: true. Entities affected : ID:
de72f436-2d2f-4478-b962-fcae0070d400 Type: Storage
2018-08-15 06:29:34,779+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] START, CreateImageVDSCommand(
CreateImageVDSCommandParameters:{storagePoolId='4e05a820-9faf-11e8-ad4e-00163e6e2f69',
ignoreFailoverLimit='false',
storageDomainId='de72f436-2d2f-4478-b962-fcae0070d400',
imageGroupId='7e9152b6-3780-4ad9-bb79-1f8bb8df304e',
imageSizeInBytes='10240', volumeFormat='RAW',
newImageId='7fb3b645-891f-4069-9911-f99c193430c2',
imageType='Preallocated',
newImageDescription='{"DiskAlias":"win10_admin2_hibernation_metadata","DiskDescription":"metadata
for VM hibernation"}', imageInitialSizeInBytes='0'}), log id: 6ea33656
2018-08-15 06:29:34,779+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] -- executeIrsBrokerCommand: calling
'createVolume' with two new parameters: description and UUID
2018-08-15 06:29:34,813+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] FINISH, CreateImageVDSCommand,
return: 7fb3b645-891f-4069-9911-f99c193430c2, log id: 6ea33656
2018-08-15 06:29:34,816+08 INFO
[org.ovirt.engine.core.bll.CommandMultiAsyncTasks]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] CommandMultiAsyncTasks::attachTask:
Attaching task '225c5c6d-1fc9-43f3-951c-b2c766161279' to command
'a931a16a-993a-48a1-bb44-3f00c6bf81b6'.
2018-08-15 06:29:34,823+08 INFO
[org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] Adding task
'225c5c6d-1fc9-43f3-951c-b2c766161279' (Parent Command 'HibernateVm',
Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters'), polling
hasn't started yet..
2018-08-15 06:29:34,843+08 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] EVENT_ID: USER_SUSPEND_VM(501),
Suspending VM win10_admin2 was initiated by User admin@internal-authz
(Host: h4).
2018-08-15 06:29:34,843+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] BaseAsyncTask::startPollingTask:
Starting to poll task '636308af-8d23-4e25-8fa5-bceb20355da6'.
2018-08-15 06:29:34,843+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5855)
[2fa69451-4baf-44b1-8a8b-e948b88346db] BaseAsyncTask::startPollingTask:
Starting to poll task '225c5c6d-1fc9-43f3-951c-b2c766161279'.
2018-08-15 06:29:39,950+08 INFO
[org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
(EE-ManagedThreadFactory-engineScheduled-Thread-51) [] Polling and updating
Async Tasks: 2 tasks, 2 tasks to poll now
2018-08-15 06:29:39,957+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-51) []
SPMAsyncTask::PollTask: Polling task '636308af-8d23-4e25-8fa5-bceb20355da6'
(Parent Command 'HibernateVm', Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned
status 'finished', result 'success'.
2018-08-15 06:29:39,961+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-51) []
BaseAsyncTask::onTaskEndSuccess: Task
'636308af-8d23-4e25-8fa5-bceb20355da6' (Parent Command 'HibernateVm',
Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') ended
successfully.
2018-08-15 06:29:39,962+08 INFO
[org.ovirt.engine.core.bll.CommandMultiAsyncTasks]
(EE-ManagedThreadFactory-engineScheduled-Thread-51) [] Task with DB Task ID
'853102c7-a283-4483-9c52-2ea1a9c11b4d' and VDSM Task ID
'225c5c6d-1fc9-43f3-951c-b2c766161279' is in state Polling. End action for
command a931a16a-993a-48a1-bb44-3f00c6bf81b6 will proceed when all the
entity's tasks are completed.
2018-08-15 06:29:39,962+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-51) []
SPMAsyncTask::PollTask: Polling task '225c5c6d-1fc9-43f3-951c-b2c766161279'
(Parent Command 'HibernateVm', Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned
status 'finished', result 'success'.
2018-08-15 06:29:39,965+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-51) []
BaseAsyncTask::onTaskEndSuccess: Task
'225c5c6d-1fc9-43f3-951c-b2c766161279' (Parent Command 'HibernateVm',
Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') ended
successfully.
2018-08-15 06:29:39,968+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-51) []
CommandAsyncTask::endActionIfNecessary: All tasks of command
'a931a16a-993a-48a1-bb44-3f00c6bf81b6' has ended -> executing
'endAction'
2018-08-15 06:29:39,968+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-51) []
CommandAsyncTask::endAction: Ending action for '2' tasks (command ID:
'a931a16a-993a-48a1-bb44-3f00c6bf81b6'): calling endAction '.
2018-08-15 06:29:39,968+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5856) []
CommandAsyncTask::endCommandAction [within thread] context: Attempting to
endAction 'HibernateVm',
2018-08-15 06:29:40,025+08 INFO
[org.ovirt.engine.core.bll.HibernateVmCommand]
(EE-ManagedThreadFactory-engine-Thread-5856) [] Ending command
'org.ovirt.engine.core.bll.HibernateVmCommand' successfully.
2018-08-15 06:29:40,030+08 INFO
[org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand]
(EE-ManagedThreadFactory-engine-Thread-5856)
[2fa69451-4baf-44b1-8a8b-e948b88346db] Ending command
'org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand'
successfully.
2018-08-15 06:29:40,038+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856)
[2fa69451-4baf-44b1-8a8b-e948b88346db] START, GetImageInfoVDSCommand(
GetImageInfoVDSCommandParameters:{storagePoolId='4e05a820-9faf-11e8-ad4e-00163e6e2f69',
ignoreFailoverLimit='false',
storageDomainId='de72f436-2d2f-4478-b962-fcae0070d400',
imageGroupId='17ebb2d8-41d5-4a64-a5ea-5bf590cfd6a0',
imageId='e182ef47-5583-4616-94ba-c6806ec8e462'}), log id: 2d2b0b62
2018-08-15 06:29:40,040+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856)
[2fa69451-4baf-44b1-8a8b-e948b88346db] START,
GetVolumeInfoVDSCommand(HostName = h4,
GetVolumeInfoVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
storagePoolId='4e05a820-9faf-11e8-ad4e-00163e6e2f69',
storageDomainId='de72f436-2d2f-4478-b962-fcae0070d400',
imageGroupId='17ebb2d8-41d5-4a64-a5ea-5bf590cfd6a0',
imageId='e182ef47-5583-4616-94ba-c6806ec8e462'}), log id: 4bda0dd9
2018-08-15 06:29:40,076+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856)
[2fa69451-4baf-44b1-8a8b-e948b88346db] FINISH, GetVolumeInfoVDSCommand,
return:
org.ovirt.engine.core.common.businessentities.storage.DiskImage@bc3e4faa,
log id: 4bda0dd9
2018-08-15 06:29:40,076+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856)
[2fa69451-4baf-44b1-8a8b-e948b88346db] FINISH, GetImageInfoVDSCommand,
return:
org.ovirt.engine.core.common.businessentities.storage.DiskImage@bc3e4faa,
log id: 2d2b0b62
2018-08-15 06:29:40,088+08 INFO
[org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand]
(EE-ManagedThreadFactory-engine-Thread-5856)
[2fa69451-4baf-44b1-8a8b-e948b88346db] Ending command
'org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand'
successfully.
2018-08-15 06:29:40,090+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856)
[2fa69451-4baf-44b1-8a8b-e948b88346db] START, GetImageInfoVDSCommand(
GetImageInfoVDSCommandParameters:{storagePoolId='4e05a820-9faf-11e8-ad4e-00163e6e2f69',
ignoreFailoverLimit='false',
storageDomainId='de72f436-2d2f-4478-b962-fcae0070d400',
imageGroupId='7e9152b6-3780-4ad9-bb79-1f8bb8df304e',
imageId='7fb3b645-891f-4069-9911-f99c193430c2'}), log id: 39975e36
2018-08-15 06:29:40,092+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856)
[2fa69451-4baf-44b1-8a8b-e948b88346db] START,
GetVolumeInfoVDSCommand(HostName = h4,
GetVolumeInfoVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
storagePoolId='4e05a820-9faf-11e8-ad4e-00163e6e2f69',
storageDomainId='de72f436-2d2f-4478-b962-fcae0070d400',
imageGroupId='7e9152b6-3780-4ad9-bb79-1f8bb8df304e',
imageId='7fb3b645-891f-4069-9911-f99c193430c2'}), log id: 74f6476f
2018-08-15 06:29:40,118+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856)
[2fa69451-4baf-44b1-8a8b-e948b88346db] FINISH, GetVolumeInfoVDSCommand,
return:
org.ovirt.engine.core.common.businessentities.storage.DiskImage@d95d0882,
log id: 74f6476f
2018-08-15 06:29:40,118+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856)
[2fa69451-4baf-44b1-8a8b-e948b88346db] FINISH, GetImageInfoVDSCommand,
return:
org.ovirt.engine.core.common.businessentities.storage.DiskImage@d95d0882,
log id: 39975e36
2018-08-15 06:29:40,138+08 INFO
[org.ovirt.engine.core.bll.memory.MemoryStorageHandler]
(EE-ManagedThreadFactory-engine-Thread-5856) [] The memory volumes of VM
(name 'win10_admin2', id '3157ba6d-2758-4052-8d29-c3e0d2cb53eb') will be
stored in storage domain (name 'uos', id
'de72f436-2d2f-4478-b962-fcae0070d400')
2018-08-15 06:29:40,139+08 INFO
[org.ovirt.engine.core.vdsbroker.HibernateVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856) [] START, HibernateVDSCommand(
HibernateVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
vmId='3157ba6d-2758-4052-8d29-c3e0d2cb53eb',
hibernationVolHandle='de72f436-2d2f-4478-b962-fcae0070d400,4e05a820-9faf-11e8-ad4e-00163e6e2f69,17ebb2d8-41d5-4a64-a5ea-5bf590cfd6a0,e182ef47-5583-4616-94ba-c6806ec8e462,7e9152b6-3780-4ad9-bb79-1f8bb8df304e,7fb3b645-891f-4069-9911-f99c193430c2'}),
log id: 87d866c
2018-08-15 06:29:40,140+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HibernateBrokerVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856) [] START,
HibernateBrokerVDSCommand(HostName = h4,
HibernateVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
vmId='3157ba6d-2758-4052-8d29-c3e0d2cb53eb',
hibernationVolHandle='de72f436-2d2f-4478-b962-fcae0070d400,4e05a820-9faf-11e8-ad4e-00163e6e2f69,17ebb2d8-41d5-4a64-a5ea-5bf590cfd6a0,e182ef47-5583-4616-94ba-c6806ec8e462,7e9152b6-3780-4ad9-bb79-1f8bb8df304e,7fb3b645-891f-4069-9911-f99c193430c2'}),
log id: 6b020dff
2018-08-15 06:29:40,183+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HibernateBrokerVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856) [] FINISH,
HibernateBrokerVDSCommand, log id: 6b020dff
2018-08-15 06:29:40,186+08 INFO
[org.ovirt.engine.core.vdsbroker.HibernateVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856) [] FINISH,
HibernateVDSCommand, log id: 87d866c
2018-08-15 06:29:40,190+08 INFO
[org.ovirt.engine.core.bll.HibernateVmCommand]
(EE-ManagedThreadFactory-engine-Thread-5856) [] Lock freed to object
'EngineLock:{exclusiveLocks='[3157ba6d-2758-4052-8d29-c3e0d2cb53eb=VM]',
sharedLocks=''}'
2018-08-15 06:29:40,190+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5856) []
CommandAsyncTask::HandleEndActionResult [within thread]: endAction for
action type 'HibernateVm' completed, handling the result.
2018-08-15 06:29:40,190+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5856) []
CommandAsyncTask::HandleEndActionResult [within thread]: endAction for
action type 'HibernateVm' succeeded, clearing tasks.
2018-08-15 06:29:40,190+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5856) []
SPMAsyncTask::ClearAsyncTask: Attempting to clear task
'636308af-8d23-4e25-8fa5-bceb20355da6'
2018-08-15 06:29:40,191+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856) [] START,
SPMClearTaskVDSCommand(
SPMTaskGuidBaseVDSCommandParameters:{storagePoolId='4e05a820-9faf-11e8-ad4e-00163e6e2f69',
ignoreFailoverLimit='false',
taskId='636308af-8d23-4e25-8fa5-bceb20355da6'}), log id: 1d68c2cd
2018-08-15 06:29:40,192+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856) [] START,
HSMClearTaskVDSCommand(HostName = h4,
HSMTaskGuidBaseVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
taskId='636308af-8d23-4e25-8fa5-bceb20355da6'}), log id: 75913543
2018-08-15 06:29:40,199+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856) [] FINISH,
HSMClearTaskVDSCommand, log id: 75913543
2018-08-15 06:29:40,199+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856) [] FINISH,
SPMClearTaskVDSCommand, log id: 1d68c2cd
2018-08-15 06:29:40,203+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5856) []
BaseAsyncTask::removeTaskFromDB: Removed task
'636308af-8d23-4e25-8fa5-bceb20355da6' from DataBase
2018-08-15 06:29:40,203+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5856) []
SPMAsyncTask::ClearAsyncTask: Attempting to clear task
'225c5c6d-1fc9-43f3-951c-b2c766161279'
2018-08-15 06:29:40,203+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856) [] START,
SPMClearTaskVDSCommand(
SPMTaskGuidBaseVDSCommandParameters:{storagePoolId='4e05a820-9faf-11e8-ad4e-00163e6e2f69',
ignoreFailoverLimit='false',
taskId='225c5c6d-1fc9-43f3-951c-b2c766161279'}), log id: 4db22759
2018-08-15 06:29:40,204+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856) [] START,
HSMClearTaskVDSCommand(HostName = h4,
HSMTaskGuidBaseVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
taskId='225c5c6d-1fc9-43f3-951c-b2c766161279'}), log id: 58dd1b8a
2018-08-15 06:29:40,211+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856) [] FINISH,
HSMClearTaskVDSCommand, log id: 58dd1b8a
2018-08-15 06:29:40,211+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5856) [] FINISH,
SPMClearTaskVDSCommand, log id: 4db22759
2018-08-15 06:29:40,214+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5856) []
BaseAsyncTask::removeTaskFromDB: Removed task
'225c5c6d-1fc9-43f3-951c-b2c766161279' from DataBase
2018-08-15 06:29:40,214+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5856) []
CommandAsyncTask::HandleEndActionResult [within thread]: Removing
CommandMultiAsyncTasks object for entity
'a931a16a-993a-48a1-bb44-3f00c6bf81b6'
2018-08-15 06:29:50,745+08 INFO
[org.ovirt.engine.core.bll.SetVmTicketCommand] (default task-80) [68ad18ed]
Running command: SetVmTicketCommand internal: false. Entities affected :
ID: c326468b-ac01-4b8d-8eab-2129ccd8b0d8 Type: VMAction group CONNECT_TO_VM
with role type USER
2018-08-15 06:29:50,753+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SetVmTicketVDSCommand] (default
task-80) [68ad18ed] START, SetVmTicketVDSCommand(HostName = h4,
SetVmTicketVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
vmId='c326468b-ac01-4b8d-8eab-2129ccd8b0d8', protocol='SPICE',
ticket='IcDJe0MdaeIl', validTime='120', userName='admin',
userId='6303e0de-9faf-11e8-b20b-00163e6e2f69',
disconnectAction='LOCK_SCREEN'}), log id: 51123bc
2018-08-15 06:29:50,795+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SetVmTicketVDSCommand] (default
task-80) [68ad18ed] FINISH, SetVmTicketVDSCommand, log id: 51123bc
2018-08-15 06:29:50,805+08 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(default task-80) [68ad18ed] EVENT_ID: VM_SET_TICKET(164), User
admin@internal-authz initiated console session for VM yumServer
2018-08-15 06:29:56,160+08 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedThreadFactory-engineScheduled-Thread-34) [] EVENT_ID:
VM_CONSOLE_CONNECTED(167), User admin@internal-authz is connected to VM
yumServer.
2018-08-15 06:30:08,263+08 INFO
[org.ovirt.engine.core.bll.SetVmTicketCommand] (default task-80) [ed9ab4e]
Running command: SetVmTicketCommand internal: false. Entities affected :
ID: c326468b-ac01-4b8d-8eab-2129ccd8b0d8 Type: VMAction group CONNECT_TO_VM
with role type USER
2018-08-15 06:30:08,270+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SetVmTicketVDSCommand] (default
task-80) [ed9ab4e] START, SetVmTicketVDSCommand(HostName = h4,
SetVmTicketVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
vmId='c326468b-ac01-4b8d-8eab-2129ccd8b0d8', protocol='SPICE',
ticket='cwRAhnwEuKOA', validTime='120', userName='admin',
userId='6303e0de-9faf-11e8-b20b-00163e6e2f69',
disconnectAction='LOCK_SCREEN'}), log id: 3e0b4989
2018-08-15 06:30:08,301+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SetVmTicketVDSCommand] (default
task-80) [ed9ab4e] FINISH, SetVmTicketVDSCommand, log id: 3e0b4989
2018-08-15 06:30:08,310+08 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(default task-80) [ed9ab4e] EVENT_ID: VM_SET_TICKET(164), User
admin@internal-authz initiated console session for VM yumServer
2018-08-15 06:30:11,198+08 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(EE-ManagedThreadFactory-engineScheduled-Thread-1) [] VM
'3157ba6d-2758-4052-8d29-c3e0d2cb53eb' was reported as Down on VDS
'a8f6210a-fce4-4fec-bb87-4ccddb82a232'(h4)
2018-08-15 06:30:11,199+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-1) [] START,
DestroyVDSCommand(HostName = h4,
DestroyVmVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
vmId='3157ba6d-2758-4052-8d29-c3e0d2cb53eb', secondsToWait='0',
gracefully='false', reason='', ignoreNoVm='true'}), log id:
53cc67
2018-08-15 06:30:12,537+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-1) [] FINISH,
DestroyVDSCommand, log id: 53cc67
2018-08-15 06:30:12,538+08 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(EE-ManagedThreadFactory-engineScheduled-Thread-1) [] VM
'3157ba6d-2758-4052-8d29-c3e0d2cb53eb'(win10_admin2) moved from
'SavingState' --> 'Down'
2018-08-15 06:30:12,588+08 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedThreadFactory-engineScheduled-Thread-1) [] EVENT_ID:
USER_SUSPEND_VM_OK(503), VM win10_admin2 on Host h4 is suspended.
2018-08-15 06:30:12,603+08 INFO
[org.ovirt.engine.core.bll.ProcessDownVmCommand]
(EE-ManagedThreadFactory-engine-Thread-5861) [66addd18] Running command:
ProcessDownVmCommand internal: true.
2018-08-15 06:30:27,625+08 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher]
(EE-ManagedThreadFactory-engineScheduled-Thread-97) [] Fetched 9 VMs from
VDS 'a8f6210a-fce4-4fec-bb87-4ccddb82a232'
2018-08-15 06:30:27,639+08 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedThreadFactory-engineScheduled-Thread-97) [] EVENT_ID:
VM_CONSOLE_DISCONNECTED(168), User admin@internal-authz got disconnected
from VM yumServer.
2018-08-15 06:30:28,413+08 INFO [org.ovirt.engine.core.bll.RunVmCommand]
(default task-80) [408cddc1-9309-4553-a732-05239879d301] Lock Acquired to
object
'EngineLock:{exclusiveLocks='[3157ba6d-2758-4052-8d29-c3e0d2cb53eb=VM]',
sharedLocks=''}'
2018-08-15 06:30:28,430+08 INFO
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default
task-80) [408cddc1-9309-4553-a732-05239879d301] START,
IsVmDuringInitiatingVDSCommand(
IsVmDuringInitiatingVDSCommandParameters:{vmId='3157ba6d-2758-4052-8d29-c3e0d2cb53eb'}),
log id: 5a30cd3b
2018-08-15 06:30:28,430+08 INFO
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default
task-80) [408cddc1-9309-4553-a732-05239879d301] FINISH,
IsVmDuringInitiatingVDSCommand, return: false, log id: 5a30cd3b
2018-08-15 06:30:28,469+08 INFO [org.ovirt.engine.core.bll.RunVmCommand]
(EE-ManagedThreadFactory-engine-Thread-5864)
[408cddc1-9309-4553-a732-05239879d301] Running command: RunVmCommand
internal: false. Entities affected : ID:
3157ba6d-2758-4052-8d29-c3e0d2cb53eb Type: VMAction group RUN_VM with role
type USER
2018-08-15 06:30:28,493+08 INFO
[org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5864)
[408cddc1-9309-4553-a732-05239879d301] START,
UpdateVmDynamicDataVDSCommand(
UpdateVmDynamicDataVDSCommandParameters:{hostId='null',
vmId='3157ba6d-2758-4052-8d29-c3e0d2cb53eb',
vmDynamic='org.ovirt.engine.core.common.businessentities.VmDynamic@3829bf01'}),
log id: 288a3b77
2018-08-15 06:30:28,495+08 INFO
[org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5864)
[408cddc1-9309-4553-a732-05239879d301] FINISH,
UpdateVmDynamicDataVDSCommand, log id: 288a3b77
2018-08-15 06:30:28,522+08 INFO
[org.ovirt.engine.core.vdsbroker.CreateVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5864)
[408cddc1-9309-4553-a732-05239879d301] START, CreateVDSCommand(
CreateVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
vmId='3157ba6d-2758-4052-8d29-c3e0d2cb53eb', vm='VM [win10_admin2]'}),
log
id: 367b163
2018-08-15 06:30:28,522+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5864)
[408cddc1-9309-4553-a732-05239879d301] START,
CreateBrokerVDSCommand(HostName = h4,
CreateVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
vmId='3157ba6d-2758-4052-8d29-c3e0d2cb53eb', vm='VM [win10_admin2]'}),
log
id: 5b68ed26
2018-08-15 06:30:28,535+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5864)
[408cddc1-9309-4553-a732-05239879d301] VM <?xml version="1.0"
encoding="UTF-8"?><domain type="kvm" xmlns:ovirt-tune="
http://ovirt.org/vm/tune/1.0"
xmlns:ovirt-vm="http://ovirt.org/vm/1.0">
<name>win10_admin2</name>
<uuid>3157ba6d-2758-4052-8d29-c3e0d2cb53eb</uuid>
<memory>3145728</memory>
<currentMemory>3145728</currentMemory>
<iothreads>1</iothreads>
<maxMemory slots="16">12582912</maxMemory>
<vcpu current="2">16</vcpu>
<sysinfo type="smbios">
<system>
<entry name="manufacturer">oVirt</entry>
<entry name="product">OS-NAME:</entry>
<entry name="version">OS-VERSION:</entry>
<entry name="serial">HOST-SERIAL:</entry>
<entry
name="uuid">3157ba6d-2758-4052-8d29-c3e0d2cb53eb</entry>
</system>
</sysinfo>
<clock offset="variable" adjustment="3600">
<timer name="hypervclock" present="yes"/>
<timer name="rtc" tickpolicy="catchup"/>
<timer name="pit" tickpolicy="delay"/>
<timer name="hpet" present="no"/>
</clock>
<features>
<acpi/>
<hyperv>
<relaxed state="on"/>
<vapic state="on"/>
<spinlocks state="on" retries="8191"/>
</hyperv>
</features>
<cpu match="exact">
<model>Haswell</model>
<topology cores="1" threads="1" sockets="16"/>
<numa>
<cell id="0" cpus="0,1" memory="3145728"/>
</numa>
</cpu>
<cputune/>
<devices>
<input type="tablet" bus="usb"/>
<channel type="unix">
<target type="virtio" name="ovirt-guest-agent.0"/>
<source mode="bind"
path="/var/lib/libvirt/qemu/channels/3157ba6d-2758-4052-8d29-c3e0d2cb53eb.ovirt-guest-agent.0"/>
</channel>
<channel type="unix">
<target type="virtio" name="org.qemu.guest_agent.0"/>
<source mode="bind"
path="/var/lib/libvirt/qemu/channels/3157ba6d-2758-4052-8d29-c3e0d2cb53eb.org.qemu.guest_agent.0"/>
</channel>
<controller type="scsi" model="virtio-scsi"
index="0">
<driver iothread="1"/>
<alias name="ua-0c573b63-ff17-4f1d-aa2f-52a04f1444a7"/>
<address bus="0x00" domain="0x0000" function="0x0"
slot="0x04"
type="pci"/>
</controller>
<graphics type="vnc" port="-1" autoport="yes"
passwd="*****"
passwdValidTo="1970-01-01T00:00:01" keymap="en-us">
<listen type="network" network="vdsm-wan"/>
</graphics>
<video>
<model type="qxl" vram="8192" heads="1"
ram="65536" vgamem="16384"/>
<alias name="ua-3eaf17ab-6938-4cb6-8f2d-239dde553be5"/>
<address bus="0x00" domain="0x0000" function="0x0"
slot="0x02"
type="pci"/>
</video>
<controller type="virtio-serial" index="0"
ports="16">
<alias name="ua-4c206e20-6380-45b2-a9ce-81caa82a9170"/>
<address bus="0x00" domain="0x0000" function="0x0"
slot="0x05"
type="pci"/>
</controller>
<controller type="ide">
<address bus="0x00" domain="0x0000" function="0x1"
slot="0x01"
type="pci"/>
</controller>
<controller type="usb" model="piix3-uhci"
index="0">
<address bus="0x00" domain="0x0000" function="0x2"
slot="0x01"
type="pci"/>
</controller>
<rng model="virtio">
<backend model="random">/dev/urandom</backend>
<alias name="ua-e6cbd1fb-394d-467b-9c35-0636fbe07faf"/>
</rng>
<memballoon model="none"/>
<interface type="bridge">
<model type="virtio"/>
<link state="up"/>
<source bridge="tvlan2870"/>
<driver queues="2" name="vhost"/>
<alias name="ua-2c27c79d-cd54-41b3-ab96-0ccb75d2d312"/>
<address bus="0x00" domain="0x0000" function="0x0"
slot="0x03"
type="pci"/>
<mac address="00:1a:4a:16:01:13"/>
<mtu size="1500"/>
<filterref filter="vdsm-no-mac-spoofing"/>
<bandwidth/>
</interface>
<disk type="file" device="cdrom" snapshot="no">
<driver name="qemu" type="raw"
error_policy="report"/>
<source file="" startupPolicy="optional"/>
<target dev="hdc" bus="ide"/>
<readonly/>
<alias name="ua-801eaa49-b1b9-4c16-af8e-aa9547f04adc"/>
<address bus="1" controller="0" unit="0"
type="drive" target="0"/>
</disk>
<disk snapshot="no" type="block" device="disk">
<target dev="sda" bus="scsi"/>
<source
dev="/rhev/data-center/mnt/blockSD/de72f436-2d2f-4478-b962-fcae0070d400/images/4ee5bb0d-6b51-43d0-a398-665ec9d0abdf/deb2d695-84d2-413e-9546-3de6a2d3055b"/>
<driver name="qemu" io="native" type="qcow2"
error_policy="stop"
cache="none"/>
<alias name="ua-4ee5bb0d-6b51-43d0-a398-665ec9d0abdf"/>
<address bus="0" controller="0" unit="0"
type="drive" target="0"/>
<boot order="1"/>
<serial>4ee5bb0d-6b51-43d0-a398-665ec9d0abdf</serial>
</disk>
</devices>
<pm>
<suspend-to-disk enabled="no"/>
<suspend-to-mem enabled="no"/>
</pm>
<os>
<type arch="x86_64"
machine="pc-i440fx-rhel7.3.0">hvm</type>
<smbios mode="sysinfo"/>
</os>
<metadata>
<ovirt-tune:qos/>
<ovirt-vm:vm>
<minGuaranteedMemoryMb
type="int">3072</minGuaranteedMemoryMb>
<clusterVersion>4.2</clusterVersion>
<ovirt-vm:custom/>
<ovirt-vm:device mac_address="00:1a:4a:16:01:13">
<ovirt-vm:custom/>
</ovirt-vm:device>
<ovirt-vm:device devtype="disk" name="sda">
<ovirt-vm:poolID>4e05a820-9faf-11e8-ad4e-00163e6e2f69</ovirt-vm:poolID>
<ovirt-vm:volumeID>deb2d695-84d2-413e-9546-3de6a2d3055b</ovirt-vm:volumeID>
<ovirt-vm:imageID>4ee5bb0d-6b51-43d0-a398-665ec9d0abdf</ovirt-vm:imageID>
<ovirt-vm:domainID>de72f436-2d2f-4478-b962-fcae0070d400</ovirt-vm:domainID>
</ovirt-vm:device>
<launchPaused>false</launchPaused>
<resumeBehavior>auto_resume</resumeBehavior>
</ovirt-vm:vm>
</metadata>
</domain>
2018-08-15 06:30:29,322+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5864)
[408cddc1-9309-4553-a732-05239879d301] FINISH, CreateBrokerVDSCommand, log
id: 5b68ed26
2018-08-15 06:30:29,324+08 INFO
[org.ovirt.engine.core.vdsbroker.CreateVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5864)
[408cddc1-9309-4553-a732-05239879d301] FINISH, CreateVDSCommand, return:
RestoringState, log id: 367b163
2018-08-15 06:30:29,325+08 INFO [org.ovirt.engine.core.bll.RunVmCommand]
(EE-ManagedThreadFactory-engine-Thread-5864)
[408cddc1-9309-4553-a732-05239879d301] Lock freed to object
'EngineLock:{exclusiveLocks='[3157ba6d-2758-4052-8d29-c3e0d2cb53eb=VM]',
sharedLocks=''}'
2018-08-15 06:30:29,329+08 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedThreadFactory-engine-Thread-5864)
[408cddc1-9309-4553-a732-05239879d301] EVENT_ID: USER_STARTED_VM(153), VM
win10_admin2 was started by admin@internal-authz (Host: h4).
2018-08-15 06:30:41,604+08 INFO
[org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
(EE-ManagedThreadFactory-engineScheduled-Thread-29) [] Setting new tasks
map. The map contains now 0 tasks
2018-08-15 06:30:41,604+08 INFO
[org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
(EE-ManagedThreadFactory-engineScheduled-Thread-29) [] Cleared all tasks of
pool '4e05a820-9faf-11e8-ad4e-00163e6e2f69'.
2018-08-15 06:30:42,675+08 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher]
(EE-ManagedThreadFactory-engineScheduled-Thread-6) [] Fetched 10 VMs from
VDS 'a8f6210a-fce4-4fec-bb87-4ccddb82a232'
2018-08-15 06:30:42,686+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.DumpXmlsVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-6) [] START,
DumpXmlsVDSCommand(HostName = h4,
Params:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
vmIds='[3157ba6d-2758-4052-8d29-c3e0d2cb53eb]'}), log id: 4acb6f39
2018-08-15 06:30:42,708+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.DumpXmlsVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-6) [] FINISH,
DumpXmlsVDSCommand, return: [{vmId=3157ba6d-2758-4052-8d29-c3e0d2cb53eb,
devices=[Ljava.util.Map;@5fa8f608,
guestDiskMapping={4ee5bb0d-6b51-43d0-a398-665ec9d0abdf={name=\\.\PHYSICALDRIVE0}}}],
log id: 4acb6f39
2018-08-15 06:30:59,778+08 INFO [org.ovirt.engine.core.bll.RunVmCommand]
(default task-80) [0004457d-5f69-4c0d-9f9c-6fa081049f4b] Lock Acquired to
object
'EngineLock:{exclusiveLocks='[8471050b-7dda-466f-aecb-5b35e4aa8d2f=VM]',
sharedLocks=''}'
2018-08-15 06:30:59,795+08 INFO
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default
task-80) [0004457d-5f69-4c0d-9f9c-6fa081049f4b] START,
IsVmDuringInitiatingVDSCommand(
IsVmDuringInitiatingVDSCommandParameters:{vmId='8471050b-7dda-466f-aecb-5b35e4aa8d2f'}),
log id: 4acbf477
2018-08-15 06:30:59,795+08 INFO
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default
task-80) [0004457d-5f69-4c0d-9f9c-6fa081049f4b] FINISH,
IsVmDuringInitiatingVDSCommand, return: false, log id: 4acbf477
2018-08-15 06:30:59,834+08 INFO [org.ovirt.engine.core.bll.RunVmCommand]
(EE-ManagedThreadFactory-engine-Thread-5869)
[0004457d-5f69-4c0d-9f9c-6fa081049f4b] Running command: RunVmCommand
internal: false. Entities affected : ID:
8471050b-7dda-466f-aecb-5b35e4aa8d2f Type: VMAction group RUN_VM with role
type USER
2018-08-15 06:30:59,860+08 INFO
[org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5869)
[0004457d-5f69-4c0d-9f9c-6fa081049f4b] START,
UpdateVmDynamicDataVDSCommand(
UpdateVmDynamicDataVDSCommandParameters:{hostId='null',
vmId='8471050b-7dda-466f-aecb-5b35e4aa8d2f',
vmDynamic='org.ovirt.engine.core.common.businessentities.VmDynamic@b54b5578'}),
log id: 433c6d3c
2018-08-15 06:30:59,863+08 INFO
[org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5869)
[0004457d-5f69-4c0d-9f9c-6fa081049f4b] FINISH,
UpdateVmDynamicDataVDSCommand, log id: 433c6d3c
2018-08-15 06:30:59,888+08 INFO
[org.ovirt.engine.core.vdsbroker.CreateVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5869)
[0004457d-5f69-4c0d-9f9c-6fa081049f4b] START, CreateVDSCommand(
CreateVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
vmId='8471050b-7dda-466f-aecb-5b35e4aa8d2f', vm='VM [win10_liug]'}), log
id: 6fe2c3d
2018-08-15 06:30:59,889+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5869)
[0004457d-5f69-4c0d-9f9c-6fa081049f4b] START,
CreateBrokerVDSCommand(HostName = h4,
CreateVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
vmId='8471050b-7dda-466f-aecb-5b35e4aa8d2f', vm='VM [win10_liug]'}), log
id: 38d7bec6
2018-08-15 06:30:59,903+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5869)
[0004457d-5f69-4c0d-9f9c-6fa081049f4b] VM <?xml version="1.0"
encoding="UTF-8"?><domain type="kvm" xmlns:ovirt-tune="
http://ovirt.org/vm/tune/1.0"
xmlns:ovirt-vm="http://ovirt.org/vm/1.0">
<name>win10_liug</name>
<uuid>8471050b-7dda-466f-aecb-5b35e4aa8d2f</uuid>
<memory>3145728</memory>
<currentMemory>3145728</currentMemory>
<iothreads>1</iothreads>
<maxMemory slots="16">12582912</maxMemory>
<vcpu current="2">16</vcpu>
<sysinfo type="smbios">
<system>
<entry name="manufacturer">oVirt</entry>
<entry name="product">OS-NAME:</entry>
<entry name="version">OS-VERSION:</entry>
<entry name="serial">HOST-SERIAL:</entry>
<entry
name="uuid">8471050b-7dda-466f-aecb-5b35e4aa8d2f</entry>
</system>
</sysinfo>
<clock offset="variable" adjustment="3600">
<timer name="hypervclock" present="yes"/>
<timer name="rtc" tickpolicy="catchup"/>
<timer name="pit" tickpolicy="delay"/>
<timer name="hpet" present="no"/>
</clock>
<features>
<acpi/>
<hyperv>
<relaxed state="on"/>
<vapic state="on"/>
<spinlocks state="on" retries="8191"/>
</hyperv>
</features>
<cpu match="exact">
<model>Haswell</model>
<topology cores="1" threads="1" sockets="16"/>
<numa>
<cell id="0" cpus="0,1" memory="3145728"/>
</numa>
</cpu>
<cputune/>
<devices>
<input type="tablet" bus="usb"/>
<channel type="unix">
<target type="virtio" name="ovirt-guest-agent.0"/>
<source mode="bind"
path="/var/lib/libvirt/qemu/channels/8471050b-7dda-466f-aecb-5b35e4aa8d2f.ovirt-guest-agent.0"/>
</channel>
<channel type="unix">
<target type="virtio" name="org.qemu.guest_agent.0"/>
<source mode="bind"
path="/var/lib/libvirt/qemu/channels/8471050b-7dda-466f-aecb-5b35e4aa8d2f.org.qemu.guest_agent.0"/>
</channel>
<controller type="scsi" model="virtio-scsi"
index="0">
<driver iothread="1"/>
<alias name="ua-03e3abbd-cf49-4f89-9d70-e44c15a54e57"/>
<address bus="0x00" domain="0x0000" function="0x0"
slot="0x04"
type="pci"/>
</controller>
<video>
<model type="qxl" vram="8192" heads="1"
ram="65536" vgamem="16384"/>
<alias name="ua-0e78fe1f-decf-4f70-a623-d70f533556a5"/>
<address bus="0x00" domain="0x0000" function="0x0"
slot="0x02"
type="pci"/>
</video>
<controller type="usb" model="piix3-uhci"
index="0">
<address bus="0x00" domain="0x0000" function="0x2"
slot="0x01"
type="pci"/>
</controller>
<graphics type="vnc" port="-1" autoport="yes"
passwd="*****"
passwdValidTo="1970-01-01T00:00:01" keymap="en-us">
<listen type="network" network="vdsm-wan"/>
</graphics>
<controller type="ide">
<address bus="0x00" domain="0x0000" function="0x1"
slot="0x01"
type="pci"/>
</controller>
<controller type="virtio-serial" index="0"
ports="16">
<alias name="ua-c97f1593-773c-4f30-be1e-0f7dc12fca1b"/>
<address bus="0x00" domain="0x0000" function="0x0"
slot="0x05"
type="pci"/>
</controller>
<rng model="virtio">
<backend model="random">/dev/urandom</backend>
<alias name="ua-e6cbd1fb-394d-467b-9c35-0636fbe07faf"/>
</rng>
<memballoon model="none"/>
<interface type="bridge">
<model type="virtio"/>
<link state="up"/>
<source bridge="tvlan2870"/>
<driver queues="2" name="vhost"/>
<alias name="ua-44bae05b-6547-4f70-b66f-f6e1b70089e2"/>
<address bus="0x00" domain="0x0000" function="0x0"
slot="0x03"
type="pci"/>
<mac address="00:1a:4a:16:01:17"/>
<mtu size="1500"/>
<filterref filter="vdsm-no-mac-spoofing"/>
<bandwidth/>
</interface>
<disk type="file" device="cdrom" snapshot="no">
<driver name="qemu" type="raw"
error_policy="report"/>
<source file="" startupPolicy="optional"/>
<target dev="hdc" bus="ide"/>
<readonly/>
<alias name="ua-2f925984-53c1-41c3-8878-6f02bc495c62"/>
<address bus="1" controller="0" unit="0"
type="drive" target="0"/>
</disk>
<disk snapshot="no" type="block" device="disk">
<target dev="sda" bus="scsi"/>
<source
dev="/rhev/data-center/mnt/blockSD/de72f436-2d2f-4478-b962-fcae0070d400/images/0348e1f1-ed58-48ea-ae07-f5177f59b48c/7517e930-673e-49b3-9901-81bce3f94375"/>
<driver name="qemu" io="native" type="qcow2"
error_policy="stop"
cache="none"/>
<alias name="ua-0348e1f1-ed58-48ea-ae07-f5177f59b48c"/>
<address bus="0" controller="0" unit="0"
type="drive" target="0"/>
<boot order="1"/>
<serial>0348e1f1-ed58-48ea-ae07-f5177f59b48c</serial>
</disk>
</devices>
<pm>
<suspend-to-disk enabled="no"/>
<suspend-to-mem enabled="no"/>
</pm>
<os>
<type arch="x86_64"
machine="pc-i440fx-rhel7.3.0">hvm</type>
<smbios mode="sysinfo"/>
</os>
<metadata>
<ovirt-tune:qos/>
<ovirt-vm:vm>
<minGuaranteedMemoryMb
type="int">3072</minGuaranteedMemoryMb>
<clusterVersion>4.2</clusterVersion>
<ovirt-vm:custom/>
<ovirt-vm:device mac_address="00:1a:4a:16:01:17">
<ovirt-vm:custom/>
</ovirt-vm:device>
<ovirt-vm:device devtype="disk" name="sda">
<ovirt-vm:poolID>4e05a820-9faf-11e8-ad4e-00163e6e2f69</ovirt-vm:poolID>
<ovirt-vm:volumeID>7517e930-673e-49b3-9901-81bce3f94375</ovirt-vm:volumeID>
<ovirt-vm:imageID>0348e1f1-ed58-48ea-ae07-f5177f59b48c</ovirt-vm:imageID>
<ovirt-vm:domainID>de72f436-2d2f-4478-b962-fcae0070d400</ovirt-vm:domainID>
</ovirt-vm:device>
<launchPaused>false</launchPaused>
<resumeBehavior>auto_resume</resumeBehavior>
</ovirt-vm:vm>
</metadata>
</domain>
2018-08-15 06:31:00,761+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5869)
[0004457d-5f69-4c0d-9f9c-6fa081049f4b] FINISH, CreateBrokerVDSCommand, log
id: 38d7bec6
2018-08-15 06:31:00,763+08 INFO
[org.ovirt.engine.core.vdsbroker.CreateVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5869)
[0004457d-5f69-4c0d-9f9c-6fa081049f4b] FINISH, CreateVDSCommand, return:
RestoringState, log id: 6fe2c3d
2018-08-15 06:31:00,764+08 INFO [org.ovirt.engine.core.bll.RunVmCommand]
(EE-ManagedThreadFactory-engine-Thread-5869)
[0004457d-5f69-4c0d-9f9c-6fa081049f4b] Lock freed to object
'EngineLock:{exclusiveLocks='[8471050b-7dda-466f-aecb-5b35e4aa8d2f=VM]',
sharedLocks=''}'
2018-08-15 06:31:00,767+08 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedThreadFactory-engine-Thread-5869)
[0004457d-5f69-4c0d-9f9c-6fa081049f4b] EVENT_ID: USER_STARTED_VM(153), VM
win10_liug was started by admin@internal-authz (Host: h4).
2018-08-15 06:31:13,773+08 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher]
(EE-ManagedThreadFactory-engineScheduled-Thread-68) [] Fetched 11 VMs from
VDS 'a8f6210a-fce4-4fec-bb87-4ccddb82a232'
2018-08-15 06:31:13,775+08 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(EE-ManagedThreadFactory-engineScheduled-Thread-68) [] VM
'8471050b-7dda-466f-aecb-5b35e4aa8d2f' was reported as Down on VDS
'a8f6210a-fce4-4fec-bb87-4ccddb82a232'(h4)
2018-08-15 06:31:13,776+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-68) [] START,
DestroyVDSCommand(HostName = h4,
DestroyVmVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
vmId='8471050b-7dda-466f-aecb-5b35e4aa8d2f', secondsToWait='0',
gracefully='false', reason='', ignoreNoVm='true'}), log id:
7ff1c305
2018-08-15 06:31:15,026+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-68) [] FINISH,
DestroyVDSCommand, log id: 7ff1c305
2018-08-15 06:31:15,026+08 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(EE-ManagedThreadFactory-engineScheduled-Thread-68) [] VM
'8471050b-7dda-466f-aecb-5b35e4aa8d2f'(win10_liug) moved from
'RestoringState' --> 'Down'
2018-08-15 06:31:15,037+08 ERROR
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedThreadFactory-engineScheduled-Thread-68) [] EVENT_ID:
VM_DOWN_ERROR(119), VM win10_liug is down with error. Exit message: Wake up
from hibernation failed:(<Element 'disk' at 0x7f8b8c602990>,
'source').
2018-08-15 06:31:15,037+08 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer]
(EE-ManagedThreadFactory-engineScheduled-Thread-68) [] add VM
'8471050b-7dda-466f-aecb-5b35e4aa8d2f'(win10_liug) to rerun treatment
2018-08-15 06:31:15,047+08 ERROR
[org.ovirt.engine.core.vdsbroker.monitoring.VmsMonitoring]
(EE-ManagedThreadFactory-engineScheduled-Thread-68) [] Rerun VM
'8471050b-7dda-466f-aecb-5b35e4aa8d2f'. Called from VDS 'h4'
2018-08-15 06:31:15,057+08 WARN
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedThreadFactory-engine-Thread-5872) [] EVENT_ID:
USER_INITIATED_RUN_VM_FAILED(151), Failed to run VM win10_liug on Host h4.
2018-08-15 06:31:15,061+08 INFO [org.ovirt.engine.core.bll.RunVmCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [] Lock Acquired to object
'EngineLock:{exclusiveLocks='[8471050b-7dda-466f-aecb-5b35e4aa8d2f=VM]',
sharedLocks=''}'
2018-08-15 06:31:15,079+08 INFO
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [] START,
IsVmDuringInitiatingVDSCommand(
IsVmDuringInitiatingVDSCommandParameters:{vmId='8471050b-7dda-466f-aecb-5b35e4aa8d2f'}),
log id: 2e0a8a81
2018-08-15 06:31:15,079+08 INFO
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [] FINISH,
IsVmDuringInitiatingVDSCommand, return: false, log id: 2e0a8a81
2018-08-15 06:31:15,084+08 WARN [org.ovirt.engine.core.bll.RunVmCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [] Validation of action
'RunVm' failed for user admin@internal-authz. Reasons:
VAR__ACTION__RUN,VAR__TYPE__VM,VAR__ACTION__RUN,VAR__TYPE__VM,VAR__ACTION__RUN,VAR__TYPE__VM,SCHEDULING_NO_HOSTS
2018-08-15 06:31:15,084+08 INFO [org.ovirt.engine.core.bll.RunVmCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [] Lock freed to object
'EngineLock:{exclusiveLocks='[8471050b-7dda-466f-aecb-5b35e4aa8d2f=VM]',
sharedLocks=''}'
2018-08-15 06:31:15,097+08 INFO
[org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [790b75cc] Lock Acquired to
object
'EngineLock:{exclusiveLocks='[5b1067a8-8d10-42b4-b2ba-b5a9e316e004=DISK]',
sharedLocks=''}'
2018-08-15 06:31:15,103+08 INFO
[org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [790b75cc] Running command:
RemoveDiskCommand internal: true. Entities affected : ID:
5b1067a8-8d10-42b4-b2ba-b5a9e316e004 Type: DiskAction group DELETE_DISK
with role type USER
2018-08-15 06:31:15,115+08 INFO
[org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [790b75cc] Running command:
RemoveImageCommand internal: true. Entities affected : ID:
de72f436-2d2f-4478-b962-fcae0070d400 Type: Storage
2018-08-15 06:31:15,167+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [790b75cc] START,
DeleteImageGroupVDSCommand(
DeleteImageGroupVDSCommandParameters:{storagePoolId='4e05a820-9faf-11e8-ad4e-00163e6e2f69',
ignoreFailoverLimit='false',
storageDomainId='de72f436-2d2f-4478-b962-fcae0070d400',
imageGroupId='5b1067a8-8d10-42b4-b2ba-b5a9e316e004', postZeros='false',
discard='true', forceDelete='false'}), log id: 15127276
2018-08-15 06:31:15,523+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [790b75cc] FINISH,
DeleteImageGroupVDSCommand, log id: 15127276
2018-08-15 06:31:15,526+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5872) [790b75cc]
CommandAsyncTask::Adding CommandMultiAsyncTasks object for command
'd74476b7-e512-4a56-ab30-dbae4ec4057a'
2018-08-15 06:31:15,526+08 INFO
[org.ovirt.engine.core.bll.CommandMultiAsyncTasks]
(EE-ManagedThreadFactory-engine-Thread-5872) [790b75cc]
CommandMultiAsyncTasks::attachTask: Attaching task
'cef7b7dd-ea68-4fa4-9603-ff81f1105dd5' to command
'd74476b7-e512-4a56-ab30-dbae4ec4057a'.
2018-08-15 06:31:15,534+08 INFO
[org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
(EE-ManagedThreadFactory-engine-Thread-5872) [790b75cc] Adding task
'cef7b7dd-ea68-4fa4-9603-ff81f1105dd5' (Parent Command 'RemoveDisk',
Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters'), polling
hasn't started yet..
2018-08-15 06:31:15,648+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5872) [790b75cc]
BaseAsyncTask::startPollingTask: Starting to poll task
'cef7b7dd-ea68-4fa4-9603-ff81f1105dd5'.
2018-08-15 06:31:15,648+08 INFO
[org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [790b75cc] Lock freed to
object
'EngineLock:{exclusiveLocks='[5b1067a8-8d10-42b4-b2ba-b5a9e316e004=DISK]',
sharedLocks=''}'
2018-08-15 06:31:15,654+08 INFO
[org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [2bf8691e] Lock Acquired to
object
'EngineLock:{exclusiveLocks='[8b7936b3-dc4b-4f84-b132-e57844667093=DISK]',
sharedLocks=''}'
2018-08-15 06:31:15,670+08 INFO
[org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [2bf8691e] Running command:
RemoveDiskCommand internal: true. Entities affected : ID:
8b7936b3-dc4b-4f84-b132-e57844667093 Type: DiskAction group DELETE_DISK
with role type USER
2018-08-15 06:31:15,675+08 INFO
[org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [2bf8691e] Running command:
RemoveImageCommand internal: true. Entities affected : ID:
de72f436-2d2f-4478-b962-fcae0070d400 Type: Storage
2018-08-15 06:31:15,709+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [2bf8691e] START,
DeleteImageGroupVDSCommand(
DeleteImageGroupVDSCommandParameters:{storagePoolId='4e05a820-9faf-11e8-ad4e-00163e6e2f69',
ignoreFailoverLimit='false',
storageDomainId='de72f436-2d2f-4478-b962-fcae0070d400',
imageGroupId='8b7936b3-dc4b-4f84-b132-e57844667093', postZeros='false',
discard='true', forceDelete='false'}), log id: 27ee9e44
2018-08-15 06:31:19,970+08 INFO
[org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
(EE-ManagedThreadFactory-engineScheduled-Thread-92) [] Polling and updating
Async Tasks: 1 tasks, 1 tasks to poll now
2018-08-15 06:31:21,093+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [2bf8691e] FINISH,
DeleteImageGroupVDSCommand, log id: 27ee9e44
2018-08-15 06:31:21,097+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5872) [2bf8691e]
CommandAsyncTask::Adding CommandMultiAsyncTasks object for command
'8bf17c42-1292-4e4d-a3e6-beeec059638f'
2018-08-15 06:31:21,097+08 INFO
[org.ovirt.engine.core.bll.CommandMultiAsyncTasks]
(EE-ManagedThreadFactory-engine-Thread-5872) [2bf8691e]
CommandMultiAsyncTasks::attachTask: Attaching task
'736f8e97-bf2e-4532-bb59-de7475f57d86' to command
'8bf17c42-1292-4e4d-a3e6-beeec059638f'.
2018-08-15 06:31:21,145+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-92) []
SPMAsyncTask::PollTask: Polling task 'cef7b7dd-ea68-4fa4-9603-ff81f1105dd5'
(Parent Command 'RemoveDisk', Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned
status 'running'.
2018-08-15 06:31:21,145+08 INFO
[org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
(EE-ManagedThreadFactory-engineScheduled-Thread-92) [] Finished polling
Tasks, will poll again in 10 seconds.
2018-08-15 06:31:21,145+08 INFO
[org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
(EE-ManagedThreadFactory-engine-Thread-5872) [2bf8691e] Adding task
'736f8e97-bf2e-4532-bb59-de7475f57d86' (Parent Command 'RemoveDisk',
Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters'), polling
hasn't started yet..
2018-08-15 06:31:21,221+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5872) [2bf8691e]
BaseAsyncTask::startPollingTask: Starting to poll task
'736f8e97-bf2e-4532-bb59-de7475f57d86'.
2018-08-15 06:31:21,222+08 INFO
[org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand]
(EE-ManagedThreadFactory-engine-Thread-5872) [2bf8691e] Lock freed to
object
'EngineLock:{exclusiveLocks='[8b7936b3-dc4b-4f84-b132-e57844667093=DISK]',
sharedLocks=''}'
2018-08-15 06:31:21,224+08 ERROR
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(EE-ManagedThreadFactory-engine-Thread-5872) [2bf8691e] EVENT_ID:
USER_FAILED_RUN_VM(54), Failed to run VM win10_liug (User:
admin@internal-authz).
2018-08-15 06:31:21,265+08 INFO
[org.ovirt.engine.core.bll.ProcessDownVmCommand]
(EE-ManagedThreadFactory-engine-Thread-5875) [60ef8c41] Running command:
ProcessDownVmCommand internal: true.
2018-08-15 06:31:30,072+08 INFO
[org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher]
(EE-ManagedThreadFactory-engineScheduled-Thread-8) [] Fetched 10 VMs from
VDS 'a8f6210a-fce4-4fec-bb87-4ccddb82a232'
2018-08-15 06:31:31,145+08 INFO
[org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
(EE-ManagedThreadFactory-engineScheduled-Thread-16) [] Polling and updating
Async Tasks: 2 tasks, 2 tasks to poll now
2018-08-15 06:31:31,174+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-16) []
SPMAsyncTask::PollTask: Polling task 'cef7b7dd-ea68-4fa4-9603-ff81f1105dd5'
(Parent Command 'RemoveDisk', Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned
status 'finished', result 'success'.
2018-08-15 06:31:31,176+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-16) []
BaseAsyncTask::onTaskEndSuccess: Task
'cef7b7dd-ea68-4fa4-9603-ff81f1105dd5' (Parent Command 'RemoveDisk',
Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') ended
successfully.
2018-08-15 06:31:31,179+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-16) []
CommandAsyncTask::endActionIfNecessary: All tasks of command
'd74476b7-e512-4a56-ab30-dbae4ec4057a' has ended -> executing
'endAction'
2018-08-15 06:31:31,179+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-16) []
CommandAsyncTask::endAction: Ending action for '1' tasks (command ID:
'd74476b7-e512-4a56-ab30-dbae4ec4057a'): calling endAction '.
2018-08-15 06:31:31,180+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-16) []
SPMAsyncTask::PollTask: Polling task '736f8e97-bf2e-4532-bb59-de7475f57d86'
(Parent Command 'RemoveDisk', Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned
status 'finished', result 'success'.
2018-08-15 06:31:31,180+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5876) []
CommandAsyncTask::endCommandAction [within thread] context: Attempting to
endAction 'RemoveDisk',
2018-08-15 06:31:31,181+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-16) []
BaseAsyncTask::onTaskEndSuccess: Task
'736f8e97-bf2e-4532-bb59-de7475f57d86' (Parent Command 'RemoveDisk',
Parameters Type
'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') ended
successfully.
2018-08-15 06:31:31,183+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-16) []
CommandAsyncTask::endActionIfNecessary: All tasks of command
'8bf17c42-1292-4e4d-a3e6-beeec059638f' has ended -> executing
'endAction'
2018-08-15 06:31:31,183+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engineScheduled-Thread-16) []
CommandAsyncTask::endAction: Ending action for '1' tasks (command ID:
'8bf17c42-1292-4e4d-a3e6-beeec059638f'): calling endAction '.
2018-08-15 06:31:31,183+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5877) []
CommandAsyncTask::endCommandAction [within thread] context: Attempting to
endAction 'RemoveDisk',
2018-08-15 06:31:31,185+08 INFO
[org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand]
(EE-ManagedThreadFactory-engine-Thread-5876) [790b75cc] Ending command
'org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand' successfully.
2018-08-15 06:31:31,188+08 INFO
[org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand]
(EE-ManagedThreadFactory-engine-Thread-5877) [2bf8691e] Ending command
'org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand' successfully.
2018-08-15 06:31:31,190+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5876) [790b75cc]
CommandAsyncTask::HandleEndActionResult [within thread]: endAction for
action type 'RemoveDisk' completed, handling the result.
2018-08-15 06:31:31,190+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5876) [790b75cc]
CommandAsyncTask::HandleEndActionResult [within thread]: endAction for
action type 'RemoveDisk' succeeded, clearing tasks.
2018-08-15 06:31:31,190+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5876) [790b75cc]
SPMAsyncTask::ClearAsyncTask: Attempting to clear task
'cef7b7dd-ea68-4fa4-9603-ff81f1105dd5'
2018-08-15 06:31:31,190+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5876) [790b75cc] START,
SPMClearTaskVDSCommand(
SPMTaskGuidBaseVDSCommandParameters:{storagePoolId='4e05a820-9faf-11e8-ad4e-00163e6e2f69',
ignoreFailoverLimit='false',
taskId='cef7b7dd-ea68-4fa4-9603-ff81f1105dd5'}), log id: 17450a43
2018-08-15 06:31:31,191+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5877) [2bf8691e]
CommandAsyncTask::HandleEndActionResult [within thread]: endAction for
action type 'RemoveDisk' completed, handling the result.
2018-08-15 06:31:31,191+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5877) [2bf8691e]
CommandAsyncTask::HandleEndActionResult [within thread]: endAction for
action type 'RemoveDisk' succeeded, clearing tasks.
2018-08-15 06:31:31,191+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5877) [2bf8691e]
SPMAsyncTask::ClearAsyncTask: Attempting to clear task
'736f8e97-bf2e-4532-bb59-de7475f57d86'
2018-08-15 06:31:31,191+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5876) [790b75cc] START,
HSMClearTaskVDSCommand(HostName = h4,
HSMTaskGuidBaseVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
taskId='cef7b7dd-ea68-4fa4-9603-ff81f1105dd5'}), log id: 817b10d
2018-08-15 06:31:31,192+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5877) [2bf8691e] START,
SPMClearTaskVDSCommand(
SPMTaskGuidBaseVDSCommandParameters:{storagePoolId='4e05a820-9faf-11e8-ad4e-00163e6e2f69',
ignoreFailoverLimit='false',
taskId='736f8e97-bf2e-4532-bb59-de7475f57d86'}), log id: 4eb5cbde
2018-08-15 06:31:31,198+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5876) [790b75cc] FINISH,
HSMClearTaskVDSCommand, log id: 817b10d
2018-08-15 06:31:31,198+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5876) [790b75cc] FINISH,
SPMClearTaskVDSCommand, log id: 17450a43
2018-08-15 06:31:31,198+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5877) [2bf8691e] START,
HSMClearTaskVDSCommand(HostName = h4,
HSMTaskGuidBaseVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
taskId='736f8e97-bf2e-4532-bb59-de7475f57d86'}), log id: 57b4b85e
2018-08-15 06:31:31,200+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5876) [790b75cc]
BaseAsyncTask::removeTaskFromDB: Removed task
'cef7b7dd-ea68-4fa4-9603-ff81f1105dd5' from DataBase
2018-08-15 06:31:31,200+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5876) [790b75cc]
CommandAsyncTask::HandleEndActionResult [within thread]: Removing
CommandMultiAsyncTasks object for entity
'd74476b7-e512-4a56-ab30-dbae4ec4057a'
2018-08-15 06:31:31,203+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5877) [2bf8691e] FINISH,
HSMClearTaskVDSCommand, log id: 57b4b85e
2018-08-15 06:31:31,204+08 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5877) [2bf8691e] FINISH,
SPMClearTaskVDSCommand, log id: 4eb5cbde
2018-08-15 06:31:31,206+08 INFO
[org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5877) [2bf8691e]
BaseAsyncTask::removeTaskFromDB: Removed task
'736f8e97-bf2e-4532-bb59-de7475f57d86' from DataBase
2018-08-15 06:31:31,206+08 INFO
[org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
(EE-ManagedThreadFactory-engine-Thread-5877) [2bf8691e]
CommandAsyncTask::HandleEndActionResult [within thread]: Removing
CommandMultiAsyncTasks object for entity
'8bf17c42-1292-4e4d-a3e6-beeec059638f'
2018-08-15 06:31:53,480+08 INFO [org.ovirt.engine.core.bll.RunVmCommand]
(default task-80) [bb8b67ea-c0fb-44ce-b7b3-3116c7c7d835] Lock Acquired to
object
'EngineLock:{exclusiveLocks='[8471050b-7dda-466f-aecb-5b35e4aa8d2f=VM]',
sharedLocks=''}'
2018-08-15 06:31:53,502+08 INFO
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default
task-80) [bb8b67ea-c0fb-44ce-b7b3-3116c7c7d835] START,
IsVmDuringInitiatingVDSCommand(
IsVmDuringInitiatingVDSCommandParameters:{vmId='8471050b-7dda-466f-aecb-5b35e4aa8d2f'}),
log id: 32034a6f
2018-08-15 06:31:53,503+08 INFO
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default
task-80) [bb8b67ea-c0fb-44ce-b7b3-3116c7c7d835] FINISH,
IsVmDuringInitiatingVDSCommand, return: false, log id: 32034a6f
2018-08-15 06:31:53,546+08 INFO [org.ovirt.engine.core.bll.RunVmCommand]
(EE-ManagedThreadFactory-engine-Thread-5882)
[bb8b67ea-c0fb-44ce-b7b3-3116c7c7d835] Running command: RunVmCommand
internal: false. Entities affected : ID:
8471050b-7dda-466f-aecb-5b35e4aa8d2f Type: VMAction group RUN_VM with role
type USER
2018-08-15 06:31:53,573+08 INFO
[org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5882)
[bb8b67ea-c0fb-44ce-b7b3-3116c7c7d835] START,
UpdateVmDynamicDataVDSCommand(
UpdateVmDynamicDataVDSCommandParameters:{hostId='null',
vmId='8471050b-7dda-466f-aecb-5b35e4aa8d2f',
vmDynamic='org.ovirt.engine.core.common.businessentities.VmDynamic@3a1e1008'}),
log id: 6ae1eac3
2018-08-15 06:31:53,575+08 INFO
[org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5882)
[bb8b67ea-c0fb-44ce-b7b3-3116c7c7d835] FINISH,
UpdateVmDynamicDataVDSCommand, log id: 6ae1eac3
2018-08-15 06:31:53,577+08 INFO
[org.ovirt.engine.core.vdsbroker.CreateVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5882)
[bb8b67ea-c0fb-44ce-b7b3-3116c7c7d835] START, CreateVDSCommand(
CreateVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
vmId='8471050b-7dda-466f-aecb-5b35e4aa8d2f', vm='VM [win10_liug]'}), log
id: 22f8dbb6
2018-08-15 06:31:53,578+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5882)
[bb8b67ea-c0fb-44ce-b7b3-3116c7c7d835] START,
CreateBrokerVDSCommand(HostName = h4,
CreateVDSCommandParameters:{hostId='a8f6210a-fce4-4fec-bb87-4ccddb82a232',
vmId='8471050b-7dda-466f-aecb-5b35e4aa8d2f', vm='VM [win10_liug]'}), log
id: 1edb8509
2018-08-15 06:31:53,588+08 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-5882)
[bb8b67ea-c0fb-44ce-b7b3-3116c7c7d835] VM <?xml version="1.0"
encoding="UTF-8"?><domain type="kvm" xmlns:ovirt-tune="
http://ovirt.org/vm/tune/1.0"
xmlns:ovirt-vm="http://ovirt.org/vm/1.0">
<name>win10_liug</name>
<uuid>8471050b-7dda-466f-aecb-5b35e4aa8d2f</uuid>
<memory>3145728</memory>
<currentMemory>3145728</currentMemory>
<iothreads>1</iothreads>
<maxMemory slots="16">12582912</maxMemory>
<vcpu current="2">16</vcpu>
<sysinfo type="smbios">
<system>
<entry name="manufacturer">oVirt</entry>
<entry name="product">OS-NAME:</entry>
<entry name="version">OS-VERSION:</entry>
<entry name="serial">HOST-SERIAL:</entry>
<entry
name="uuid">8471050b-7dda-466f-aecb-5b35e4aa8d2f</entry>
</system>
</sysinfo>
<clock offset="variable" adjustment="3600">
<timer name="hypervclock" present="yes"/>
<timer name="rtc" tickpolicy="catchup"/>
<timer name="pit" tickpolicy="delay"/>
<timer name="hpet" present="no"/>
</clock>
<features>
<acpi/>
<hyperv>
<relaxed state="on"/>
<vapic state="on"/>
<spinlocks state="on" retries="8191"/>
</hyperv>
</features>
<cpu match="exact">
<model>Haswell</model>
<topology cores="1" threads="1" sockets="16"/>
<numa>
<cell id="0" cpus="0,1" memory="3145728"/>
</numa>
</cpu>
<cputune/>
<devices>
<input type="tablet" bus="usb"/>
<channel type="unix">
<target type="virtio" name="ovirt-guest-agent.0"/>
<source mode="bind"
path="/var/lib/libvirt/qemu/channels/8471050b-7dda-466f-aecb-5b35e4aa8d2f.ovirt-guest-agent.0"/>
</channel>
<channel type="unix">
<target type="virtio" name="org.qemu.guest_agent.0"/>
<source mode="bind"
path="/var/lib/libvirt/qemu/channels/8471050b-7dda-466f-aecb-5b35e4aa8d2f.org.qemu.guest_agent.0"/>
</channel>
<controller type="scsi" model="virtio-scsi"
index="0">
<driver iothread="1"/>
<alias name="ua-03e3abbd-cf49-4f89-9d70-e44c15a54e57"/>
<address bus="0x00" domain="0x0000" function="0x0"
slot="0x04"
type="pci"/>
</controller>
<video>
<model type="qxl" vram="8192" heads="1"
ram="65536" vgamem="16384"/>
<alias name="ua-0e78fe1f-decf-4f70-a623-d70f533556a5"/>
<address bus="0x00" domain="0x0000" function="0x0"
slot="0x02"
type="pci"/>
</video>
<controller type="usb" model="piix3-uhci"
index="0">
<address bus="0x00" domain="0x0000" function="0x2"
slot="0x01"
type="pci"/>
</controller>
<graphics type="vnc" port="-1" autoport="yes"
passwd="*****"
passwdValidTo="1970-01-01T00:00:01" keymap="en-us">
<listen type="network" network="vdsm-wan"/>
</graphics>
<controller type="ide">
<address bus="0x00" domain="0x0000" function="0x1"
slot="0x01"
type="pci"/>
</controller>
<controller type="virtio-serial" index="0"
ports="16">
<alias name="ua-c97f1593-773c-4f30-be1e-0f7dc12fca1b"/>
<address bus="0x00" domain="0x0000" function="0x0"
slot="0x05"
type="pci"/>
</controller>
<rng model="virtio">
<backend model="random">/dev/urandom</backend>
<alias name="ua-e6cbd1fb-394d-467b-9c35-0636fbe07faf"/>
</rng>
<memballoon model="none"/>
<interface type="bridge">
<model type="virtio"/>
<link state="up"/>
<source bridge="tvlan2870"/>
<driver queues="2" name="vhost"/>
<alias name="ua-44bae05b-6547-4f70-b66f-f6e1b70089e2"/>
<address bus="0x00" domain="0x0000" function="0x0"
slot="0x03"
type="pci"/>
<mac address="00:1a:4a:16:01:17"/>
<mtu size="1500"/>
<filterref filter="vdsm-no-mac-spoofing"/>
<bandwidth/>
</interface>
<disk type="file" device="cdrom" snapshot="no">
<driver name="qemu" type="raw"
error_policy="report"/>
<source file="" startupPolicy="optional"/>
<target dev="hdc" bus="ide"/>
<readonly/>
<alias name="ua-2f925984-53c1-41c3-8878-6f02bc495c62"/>
<address bus="1" controller="0" unit="0"
type="drive" target="0"/>
</disk>
<disk snapshot="no" type="block" device="disk">
<target dev="sda" bus="scsi"/>
<source
dev="/rhev/data-center/mnt/blockSD/de72f436-2d2f-4478-b962-fcae0070d400/images/0348e1f1-ed58-48ea-ae07-f5177f59b48c/7517e930-673e-49b3-9901-81bce3f94375"/>
<driver name="qemu" io="native" type="qcow2"
error_policy="stop"
cache="none"/>
<alias name="ua-0348e1f1-ed58-48ea-ae07-f5177f59b48c"/>
<address bus="0" controller="0" unit="0"
type="drive" target="0"/>
<boot order="1"/>