There is an ERROR in the log. How to deal with this problem
2018-07-03 11:28:40,493+08 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (EE-ManagedThreadFactory-engineScheduled-Thread-58) [] VM '56b28418-9dcf-4d46-87fe-0dfef05bb141' was discovered as 'Down' on VDS '7902d7f8-348e-426e-a3c3-399d08b0eb1e'(tchypnode1.ecr.com)
2018-07-03 11:28:40,511+08 INFO [org.ovirt.engine.core.bll.AddUnmanagedVmsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-58) [55d6983c] Running command: AddUnmanagedVmsCommand internal: true.
2018-07-03 11:28:40,514+08 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-58) [55d6983c] START, FullListVDSCommand(HostName = tchypnode1.ecr.com, FullListVDSCommandParameters:{hostId='7902d7f8-348e-426e-a3c3-399d08b0eb1e', vmIds='[56b28418-9dcf-4d46-87fe-0dfef05bb141]'}), log id: 7f6022f8
2018-07-03 11:28:40,521+08 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-58) [55d6983c] FINISH, FullListVDSCommand, return: [{status=Down, guestFQDN=, kvmEnable=true, xml=<?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>avodev-controller</name><uuid>56b28418-9dcf-4d46-87fe-0dfef05bb141</uuid><memory>8388608</memory><currentMemory>8388608</currentMemory><maxMemory slots="16">33554432</maxMemory><vcpu current="4">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">56b28418-9dcf-4d46-87fe-0dfef05bb141</entry></system></sysinfo><clock offset="variable" adjustment="0"><timer name="rtc" tickpolicy="catchup"></timer><timer name="pit" tickpolicy="delay"></timer><timer name="hpet" present="no"></timer></clock><features><acpi></acpi></features><cpu match="exact"><model>Nehalem</model><topology cores="1" threads="1" sockets="16"></topology><numa><cell cpus="0,1,2,3" memory="8388608"></cell></numa></cpu><cputune></cputune><devices><input type="tablet" bus="usb"></input><channel type="unix"><target type="virtio" name="ovirt-guest-agent.0"></target><source mode="bind" path="/var/lib/libvirt/qemu/channels/56b28418-9dcf-4d46-87fe-0dfef05bb141.ovirt-guest-agent.0"></source></channel><channel type="unix"><target type="virtio" name="org.qemu.guest_agent.0"></target><source mode="bind" path="/var/lib/libvirt/qemu/channels/56b28418-9dcf-4d46-87fe-0dfef05bb141.org.qemu.guest_agent.0"></source></channel><controller type="scsi" model="virtio-scsi" index="0"></controller><controller type="usb" model="piix3-uhci" index="0"><address bus="0x00" domain="0x0000" function="0x2" slot="0x01" type="pci"></address></controller><controller type="virtio-serial" index="0" ports="16"><address bus="0x00" domain="0x0000" function="0x0" slot="0x04" type="pci"></address></controller><graphics type="vnc" port="-1" autoport="yes" passwd="*****" passwdValidTo="1970-01-01T00:00:01" keymap="en-us"><listen type="network" network="vdsm-ovirtmgmt"></listen></graphics><controller type="ide"><address bus="0x00" domain="0x0000" function="0x1" slot="0x01" type="pci"></address></controller><rng model="virtio"><backend model="random">/dev/urandom</backend></rng><memballoon model="virtio"><stats period="5"></stats><address bus="0x00" domain="0x0000" function="0x0" slot="0x06" type="pci"></address></memballoon><video><model type="vga" vram="16384" heads="1"></model></video><interface type="bridge"><model type="virtio"></model><link state="up"></link><source bridge="ovirtmgmt"></source><address bus="0x00" domain="0x0000" function="0x0" slot="0x03" type="pci"></address><mac address="00:1a:4a:16:01:da"></mac><filterref filter="vdsm-no-mac-spoofing"></filterref><bandwidth></bandwidth></interface><interface type="bridge"><model type="virtio"></model><link state="up"></link><source bridge="ovirtmgmt"></source><address bus="0x00" domain="0x0000" function="0x0" slot="0x07" type="pci"></address><mac address="00:1a:4a:16:01:db"></mac><filterref filter="vdsm-no-mac-spoofing"></filterref><bandwidth></bandwidth></interface><disk type="file" device="cdrom" snapshot="no"><driver name="qemu" type="raw" error_policy="report"></driver><source file="/rhev/data-center/mnt/192.168.100.59:_exports_iso/6ff100c0-d08d-4504-832d-53876bf97349/images/11111111-1111-1111-1111-111111111111/CentOS-7-x86_64-Minimal-1804.iso" startupPolicy="optional"></source><target dev="hdc" bus="ide"></target><readonly></readonly><address bus="1" controller="0" unit="0" type="drive" target="0"></address><boot order="2"></boot></disk><disk snapshot="no" type="file" device="disk"><target dev="sda" bus="scsi"></target><source file="/rhev/data-center/5b0f6949-02d6-00bf-008b-000000000167/461517fd-986a-4b39-9b84-5fd54ef06967/images/8e17d226-94d0-42f8-ae29-9c795db7e522/3b4e2ee9-ba96-4b4d-8392-94e2736e6dab"></source><driver name="qemu" io="threads" type="qcow2" error_policy="stop" cache="none"></driver><address bus="0" controller="0" unit="0" type="drive" target="0"></address><boot order="1"></boot><serial>8e17d226-94d0-42f8-ae29-9c795db7e522</serial></disk><disk snapshot="no" type="file" device="disk"><target dev="sdb" bus="scsi"></target><source file="/rhev/data-center/5b0f6949-02d6-00bf-008b-000000000167/c5a790c2-2885-4220-b803-35e4a40ecef6/images/d0a00b64-3676-4783-a7af-9bb53940b03e/a88be564-84f8-4232-9ba6-91be4625a469"></source><driver name="qemu" io="threads" type="qcow2" error_policy="stop" cache="none"></driver><address bus="0" controller="0" unit="1" type="drive" target="0"></address><serial>d0a00b64-3676-4783-a7af-9bb53940b03e</serial></disk><disk snapshot="no" type="file" device="disk"><target dev="sdc" bus="scsi"></target><source file="/rhev/data-center/5b0f6949-02d6-00bf-008b-000000000167/c5a790c2-2885-4220-b803-35e4a40ecef6/images/03352bba-9d9f-4fca-ac35-f4aa7767e0b6/26a2e47d-2b10-454a-83f4-3c3c96d27f72"></source><driver name="qemu" io="threads" type="qcow2" error_policy="stop" cache="none"></driver><address bus="0" controller="0" unit="2" type="drive" target="0"></address><serial>03352bba-9d9f-4fca-ac35-f4aa7767e0b6</serial></disk></devices><pm><suspend-to-disk enabled="no"></suspend-to-disk><suspend-to-mem enabled="no"></suspend-to-mem></pm><os><type arch="x86_64" machine="pc-i440fx-2.5">hvm</type><smbios mode="sysinfo"></smbios></os><metadata><ovirt-tune:qos></ovirt-tune:qos><ovirt-vm:vm><minGuaranteedMemoryMb type="int">4096</minGuaranteedMemoryMb><clusterVersion>4.2</clusterVersion><ovirt-vm:custom></ovirt-vm:custom><ovirt-vm:device mac_address="00:1a:4a:16:01:db"><ovirt-vm:custom></ovirt-vm:custom></ovirt-vm:device><ovirt-vm:device mac_address="00:1a:4a:16:01:da"><ovirt-vm:custom></ovirt-vm:custom></ovirt-vm:device><ovirt-vm:device devtype="disk" name="sdb"><ovirt-vm:imageID>d0a00b64-3676-4783-a7af-9bb53940b03e</ovirt-vm:imageID><ovirt-vm:poolID>5b0f6949-02d6-00bf-008b-000000000167</ovirt-vm:poolID><ovirt-vm:volumeID>a88be564-84f8-4232-9ba6-91be4625a469</ovirt-vm:volumeID><ovirt-vm:domainID>c5a790c2-2885-4220-b803-35e4a40ecef6</ovirt-vm:domainID></ovirt-vm:device><ovirt-vm:device devtype="disk" name="sda"><ovirt-vm:imageID>8e17d226-94d0-42f8-ae29-9c795db7e522</ovirt-vm:imageID><ovirt-vm:poolID>5b0f6949-02d6-00bf-008b-000000000167</ovirt-vm:poolID><ovirt-vm:volumeID>3b4e2ee9-ba96-4b4d-8392-94e2736e6dab</ovirt-vm:volumeID><ovirt-vm:domainID>461517fd-986a-4b39-9b84-5fd54ef06967</ovirt-vm:domainID></ovirt-vm:device><ovirt-vm:device devtype="disk" name="sdc"><ovirt-vm:imageID>03352bba-9d9f-4fca-ac35-f4aa7767e0b6</ovirt-vm:imageID><ovirt-vm:poolID>5b0f6949-02d6-00bf-008b-000000000167</ovirt-vm:poolID><ovirt-vm:volumeID>26a2e47d-2b10-454a-83f4-3c3c96d27f72</ovirt-vm:volumeID><ovirt-vm:domainID>c5a790c2-2885-4220-b803-35e4a40ecef6</ovirt-vm:domainID></ovirt-vm:device><launchPaused>false</launchPaused><resumeBehavior>auto_resume</resumeBehavior></ovirt-vm:vm></metadata></domain>, enableGuestEvents=true, vmId=56b28418-9dcf-4d46-87fe-0dfef05bb141, devices=[Ljava.lang.Object;@1a054604, guestDiskMapping={}, username=Unknown, vmType=kvm, smp=1, arch=x86_64, clientIp=, statusTime=7232123440, vmName=nNone, guestIPs=}], log id: 7f6022f8
2018-07-03 11:28:40,522+08 ERROR [org.ovirt.engine.core.bll.AddUnmanagedVmsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-58) [55d6983c] Command 'org.ovirt.engine.core.bll.AddUnmanagedVmsCommand' failed: null
2018-07-03 11:28:40,522+08 ERROR [org.ovirt.engine.core.bll.AddUnmanagedVmsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-58) [55d6983c] Exception: java.lang.NumberFormatException: null
at java.lang.Integer.parseInt(Integer.java:542) [rt.jar:1.8.0_161]
at java.lang.Integer.parseInt(Integer.java:615) [rt.jar:1.8.0_161]
at org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerObjectsBuilder.parseIntVdsProperty(VdsBrokerObjectsBuilder.java:777) [vdsbroker.jar:]
at org.ovirt.engine.core.bll.AddUnmanagedVmsCommand.convertVm(AddUnmanagedVmsCommand.java:121) [bll.jar:]
at org.ovirt.engine.core.bll.AddUnmanagedVmsCommand.executeCommand(AddUnmanagedVmsCommand.java:97) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase.executeWithoutTransaction(CommandBase.java:1132) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase.executeActionInTransactionScope(CommandBase.java:1272) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1914) [bll.jar:]
at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInSuppressed(TransactionSupport.java:164) [utils.jar:]
at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInScope(TransactionSupport.java:103) [utils.jar:]
at org.ovirt.engine.core.bll.CommandBase.execute(CommandBase.java:1332) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase.executeAction(CommandBase.java:406) [bll.jar:]
at org.ovirt.engine.core.bll.executor.DefaultBackendActionExecutor.execute(DefaultBackendActionExecutor.java:13) [bll.jar:]
at org.ovirt.engine.core.bll.Backend.runAction(Backend.java:468) [bll.jar:]
at org.ovirt.engine.core.bll.Backend.runActionImpl(Backend.java:450) [bll.jar:]
at org.ovirt.engine.core.bll.Backend.runInternalAction(Backend.java:656) [bll.jar:]
at sun.reflect.GeneratedMethodAccessor452.invoke(Unknown Source) [:1.8.0_161]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_161]
at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_161]
at org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.java:52)
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:509)
at org.jboss.as.weld.interceptors.Jsr299BindingsInterceptor.delegateInterception(Jsr299BindingsInterceptor.java:78)
at org.jboss.as.weld.interceptors.Jsr299BindingsInterceptor.doMethodInterception(Jsr299BindingsInterceptor.java:88)
at org.jboss.as.weld.interceptors.Jsr299BindingsInterceptor.processInvocation(Jsr299BindingsInterceptor.java:101)
at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63)
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.as.ejb3.component.invocationmetrics.ExecutionTimeInterceptor.processInvocation(ExecutionTimeInterceptor.java:43) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.as.ee.concurrent.ConcurrentContextInterceptor.processInvocation(ConcurrentContextInterceptor.java:45) [wildfly-ee-11.0.0.Final.jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:40)
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:53)
at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:52)
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.as.ejb3.component.singleton.SingletonComponentInstanceAssociationInterceptor.processInvocation(SingletonComponentInstanceAssociationInterceptor.java:53) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInNoTx(CMTTxInterceptor.java:264) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor.supports(CMTTxInterceptor.java:379) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:244) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:509)
at org.jboss.weld.ejb.AbstractEJBRequestScopeActivationInterceptor.aroundInvoke(AbstractEJBRequestScopeActivationInterceptor.java:73) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final]
at org.jboss.as.weld.ejb.EjbRequestScopeActivationInterceptor.processInvocation(EjbRequestScopeActivationInterceptor.java:89)
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.as.ejb3.component.invocationmetrics.WaitTimeInterceptor.processInvocation(WaitTimeInterceptor.java:47) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.as.ejb3.security.SecurityContextInterceptor.processInvocation(SecurityContextInterceptor.java:100) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.as.ejb3.deployment.processors.StartupAwaitInterceptor.processInvocation(StartupAwaitInterceptor.java:22) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.as.ejb3.component.interceptors.ShutDownInterceptorFactory$1.processInvocation(ShutDownInterceptorFactory.java:64) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:67) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50)
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.invocation.ContextClassLoaderInterceptor.processInvocation(ContextClassLoaderInterceptor.java:60)
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.invocation.InterceptorContext.run(InterceptorContext.java:438)
at org.wildfly.security.manager.WildFlySecurityManager.doChecked(WildFlySecurityManager.java:609)
at org.jboss.invocation.AccessCheckingInterceptor.processInvocation(AccessCheckingInterceptor.java:57)
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422)
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:53)
at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:198)
at org.jboss.as.ee.component.ViewDescription$1.processInvocation(ViewDescription.java:185)
at org.jboss.as.ee.component.ProxyInvocationHandler.invoke(ProxyInvocationHandler.java:81)
at org.ovirt.engine.core.bll.interfaces.BackendInternal$$$view3.runInternalAction(Unknown Source) [bll.jar:]
at sun.reflect.GeneratedMethodAccessor451.invoke(Unknown Source) [:1.8.0_161]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_161]
at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_161]
at org.jboss.weld.util.reflection.Reflections.invokeAndUnwrap(Reflections.java:433) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final]
at org.jboss.weld.bean.proxy.EnterpriseBeanProxyMethodHandler.invoke(EnterpriseBeanProxyMethodHandler.java:127) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final]
at org.jboss.weld.bean.proxy.EnterpriseTargetBeanInstance.invoke(EnterpriseTargetBeanInstance.java:56) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final]
at org.jboss.weld.bean.proxy.InjectionPointPropagatingEnterpriseTargetBeanInstance.invoke(InjectionPointPropagatingEnterpriseTargetBeanInstance.java:67) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final]
at org.jboss.weld.bean.proxy.ProxyMethodHandler.invoke(ProxyMethodHandler.java:100) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final]
at org.ovirt.engine.core.bll.BackendCommandObjectsHandler$BackendInternal$BackendLocal$2049259618$Proxy$_$$_Weld$EnterpriseProxy$.runInternalAction(Unknown Source) [bll.jar:]
at org.ovirt.engine.core.bll.VdsEventListener.addUnmanagedVms(VdsEventListener.java:473) [bll.jar:]
at org.ovirt.engine.core.vdsbroker.monitoring.VmsMonitoring.addUnmanagedVms(VmsMonitoring.java:326) [vdsbroker.jar:]
at org.ovirt.engine.core.vdsbroker.monitoring.VmsMonitoring.perform(VmsMonitoring.java:96) [vdsbroker.jar:]
at org.ovirt.engine.core.vdsbroker.monitoring.PollVmStatsRefresher.poll(PollVmStatsRefresher.java:43) [vdsbroker.jar:]
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [rt.jar:1.8.0_161]
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) [rt.jar:1.8.0_161]
at org.glassfish.enterprise.concurrent.internal.ManagedScheduledThreadPoolExecutor$ManagedScheduledFutureTask.access$201(ManagedScheduledThreadPoolExecutor.java:383) [javax.enterprise.concurrent-1.0.jar:]
at org.glassfish.enterprise.concurrent.internal.ManagedScheduledThreadPoolExecutor$ManagedScheduledFutureTask.run(ManagedScheduledThreadPoolExecutor.java:534) [javax.enterprise.concurrent-1.0.jar:]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [rt.jar:1.8.0_161]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [rt.jar:1.8.0_161]
at java.lang.Thread.run(Thread.java:748) [rt.jar:1.8.0_161]
at org.glassfish.enterprise.concurrent.ManagedThreadFactoryImpl$ManagedThread.run(ManagedThreadFactoryImpl.java:250) [javax.enterprise.concurrent-1.0.jar:]
at org.jboss.as.ee.concurrent.service.ElytronManagedThreadFactory$ElytronManagedThread.run(ElytronManagedThreadFactory.java:78)
2018-07-03 11:28:41,840+08 INFO [org.ovirt.engine.core.bll.RunVmCommand] (default task-65) [a2075a4a-458f-4224-820a-c3acb8d776fa] Lock Acquired to object 'EngineLock:{exclusiveLocks='[0febbdb6-9b90-4052-8169-4f6792d99d1e=VM]', sharedLocks=''}'
2018-07-03 11:28:41,871+08 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default task-65) [a2075a4a-458f-4224-820a-c3acb8d776fa] START, IsVmDuringInitiatingVDSCommand( IsVmDuringInitiatingVDSCommandParameters:{vmId='0febbdb6-9b90-4052-8169-4f6792d99d1e'}), log id: 18b64302
2018-07-03 11:28:41,871+08 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default task-65) [a2075a4a-458f-4224-820a-c3acb8d776fa] FINISH, IsVmDuringInitiatingVDSCommand, return: false, log id: 18b64302
2018-07-03 11:28:41,939+08 INFO [org.ovirt.engine.core.bll.RunVmCommand] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] Running command: RunVmCommand internal: false. Entities affected : ID: 0febbdb6-9b90-4052-8169-4f6792d99d1e Type: VMAction group RUN_VM with role type USER
2018-07-03 11:28:41,995+08 INFO [org.ovirt.engine.core.bll.scheduling.policyunits.PreferredHostsWeightPolicyUnit] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] Penalizing host 'tchypnode2.ecr.com' because it is not preferred.
2018-07-03 11:28:41,995+08 INFO [org.ovirt.engine.core.bll.scheduling.policyunits.PreferredHostsWeightPolicyUnit] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] Penalizing host 'tchypnode1.ecr.com' because it is not preferred.
2018-07-03 11:28:41,995+08 INFO [org.ovirt.engine.core.bll.scheduling.policyunits.PreferredHostsWeightPolicyUnit] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] Penalizing host 'storage2' because it is not preferred.
2018-07-03 11:28:42,004+08 INFO [org.ovirt.engine.core.bll.RunVmCommand] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] Running VM with attached cd 'CentOS-7-x86_64-Minimal-1804.iso'
2018-07-03 11:28:42,007+08 INFO [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] START, UpdateVmDynamicDataVDSCommand( UpdateVmDynamicDataVDSCommandParameters:{hostId='null', vmId='0febbdb6-9b90-4052-8169-4f6792d99d1e', vmDynamic='org.ovirt.engine.core.common.businessentities.VmDynamic@3746b80a'}), log id: 33de8399
2018-07-03 11:28:42,008+08 INFO [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] FINISH, UpdateVmDynamicDataVDSCommand, log id: 33de8399
2018-07-03 11:28:42,011+08 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.IsoPrefixVDSCommand] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] START, IsoPrefixVDSCommand(HostName = storage3, VdsAndPoolIDVDSParametersBase:{hostId='862f44c5-3529-4ef1-a2a6-2910d5b93460', storagePoolId='5b0f6949-02d6-00bf-008b-000000000167'}), log id: 39168ed2
2018-07-03 11:28:42,011+08 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.IsoPrefixVDSCommand] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] FINISH, IsoPrefixVDSCommand, return: /rhev/data-center/mnt/192.168.100.59:_exports_iso/6ff100c0-d08d-4504-832d-53876bf97349/images/11111111-1111-1111-1111-111111111111, log id: 39168ed2
2018-07-03 11:28:42,017+08 INFO [org.ovirt.engine.core.vdsbroker.CreateVDSCommand] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] START, CreateVDSCommand( CreateVDSCommandParameters:{hostId='862f44c5-3529-4ef1-a2a6-2910d5b93460', vmId='0febbdb6-9b90-4052-8169-4f6792d99d1e', vm='VM [badvm-avodev-controller]'}), log id: 72322ec5
2018-07-03 11:28:42,020+08 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] START, CreateBrokerVDSCommand(HostName = storage3, CreateVDSCommandParameters:{hostId='862f44c5-3529-4ef1-a2a6-2910d5b93460', vmId='0febbdb6-9b90-4052-8169-4f6792d99d1e', vm='VM [badvm-avodev-controller]'}), log id: 68b50b27
2018-07-03 11:28:42,024+08 INFO [org.ovirt.engine.core.vdsbroker.builder.vminfo.VmInfoBuilderImpl] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] Bootable disk '1ea736ad-164c-4ac2-a6ce-9b8e6eceefde' set to index '0'
2018-07-03 11:28:42,042+08 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] VM {memGuaranteedSize=4096, smpThreadsPerCore=1, cpuType=Nehalem, vmId=0febbdb6-9b90-4052-8169-4f6792d99d1e, acpiEnable=true, tabletEnable=true, vmType=kvm, smp=4, smpCoresPerSocket=1, emulatedMachine=pc-i440fx-2.5, smartcardEnable=false, guestNumaNodes=[{memory=8192, cpus=0,1,2,3, nodeIndex=0}], transparentHugePages=true, displayNetwork=ovirtmgmt, vmName=badvm-avodev-controller, maxVCpus=16, kvmEnable=true, devices=[{address={bus=0x00, domain=0x0000, function=0x0, slot=0x02, type=pci}, type=video, specParams={vram=16384}, device=vga, deviceId=a50622b4-d3d4-4319-ae6d-0c66848321ef}, {type=graphics, specParams={keyMap=en-us}, device=vnc, deviceId=8dd702a4-f289-4bd1-a991-74b9c7224568}, {iface=ide, shared=false, path=/rhev/data-center/mnt/192.168.100.59:_exports_iso/6ff100c0-d08d-4504-832d-53876bf97349/images/11111111-1111-1111-1111-111111111111/CentOS-7-x86_64-Minimal-1804.iso, address={bus=1, controller=0, unit=0, type=drive, target=0}, readonly=true, bootOrder=2, index=2, type=disk, specParams={path=CentOS-7-x86_64-Minimal-1804.iso}, device=cdrom, deviceId=89f6751c-9b33-4171-9dfa-e3a513ae7729}, {discard=false, shared=false, address={bus=0, controller=0, unit=0, type=drive, target=0}, imageID=1ea736ad-164c-4ac2-a6ce-9b8e6eceefde, format=cow, index=0, optional=false, type=disk, deviceId=1ea736ad-164c-4ac2-a6ce-9b8e6eceefde, domainID=461517fd-986a-4b39-9b84-5fd54ef06967, propagateErrors=off, iface=scsi, readonly=false, bootOrder=1, poolID=5b0f6949-02d6-00bf-008b-000000000167, volumeID=b7f8140f-3a34-40fd-9fec-878df3d159a4, diskType=file, specParams={}, device=disk}, {discard=false, shared=false, address={bus=0, controller=0, unit=1, type=drive, target=0}, imageID=183b3ace-64e1-49cf-a214-b5462f989171, format=cow, optional=false, type=disk, deviceId=183b3ace-64e1-49cf-a214-b5462f989171, domainID=c5a790c2-2885-4220-b803-35e4a40ecef6, propagateErrors=off, iface=scsi, readonly=false, poolID=5b0f6949-02d6-00bf-008b-000000000167, volumeID=36ea0af6-b681-4923-bf70-6b51717f372d, diskType=file, specParams={}, device=disk}, {discard=false, shared=false, address={bus=0, controller=0, unit=2, type=drive, target=0}, imageID=5866d66c-0756-4544-af6a-95f5aed9312b, format=cow, optional=false, type=disk, deviceId=5866d66c-0756-4544-af6a-95f5aed9312b, domainID=c5a790c2-2885-4220-b803-35e4a40ecef6, propagateErrors=off, iface=scsi, readonly=false, poolID=5b0f6949-02d6-00bf-008b-000000000167, volumeID=1751cd16-fd89-4441-b847-45169689c9a7, diskType=file, specParams={}, device=disk}, {filter=vdsm-no-mac-spoofing, nicModel=pv, address={bus=0x00, domain=0x0000, function=0x0, slot=0x03, type=pci}, filterParameters=[], type=interface, specParams={inbound={}, outbound={}}, device=bridge, linkActive=true, deviceId=59cdfb1f-ef08-4fee-a99b-27ad6a27c14e, macAddr=00:1a:4a:16:01:f5, network=ovirtmgmt}, {filter=vdsm-no-mac-spoofing, nicModel=pv, address={bus=0x00, domain=0x0000, function=0x0, slot=0x07, type=pci}, filterParameters=[], type=interface, specParams={inbound={}, outbound={}}, device=bridge, linkActive=true, deviceId=d3bcaa77-ef63-4371-a59f-8e9d444c9cec, macAddr=00:1a:4a:16:01:f6, network=ovirtmgmt}, {address={bus=0x00, domain=0x0000, function=0x2, slot=0x01, type=pci}, index=0, model=piix3-uhci, type=controller, specParams={}, device=usb, deviceId=05c84b2b-2f7a-4dbf-a4f4-89572562bdca}, {address={bus=0x00, domain=0x0000, function=0x0, slot=0x06, type=pci}, type=balloon, specParams={model=virtio}, device=memballoon, deviceId=0a8c9c29-575c-4bcd-b983-7c7d1b5bf020}, {index=0, model=virtio-scsi, type=controller, specParams={}, device=scsi, deviceId=cc5b8141-51ed-4a8b-9cf4-a703fa9a3dd1}, {address={bus=0x00, domain=0x0000, function=0x0, slot=0x04, type=pci}, type=controller, specParams={}, device=virtio-serial, deviceId=d2049d59-412f-4518-9e0e-22c3ead63438}, {model=virtio, type=rng, specParams={source=urandom}, device=virtio, deviceId=befbd382-3e77-4773-a3bb-766b660a4248}], custom={device_17eb478e-16dd-4d17-9f90-d978a28cc2b9device_50c094be-df54-477f-a0e2-f2ce36a2132fdevice_04a84b3e-b86b-454e-96bc-2d3151a315f6=VmDevice:{id='VmDeviceId:{deviceId='04a84b3e-b86b-454e-96bc-2d3151a315f6', vmId='0febbdb6-9b90-4052-8169-4f6792d99d1e'}', device='unix', type='CHANNEL', specParams='[]', address='{type=virtio-serial, bus=0, controller=0, port=1}', managed='false', plugged='true', readOnly='false', deviceAlias='channel0', customProperties='[]', snapshotId='null', logicalName='null', hostDevice=''}, device_17eb478e-16dd-4d17-9f90-d978a28cc2b9device_50c094be-df54-477f-a0e2-f2ce36a2132f=VmDevice:{id='VmDeviceId:{deviceId='50c094be-df54-477f-a0e2-f2ce36a2132f', vmId='0febbdb6-9b90-4052-8169-4f6792d99d1e'}', device='scsi', type='CONTROLLER', specParams='[index=0]', address='{type=pci, slot=0x05, bus=0x00, domain=0x0000, function=0x0}', managed='false', plugged='true', readOnly='false', deviceAlias='scsi0', customProperties='[]', snapshotId='null', logicalName='null', hostDevice=''}, device_17eb478e-16dd-4d17-9f90-d978a28cc2b9device_50c094be-df54-477f-a0e2-f2ce36a2132fdevice_04a84b3e-b86b-454e-96bc-2d3151a315f6device_0f1f725b-ec13-4ce4-9dfb-8882aa0b28e7=VmDevice:{id='VmDeviceId:{deviceId='0f1f725b-ec13-4ce4-9dfb-8882aa0b28e7', vmId='0febbdb6-9b90-4052-8169-4f6792d99d1e'}', device='unix', type='CHANNEL', specParams='[]', address='{type=virtio-serial, bus=0, controller=0, port=2}', managed='false', plugged='true', readOnly='false', deviceAlias='channel1', customProperties='[]', snapshotId='null', logicalName='null', hostDevice=''}, device_17eb478e-16dd-4d17-9f90-d978a28cc2b9=VmDevice:{id='VmDeviceId:{deviceId='17eb478e-16dd-4d17-9f90-d978a28cc2b9', vmId='0febbdb6-9b90-4052-8169-4f6792d99d1e'}', device='ide', type='CONTROLLER', specParams='[]', address='{type=pci, slot=0x01, bus=0x00, domain=0x0000, function=0x1}', managed='false', plugged='true', readOnly='false', deviceAlias='ide', customProperties='[]', snapshotId='null', logicalName='null', hostDevice=''}}, timeOffset=0, nice=0, maxMemSize=32768, maxMemSlots=16, bootMenuEnable=false, memSize=8192, agentChannelName=ovirt-guest-agent.0}
2018-07-03 11:28:42,056+08 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] 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>badvm-avodev-controller</name>
<uuid>0febbdb6-9b90-4052-8169-4f6792d99d1e</uuid>
<memory>8388608</memory>
<currentMemory>8388608</currentMemory>
<maxMemory slots="16">33554432</maxMemory>
<vcpu current="4">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">0febbdb6-9b90-4052-8169-4f6792d99d1e</entry>
</system>
</sysinfo>
<clock offset="variable" adjustment="0">
<timer name="rtc" tickpolicy="catchup"/>
<timer name="pit" tickpolicy="delay"/>
<timer name="hpet" present="no"/>
</clock>
<features>
<acpi/>
</features>
<cpu match="exact">
<model>Nehalem</model>
<topology cores="1" threads="1" sockets="16"/>
<numa>
<cell cpus="0,1,2,3" memory="8388608"/>
</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/0febbdb6-9b90-4052-8169-4f6792d99d1e.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/0febbdb6-9b90-4052-8169-4f6792d99d1e.org.qemu.guest_agent.0"/>
</channel>
<controller type="usb" model="piix3-uhci" index="0">
<address bus="0x00" domain="0x0000" function="0x2" slot="0x01" type="pci"/>
</controller>
<memballoon model="virtio">
<stats period="5"/>
<address bus="0x00" domain="0x0000" function="0x0" slot="0x06" type="pci"/>
</memballoon>
<controller type="ide">
<address bus="0x00" domain="0x0000" function="0x1" slot="0x01" type="pci"/>
</controller>
<controller type="scsi" index="0">
<address bus="0x00" domain="0x0000" function="0x0" slot="0x05" 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-ovirtmgmt"/>
</graphics>
<video>
<model type="vga" vram="16384" heads="1"/>
<address bus="0x00" domain="0x0000" function="0x0" slot="0x02" type="pci"/>
</video>
<rng model="virtio">
<backend model="random">/dev/urandom</backend>
</rng>
<controller type="virtio-serial" index="0" ports="16">
<address bus="0x00" domain="0x0000" function="0x0" slot="0x04" type="pci"/>
</controller>
<interface type="bridge">
<model type="virtio"/>
<link state="up"/>
<source bridge="ovirtmgmt"/>
<address bus="0x00" domain="0x0000" function="0x0" slot="0x03" type="pci"/>
<mac address="00:1a:4a:16:01:f5"/>
<filterref filter="vdsm-no-mac-spoofing"/>
<bandwidth/>
</interface>
<interface type="bridge">
<model type="virtio"/>
<link state="up"/>
<source bridge="ovirtmgmt"/>
<address bus="0x00" domain="0x0000" function="0x0" slot="0x07" type="pci"/>
<mac address="00:1a:4a:16:01:f6"/>
<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="/rhev/data-center/mnt/192.168.100.59:_exports_iso/6ff100c0-d08d-4504-832d-53876bf97349/images/11111111-1111-1111-1111-111111111111/CentOS-7-x86_64-Minimal-1804.iso" startupPolicy="optional"/>
<target dev="hdc" bus="ide"/>
<readonly/>
<address bus="1" controller="0" unit="0" type="drive" target="0"/>
<boot order="2"/>
</disk>
<disk snapshot="no" type="file" device="disk">
<target dev="sda" bus="scsi"/>
<source file="/rhev/data-center/5b0f6949-02d6-00bf-008b-000000000167/461517fd-986a-4b39-9b84-5fd54ef06967/images/1ea736ad-164c-4ac2-a6ce-9b8e6eceefde/b7f8140f-3a34-40fd-9fec-878df3d159a4"/>
<driver name="qemu" io="threads" type="qcow2" error_policy="stop" cache="none"/>
<address bus="0" controller="0" unit="0" type="drive" target="0"/>
<boot order="1"/>
<serial>1ea736ad-164c-4ac2-a6ce-9b8e6eceefde</serial>
</disk>
<disk snapshot="no" type="file" device="disk">
<target dev="sdb" bus="scsi"/>
<source file="/rhev/data-center/5b0f6949-02d6-00bf-008b-000000000167/c5a790c2-2885-4220-b803-35e4a40ecef6/images/183b3ace-64e1-49cf-a214-b5462f989171/36ea0af6-b681-4923-bf70-6b51717f372d"/>
<driver name="qemu" io="threads" type="qcow2" error_policy="stop" cache="none"/>
<address bus="0" controller="0" unit="1" type="drive" target="0"/>
<serial>183b3ace-64e1-49cf-a214-b5462f989171</serial>
</disk>
<disk snapshot="no" type="file" device="disk">
<target dev="sdc" bus="scsi"/>
<source file="/rhev/data-center/5b0f6949-02d6-00bf-008b-000000000167/c5a790c2-2885-4220-b803-35e4a40ecef6/images/5866d66c-0756-4544-af6a-95f5aed9312b/1751cd16-fd89-4441-b847-45169689c9a7"/>
<driver name="qemu" io="threads" type="qcow2" error_policy="stop" cache="none"/>
<address bus="0" controller="0" unit="2" type="drive" target="0"/>
<serial>5866d66c-0756-4544-af6a-95f5aed9312b</serial>
</disk>
</devices>
<pm>
<suspend-to-disk enabled="no"/>
<suspend-to-mem enabled="no"/>
</pm>
<os>
<type arch="x86_64" machine="pc-i440fx-2.5">hvm</type>
<smbios mode="sysinfo"/>
</os>
<metadata>
<ovirt-tune:qos/>
<ovirt-vm:vm>
<minGuaranteedMemoryMb type="int">4096</minGuaranteedMemoryMb>
<clusterVersion>4.2</clusterVersion>
<ovirt-vm:custom/>
<ovirt-vm:device mac_address="00:1a:4a:16:01:f6">
<ovirt-vm:custom/>
</ovirt-vm:device>
<ovirt-vm:device mac_address="00:1a:4a:16:01:f5">
<ovirt-vm:custom/>
</ovirt-vm:device>
<ovirt-vm:device devtype="disk" name="sdb">
<ovirt-vm:imageID>183b3ace-64e1-49cf-a214-b5462f989171</ovirt-vm:imageID>
<ovirt-vm:poolID>5b0f6949-02d6-00bf-008b-000000000167</ovirt-vm:poolID>
<ovirt-vm:volumeID>36ea0af6-b681-4923-bf70-6b51717f372d</ovirt-vm:volumeID>
<ovirt-vm:domainID>c5a790c2-2885-4220-b803-35e4a40ecef6</ovirt-vm:domainID>
</ovirt-vm:device>
<ovirt-vm:device devtype="disk" name="sda">
<ovirt-vm:imageID>1ea736ad-164c-4ac2-a6ce-9b8e6eceefde</ovirt-vm:imageID>
<ovirt-vm:poolID>5b0f6949-02d6-00bf-008b-000000000167</ovirt-vm:poolID>
<ovirt-vm:volumeID>b7f8140f-3a34-40fd-9fec-878df3d159a4</ovirt-vm:volumeID>
<ovirt-vm:domainID>461517fd-986a-4b39-9b84-5fd54ef06967</ovirt-vm:domainID>
</ovirt-vm:device>
<ovirt-vm:device devtype="disk" name="sdc">
<ovirt-vm:imageID>5866d66c-0756-4544-af6a-95f5aed9312b</ovirt-vm:imageID>
<ovirt-vm:poolID>5b0f6949-02d6-00bf-008b-000000000167</ovirt-vm:poolID>
<ovirt-vm:volumeID>1751cd16-fd89-4441-b847-45169689c9a7</ovirt-vm:volumeID>
<ovirt-vm:domainID>c5a790c2-2885-4220-b803-35e4a40ecef6</ovirt-vm:domainID>
</ovirt-vm:device>
<launchPaused>false</launchPaused>
<resumeBehavior>auto_resume</resumeBehavior>
</ovirt-vm:vm>
</metadata>
</domain>
2018-07-03 11:28:42,072+08 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] FINISH, CreateBrokerVDSCommand, log id: 68b50b27
2018-07-03 11:28:42,074+08 INFO [org.ovirt.engine.core.vdsbroker.CreateVDSCommand] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] FINISH, CreateVDSCommand, return: WaitForLaunch, log id: 72322ec5
2018-07-03 11:28:42,074+08 INFO [org.ovirt.engine.core.bll.RunVmCommand] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] Lock freed to object 'EngineLock:{exclusiveLocks='[0febbdb6-9b90-4052-8169-4f6792d99d1e=VM]', sharedLocks=''}'
2018-07-03 11:28:42,079+08 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engine-Thread-67220) [a2075a4a-458f-4224-820a-c3acb8d776fa] EVENT_ID: USER_STARTED_VM(153), VM badvm-avodev-controller was started by admin@internal-authz (Host: storage3).
2018-07-03 11:28:43,803+08 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DumpXmlsVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-72) [] START, DumpXmlsVDSCommand(HostName = storage3, Params:{hostId='862f44c5-3529-4ef1-a2a6-2910d5b93460', vmIds='[0febbdb6-9b90-4052-8169-4f6792d99d1e]'}), log id: 39084aef
2018-07-03 11:28:43,835+08 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DumpXmlsVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-72) [] FINISH, DumpXmlsVDSCommand, return: [{vmId=0febbdb6-9b90-4052-8169-4f6792d99d1e, devices=[Ljava.util.Map;@749e3a2d}], log id: 39084aef
2018-07-03 11:28:43,837+08 ERROR [org.ovirt.engine.core.vdsbroker.monitoring.VmDevicesMonitoring] (EE-ManagedThreadFactory-engineScheduled-Thread-72) [] VM '0febbdb6-9b90-4052-8169-4f6792d99d1e' managed non pluggable device was removed unexpectedly from libvirt: 'VmDevice:{id='VmDeviceId:{deviceId='cc5b8141-51ed-4a8b-9cf4-a703fa9a3dd1', vmId='0febbdb6-9b90-4052-8169-4f6792d99d1e'}', device='virtio-scsi', type='CONTROLLER', specParams='[]', address='', managed='true', plugged='false', readOnly='false', deviceAlias='', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}'
2018-07-03 11:28:44,132+08 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (ForkJoinPool-1-worker-9) [] VM '0febbdb6-9b90-4052-8169-4f6792d99d1e'(badvm-avodev-controller) moved from 'WaitForLaunch' --> 'PoweringUp'
2018-07-03 11:28:44,143+08 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DumpXmlsVDSCommand] (ForkJoinPool-1-worker-9) [] START, DumpXmlsVDSCommand(HostName = storage3, Params:{hostId='862f44c5-3529-4ef1-a2a6-2910d5b93460', vmIds='[0febbdb6-9b90-4052-8169-4f6792d99d1e]'}), log id: 47bab6eb
2018-07-03 11:28:44,184+08 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DumpXmlsVDSCommand] (ForkJoinPool-1-worker-9) [] FINISH, DumpXmlsVDSCommand, return: [{vmId=0febbdb6-9b90-4052-8169-4f6792d99d1e, devices=[Ljava.util.Map;@5a5f0670}], log id: 47bab6eb
2018-07-03 11:28:44,185+08 ERROR [org.ovirt.engine.core.vdsbroker.monitoring.VmDevicesMonitoring] (ForkJoinPool-1-worker-9) [] VM '0febbdb6-9b90-4052-8169-4f6792d99d1e' managed non pluggable device was removed unexpectedly from libvirt: 'VmDevice:{id='VmDeviceId:{deviceId='cc5b8141-51ed-4a8b-9cf4-a703fa9a3dd1', vmId='0febbdb6-9b90-4052-8169-4f6792d99d1e'}', device='virtio-scsi', type='CONTROLLER', specParams='[]', address='', managed='true', plugged='false', readOnly='false', deviceAlias='', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}'
2018-07-03 11:28:53,460+08 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [] VM '56b28418-9dcf-4d46-87fe-0dfef05bb141' was discovered as 'Down' on VDS 'a24d7172-1c3c-44ab-8ef3-9f863aeb4a87'(storage2)
2018-07-03 11:28:53,477+08 INFO [org.ovirt.engine.core.bll.AddUnmanagedVmsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [609d6b57] Running command: AddUnmanagedVmsCommand internal: true.
2018-07-03 11:28:53,480+08 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [609d6b57] START, FullListVDSCommand(HostName = storage2, FullListVDSCommandParameters:{hostId='a24d7172-1c3c-44ab-8ef3-9f863aeb4a87', vmIds='[56b28418-9dcf-4d46-87fe-0dfef05bb141]'}), log id: 7ff29962
2018-07-03 11:28:53,486+08 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [609d6b57] FINISH, FullListVDSCommand, return: [{status=Down, guestFQDN=, kvmEnable=true, xml=<?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>avodev-controller</name><uuid>56b28418-9dcf-4d46-87fe-0dfef05bb141</uuid><memory>8388608</memory><currentMemory>8388608</currentMemory><maxMemory slots="16">33554432</maxMemory><vcpu current="4">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">56b28418-9dcf-4d46-87fe-0dfef05bb141</entry></system></sysinfo><clock offset="variable" adjustment="0"><timer name="rtc" tickpolicy="catchup"></timer><timer name="pit" tickpolicy="delay"></timer><timer name="hpet" present="no"></timer></clock><features><acpi></acpi></features><cpu match="exact"><model>Nehalem</model><topology cores="1" threads="1" sockets="16"></topology><numa><cell cpus="0,1,2,3" memory="8388608"></cell></numa></cpu><cputune></cputune><devices><input type="tablet" bus="usb"></input><channel type="unix"><target type="virtio" name="ovirt-guest-agent.0"></target><source mode="bind" path="/var/lib/libvirt/qemu/channels/56b28418-9dcf-4d46-87fe-0dfef05bb141.ovirt-guest-agent.0"></source></channel><channel type="unix"><target type="virtio" name="org.qemu.guest_agent.0"></target><source mode="bind" path="/var/lib/libvirt/qemu/channels/56b28418-9dcf-4d46-87fe-0dfef05bb141.org.qemu.guest_agent.0"></source></channel><controller type="scsi" model="virtio-scsi" index="0"></controller><controller type="usb" model="piix3-uhci" index="0"><address bus="0x00" domain="0x0000" function="0x2" slot="0x01" type="pci"></address></controller><controller type="virtio-serial" index="0" ports="16"><address bus="0x00" domain="0x0000" function="0x0" slot="0x04" type="pci"></address></controller><graphics type="vnc" port="-1" autoport="yes" passwd="*****" passwdValidTo="1970-01-01T00:00:01" keymap="en-us"><listen type="network" network="vdsm-ovirtmgmt"></listen></graphics><controller type="ide"><address bus="0x00" domain="0x0000" function="0x1" slot="0x01" type="pci"></address></controller><rng model="virtio"><backend model="random">/dev/urandom</backend></rng><memballoon model="virtio"><stats period="5"></stats><address bus="0x00" domain="0x0000" function="0x0" slot="0x06" type="pci"></address></memballoon><video><model type="vga" vram="16384" heads="1"></model></video><interface type="bridge"><model type="virtio"></model><link state="up"></link><source bridge="ovirtmgmt"></source><address bus="0x00" domain="0x0000" function="0x0" slot="0x03" type="pci"></address><mac address="00:1a:4a:16:01:da"></mac><filterref filter="vdsm-no-mac-spoofing"></filterref><bandwidth></bandwidth></interface><interface type="bridge"><model type="virtio"></model><link state="up"></link><source bridge="ovirtmgmt"></source><address bus="0x00" domain="0x0000" function="0x0" slot="0x07" type="pci"></address><mac address="00:1a:4a:16:01:db"></mac><filterref filter="vdsm-no-mac-spoofing"></filterref><bandwidth></bandwidth></interface><disk type="file" device="cdrom" snapshot="no"><driver name="qemu" type="raw" error_policy="report"></driver><source file="/rhev/data-center/mnt/192.168.100.59:_exports_iso/6ff100c0-d08d-4504-832d-53876bf97349/images/11111111-1111-1111-1111-111111111111/CentOS-7-x86_64-Minimal-1804.iso" startupPolicy="optional"></source><target dev="hdc" bus="ide"></target><readonly></readonly><address bus="1" controller="0" unit="0" type="drive" target="0"></address><boot order="2"></boot></disk><disk snapshot="no" type="file" device="disk"><target dev="sda" bus="scsi"></target><source file="/rhev/data-center/5b0f6949-02d6-00bf-008b-000000000167/461517fd-986a-4b39-9b84-5fd54ef06967/images/8e17d226-94d0-42f8-ae29-9c795db7e522/3b4e2ee9-ba96-4b4d-8392-94e2736e6dab"></source><driver name="qemu" io="threads" type="qcow2" error_policy="stop" cache="none"></driver><address bus="0" controller="0" unit="0" type="drive" target="0"></address><boot order="1"></boot><serial>8e17d226-94d0-42f8-ae29-9c795db7e522</serial></disk><disk snapshot="no" type="file" device="disk"><target dev="sdb" bus="scsi"></target><source file="/rhev/data-center/5b0f6949-02d6-00bf-008b-000000000167/c5a790c2-2885-4220-b803-35e4a40ecef6/images/d0a00b64-3676-4783-a7af-9bb53940b03e/a88be564-84f8-4232-9ba6-91be4625a469"></source><driver name="qemu" io="threads" type="qcow2" error_policy="stop" cache="none"></driver><address bus="0" controller="0" unit="1" type="drive" target="0"></address><serial>d0a00b64-3676-4783-a7af-9bb53940b03e</serial></disk><disk snapshot="no" type="file" device="disk"><target dev="sdc" bus="scsi"></target><source file="/rhev/data-center/5b0f6949-02d6-00bf-008b-000000000167/c5a790c2-2885-4220-b803-35e4a40ecef6/images/03352bba-9d9f-4fca-ac35-f4aa7767e0b6/26a2e47d-2b10-454a-83f4-3c3c96d27f72"></source><driver name="qemu" io="threads" type="qcow2" error_policy="stop" cache="none"></driver><address bus="0" controller="0" unit="2" type="drive" target="0"></address><serial>03352bba-9d9f-4fca-ac35-f4aa7767e0b6</serial></disk></devices><pm><suspend-to-disk enabled="no"></suspend-to-disk><suspend-to-mem enabled="no"></suspend-to-mem></pm><os><type arch="x86_64" machine="pc-i440fx-2.5">hvm</type><smbios mode="sysinfo"></smbios></os><metadata><ovirt-tune:qos></ovirt-tune:qos><ovirt-vm:vm><minGuaranteedMemoryMb type="int">4096</minGuaranteedMemoryMb><clusterVersion>4.2</clusterVersion><ovirt-vm:custom></ovirt-vm:custom><ovirt-vm:device mac_address="00:1a:4a:16:01:db"><ovirt-vm:custom></ovirt-vm:custom></ovirt-vm:device><ovirt-vm:device mac_address="00:1a:4a:16:01:da"><ovirt-vm:custom></ovirt-vm:custom></ovirt-vm:device><ovirt-vm:device devtype="disk" name="sdb"><ovirt-vm:imageID>d0a00b64-3676-4783-a7af-9bb53940b03e</ovirt-vm:imageID><ovirt-vm:poolID>5b0f6949-02d6-00bf-008b-000000000167</ovirt-vm:poolID><ovirt-vm:volumeID>a88be564-84f8-4232-9ba6-91be4625a469</ovirt-vm:volumeID><ovirt-vm:domainID>c5a790c2-2885-4220-b803-35e4a40ecef6</ovirt-vm:domainID></ovirt-vm:device><ovirt-vm:device devtype="disk" name="sda"><ovirt-vm:imageID>8e17d226-94d0-42f8-ae29-9c795db7e522</ovirt-vm:imageID><ovirt-vm:poolID>5b0f6949-02d6-00bf-008b-000000000167</ovirt-vm:poolID><ovirt-vm:volumeID>3b4e2ee9-ba96-4b4d-8392-94e2736e6dab</ovirt-vm:volumeID><ovirt-vm:domainID>461517fd-986a-4b39-9b84-5fd54ef06967</ovirt-vm:domainID></ovirt-vm:device><ovirt-vm:device devtype="disk" name="sdc"><ovirt-vm:imageID>03352bba-9d9f-4fca-ac35-f4aa7767e0b6</ovirt-vm:imageID><ovirt-vm:poolID>5b0f6949-02d6-00bf-008b-000000000167</ovirt-vm:poolID><ovirt-vm:volumeID>26a2e47d-2b10-454a-83f4-3c3c96d27f72</ovirt-vm:volumeID><ovirt-vm:domainID>c5a790c2-2885-4220-b803-35e4a40ecef6</ovirt-vm:domainID></ovirt-vm:device><launchPaused>false</launchPaused><resumeBehavior>auto_resume</resumeBehavior></ovirt-vm:vm></metadata></domain>, enableGuestEvents=true, vmId=56b28418-9dcf-4d46-87fe-0dfef05bb141, devices=[Ljava.lang.Object;@671dc026, guestDiskMapping={}, username=Unknown, vmType=kvm, smp=1, arch=x86_64, clientIp=, statusTime=4814199690, vmName=nNone, guestIPs=}], log id: 7ff29962
2018-07-03 11:28:53,486+08 ERROR [org.ovirt.engine.core.bll.AddUnmanagedVmsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [609d6b57] Command 'org.ovirt.engine.core.bll.AddUnmanagedVmsCommand' failed: null