Hi,

We're running oVirt 4.1.9, today I put a host on maintenance, I saw one of the VMs was taking too long to migrate so I shut it down. It seems that just in that moment the machine ended migrating, but the shutdown did happen as well.

Now, when I try to start the VM I'm getting the following error:

2018-03-21 12:31:02,309Z ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler3) [7985a4e2] EVENT_ID: VM_DOWN_ERROR(119), Correlation ID: null, Call Stack: null, Custom ID: null, Custom Event ID: -1, Message: VM openmaint.iaas.domain.com is down with error. Exit message: Bad volume specification {'index': '0', u'domainID': u'04cb5bd0-d94e-4d14-a71a-e63a669e11b9', 'reqsize': '0', u'format': u'cow', u'optional': u'false', u'address': {u'function': u'0x0', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'slot': u'0x06'}, u'volumeID': u'68ee7a04-ceff-49f0-bf91-256870543921', 'apparentsize': '3221225472', u'imageID': u'9d087e6b-0832-46db-acb0-16d5131afa0c', u'discard': False, u'specParams': {}, u'readonly': u'false', u'iface': u'virtio', u'deviceId': u'9d087e6b-0832-46db-acb0-16d5131afa0c', 'truesize': '3221225472', u'poolID': u'75bf8f48-970f-42bc-8596-f8ab6efb2b63', u'device': u'disk', u'shared': u'false', u'propagateErrors': u'off', u'type': u'disk'}.

It looks quite bad... I'm attaching the engine.log since the moment I start the VM.

Is there anything I can do to recover the VM? oVirt says the disk is OK in the 'Disks' tab.

Thanks.
2018-03-21 12:30:39,539Z INFO  [org.ovirt.engine.core.bll.RunVmCommand] 
(default task-151) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] Lock Acquired to 
object 'EngineLock:{exclusiveLocks='[f503b710-7165-415b-a567-16251da7212d=VM]', 
sharedLocks=''}'
2018-03-21 12:30:39,645Z INFO  
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default 
task-151) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] START, 
IsVmDuringInitiatingVDSCommand( 
IsVmDuringInitiatingVDSCommandParameters:{runAsync='true', 
vmId='f503b710-7165-415b-a567-16251da7212d'}), log id: 15ef3c8a
2018-03-21 12:30:39,645Z INFO  
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default 
task-151) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] FINISH, 
IsVmDuringInitiatingVDSCommand, return: false, log id: 15ef3c8a
2018-03-21 12:30:39,792Z INFO  
[org.ovirt.engine.core.bll.scheduling.SchedulingManager] (default task-151) 
[429d4c9e-f77d-4fad-951c-08a6b7751bd6] Candidate host 'kvmr05.domain.com' 
('f7ab19fe-5192-4a22-88cf-c8d019fa0372') was filtered out by 
'VAR__FILTERTYPE__INTERNAL' filter 'Memory' (correlation id: null)
2018-03-21 12:30:39,863Z INFO  [org.ovirt.engine.core.bll.RunVmCommand] 
(org.ovirt.thread.pool-6-thread-46) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] 
Running command: RunVmCommand internal: false. Entities affected :  ID: 
f503b710-7165-415b-a567-16251da7212d Type: VMAction group RUN_VM with role type 
USER
2018-03-21 12:30:39,870Z INFO  [org.ovirt.engine.core.bll.RunVmCommand] 
(org.ovirt.thread.pool-6-thread-46) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] 
Emulated machine 'pc-i440fx-rhel7.3.0' selected since Custom Compatibility 
Version is set for 'VM [openmaint.iaas.domain.com]'
2018-03-21 12:30:39,979Z INFO  
[org.ovirt.engine.core.bll.scheduling.SchedulingManager] 
(org.ovirt.thread.pool-6-thread-46) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] 
Candidate host 'kvmr05.domain.com' ('f7ab19fe-5192-4a22-88cf-c8d019fa0372') was 
filtered out by 'VAR__FILTERTYPE__INTERNAL' filter 'Memory' (correlation id: 
429d4c9e-f77d-4fad-951c-08a6b7751bd6)
2018-03-21 12:30:40,032Z INFO  
[org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] 
(org.ovirt.thread.pool-6-thread-46) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] 
START, UpdateVmDynamicDataVDSCommand( 
UpdateVmDynamicDataVDSCommandParameters:{runAsync='true', hostId='null', 
vmId='f503b710-7165-415b-a567-16251da7212d', 
vmDynamic='org.ovirt.engine.core.common.businessentities.VmDynamic@db93365b'}), 
log id: 141aa350
2018-03-21 12:30:40,037Z INFO  
[org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] 
(org.ovirt.thread.pool-6-thread-46) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] 
FINISH, UpdateVmDynamicDataVDSCommand, log id: 141aa350
2018-03-21 12:30:40,040Z INFO  
[org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] 
(org.ovirt.thread.pool-6-thread-46) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] 
START, CreateVmVDSCommand( CreateVmVDSCommandParameters:{runAsync='true', 
hostId='b2dfb945-d767-44aa-a547-2d1a4381f8e3', 
vmId='f503b710-7165-415b-a567-16251da7212d', vm='VM 
[openmaint.iaas.domain.com]'}), log id: 3435053c
2018-03-21 12:30:40,046Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] 
(org.ovirt.thread.pool-6-thread-46) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] 
START, CreateVDSCommand(HostName = kvmr04.domain.com, 
CreateVmVDSCommandParameters:{runAsync='true', 
hostId='b2dfb945-d767-44aa-a547-2d1a4381f8e3', 
vmId='f503b710-7165-415b-a567-16251da7212d', vm='VM 
[openmaint.iaas.domain.com]'}), log id: 39d5e20a
2018-03-21 12:30:40,071Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] 
(org.ovirt.thread.pool-6-thread-46) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] VM 
{memGuaranteedSize=2048, smpThreadsPerCore=1, cpuType=Nehalem, 
vmId=f503b710-7165-415b-a567-16251da7212d, acpiEnable=true, tabletEnable=true, 
vmType=kvm, smp=4, smpCoresPerSocket=1, emulatedMachine=pc-i440fx-rhel7.3.0, 
smartcardEnable=false, guestNumaNodes=[{memory=8192, cpus=0,1,2,3, 
nodeIndex=0}], transparentHugePages=true, displayNetwork=ovirtmgmt, 
vmName=openmaint.iaas.domain.com, maxVCpus=16, kvmEnable=true, 
devices=[{address={bus=0x00, domain=0x0000, function=0x0, slot=0x02, type=pci}, 
type=video, specParams={vgamem=16384, heads=1, vram=8192, ram=65536}, 
device=qxl, deviceId=3c76b23d-6328-4a47-8c9e-5e8dc55aa6ae}, {type=graphics, 
specParams={keyMap=es}, device=vnc, 
deviceId=5eeecacb-7e33-4a5f-9cb4-17721840c1d5}, {iface=ide, shared=false, 
path=, address={bus=1, controller=0, unit=0, type=drive, target=0}, 
readonly=true, index=2, type=disk, specParams={path=}, device=cdrom, 
deviceId=8ef4a925-7575-4f4b-ad05-12d7a154cd75}, {discard=false, shared=false, 
address={bus=0x00, domain=0x0000, function=0x0, slot=0x06, type=pci}, 
imageID=9d087e6b-0832-46db-acb0-16d5131afa0c, format=cow, optional=false, 
type=disk, deviceId=9d087e6b-0832-46db-acb0-16d5131afa0c, 
domainID=04cb5bd0-d94e-4d14-a71a-e63a669e11b9, propagateErrors=off, 
iface=virtio, readonly=false, poolID=75bf8f48-970f-42bc-8596-f8ab6efb2b63, 
volumeID=68ee7a04-ceff-49f0-bf91-256870543921, specParams={}, device=disk}, 
{filter=vdsm-no-mac-spoofing, nicModel=pv, address={bus=0x00, domain=0x0000, 
function=0x0, slot=0x03, type=pci}, type=interface, specParams={inbound={}, 
outbound={}}, device=bridge, linkActive=true, 
deviceId=c50517f8-0581-4df0-a258-3c019d0896ab, macAddr=00:1a:4a:4d:dd:2e, 
network=PDIPUB1}, {address={bus=0x00, domain=0x0000, function=0x2, slot=0x01, 
type=pci}, index=0, model=piix3-uhci, type=controller, specParams={}, 
device=usb, deviceId=e8d84e0f-ed0c-4700-be03-c9f575048758}, {address={bus=0x00, 
function=0x0, domain=0x0000, slot=0x07, type=pci}, type=balloon, 
specParams={model=virtio}, device=memballoon, 
deviceId=bfc20052-5912-42fa-9cb2-853bedd4c0c8}, {address={bus=0x00, 
domain=0x0000, function=0x0, slot=0x04, type=pci}, index=0, model=virtio-scsi, 
type=controller, specParams={}, device=scsi, 
deviceId=7c259e11-6f9d-41ae-b68b-cbd694d55c52}, {address={bus=0x00, 
domain=0x0000, function=0x0, slot=0x05, type=pci}, type=controller, 
specParams={}, device=virtio-serial, 
deviceId=95f027a3-e5ff-4008-b52e-ab8d1a12ccde}], 
custom={device_0d6bf039-1576-42a2-a319-5724d77d99b9device_2cd2ade8-f056-4ba7-8fc7-536370820001device_74f4dc77-eb89-4f66-bfd2-20e1896c9a88=VmDevice:{id='VmDeviceId:{deviceId='74f4dc77-eb89-4f66-bfd2-20e1896c9a88',
 vmId='f503b710-7165-415b-a567-16251da7212d'}', device='unix', type='CHANNEL', 
bootOrder='0', specParams='[]', address='{bus=0, controller=0, 
type=virtio-serial, port=2}', managed='false', plugged='true', 
readOnly='false', deviceAlias='channel1', customProperties='[]', 
snapshotId='null', logicalName='null', hostDevice='null'}, 
device_0d6bf039-1576-42a2-a319-5724d77d99b9device_2cd2ade8-f056-4ba7-8fc7-536370820001device_74f4dc77-eb89-4f66-bfd2-20e1896c9a88device_e533a76d-c803-47b5-96d7-534ea8ffd90b=VmDevice:{id='VmDeviceId:{deviceId='e533a76d-c803-47b5-96d7-534ea8ffd90b',
 vmId='f503b710-7165-415b-a567-16251da7212d'}', device='tablet', 
type='UNKNOWN', bootOrder='0', specParams='[]', address='{bus=0, type=usb, 
port=1}', managed='false', plugged='true', readOnly='false', 
deviceAlias='input0', customProperties='[]', snapshotId='null', 
logicalName='null', hostDevice='null'}, 
device_0d6bf039-1576-42a2-a319-5724d77d99b9device_2cd2ade8-f056-4ba7-8fc7-536370820001=VmDevice:{id='VmDeviceId:{deviceId='2cd2ade8-f056-4ba7-8fc7-536370820001',
 vmId='f503b710-7165-415b-a567-16251da7212d'}', device='unix', type='CHANNEL', 
bootOrder='0', specParams='[]', address='{bus=0, controller=0, 
type=virtio-serial, port=1}', managed='false', plugged='true', 
readOnly='false', deviceAlias='channel0', customProperties='[]', 
snapshotId='null', logicalName='null', hostDevice='null'}, 
device_0d6bf039-1576-42a2-a319-5724d77d99b9=VmDevice:{id='VmDeviceId:{deviceId='0d6bf039-1576-42a2-a319-5724d77d99b9',
 vmId='f503b710-7165-415b-a567-16251da7212d'}', device='ide', 
type='CONTROLLER', bootOrder='0', specParams='[]', address='{slot=0x01, 
bus=0x00, domain=0x0000, type=pci, function=0x1}', managed='false', 
plugged='true', readOnly='false', deviceAlias='ide', customProperties='[]', 
snapshotId='null', logicalName='null', hostDevice='null'}}, display=vnc, 
timeOffset=0, nice=0, maxMemSize=32768, maxMemSlots=16, bootMenuEnable=false, 
memSize=8192}
2018-03-21 12:30:40,117Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] 
(org.ovirt.thread.pool-6-thread-46) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] 
FINISH, CreateVDSCommand, log id: 39d5e20a
2018-03-21 12:30:40,127Z INFO  
[org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] 
(org.ovirt.thread.pool-6-thread-46) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] 
FINISH, CreateVmVDSCommand, return: WaitForLaunch, log id: 3435053c
2018-03-21 12:30:40,127Z INFO  [org.ovirt.engine.core.bll.RunVmCommand] 
(org.ovirt.thread.pool-6-thread-46) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] Lock 
freed to object 
'EngineLock:{exclusiveLocks='[f503b710-7165-415b-a567-16251da7212d=VM]', 
sharedLocks=''}'
2018-03-21 12:30:40,139Z INFO  
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] 
(org.ovirt.thread.pool-6-thread-46) [429d4c9e-f77d-4fad-951c-08a6b7751bd6] 
EVENT_ID: USER_STARTED_VM(153), Correlation ID: 
429d4c9e-f77d-4fad-951c-08a6b7751bd6, Job ID: 
fa0db299-208f-465d-9a9e-e23378fd55b0, Call Stack: null, Custom ID: null, Custom 
Event ID: -1, Message: VM openmaint.iaas.domain.com was started by 
admin@internal (Host: kvmr04.domain.com).
2018-03-21 12:30:40,528Z INFO  
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] 
(ForkJoinPool-1-worker-13) [] VM 'f503b710-7165-415b-a567-16251da7212d' was 
reported as Down on VDS 
'b2dfb945-d767-44aa-a547-2d1a4381f8e3'(kvmr04.domain.com)
2018-03-21 12:30:40,529Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] 
(ForkJoinPool-1-worker-13) [] START, DestroyVDSCommand(HostName = 
kvmr04.domain.com, DestroyVmVDSCommandParameters:{runAsync='true', 
hostId='b2dfb945-d767-44aa-a547-2d1a4381f8e3', 
vmId='f503b710-7165-415b-a567-16251da7212d', force='false', secondsToWait='0', 
gracefully='false', reason='', ignoreNoVm='true'}), log id: 33e1329a
2018-03-21 12:30:40,538Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] 
(ForkJoinPool-1-worker-13) [] FINISH, DestroyVDSCommand, log id: 33e1329a
2018-03-21 12:30:40,538Z INFO  
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] 
(ForkJoinPool-1-worker-13) [] VM 
'f503b710-7165-415b-a567-16251da7212d'(openmaint.iaas.domain.com) moved from 
'WaitForLaunch' --> 'Down'
2018-03-21 12:30:40,637Z ERROR 
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] 
(ForkJoinPool-1-worker-13) [] EVENT_ID: VM_DOWN_ERROR(119), Correlation ID: 
null, Call Stack: null, Custom ID: null, Custom Event ID: -1, Message: VM 
openmaint.iaas.domain.com is down with error. Exit message: Bad volume 
specification {'index': '0', u'domainID': 
u'04cb5bd0-d94e-4d14-a71a-e63a669e11b9', 'reqsize': '0', u'format': u'cow', 
u'optional': u'false', u'address': {u'function': u'0x0', u'bus': u'0x00', 
u'domain': u'0x0000', u'type': u'pci', u'slot': u'0x06'}, u'volumeID': 
u'68ee7a04-ceff-49f0-bf91-256870543921', 'apparentsize': '3221225472', 
u'imageID': u'9d087e6b-0832-46db-acb0-16d5131afa0c', u'discard': False, 
u'specParams': {}, u'readonly': u'false', u'iface': u'virtio', u'deviceId': 
u'9d087e6b-0832-46db-acb0-16d5131afa0c', 'truesize': '3221225472', u'poolID': 
u'75bf8f48-970f-42bc-8596-f8ab6efb2b63', u'device': u'disk', u'shared': 
u'false', u'propagateErrors': u'off', u'type': u'disk'}.
2018-03-21 12:30:40,637Z INFO  
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] 
(ForkJoinPool-1-worker-13) [] add VM 
'f503b710-7165-415b-a567-16251da7212d'(openmaint.iaas.domain.com) to rerun 
treatment
2018-03-21 12:30:40,677Z ERROR 
[org.ovirt.engine.core.vdsbroker.monitoring.VmsMonitoring] 
(ForkJoinPool-1-worker-13) [] Rerun VM 'f503b710-7165-415b-a567-16251da7212d'. 
Called from VDS 'kvmr04.domain.com'
2018-03-21 12:30:40,680Z INFO  
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] 
(DefaultQuartzScheduler5) [7578992f] VM 
'5782d21b-9a7f-4265-bab1-d7272f2ef155'(AS_MM_G02_ser) moved from 'PoweringUp' 
--> 'Up'
2018-03-21 12:30:40,707Z WARN  
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] 
(org.ovirt.thread.pool-6-thread-19) [] EVENT_ID: 
USER_INITIATED_RUN_VM_FAILED(151), Correlation ID: 
429d4c9e-f77d-4fad-951c-08a6b7751bd6, Job ID: 
fa0db299-208f-465d-9a9e-e23378fd55b0, Call Stack: null, Custom ID: null, Custom 
Event ID: -1, Message: Failed to run VM openmaint.iaas.domain.com on Host 
kvmr04.domain.com.
2018-03-21 12:30:40,729Z INFO  [org.ovirt.engine.core.bll.RunVmCommand] 
(org.ovirt.thread.pool-6-thread-19) [] Lock Acquired to object 
'EngineLock:{exclusiveLocks='[f503b710-7165-415b-a567-16251da7212d=VM]', 
sharedLocks=''}'
2018-03-21 12:30:40,758Z INFO  
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] 
(DefaultQuartzScheduler5) [7578992f] EVENT_ID: USER_RUN_VM(32), Correlation ID: 
66e19322-894f-4f21-b03f-cd0e3b2a6819, Job ID: 
1b2ad9eb-0955-41c8-8f20-2d10b0885ee8, Call Stack: null, Custom ID: null, Custom 
Event ID: -1, Message: VM AS_MM_G02_ser started on Host kvmr04.domain.com
2018-03-21 12:30:40,837Z INFO  
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] 
(org.ovirt.thread.pool-6-thread-19) [] START, IsVmDuringInitiatingVDSCommand( 
IsVmDuringInitiatingVDSCommandParameters:{runAsync='true', 
vmId='f503b710-7165-415b-a567-16251da7212d'}), log id: 3b161d1e
2018-03-21 12:30:40,837Z INFO  
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] 
(org.ovirt.thread.pool-6-thread-19) [] FINISH, IsVmDuringInitiatingVDSCommand, 
return: false, log id: 3b161d1e
2018-03-21 12:30:40,970Z INFO  
[org.ovirt.engine.core.bll.scheduling.SchedulingManager] 
(org.ovirt.thread.pool-6-thread-19) [] Candidate host 'kvmr05.domain.com' 
('f7ab19fe-5192-4a22-88cf-c8d019fa0372') was filtered out by 
'VAR__FILTERTYPE__INTERNAL' filter 'Memory' (correlation id: null)
2018-03-21 12:30:40,998Z INFO  [org.ovirt.engine.core.bll.RunVmCommand] 
(org.ovirt.thread.pool-6-thread-19) [] Running command: RunVmCommand internal: 
false. Entities affected :  ID: f503b710-7165-415b-a567-16251da7212d Type: 
VMAction group RUN_VM with role type USER
2018-03-21 12:30:41,080Z INFO  [org.ovirt.engine.core.bll.RunVmCommand] 
(org.ovirt.thread.pool-6-thread-19) [] Emulated machine 'pc-i440fx-rhel7.3.0' 
selected since Custom Compatibility Version is set for 'VM 
[openmaint.iaas.domain.com]'
2018-03-21 12:30:41,168Z INFO  
[org.ovirt.engine.core.bll.scheduling.SchedulingManager] 
(org.ovirt.thread.pool-6-thread-19) [] Candidate host 'kvmr05.domain.com' 
('f7ab19fe-5192-4a22-88cf-c8d019fa0372') was filtered out by 
'VAR__FILTERTYPE__INTERNAL' filter 'Memory' (correlation id: 
429d4c9e-f77d-4fad-951c-08a6b7751bd6)
2018-03-21 12:30:41,220Z INFO  
[org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] 
(org.ovirt.thread.pool-6-thread-19) [] START, UpdateVmDynamicDataVDSCommand( 
UpdateVmDynamicDataVDSCommandParameters:{runAsync='true', hostId='null', 
vmId='f503b710-7165-415b-a567-16251da7212d', 
vmDynamic='org.ovirt.engine.core.common.businessentities.VmDynamic@bdb5566f'}), 
log id: 56f9a6a2
2018-03-21 12:30:41,225Z INFO  
[org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] 
(org.ovirt.thread.pool-6-thread-19) [] FINISH, UpdateVmDynamicDataVDSCommand, 
log id: 56f9a6a2
2018-03-21 12:30:41,228Z INFO  
[org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] 
(org.ovirt.thread.pool-6-thread-19) [] START, CreateVmVDSCommand( 
CreateVmVDSCommandParameters:{runAsync='true', 
hostId='3501f01c-709b-4364-976a-7e9ff58db6ab', 
vmId='f503b710-7165-415b-a567-16251da7212d', vm='VM 
[openmaint.iaas.domain.com]'}), log id: 27e8837e
2018-03-21 12:30:41,231Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] 
(org.ovirt.thread.pool-6-thread-19) [] START, CreateVDSCommand(HostName = 
kvmr06.domain.com, CreateVmVDSCommandParameters:{runAsync='true', 
hostId='3501f01c-709b-4364-976a-7e9ff58db6ab', 
vmId='f503b710-7165-415b-a567-16251da7212d', vm='VM 
[openmaint.iaas.domain.com]'}), log id: 39b652a6
2018-03-21 12:30:41,251Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] 
(org.ovirt.thread.pool-6-thread-19) [] VM {memGuaranteedSize=2048, 
smpThreadsPerCore=1, cpuType=Nehalem, 
vmId=f503b710-7165-415b-a567-16251da7212d, acpiEnable=true, tabletEnable=true, 
vmType=kvm, smp=4, smpCoresPerSocket=1, emulatedMachine=pc-i440fx-rhel7.3.0, 
smartcardEnable=false, guestNumaNodes=[{memory=8192, cpus=0,1,2,3, 
nodeIndex=0}], transparentHugePages=true, displayNetwork=ovirtmgmt, 
vmName=openmaint.iaas.domain.com, maxVCpus=16, kvmEnable=true, 
devices=[{address={bus=0x00, domain=0x0000, function=0x0, slot=0x02, type=pci}, 
type=video, specParams={vgamem=16384, heads=1, vram=8192, ram=65536}, 
device=qxl, deviceId=3c76b23d-6328-4a47-8c9e-5e8dc55aa6ae}, {type=graphics, 
specParams={keyMap=es}, device=vnc, 
deviceId=5eeecacb-7e33-4a5f-9cb4-17721840c1d5}, {iface=ide, shared=false, 
path=, address={bus=1, controller=0, unit=0, type=drive, target=0}, 
readonly=true, index=2, type=disk, specParams={path=}, device=cdrom, 
deviceId=8ef4a925-7575-4f4b-ad05-12d7a154cd75}, {discard=false, shared=false, 
address={bus=0x00, domain=0x0000, function=0x0, slot=0x06, type=pci}, 
imageID=9d087e6b-0832-46db-acb0-16d5131afa0c, format=cow, optional=false, 
type=disk, deviceId=9d087e6b-0832-46db-acb0-16d5131afa0c, 
domainID=04cb5bd0-d94e-4d14-a71a-e63a669e11b9, propagateErrors=off, 
iface=virtio, readonly=false, poolID=75bf8f48-970f-42bc-8596-f8ab6efb2b63, 
volumeID=68ee7a04-ceff-49f0-bf91-256870543921, specParams={}, device=disk}, 
{filter=vdsm-no-mac-spoofing, nicModel=pv, address={bus=0x00, domain=0x0000, 
function=0x0, slot=0x03, type=pci}, type=interface, specParams={inbound={}, 
outbound={}}, device=bridge, linkActive=true, 
deviceId=c50517f8-0581-4df0-a258-3c019d0896ab, macAddr=00:1a:4a:4d:dd:2e, 
network=PDIPUB1}, {address={bus=0x00, domain=0x0000, function=0x2, slot=0x01, 
type=pci}, index=0, model=piix3-uhci, type=controller, specParams={}, 
device=usb, deviceId=e8d84e0f-ed0c-4700-be03-c9f575048758}, {address={bus=0x00, 
function=0x0, domain=0x0000, slot=0x07, type=pci}, type=balloon, 
specParams={model=virtio}, device=memballoon, 
deviceId=bfc20052-5912-42fa-9cb2-853bedd4c0c8}, {address={bus=0x00, 
domain=0x0000, function=0x0, slot=0x04, type=pci}, index=0, model=virtio-scsi, 
type=controller, specParams={}, device=scsi, 
deviceId=7c259e11-6f9d-41ae-b68b-cbd694d55c52}, {address={bus=0x00, 
domain=0x0000, function=0x0, slot=0x05, type=pci}, type=controller, 
specParams={}, device=virtio-serial, 
deviceId=95f027a3-e5ff-4008-b52e-ab8d1a12ccde}], 
custom={device_0d6bf039-1576-42a2-a319-5724d77d99b9device_2cd2ade8-f056-4ba7-8fc7-536370820001device_74f4dc77-eb89-4f66-bfd2-20e1896c9a88=VmDevice:{id='VmDeviceId:{deviceId='74f4dc77-eb89-4f66-bfd2-20e1896c9a88',
 vmId='f503b710-7165-415b-a567-16251da7212d'}', device='unix', type='CHANNEL', 
bootOrder='0', specParams='[]', address='{bus=0, controller=0, 
type=virtio-serial, port=2}', managed='false', plugged='true', 
readOnly='false', deviceAlias='channel1', customProperties='[]', 
snapshotId='null', logicalName='null', hostDevice='null'}, 
device_0d6bf039-1576-42a2-a319-5724d77d99b9device_2cd2ade8-f056-4ba7-8fc7-536370820001device_74f4dc77-eb89-4f66-bfd2-20e1896c9a88device_e533a76d-c803-47b5-96d7-534ea8ffd90b=VmDevice:{id='VmDeviceId:{deviceId='e533a76d-c803-47b5-96d7-534ea8ffd90b',
 vmId='f503b710-7165-415b-a567-16251da7212d'}', device='tablet', 
type='UNKNOWN', bootOrder='0', specParams='[]', address='{bus=0, type=usb, 
port=1}', managed='false', plugged='true', readOnly='false', 
deviceAlias='input0', customProperties='[]', snapshotId='null', 
logicalName='null', hostDevice='null'}, 
device_0d6bf039-1576-42a2-a319-5724d77d99b9device_2cd2ade8-f056-4ba7-8fc7-536370820001=VmDevice:{id='VmDeviceId:{deviceId='2cd2ade8-f056-4ba7-8fc7-536370820001',
 vmId='f503b710-7165-415b-a567-16251da7212d'}', device='unix', type='CHANNEL', 
bootOrder='0', specParams='[]', address='{bus=0, controller=0, 
type=virtio-serial, port=1}', managed='false', plugged='true', 
readOnly='false', deviceAlias='channel0', customProperties='[]', 
snapshotId='null', logicalName='null', hostDevice='null'}, 
device_0d6bf039-1576-42a2-a319-5724d77d99b9=VmDevice:{id='VmDeviceId:{deviceId='0d6bf039-1576-42a2-a319-5724d77d99b9',
 vmId='f503b710-7165-415b-a567-16251da7212d'}', device='ide', 
type='CONTROLLER', bootOrder='0', specParams='[]', address='{slot=0x01, 
bus=0x00, domain=0x0000, type=pci, function=0x1}', managed='false', 
plugged='true', readOnly='false', deviceAlias='ide', customProperties='[]', 
snapshotId='null', logicalName='null', hostDevice='null'}}, display=vnc, 
timeOffset=0, nice=0, maxMemSize=32768, maxMemSlots=16, bootMenuEnable=false, 
memSize=8192}
2018-03-21 12:30:41,317Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] 
(org.ovirt.thread.pool-6-thread-19) [] FINISH, CreateVDSCommand, log id: 
39b652a6
2018-03-21 12:30:41,327Z INFO  
[org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] 
(org.ovirt.thread.pool-6-thread-19) [] FINISH, CreateVmVDSCommand, return: 
WaitForLaunch, log id: 27e8837e
2018-03-21 12:30:41,327Z INFO  [org.ovirt.engine.core.bll.RunVmCommand] 
(org.ovirt.thread.pool-6-thread-19) [] Lock freed to object 
'EngineLock:{exclusiveLocks='[f503b710-7165-415b-a567-16251da7212d=VM]', 
sharedLocks=''}'
2018-03-21 12:30:41,333Z INFO  
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] 
(org.ovirt.thread.pool-6-thread-19) [] EVENT_ID: USER_STARTED_VM(153), 
Correlation ID: 429d4c9e-f77d-4fad-951c-08a6b7751bd6, Job ID: 
fa0db299-208f-465d-9a9e-e23378fd55b0, Call Stack: null, Custom ID: null, Custom 
Event ID: -1, Message: VM openmaint.iaas.domain.com was started by 
admin@internal (Host: kvmr06.domain.com).
2018-03-21 12:30:48,505Z INFO  
[org.ovirt.engine.core.bll.scheduling.policyunits.EvenGuestDistributionBalancePolicyUnit]
 (DefaultQuartzScheduler3) [3487f436] There is no host with more than 45 
running guests, no balancing is needed
2018-03-21 12:30:48,583Z WARN  
[org.ovirt.engine.core.bll.scheduling.policyunits.EvenGuestDistributionBalancePolicyUnit]
 (DefaultQuartzScheduler3) [3487f436] There is no host with less than 40 
running guests
2018-03-21 12:30:48,583Z WARN  
[org.ovirt.engine.core.bll.scheduling.policyunits.CpuAndMemoryBalancingPolicyUnit]
 (DefaultQuartzScheduler3) [3487f436] All candidate hosts have been filtered, 
can't balance the cluster 'Cluster-Rojo' based on the CPU usage, will try 
memory based approach
2018-03-21 12:30:55,774Z INFO  
[org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher] 
(DefaultQuartzScheduler3) [59da7f2a] Fetched 50 VMs from VDS 
'3501f01c-709b-4364-976a-7e9ff58db6ab'
2018-03-21 12:30:55,788Z INFO  
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] 
(DefaultQuartzScheduler3) [59da7f2a] VM 'f503b710-7165-415b-a567-16251da7212d' 
was reported as Down on VDS 
'3501f01c-709b-4364-976a-7e9ff58db6ab'(kvmr06.domain.com)
2018-03-21 12:30:55,789Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] 
(DefaultQuartzScheduler3) [59da7f2a] START, DestroyVDSCommand(HostName = 
kvmr06.domain.com, DestroyVmVDSCommandParameters:{runAsync='true', 
hostId='3501f01c-709b-4364-976a-7e9ff58db6ab', 
vmId='f503b710-7165-415b-a567-16251da7212d', force='false', secondsToWait='0', 
gracefully='false', reason='', ignoreNoVm='true'}), log id: 52c00388
2018-03-21 12:30:55,797Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] 
(DefaultQuartzScheduler3) [59da7f2a] FINISH, DestroyVDSCommand, log id: 52c00388
2018-03-21 12:30:55,797Z INFO  
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] 
(DefaultQuartzScheduler3) [59da7f2a] VM 
'f503b710-7165-415b-a567-16251da7212d'(openmaint.iaas.domain.com) moved from 
'WaitForLaunch' --> 'Down'
2018-03-21 12:30:55,837Z ERROR 
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] 
(DefaultQuartzScheduler3) [59da7f2a] EVENT_ID: VM_DOWN_ERROR(119), Correlation 
ID: null, Call Stack: null, Custom ID: null, Custom Event ID: -1, Message: VM 
openmaint.iaas.domain.com is down with error. Exit message: Bad volume 
specification {'index': '0', u'domainID': 
u'04cb5bd0-d94e-4d14-a71a-e63a669e11b9', 'reqsize': '0', u'format': u'cow', 
u'optional': u'false', u'address': {u'function': u'0x0', u'bus': u'0x00', 
u'domain': u'0x0000', u'type': u'pci', u'slot': u'0x06'}, u'volumeID': 
u'68ee7a04-ceff-49f0-bf91-256870543921', 'apparentsize': '3221225472', 
u'imageID': u'9d087e6b-0832-46db-acb0-16d5131afa0c', u'discard': False, 
u'specParams': {}, u'readonly': u'false', u'iface': u'virtio', u'deviceId': 
u'9d087e6b-0832-46db-acb0-16d5131afa0c', 'truesize': '3221225472', u'poolID': 
u'75bf8f48-970f-42bc-8596-f8ab6efb2b63', u'device': u'disk', u'shared': 
u'false', u'propagateErrors': u'off', u'type': u'disk'}.
2018-03-21 12:30:55,838Z INFO  
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] 
(DefaultQuartzScheduler3) [59da7f2a] add VM 
'f503b710-7165-415b-a567-16251da7212d'(openmaint.iaas.domain.com) to rerun 
treatment
2018-03-21 12:30:55,916Z ERROR 
[org.ovirt.engine.core.vdsbroker.monitoring.VmsMonitoring] 
(DefaultQuartzScheduler3) [59da7f2a] Rerun VM 
'f503b710-7165-415b-a567-16251da7212d'. Called from VDS 'kvmr06.domain.com'
2018-03-21 12:30:55,947Z WARN  
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] EVENT_ID: 
USER_INITIATED_RUN_VM_FAILED(151), Correlation ID: 
429d4c9e-f77d-4fad-951c-08a6b7751bd6, Job ID: 
fa0db299-208f-465d-9a9e-e23378fd55b0, Call Stack: null, Custom ID: null, Custom 
Event ID: -1, Message: Failed to run VM openmaint.iaas.domain.com on Host 
kvmr06.domain.com.
2018-03-21 12:30:55,960Z INFO  [org.ovirt.engine.core.bll.RunVmCommand] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] Lock Acquired to object 
'EngineLock:{exclusiveLocks='[f503b710-7165-415b-a567-16251da7212d=VM]', 
sharedLocks=''}'
2018-03-21 12:30:56,059Z INFO  
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] START, 
IsVmDuringInitiatingVDSCommand( 
IsVmDuringInitiatingVDSCommandParameters:{runAsync='true', 
vmId='f503b710-7165-415b-a567-16251da7212d'}), log id: 4864709e
2018-03-21 12:30:56,059Z INFO  
[org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] FINISH, 
IsVmDuringInitiatingVDSCommand, return: false, log id: 4864709e
2018-03-21 12:30:56,177Z INFO  
[org.ovirt.engine.core.bll.scheduling.SchedulingManager] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] Candidate host 
'kvmr05.domain.com' ('f7ab19fe-5192-4a22-88cf-c8d019fa0372') was filtered out 
by 'VAR__FILTERTYPE__INTERNAL' filter 'Memory' (correlation id: null)
2018-03-21 12:30:56,217Z INFO  [org.ovirt.engine.core.bll.RunVmCommand] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] Running command: RunVmCommand 
internal: false. Entities affected :  ID: f503b710-7165-415b-a567-16251da7212d 
Type: VMAction group RUN_VM with role type USER
2018-03-21 12:30:56,309Z INFO  [org.ovirt.engine.core.bll.RunVmCommand] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] Emulated machine 
'pc-i440fx-rhel7.3.0' selected since Custom Compatibility Version is set for 
'VM [openmaint.iaas.domain.com]'
2018-03-21 12:30:56,416Z INFO  
[org.ovirt.engine.core.bll.scheduling.SchedulingManager] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] Candidate host 
'kvmr05.domain.com' ('f7ab19fe-5192-4a22-88cf-c8d019fa0372') was filtered out 
by 'VAR__FILTERTYPE__INTERNAL' filter 'Memory' (correlation id: 
429d4c9e-f77d-4fad-951c-08a6b7751bd6)
2018-03-21 12:30:56,453Z INFO  
[org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] START, 
UpdateVmDynamicDataVDSCommand( 
UpdateVmDynamicDataVDSCommandParameters:{runAsync='true', hostId='null', 
vmId='f503b710-7165-415b-a567-16251da7212d', 
vmDynamic='org.ovirt.engine.core.common.businessentities.VmDynamic@99dea016'}), 
log id: 44a8f421
2018-03-21 12:30:56,460Z INFO  
[org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] FINISH, 
UpdateVmDynamicDataVDSCommand, log id: 44a8f421
2018-03-21 12:30:56,462Z INFO  
[org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] START, CreateVmVDSCommand( 
CreateVmVDSCommandParameters:{runAsync='true', 
hostId='1828d0dc-e953-4d6a-8a95-528bb7aa849a', 
vmId='f503b710-7165-415b-a567-16251da7212d', vm='VM 
[openmaint.iaas.domain.com]'}), log id: 7bcae8aa
2018-03-21 12:30:56,466Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] START, CreateVDSCommand(HostName 
= kvmr01.domain.com, CreateVmVDSCommandParameters:{runAsync='true', 
hostId='1828d0dc-e953-4d6a-8a95-528bb7aa849a', 
vmId='f503b710-7165-415b-a567-16251da7212d', vm='VM 
[openmaint.iaas.domain.com]'}), log id: 670ba7eb
2018-03-21 12:30:56,491Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] VM {memGuaranteedSize=2048, 
smpThreadsPerCore=1, cpuType=Nehalem, 
vmId=f503b710-7165-415b-a567-16251da7212d, acpiEnable=true, tabletEnable=true, 
vmType=kvm, smp=4, smpCoresPerSocket=1, emulatedMachine=pc-i440fx-rhel7.3.0, 
smartcardEnable=false, guestNumaNodes=[{memory=8192, cpus=0,1,2,3, 
nodeIndex=0}], transparentHugePages=true, displayNetwork=ovirtmgmt, 
vmName=openmaint.iaas.domain.com, maxVCpus=16, kvmEnable=true, 
devices=[{address={bus=0x00, domain=0x0000, function=0x0, slot=0x02, type=pci}, 
type=video, specParams={vgamem=16384, heads=1, vram=8192, ram=65536}, 
device=qxl, deviceId=3c76b23d-6328-4a47-8c9e-5e8dc55aa6ae}, {type=graphics, 
specParams={keyMap=es}, device=vnc, 
deviceId=5eeecacb-7e33-4a5f-9cb4-17721840c1d5}, {iface=ide, shared=false, 
path=, address={bus=1, controller=0, unit=0, type=drive, target=0}, 
readonly=true, index=2, type=disk, specParams={path=}, device=cdrom, 
deviceId=8ef4a925-7575-4f4b-ad05-12d7a154cd75}, {discard=false, shared=false, 
address={bus=0x00, domain=0x0000, function=0x0, slot=0x06, type=pci}, 
imageID=9d087e6b-0832-46db-acb0-16d5131afa0c, format=cow, optional=false, 
type=disk, deviceId=9d087e6b-0832-46db-acb0-16d5131afa0c, 
domainID=04cb5bd0-d94e-4d14-a71a-e63a669e11b9, propagateErrors=off, 
iface=virtio, readonly=false, poolID=75bf8f48-970f-42bc-8596-f8ab6efb2b63, 
volumeID=68ee7a04-ceff-49f0-bf91-256870543921, specParams={}, device=disk}, 
{filter=vdsm-no-mac-spoofing, nicModel=pv, address={bus=0x00, domain=0x0000, 
function=0x0, slot=0x03, type=pci}, type=interface, specParams={inbound={}, 
outbound={}}, device=bridge, linkActive=true, 
deviceId=c50517f8-0581-4df0-a258-3c019d0896ab, macAddr=00:1a:4a:4d:dd:2e, 
network=PDIPUB1}, {address={bus=0x00, domain=0x0000, function=0x2, slot=0x01, 
type=pci}, index=0, model=piix3-uhci, type=controller, specParams={}, 
device=usb, deviceId=e8d84e0f-ed0c-4700-be03-c9f575048758}, {address={bus=0x00, 
function=0x0, domain=0x0000, slot=0x07, type=pci}, type=balloon, 
specParams={model=virtio}, device=memballoon, 
deviceId=bfc20052-5912-42fa-9cb2-853bedd4c0c8}, {address={bus=0x00, 
domain=0x0000, function=0x0, slot=0x04, type=pci}, index=0, model=virtio-scsi, 
type=controller, specParams={}, device=scsi, 
deviceId=7c259e11-6f9d-41ae-b68b-cbd694d55c52}, {address={bus=0x00, 
domain=0x0000, function=0x0, slot=0x05, type=pci}, type=controller, 
specParams={}, device=virtio-serial, 
deviceId=95f027a3-e5ff-4008-b52e-ab8d1a12ccde}], 
custom={device_0d6bf039-1576-42a2-a319-5724d77d99b9device_2cd2ade8-f056-4ba7-8fc7-536370820001device_74f4dc77-eb89-4f66-bfd2-20e1896c9a88=VmDevice:{id='VmDeviceId:{deviceId='74f4dc77-eb89-4f66-bfd2-20e1896c9a88',
 vmId='f503b710-7165-415b-a567-16251da7212d'}', device='unix', type='CHANNEL', 
bootOrder='0', specParams='[]', address='{bus=0, controller=0, 
type=virtio-serial, port=2}', managed='false', plugged='true', 
readOnly='false', deviceAlias='channel1', customProperties='[]', 
snapshotId='null', logicalName='null', hostDevice='null'}, 
device_0d6bf039-1576-42a2-a319-5724d77d99b9device_2cd2ade8-f056-4ba7-8fc7-536370820001device_74f4dc77-eb89-4f66-bfd2-20e1896c9a88device_e533a76d-c803-47b5-96d7-534ea8ffd90b=VmDevice:{id='VmDeviceId:{deviceId='e533a76d-c803-47b5-96d7-534ea8ffd90b',
 vmId='f503b710-7165-415b-a567-16251da7212d'}', device='tablet', 
type='UNKNOWN', bootOrder='0', specParams='[]', address='{bus=0, type=usb, 
port=1}', managed='false', plugged='true', readOnly='false', 
deviceAlias='input0', customProperties='[]', snapshotId='null', 
logicalName='null', hostDevice='null'}, 
device_0d6bf039-1576-42a2-a319-5724d77d99b9device_2cd2ade8-f056-4ba7-8fc7-536370820001=VmDevice:{id='VmDeviceId:{deviceId='2cd2ade8-f056-4ba7-8fc7-536370820001',
 vmId='f503b710-7165-415b-a567-16251da7212d'}', device='unix', type='CHANNEL', 
bootOrder='0', specParams='[]', address='{bus=0, controller=0, 
type=virtio-serial, port=1}', managed='false', plugged='true', 
readOnly='false', deviceAlias='channel0', customProperties='[]', 
snapshotId='null', logicalName='null', hostDevice='null'}, 
device_0d6bf039-1576-42a2-a319-5724d77d99b9=VmDevice:{id='VmDeviceId:{deviceId='0d6bf039-1576-42a2-a319-5724d77d99b9',
 vmId='f503b710-7165-415b-a567-16251da7212d'}', device='ide', 
type='CONTROLLER', bootOrder='0', specParams='[]', address='{slot=0x01, 
bus=0x00, domain=0x0000, type=pci, function=0x1}', managed='false', 
plugged='true', readOnly='false', deviceAlias='ide', customProperties='[]', 
snapshotId='null', logicalName='null', hostDevice='null'}}, display=vnc, 
timeOffset=0, nice=0, maxMemSize=32768, maxMemSlots=16, bootMenuEnable=false, 
memSize=8192}
2018-03-21 12:30:56,508Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] FINISH, CreateVDSCommand, log 
id: 670ba7eb
2018-03-21 12:30:56,522Z INFO  
[org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] FINISH, CreateVmVDSCommand, 
return: WaitForLaunch, log id: 7bcae8aa
2018-03-21 12:30:56,522Z INFO  [org.ovirt.engine.core.bll.RunVmCommand] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] Lock freed to object 
'EngineLock:{exclusiveLocks='[f503b710-7165-415b-a567-16251da7212d=VM]', 
sharedLocks=''}'
2018-03-21 12:30:56,528Z INFO  
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] 
(org.ovirt.thread.pool-6-thread-29) [59da7f2a] EVENT_ID: USER_STARTED_VM(153), 
Correlation ID: 429d4c9e-f77d-4fad-951c-08a6b7751bd6, Job ID: 
fa0db299-208f-465d-9a9e-e23378fd55b0, Call Stack: null, Custom ID: null, Custom 
Event ID: -1, Message: VM openmaint.iaas.domain.com was started by 
admin@internal (Host: kvmr01.domain.com).
2018-03-21 12:31:02,146Z INFO  
[org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher] 
(DefaultQuartzScheduler3) [7985a4e2] Fetched 50 VMs from VDS 
'1828d0dc-e953-4d6a-8a95-528bb7aa849a'
2018-03-21 12:31:02,163Z INFO  
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] 
(DefaultQuartzScheduler3) [7985a4e2] VM 'f503b710-7165-415b-a567-16251da7212d' 
was reported as Down on VDS 
'1828d0dc-e953-4d6a-8a95-528bb7aa849a'(kvmr01.domain.com)
2018-03-21 12:31:02,164Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] 
(DefaultQuartzScheduler3) [7985a4e2] START, DestroyVDSCommand(HostName = 
kvmr01.domain.com, DestroyVmVDSCommandParameters:{runAsync='true', 
hostId='1828d0dc-e953-4d6a-8a95-528bb7aa849a', 
vmId='f503b710-7165-415b-a567-16251da7212d', force='false', secondsToWait='0', 
gracefully='false', reason='', ignoreNoVm='true'}), log id: 626343ea
2018-03-21 12:31:02,172Z INFO  
[org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] 
(DefaultQuartzScheduler3) [7985a4e2] FINISH, DestroyVDSCommand, log id: 626343ea
2018-03-21 12:31:02,172Z INFO  
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] 
(DefaultQuartzScheduler3) [7985a4e2] VM 
'f503b710-7165-415b-a567-16251da7212d'(openmaint.iaas.domain.com) moved from 
'WaitForLaunch' --> 'Down'
2018-03-21 12:31:02,309Z ERROR 
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] 
(DefaultQuartzScheduler3) [7985a4e2] EVENT_ID: VM_DOWN_ERROR(119), Correlation 
ID: null, Call Stack: null, Custom ID: null, Custom Event ID: -1, Message: VM 
openmaint.iaas.domain.com is down with error. Exit message: Bad volume 
specification {'index': '0', u'domainID': 
u'04cb5bd0-d94e-4d14-a71a-e63a669e11b9', 'reqsize': '0', u'format': u'cow', 
u'optional': u'false', u'address': {u'function': u'0x0', u'bus': u'0x00', 
u'domain': u'0x0000', u'type': u'pci', u'slot': u'0x06'}, u'volumeID': 
u'68ee7a04-ceff-49f0-bf91-256870543921', 'apparentsize': '3221225472', 
u'imageID': u'9d087e6b-0832-46db-acb0-16d5131afa0c', u'discard': False, 
u'specParams': {}, u'readonly': u'false', u'iface': u'virtio', u'deviceId': 
u'9d087e6b-0832-46db-acb0-16d5131afa0c', 'truesize': '3221225472', u'poolID': 
u'75bf8f48-970f-42bc-8596-f8ab6efb2b63', u'device': u'disk', u'shared': 
u'false', u'propagateErrors': u'off', u'type': u'disk'}.
2018-03-21 12:31:02,309Z INFO  
[org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] 
(DefaultQuartzScheduler3) [7985a4e2] add VM 
'f503b710-7165-415b-a567-16251da7212d'(openmaint.iaas.domain.com) to rerun 
treatment
2018-03-21 12:31:02,393Z ERROR 
[org.ovirt.engine.core.vdsbroker.monitoring.VmsMonitoring] 
(DefaultQuartzScheduler3) [7985a4e2] Rerun VM 
'f503b710-7165-415b-a567-16251da7212d'. Called from VDS 'kvmr01.domain.com'
2018-03-21 12:31:02,417Z WARN  
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] 
(org.ovirt.thread.pool-6-thread-6) [7985a4e2] EVENT_ID: 
USER_INITIATED_RUN_VM_FAILED(151), Correlation ID: 
429d4c9e-f77d-4fad-951c-08a6b7751bd6, Job ID: 
fa0db299-208f-465d-9a9e-e23378fd55b0, Call Stack: null, Custom ID: null, Custom 
Event ID: -1, Message: Failed to run VM openmaint.iaas.domain.com on Host 
kvmr01.domain.com.
2018-03-21 12:31:02,425Z ERROR 
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] 
(org.ovirt.thread.pool-6-thread-6) [7985a4e2] EVENT_ID: USER_FAILED_RUN_VM(54), 
Correlation ID: 429d4c9e-f77d-4fad-951c-08a6b7751bd6, Job ID: 
fa0db299-208f-465d-9a9e-e23378fd55b0, Call Stack: null, Custom ID: null, Custom 
Event ID: -1, Message: Failed to run VM openmaint.iaas.domain.com (User: 
admin@internal).
2018-03-21 12:31:02,508Z INFO  [org.ovirt.engine.core.bll.ProcessDownVmCommand] 
(org.ovirt.thread.pool-6-thread-25) [45a5a99c] Running command: 
ProcessDownVmCommand internal: true.
_______________________________________________
Users mailing list
Users@ovirt.org
http://lists.ovirt.org/mailman/listinfo/users

Reply via email to