Login
[x]
Log in using an account from:
Fedora Account System
Red Hat Associate
Red Hat Customer
Or login using a Red Hat Bugzilla account
Forgot Password
Login:
Hide Forgot
Create an Account
Red Hat Bugzilla – Attachment 1490117 Details for
Bug 1599616
Setting host to local maintenance doesn't pass to the HA agent if ovirt-ha-agent and ovirt-ha-broker are down on the host
[?]
New
Simple Search
Advanced Search
My Links
Browse
Requests
Reports
Current State
Search
Tabular reports
Graphical reports
Duplicates
Other Reports
User Changes
Plotly Reports
Bug Status
Bug Severity
Non-Defaults
|
Product Dashboard
Help
Page Help!
Bug Writing Guidelines
What's new
Browser Support Policy
5.0.4.rh83 Release notes
FAQ
Guides index
User guide
Web Services
Contact
Legal
This site requires JavaScript to be enabled to function correctly, please enable it.
engine log
engine.log (text/plain), 144.85 KB, created by
Polina
on 2018-10-03 14:22:28 UTC
(
hide
)
Description:
engine log
Filename:
MIME Type:
Creator:
Polina
Created:
2018-10-03 14:22:28 UTC
Size:
144.85 KB
patch
obsolete
>2018-09-21 22:05:48,288+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher] (EE-ManagedThreadFactory-engineScheduled-Thread-56) [] Fetched 0 VMs from VDS 'a6ebcb78-bc75-4342-927f-cdf57be26a25' >2018-09-21 22:05:54,109+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-21) [vms_update_208516f0-b4a2-41e7] Lock Acquired to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_1=VM_NAME]', sharedLocks='[59fa71ca-e87d-4d72-94d4-1c65feee08bc=VM]'}' >2018-09-21 22:05:54,158+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-21) [vms_update_208516f0-b4a2-41e7] Running command: UpdateVmCommand internal: false. Entities affected : ID: 59fa71ca-e87d-4d72-94d4-1c65feee08bc Type: VMAction group EDIT_VM_PROPERTIES with role type USER, ID: 59fa71ca-e87d-4d72-94d4-1c65feee08bc Type: VMAction group CHANGE_VM_CUSTOM_PROPERTIES with role type ADMIN, ID: 59fa71ca-e87d-4d72-94d4-1c65feee08bc Type: VMAction group EDIT_ADMIN_VM_PROPERTIES with role type ADMIN >2018-09-21 22:05:54,250+03 INFO [org.ovirt.engine.core.bll.UpdateGraphicsDeviceCommand] (default task-21) [2c30a663] Running command: UpdateGraphicsDeviceCommand internal: true. Entities affected : ID: 59fa71ca-e87d-4d72-94d4-1c65feee08bc Type: VMAction group EDIT_VM_PROPERTIES with role type USER >2018-09-21 22:05:54,256+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-21) [2c30a663] Pinned host changed for VM: golden_env_mixed_virtio_1_1. Dropping configured host devices. >2018-09-21 22:05:54,280+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-21) [2c30a663] EVENT_ID: USER_UPDATE_VM(35), VM golden_env_mixed_virtio_1_1 configuration was updated by admin@internal-authz. >2018-09-21 22:05:54,286+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-21) [2c30a663] Lock freed to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_1=VM_NAME]', sharedLocks='[59fa71ca-e87d-4d72-94d4-1c65feee08bc=VM]'}' >2018-09-21 22:05:54,606+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-26) [vms_update_d3c29001-a38a-4682] Lock Acquired to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_0=VM_NAME]', sharedLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]'}' >2018-09-21 22:05:54,643+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-26) [vms_update_d3c29001-a38a-4682] Running command: UpdateVmCommand internal: false. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_VM_PROPERTIES with role type USER, ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group CHANGE_VM_CUSTOM_PROPERTIES with role type ADMIN, ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_ADMIN_VM_PROPERTIES with role type ADMIN >2018-09-21 22:05:54,682+03 INFO [org.ovirt.engine.core.bll.UpdateGraphicsDeviceCommand] (default task-26) [107619bb] Running command: UpdateGraphicsDeviceCommand internal: true. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_VM_PROPERTIES with role type USER >2018-09-21 22:05:54,689+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-26) [107619bb] Pinned host changed for VM: golden_env_mixed_virtio_1_0. Dropping configured host devices. >2018-09-21 22:05:54,705+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-26) [107619bb] EVENT_ID: USER_UPDATE_VM(35), VM golden_env_mixed_virtio_1_0 configuration was updated by admin@internal-authz. >2018-09-21 22:05:54,713+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-26) [107619bb] Lock freed to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_0=VM_NAME]', sharedLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]'}' >2018-09-21 22:06:42,395+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-44) [vms_update_71a33aaa-6454-47d0] Lock Acquired to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_0=VM_NAME]', sharedLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]'}' >2018-09-21 22:06:42,445+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-44) [vms_update_71a33aaa-6454-47d0] Running command: UpdateVmCommand internal: false. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_VM_PROPERTIES with role type USER, ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_ADMIN_VM_PROPERTIES with role type ADMIN >2018-09-21 22:06:42,469+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-44) [vms_update_71a33aaa-6454-47d0] Pinned host changed for VM: golden_env_mixed_virtio_1_0. Dropping configured host devices. >2018-09-21 22:06:42,484+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-44) [vms_update_71a33aaa-6454-47d0] EVENT_ID: USER_UPDATE_VM(35), VM golden_env_mixed_virtio_1_0 configuration was updated by admin@internal-authz. >2018-09-21 22:06:42,489+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-44) [vms_update_71a33aaa-6454-47d0] Lock freed to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_0=VM_NAME]', sharedLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]'}' >2018-09-21 22:06:42,720+03 INFO [org.ovirt.engine.core.bll.RunVmCommand] (default task-45) [vms_syncAction_04180a19-9781-49aa] Lock Acquired to object 'EngineLock:{exclusiveLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]', sharedLocks=''}' >2018-09-21 22:06:42,812+03 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default task-45) [vms_syncAction_04180a19-9781-49aa] START, IsVmDuringInitiatingVDSCommand( IsVmDuringInitiatingVDSCommandParameters:{vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796'}), log id: 6f88d973 >2018-09-21 22:06:42,812+03 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default task-45) [vms_syncAction_04180a19-9781-49aa] FINISH, IsVmDuringInitiatingVDSCommand, return: false, log id: 6f88d973 >2018-09-21 22:06:42,834+03 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (default task-45) [vms_syncAction_04180a19-9781-49aa] Candidate host 'host_mixed_3' ('a7e45cf7-2174-42c5-a730-d5c3c568409a') was filtered out by 'VAR__FILTERTYPE__INTERNAL' filter 'PinToHost' (correlation id: null) >2018-09-21 22:06:42,864+03 INFO [org.ovirt.engine.core.bll.RunVmCommand] (default task-45) [vms_syncAction_04180a19-9781-49aa] Running command: RunVmCommand internal: false. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group RUN_VM with role type USER >2018-09-21 22:06:42,874+03 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (default task-45) [vms_syncAction_04180a19-9781-49aa] Candidate host 'host_mixed_3' ('a7e45cf7-2174-42c5-a730-d5c3c568409a') was filtered out by 'VAR__FILTERTYPE__INTERNAL' filter 'PinToHost' (correlation id: vms_syncAction_04180a19-9781-49aa) >2018-09-21 22:06:42,907+03 INFO [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (default task-45) [vms_syncAction_04180a19-9781-49aa] START, UpdateVmDynamicDataVDSCommand( UpdateVmDynamicDataVDSCommandParameters:{hostId='null', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', vmDynamic='org.ovirt.engine.core.common.businessentities.VmDynamic@502422eb'}), log id: 1b4d0f86 >2018-09-21 22:06:42,910+03 INFO [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (default task-45) [vms_syncAction_04180a19-9781-49aa] FINISH, UpdateVmDynamicDataVDSCommand, log id: 1b4d0f86 >2018-09-21 22:06:42,916+03 INFO [org.ovirt.engine.core.vdsbroker.CreateVDSCommand] (default task-45) [vms_syncAction_04180a19-9781-49aa] START, CreateVDSCommand( CreateVDSCommandParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', vm='VM [golden_env_mixed_virtio_1_0]'}), log id: e258d0d >2018-09-21 22:06:42,919+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand] (default task-45) [vms_syncAction_04180a19-9781-49aa] START, CreateBrokerVDSCommand(HostName = host_mixed_1, CreateVDSCommandParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', vm='VM [golden_env_mixed_virtio_1_0]'}), log id: 54e9f5f >2018-09-21 22:06:42,934+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand] (default task-45) [vms_syncAction_04180a19-9781-49aa] 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>golden_env_mixed_virtio_1_0</name> > <uuid>b43f9124-f743-47e9-a0f3-a15c83a8e796</uuid> > <memory>1048576</memory> > <currentMemory>1048576</currentMemory> > <maxMemory slots="16">4194304</maxMemory> > <vcpu current="1">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">b43f9124-f743-47e9-a0f3-a15c83a8e796</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>Westmere</model> > <topology cores="1" threads="1" sockets="16"/> > <numa> > <cell id="0" cpus="0" memory="1048576"/> > </numa> > </cpu> > <cputune/> > <devices> > <input type="mouse" bus="ps2"/> > <channel type="unix"> > <target type="virtio" name="ovirt-guest-agent.0"/> > <source mode="bind" path="/var/lib/libvirt/qemu/channels/b43f9124-f743-47e9-a0f3-a15c83a8e796.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/b43f9124-f743-47e9-a0f3-a15c83a8e796.org.qemu.guest_agent.0"/> > </channel> > <controller type="scsi" model="virtio-scsi" index="0"> > <alias name="ua-3c7f73f5-8c6e-4a05-98c7-914f059cc4af"/> > </controller> > <sound model="ich6"> > <alias name="ua-3e6956fd-dd98-4d66-91fc-f91e52be4b0c"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x04" type="pci"/> > </sound> > <controller type="virtio-serial" index="0" ports="16"> > <alias name="ua-4f6e44c4-cb76-459f-ac3e-082eefcf3925"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x05" type="pci"/> > </controller> > <memballoon model="virtio"> > <stats period="5"/> > <alias name="ua-57427a8e-1cd6-4913-b8ca-eabbc824aed9"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x08" type="pci"/> > </memballoon> > <video> > <model type="qxl" vram="8192" heads="1" ram="65536" vgamem="16384"/> > <alias name="ua-8abe45ec-483c-4661-80eb-ddf3f33e1628"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x02" type="pci"/> > </video> > <controller type="ide" index="0"> > <address bus="0x00" domain="0x0000" function="0x1" slot="0x01" type="pci"/> > </controller> > <graphics type="spice" port="-1" autoport="yes" passwd="*****" passwdValidTo="1970-01-01T00:00:01" tlsPort="-1"> > <channel name="main" mode="secure"/> > <channel name="inputs" mode="secure"/> > <channel name="cursor" mode="secure"/> > <channel name="playback" mode="secure"/> > <channel name="record" mode="secure"/> > <channel name="display" mode="secure"/> > <channel name="smartcard" mode="secure"/> > <channel name="usbredir" mode="secure"/> > <listen type="network" network="vdsm-ovirtmgmt"/> > </graphics> > <rng model="virtio"> > <backend model="random">/dev/urandom</backend> > <alias name="ua-bbff748a-6eea-4a22-8074-c4324b0eaa4d"/> > </rng> > <controller type="usb" model="piix3-uhci" index="0"> > <address bus="0x00" domain="0x0000" function="0x2" slot="0x01" type="pci"/> > </controller> > <channel type="spicevmc"> > <target type="virtio" name="com.redhat.spice.0"/> > </channel> > <interface type="bridge"> > <model type="virtio"/> > <link state="up"/> > <source bridge="ovirtmgmt"/> > <alias name="ua-face3b7e-cea7-4bae-92ac-f1b9f498995f"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x03" type="pci"/> > <mac address="00:1a:4a:16:88:c9"/> > <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-892dceaf-0e49-480e-aa27-12a35bc55da6"/> > <address bus="1" controller="0" unit="0" type="drive" target="0"/> > </disk> > <disk snapshot="no" type="file" device="disk"> > <target dev="vda" bus="virtio"/> > <source file="/rhev/data-center/636f1fce-bdba-11e8-89e0-001a4a168bfb/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd"/> > <driver name="qemu" io="threads" type="qcow2" error_policy="stop" cache="none"/> > <alias name="ua-f002a528-68aa-4013-8c14-7b330f932412"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x07" type="pci"/> > <boot order="1"/> > <serial>f002a528-68aa-4013-8c14-7b330f932412</serial> > </disk> > </devices> > <pm> > <suspend-to-disk enabled="no"/> > <suspend-to-mem enabled="no"/> > </pm> > <os> > <type arch="x86_64" machine="pc-i440fx-rhel7.5.0">hvm</type> > <smbios mode="sysinfo"/> > </os> > <metadata> > <ovirt-tune:qos/> > <ovirt-vm:vm> > <minGuaranteedMemoryMb type="int">1024</minGuaranteedMemoryMb> > <clusterVersion>4.2</clusterVersion> > <ovirt-vm:custom/> > <ovirt-vm:device mac_address="00:1a:4a:16:88:c9"> > <ovirt-vm:custom/> > </ovirt-vm:device> > <ovirt-vm:device devtype="disk" name="vda"> > <ovirt-vm:poolID>636f1fce-bdba-11e8-89e0-001a4a168bfb</ovirt-vm:poolID> > <ovirt-vm:volumeID>2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd</ovirt-vm:volumeID> > <ovirt-vm:imageID>f002a528-68aa-4013-8c14-7b330f932412</ovirt-vm:imageID> > <ovirt-vm:domainID>727f775a-5d4c-4e80-a6ff-bb99e18daa7a</ovirt-vm:domainID> > </ovirt-vm:device> > <launchPaused>false</launchPaused> > <resumeBehavior>auto_resume</resumeBehavior> > </ovirt-vm:vm> > </metadata> ></domain> > >2018-09-21 22:06:42,965+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand] (default task-45) [vms_syncAction_04180a19-9781-49aa] FINISH, CreateBrokerVDSCommand, log id: 54e9f5f >2018-09-21 22:06:42,968+03 INFO [org.ovirt.engine.core.vdsbroker.CreateVDSCommand] (default task-45) [vms_syncAction_04180a19-9781-49aa] FINISH, CreateVDSCommand, return: WaitForLaunch, log id: e258d0d >2018-09-21 22:06:42,968+03 INFO [org.ovirt.engine.core.bll.RunVmCommand] (default task-45) [vms_syncAction_04180a19-9781-49aa] Lock freed to object 'EngineLock:{exclusiveLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]', sharedLocks=''}' >2018-09-21 22:06:42,974+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-45) [vms_syncAction_04180a19-9781-49aa] EVENT_ID: USER_STARTED_VM(153), VM golden_env_mixed_virtio_1_0 was started by admin@internal-authz (Host: host_mixed_1). >2018-09-21 22:06:46,899+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (ForkJoinPool-1-worker-5) [] VM 'b43f9124-f743-47e9-a0f3-a15c83a8e796'(golden_env_mixed_virtio_1_0) moved from 'WaitForLaunch' --> 'PoweringUp' >2018-09-21 22:06:46,910+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DumpXmlsVDSCommand] (ForkJoinPool-1-worker-5) [] START, DumpXmlsVDSCommand(HostName = host_mixed_1, Params:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', vmIds='[b43f9124-f743-47e9-a0f3-a15c83a8e796]'}), log id: 1cbe583e >2018-09-21 22:06:46,915+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DumpXmlsVDSCommand] (ForkJoinPool-1-worker-5) [] FINISH, DumpXmlsVDSCommand, return: {b43f9124-f743-47e9-a0f3-a15c83a8e796=<domain type='kvm' id='17'> > <name>golden_env_mixed_virtio_1_0</name> > <uuid>b43f9124-f743-47e9-a0f3-a15c83a8e796</uuid> > <metadata xmlns:ns0="http://ovirt.org/vm/tune/1.0" xmlns:ovirt-vm="http://ovirt.org/vm/1.0"> > <ns0:qos/> > <ovirt-vm:vm xmlns:ovirt-vm="http://ovirt.org/vm/1.0"> > <ovirt-vm:clusterVersion>4.2</ovirt-vm:clusterVersion> > <ovirt-vm:destroy_on_reboot type="bool">False</ovirt-vm:destroy_on_reboot> > <ovirt-vm:launchPaused>false</ovirt-vm:launchPaused> > <ovirt-vm:memGuaranteedSize type="int">1024</ovirt-vm:memGuaranteedSize> > <ovirt-vm:minGuaranteedMemoryMb type="int">1024</ovirt-vm:minGuaranteedMemoryMb> > <ovirt-vm:resumeBehavior>auto_resume</ovirt-vm:resumeBehavior> > <ovirt-vm:startTime type="float">1537556802.96</ovirt-vm:startTime> > <ovirt-vm:device mac_address="00:1a:4a:16:88:c9"> > <ovirt-vm:network>ovirtmgmt</ovirt-vm:network> > <ovirt-vm:specParams/> > <ovirt-vm:vm_custom/> > </ovirt-vm:device> > <ovirt-vm:device devtype="disk" name="vda"> > <ovirt-vm:domainID>727f775a-5d4c-4e80-a6ff-bb99e18daa7a</ovirt-vm:domainID> > <ovirt-vm:imageID>f002a528-68aa-4013-8c14-7b330f932412</ovirt-vm:imageID> > <ovirt-vm:poolID>636f1fce-bdba-11e8-89e0-001a4a168bfb</ovirt-vm:poolID> > <ovirt-vm:volumeID>2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd</ovirt-vm:volumeID> > <ovirt-vm:specParams/> > <ovirt-vm:vm_custom/> > <ovirt-vm:volumeChain> > <ovirt-vm:volumeChainNode> > <ovirt-vm:domainID>727f775a-5d4c-4e80-a6ff-bb99e18daa7a</ovirt-vm:domainID> > <ovirt-vm:imageID>f002a528-68aa-4013-8c14-7b330f932412</ovirt-vm:imageID> > <ovirt-vm:leaseOffset type="int">0</ovirt-vm:leaseOffset> > <ovirt-vm:leasePath>/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd.lease</ovirt-vm:leasePath> > <ovirt-vm:path>/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd</ovirt-vm:path> > <ovirt-vm:volumeID>2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd</ovirt-vm:volumeID> > </ovirt-vm:volumeChainNode> > <ovirt-vm:volumeChainNode> > <ovirt-vm:domainID>727f775a-5d4c-4e80-a6ff-bb99e18daa7a</ovirt-vm:domainID> > <ovirt-vm:imageID>f002a528-68aa-4013-8c14-7b330f932412</ovirt-vm:imageID> > <ovirt-vm:leaseOffset type="int">0</ovirt-vm:leaseOffset> > <ovirt-vm:leasePath>/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/d7e7907f-79cf-48c1-a5f9-6d4ac2b111b6.lease</ovirt-vm:leasePath> > <ovirt-vm:path>/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/d7e7907f-79cf-48c1-a5f9-6d4ac2b111b6</ovirt-vm:path> > <ovirt-vm:volumeID>d7e7907f-79cf-48c1-a5f9-6d4ac2b111b6</ovirt-vm:volumeID> > </ovirt-vm:volumeChainNode> > </ovirt-vm:volumeChain> > </ovirt-vm:device> > <ovirt-vm:device devtype="disk" name="hdc"> > <ovirt-vm:specParams/> > <ovirt-vm:vm_custom/> > </ovirt-vm:device> ></ovirt-vm:vm> > </metadata> > <maxMemory slots='16' unit='KiB'>4194304</maxMemory> > <memory unit='KiB'>1048576</memory> > <currentMemory unit='KiB'>1048576</currentMemory> > <vcpu placement='static' current='1'>16</vcpu> > <resource> > <partition>/machine</partition> > </resource> > <sysinfo type='smbios'> > <system> > <entry name='manufacturer'>oVirt</entry> > <entry name='product'>RHEV Hypervisor</entry> > <entry name='version'>7.6-7.0.el7</entry> > <entry name='serial'>4c4c4544-0056-3010-8056-c8c04f563232</entry> > <entry name='uuid'>b43f9124-f743-47e9-a0f3-a15c83a8e796</entry> > </system> > </sysinfo> > <os> > <type arch='x86_64' machine='pc-i440fx-rhel7.5.0'>hvm</type> > <smbios mode='sysinfo'/> > </os> > <features> > <acpi/> > </features> > <cpu mode='custom' match='exact' check='full'> > <model fallback='forbid'>Westmere</model> > <topology sockets='16' cores='1' threads='1'/> > <feature policy='require' name='vme'/> > <feature policy='require' name='pclmuldq'/> > <feature policy='require' name='x2apic'/> > <feature policy='require' name='hypervisor'/> > <feature policy='require' name='arat'/> > <numa> > <cell id='0' cpus='0' memory='1048576' unit='KiB'/> > </numa> > </cpu> > <clock offset='variable' adjustment='0' basis='utc'> > <timer name='rtc' tickpolicy='catchup'/> > <timer name='pit' tickpolicy='delay'/> > <timer name='hpet' present='no'/> > </clock> > <on_poweroff>destroy</on_poweroff> > <on_reboot>restart</on_reboot> > <on_crash>destroy</on_crash> > <pm> > <suspend-to-mem enabled='no'/> > <suspend-to-disk enabled='no'/> > </pm> > <devices> > <emulator>/usr/libexec/qemu-kvm</emulator> > <disk type='file' device='cdrom'> > <driver name='qemu' error_policy='report'/> > <source startupPolicy='optional'/> > <target dev='hdc' bus='ide'/> > <readonly/> > <alias name='ua-892dceaf-0e49-480e-aa27-12a35bc55da6'/> > <address type='drive' controller='0' bus='1' target='0' unit='0'/> > </disk> > <disk type='file' device='disk' snapshot='no'> > <driver name='qemu' type='qcow2' cache='none' error_policy='stop' io='threads'/> > <source file='/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd'/> > <backingStore type='file' index='1'> > <format type='qcow2'/> > <source file='/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/d7e7907f-79cf-48c1-a5f9-6d4ac2b111b6'/> > <backingStore/> > </backingStore> > <target dev='vda' bus='virtio'/> > <serial>f002a528-68aa-4013-8c14-7b330f932412</serial> > <boot order='1'/> > <alias name='ua-f002a528-68aa-4013-8c14-7b330f932412'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x07' function='0x0'/> > </disk> > <controller type='scsi' index='0' model='virtio-scsi'> > <alias name='ua-3c7f73f5-8c6e-4a05-98c7-914f059cc4af'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x06' function='0x0'/> > </controller> > <controller type='virtio-serial' index='0' ports='16'> > <alias name='ua-4f6e44c4-cb76-459f-ac3e-082eefcf3925'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x05' function='0x0'/> > </controller> > <controller type='ide' index='0'> > <alias name='ide'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x01' function='0x1'/> > </controller> > <controller type='usb' index='0' model='piix3-uhci'> > <alias name='usb'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x01' function='0x2'/> > </controller> > <controller type='pci' index='0' model='pci-root'> > <alias name='pci.0'/> > </controller> > <interface type='bridge'> > <mac address='00:1a:4a:16:88:c9'/> > <source bridge='ovirtmgmt'/> > <target dev='vnet0'/> > <model type='virtio'/> > <filterref filter='vdsm-no-mac-spoofing'/> > <link state='up'/> > <mtu size='1500'/> > <alias name='ua-face3b7e-cea7-4bae-92ac-f1b9f498995f'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x03' function='0x0'/> > </interface> > <channel type='unix'> > <source mode='bind' path='/var/lib/libvirt/qemu/channels/b43f9124-f743-47e9-a0f3-a15c83a8e796.ovirt-guest-agent.0'/> > <target type='virtio' name='ovirt-guest-agent.0' state='disconnected'/> > <alias name='channel0'/> > <address type='virtio-serial' controller='0' bus='0' port='1'/> > </channel> > <channel type='unix'> > <source mode='bind' path='/var/lib/libvirt/qemu/channels/b43f9124-f743-47e9-a0f3-a15c83a8e796.org.qemu.guest_agent.0'/> > <target type='virtio' name='org.qemu.guest_agent.0' state='disconnected'/> > <alias name='channel1'/> > <address type='virtio-serial' controller='0' bus='0' port='2'/> > </channel> > <channel type='spicevmc'> > <target type='virtio' name='com.redhat.spice.0' state='disconnected'/> > <alias name='channel2'/> > <address type='virtio-serial' controller='0' bus='0' port='3'/> > </channel> > <input type='mouse' bus='ps2'> > <alias name='input0'/> > </input> > <input type='keyboard' bus='ps2'> > <alias name='input1'/> > </input> > <graphics type='spice' port='5900' tlsPort='5901' autoport='yes' listen='10.46.16.27' passwdValidTo='1970-01-01T00:00:01'> > <listen type='network' address='10.46.16.27' network='vdsm-ovirtmgmt'/> > <channel name='main' mode='secure'/> > <channel name='display' mode='secure'/> > <channel name='inputs' mode='secure'/> > <channel name='cursor' mode='secure'/> > <channel name='playback' mode='secure'/> > <channel name='record' mode='secure'/> > <channel name='smartcard' mode='secure'/> > <channel name='usbredir' mode='secure'/> > </graphics> > <sound model='ich6'> > <alias name='ua-3e6956fd-dd98-4d66-91fc-f91e52be4b0c'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x04' function='0x0'/> > </sound> > <video> > <model type='qxl' ram='65536' vram='8192' vgamem='16384' heads='1' primary='yes'/> > <alias name='ua-8abe45ec-483c-4661-80eb-ddf3f33e1628'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x02' function='0x0'/> > </video> > <memballoon model='virtio'> > <stats period='5'/> > <alias name='ua-57427a8e-1cd6-4913-b8ca-eabbc824aed9'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x08' function='0x0'/> > </memballoon> > <rng model='virtio'> > <backend model='random'>/dev/urandom</backend> > <alias name='ua-bbff748a-6eea-4a22-8074-c4324b0eaa4d'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x09' function='0x0'/> > </rng> > </devices> > <seclabel type='dynamic' model='selinux' relabel='yes'> > <label>system_u:system_r:svirt_t:s0:c945,c999</label> > <imagelabel>system_u:object_r:svirt_image_t:s0:c945,c999</imagelabel> > </seclabel> > <seclabel type='dynamic' model='dac' relabel='yes'> > <label>+107:+107</label> > <imagelabel>+107:+107</imagelabel> > </seclabel> ></domain> >}, log id: 1cbe583e >2018-09-21 22:06:48,335+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher] (EE-ManagedThreadFactory-engineScheduled-Thread-49) [] Fetched 1 VMs from VDS 'a6ebcb78-bc75-4342-927f-cdf57be26a25' >2018-09-21 22:06:53,426+03 INFO [org.ovirt.engine.core.bll.StopVmCommand] (default task-48) [vms_syncAction_24644d30-0a7c-4dcb] Running command: StopVmCommand internal: false. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group STOP_VM with role type USER >2018-09-21 22:06:53,431+03 INFO [org.ovirt.engine.core.vdsbroker.DestroyVmVDSCommand] (default task-48) [vms_syncAction_24644d30-0a7c-4dcb] START, DestroyVmVDSCommand( DestroyVmVDSCommandParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', secondsToWait='0', gracefully='false', reason='', ignoreNoVm='false'}), log id: 20873de4 >2018-09-21 22:06:53,435+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (default task-48) [vms_syncAction_24644d30-0a7c-4dcb] START, DestroyVDSCommand(HostName = host_mixed_1, DestroyVmVDSCommandParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', secondsToWait='0', gracefully='false', reason='', ignoreNoVm='false'}), log id: b5ff73f >2018-09-21 22:06:54,799+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (default task-48) [vms_syncAction_24644d30-0a7c-4dcb] FINISH, DestroyVDSCommand, log id: b5ff73f >2018-09-21 22:06:54,799+03 INFO [org.ovirt.engine.core.vdsbroker.DestroyVmVDSCommand] (default task-48) [vms_syncAction_24644d30-0a7c-4dcb] FINISH, DestroyVmVDSCommand, log id: 20873de4 >2018-09-21 22:06:54,804+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (ForkJoinPool-1-worker-14) [] VM 'b43f9124-f743-47e9-a0f3-a15c83a8e796' was reported as Down on VDS 'a6ebcb78-bc75-4342-927f-cdf57be26a25'(host_mixed_1) >2018-09-21 22:06:54,806+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (ForkJoinPool-1-worker-14) [] START, DestroyVDSCommand(HostName = host_mixed_1, DestroyVmVDSCommandParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', secondsToWait='0', gracefully='false', reason='', ignoreNoVm='true'}), log id: 112f65f2 >2018-09-21 22:06:54,810+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (ForkJoinPool-1-worker-14) [] Failed to destroy VM 'b43f9124-f743-47e9-a0f3-a15c83a8e796' because VM does not exist, ignoring >2018-09-21 22:06:54,810+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (ForkJoinPool-1-worker-14) [] FINISH, DestroyVDSCommand, log id: 112f65f2 >2018-09-21 22:06:54,810+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (ForkJoinPool-1-worker-14) [] VM 'b43f9124-f743-47e9-a0f3-a15c83a8e796'(golden_env_mixed_virtio_1_0) moved from 'PoweringUp' --> 'Down' >2018-09-21 22:06:54,810+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-48) [vms_syncAction_24644d30-0a7c-4dcb] EVENT_ID: USER_STOP_VM(33), VM golden_env_mixed_virtio_1_0 powered off by admin@internal-authz (Host: host_mixed_1). >2018-09-21 22:06:54,824+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ForkJoinPool-1-worker-14) [] EVENT_ID: VM_DOWN(61), VM golden_env_mixed_virtio_1_0 is down. >2018-09-21 22:06:54,841+03 INFO [org.ovirt.engine.core.bll.ProcessDownVmCommand] (EE-ManagedThreadFactory-engine-Thread-2329) [5b2ee70a] Running command: ProcessDownVmCommand internal: true. >2018-09-21 22:06:55,194+03 INFO [org.ovirt.engine.core.bll.MaintenanceNumberOfVdssCommand] (default task-60) [hosts_syncAction_ec06780c-4519-4796] Lock Acquired to object 'EngineLock:{exclusiveLocks='', sharedLocks='[636f1fce-bdba-11e8-89e0-001a4a168bfb=POOL]'}' >2018-09-21 22:06:55,291+03 INFO [org.ovirt.engine.core.bll.MaintenanceNumberOfVdssCommand] (default task-60) [hosts_syncAction_ec06780c-4519-4796] Running command: MaintenanceNumberOfVdssCommand internal: false. Entities affected : ID: a6ebcb78-bc75-4342-927f-cdf57be26a25 Type: VDSAction group MANIPULATE_HOST with role type ADMIN >2018-09-21 22:06:55,299+03 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (default task-60) [hosts_syncAction_ec06780c-4519-4796] START, SetVdsStatusVDSCommand(HostName = host_mixed_1, SetVdsStatusVDSCommandParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', status='PreparingForMaintenance', nonOperationalReason='NONE', stopSpmFailureLogged='true', maintenanceReason='null'}), log id: 7bd95bbe >2018-09-21 22:06:55,299+03 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (default task-60) [hosts_syncAction_ec06780c-4519-4796] VDS 'host_mixed_1' is spm and moved from up calling resetIrs. >2018-09-21 22:06:55,302+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.ResetIrsVDSCommand] (default task-60) [hosts_syncAction_ec06780c-4519-4796] START, ResetIrsVDSCommand( ResetIrsVDSCommandParameters:{storagePoolId='636f1fce-bdba-11e8-89e0-001a4a168bfb', ignoreFailoverLimit='false', vdsId='a6ebcb78-bc75-4342-927f-cdf57be26a25', ignoreStopFailed='false'}), log id: 31d25fb3 >2018-09-21 22:06:55,310+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand] (default task-60) [hosts_syncAction_ec06780c-4519-4796] START, SpmStopVDSCommand(HostName = host_mixed_1, SpmStopVDSCommandParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', storagePoolId='636f1fce-bdba-11e8-89e0-001a4a168bfb'}), log id: 119563e4 >2018-09-21 22:06:55,319+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand] (default task-60) [hosts_syncAction_ec06780c-4519-4796] SpmStopVDSCommand::Stopping SPM on vds 'host_mixed_1', pool id '636f1fce-bdba-11e8-89e0-001a4a168bfb' >2018-09-21 22:06:55,476+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand] (default task-60) [hosts_syncAction_ec06780c-4519-4796] FINISH, SpmStopVDSCommand, log id: 119563e4 >2018-09-21 22:06:55,482+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.ResetIrsVDSCommand] (default task-60) [hosts_syncAction_ec06780c-4519-4796] FINISH, ResetIrsVDSCommand, log id: 31d25fb3 >2018-09-21 22:06:55,492+03 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (default task-60) [hosts_syncAction_ec06780c-4519-4796] FINISH, SetVdsStatusVDSCommand, log id: 7bd95bbe >2018-09-21 22:06:55,496+03 INFO [org.ovirt.engine.core.bll.MaintenanceNumberOfVdssCommand] (default task-60) [hosts_syncAction_ec06780c-4519-4796] Lock freed to object 'EngineLock:{exclusiveLocks='', sharedLocks='[636f1fce-bdba-11e8-89e0-001a4a168bfb=POOL]'}' >2018-09-21 22:06:55,535+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.HostMonitoring] (EE-ManagedThreadFactory-engineScheduled-Thread-47) [] Updated host status from 'Preparing for Maintenance' to 'Maintenance' in database, host 'host_mixed_1'(a6ebcb78-bc75-4342-927f-cdf57be26a25) >2018-09-21 22:06:55,547+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engine-Thread-2335) [] Clearing cache of pool: '636f1fce-bdba-11e8-89e0-001a4a168bfb' for problematic entities of VDS: 'host_mixed_1'. >2018-09-21 22:06:55,547+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engine-Thread-2335) [] Removing vds '[a6ebcb78-bc75-4342-927f-cdf57be26a25]' from the domain in maintenance cache >2018-09-21 22:06:55,547+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engine-Thread-2335) [] Removing host(s) '[a6ebcb78-bc75-4342-927f-cdf57be26a25]' from hosts unseen domain report cache >2018-09-21 22:06:55,551+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStoragePoolVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-47) [] START, DisconnectStoragePoolVDSCommand(HostName = host_mixed_1, DisconnectStoragePoolVDSCommandParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', storagePoolId='636f1fce-bdba-11e8-89e0-001a4a168bfb', vds_spm_id='1'}), log id: 14cdb4ab >2018-09-21 22:06:55,571+03 INFO [org.ovirt.engine.core.bll.MaintenanceVdsCommand] (default task-60) [hosts_syncAction_ec06780c-4519-4796] Running command: MaintenanceVdsCommand internal: true. Entities affected : ID: a6ebcb78-bc75-4342-927f-cdf57be26a25 Type: VDS >2018-09-21 22:06:55,579+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-60) [hosts_syncAction_ec06780c-4519-4796] EVENT_ID: USER_VDS_MAINTENANCE_WITHOUT_REASON(620), Host host_mixed_1 was switched to Maintenance mode by admin@internal-authz. >2018-09-21 22:06:59,035+03 INFO [org.ovirt.engine.core.bll.storage.pool.SetStoragePoolStatusCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] Running command: SetStoragePoolStatusCommand internal: true. Entities affected : ID: 636f1fce-bdba-11e8-89e0-001a4a168bfb Type: StoragePool >2018-09-21 22:06:59,037+03 INFO [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] Storage Pool '636f1fce-bdba-11e8-89e0-001a4a168bfb' - Updating Storage Domain '727f775a-5d4c-4e80-a6ff-bb99e18daa7a' status from 'Active' to 'Unknown', reason: null >2018-09-21 22:06:59,038+03 INFO [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] Storage Pool '636f1fce-bdba-11e8-89e0-001a4a168bfb' - Updating Storage Domain '6ea108d4-a74b-48a4-bed0-f80ed266e1f8' status from 'Active' to 'Unknown', reason: null >2018-09-21 22:06:59,039+03 INFO [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] Storage Pool '636f1fce-bdba-11e8-89e0-001a4a168bfb' - Updating Storage Domain '0ff03194-c839-447b-9b6b-22e7c0497c53' status from 'Active' to 'Unknown', reason: null >2018-09-21 22:06:59,039+03 INFO [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] Storage Pool '636f1fce-bdba-11e8-89e0-001a4a168bfb' - Updating Storage Domain 'd07490bb-849c-49de-931b-71d9c94ddaef' status from 'Active' to 'Unknown', reason: null >2018-09-21 22:06:59,040+03 INFO [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] Storage Pool '636f1fce-bdba-11e8-89e0-001a4a168bfb' - Updating Storage Domain '6d08026e-998a-4eda-8959-66daf8643693' status from 'Active' to 'Unknown', reason: null >2018-09-21 22:06:59,040+03 INFO [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] Storage Pool '636f1fce-bdba-11e8-89e0-001a4a168bfb' - Updating Storage Domain '496562a7-da01-4b33-851d-2ba6c58d636a' status from 'Active' to 'Unknown', reason: null >2018-09-21 22:06:59,041+03 INFO [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] Storage Pool '636f1fce-bdba-11e8-89e0-001a4a168bfb' - Updating Storage Domain '5301bfc2-6b70-44ba-8f89-9aa181a6cb28' status from 'Active' to 'Unknown', reason: null >2018-09-21 22:06:59,041+03 INFO [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] Storage Pool '636f1fce-bdba-11e8-89e0-001a4a168bfb' - Updating Storage Domain 'd49ff3ce-c509-424f-a461-3e3d21c8bb03' status from 'Active' to 'Unknown', reason: null >2018-09-21 22:06:59,042+03 INFO [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] Storage Pool '636f1fce-bdba-11e8-89e0-001a4a168bfb' - Updating Storage Domain 'a55a328a-da76-4e58-99aa-bcd914a01a4d' status from 'Active' to 'Unknown', reason: null >2018-09-21 22:06:59,042+03 INFO [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] Storage Pool '636f1fce-bdba-11e8-89e0-001a4a168bfb' - Updating Storage Domain 'e90100f0-8901-433c-b50c-9bd03653c309' status from 'Active' to 'Unknown', reason: null >2018-09-21 22:06:59,042+03 INFO [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] Storage Pool '636f1fce-bdba-11e8-89e0-001a4a168bfb' - Updating Storage Domain '444d20aa-057d-4dd8-8551-5af62b5da5b4' status from 'Active' to 'Unknown', reason: null >2018-09-21 22:06:59,050+03 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] EVENT_ID: SYSTEM_CHANGE_STORAGE_POOL_STATUS_PROBLEMATIC(980), Invalid status on Data Center golden_env_mixed. Setting status to Non Responsive. >2018-09-21 22:06:59,080+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] START, ConnectStoragePoolVDSCommand(HostName = host_mixed_2, ConnectStoragePoolVDSCommandParameters:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', vdsId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', storagePoolId='636f1fce-bdba-11e8-89e0-001a4a168bfb', masterVersion='1'}), log id: 76b27a2e >2018-09-21 22:06:59,080+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] Executing with domain map: {496562a7-da01-4b33-851d-2ba6c58d636a=active, 0ff03194-c839-447b-9b6b-22e7c0497c53=active, d49ff3ce-c509-424f-a461-3e3d21c8bb03=active, 444d20aa-057d-4dd8-8551-5af62b5da5b4=active, 6d08026e-998a-4eda-8959-66daf8643693=active, d07490bb-849c-49de-931b-71d9c94ddaef=active, a55a328a-da76-4e58-99aa-bcd914a01a4d=active, 5301bfc2-6b70-44ba-8f89-9aa181a6cb28=active, 727f775a-5d4c-4e80-a6ff-bb99e18daa7a=active, e90100f0-8901-433c-b50c-9bd03653c309=active, 6ea108d4-a74b-48a4-bed0-f80ed266e1f8=active} >2018-09-21 22:07:00,075+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] FINISH, ConnectStoragePoolVDSCommand, log id: 76b27a2e >2018-09-21 22:07:00,087+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] hostFromVds::selectedVds - 'host_mixed_2', spmStatus 'Free', storage pool 'golden_env_mixed', storage pool version '4.2' >2018-09-21 22:07:00,091+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] starting spm on vds 'host_mixed_2', storage pool 'golden_env_mixed', prevId '-1', LVER '-1' >2018-09-21 22:07:00,095+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] START, SpmStartVDSCommand(HostName = host_mixed_2, SpmStartVDSCommandParameters:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', storagePoolId='636f1fce-bdba-11e8-89e0-001a4a168bfb', prevId='-1', prevLVER='-1', storagePoolFormatType='V4', recoveryMode='Manual', SCSIFencing='false'}), log id: 4531ae87 >2018-09-21 22:07:00,100+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] spmStart polling started: taskId '03b7c299-c811-4b6d-b6db-b81a16342e4e' >2018-09-21 22:07:02,123+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] spmStart polling ended: taskId '03b7c299-c811-4b6d-b6db-b81a16342e4e' task status 'finished' >2018-09-21 22:07:02,142+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] spmStart polling ended, spm status: SPM >2018-09-21 22:07:02,144+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] START, HSMClearTaskVDSCommand(HostName = host_mixed_2, HSMTaskGuidBaseVDSCommandParameters:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', taskId='03b7c299-c811-4b6d-b6db-b81a16342e4e'}), log id: 479caba8 >2018-09-21 22:07:02,148+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] FINISH, HSMClearTaskVDSCommand, log id: 479caba8 >2018-09-21 22:07:02,148+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] FINISH, SpmStartVDSCommand, return: org.ovirt.engine.core.common.businessentities.SpmStatusResult@6f257ccd, log id: 4531ae87 >2018-09-21 22:07:02,150+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] Initialize Irs proxy from vds: lynx15.lab.eng.tlv2.redhat.com >2018-09-21 22:07:02,153+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-13) [64e9571] EVENT_ID: IRS_HOSTED_ON_VDS(204), Storage Pool Manager runs on Host lynx15.lab.eng.tlv2.redhat.com (Address: lynx15.lab.eng.tlv2.redhat.com), Data Center golden_env_mixed. >2018-09-21 22:07:02,165+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2336) [64e9571] START, SPMGetAllTasksInfoVDSCommand( IrsBaseVDSCommandParameters:{storagePoolId='636f1fce-bdba-11e8-89e0-001a4a168bfb', ignoreFailoverLimit='false'}), log id: 7c9b02aa >2018-09-21 22:07:02,312+03 INFO [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) [] Connecting to lynx15.lab.eng.tlv2.redhat.com/10.46.16.30 >2018-09-21 22:07:02,815+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2336) [64e9571] -- executeIrsBrokerCommand: Attempting on storage pool '636f1fce-bdba-11e8-89e0-001a4a168bfb' >2018-09-21 22:07:02,817+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksInfoVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2336) [64e9571] START, HSMGetAllTasksInfoVDSCommand(HostName = host_mixed_2, VdsIdVDSCommandParametersBase:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01'}), log id: 4042e03c >2018-09-21 22:07:02,822+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksInfoVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2336) [64e9571] FINISH, HSMGetAllTasksInfoVDSCommand, return: [], log id: 4042e03c >2018-09-21 22:07:02,822+03 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2336) [64e9571] FINISH, SPMGetAllTasksInfoVDSCommand, return: [], log id: 7c9b02aa >2018-09-21 22:07:02,823+03 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory-engine-Thread-2336) [64e9571] Discovered no tasks on Storage Pool 'golden_env_mixed' >2018-09-21 22:07:02,883+03 INFO [org.ovirt.engine.core.bll.storage.pool.SyncStorageDomainsLunsCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [6fd36bfa] Running command: SyncStorageDomainsLunsCommand internal: true. >2018-09-21 22:07:02,886+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetDeviceListVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [6fd36bfa] START, GetDeviceListVDSCommand(HostName = host_mixed_2, GetDeviceListVDSCommandParameters:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', storageType='UNKNOWN', checkStatus='false', lunIds='null'}), log id: 6413a7e6 >2018-09-21 22:07:03,269+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStoragePoolVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-47) [] FINISH, DisconnectStoragePoolVDSCommand, log id: 14cdb4ab >2018-09-21 22:07:03,285+03 INFO [org.ovirt.engine.core.bll.storage.pool.DisconnectHostFromStoragePoolServersCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-47) [1e4206b5] Running command: DisconnectHostFromStoragePoolServersCommand internal: true. Entities affected : ID: 636f1fce-bdba-11e8-89e0-001a4a168bfb Type: StoragePool >2018-09-21 22:07:03,314+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-47) [1e4206b5] START, DisconnectStorageServerVDSCommand(HostName = host_mixed_1, StorageServerConnectionManagementVDSParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', storagePoolId='636f1fce-bdba-11e8-89e0-001a4a168bfb', storageType='NFS', connectionList='[StorageServerConnections:{id='c784238a-6f15-4c80-871d-14343adbce82', connection='mantis-nfs-lif2.lab.eng.tlv2.redhat.com:/nas01/ge_4_nfs_0', iqn='null', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='7b416557-c145-4e68-9fc4-d17eefdba6af', connection='mantis-nfs-lif2.lab.eng.tlv2.redhat.com:/nas01/ge_4_nfs_2', iqn='null', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='0a352502-59f1-4ce0-9b80-b140c7dbf350', connection='mantis-nfs-lif2.lab.eng.tlv2.redhat.com:/nas01/ge_4_nfs_1', iqn='null', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='bfc28ded-77e8-4024-bcf2-14f87d727ff5', connection='mantis-nfs-lif2.lab.eng.tlv2.redhat.com:/nas01/ge_4_export', iqn='null', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}]', sendNetworkEventOnFailure='true'}), log id: 36f94a7c >2018-09-21 22:07:03,626+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetDeviceListVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [6fd36bfa] FINISH, GetDeviceListVDSCommand, return: [LUNs:{id='3600a09803830447a4f244c4657595054', physicalVolumeId='JDUIYw-jeML-0J6j-u9uC-6LsA-t6My-av7boJ', volumeGroupId='Vp9Oj3-c5yL-Wvce-vu3f-fEKt-qWub-Yow0mp', serial='SNETAPP_LUN_C-Mode_80DzO_LFWYPT', lunMapping='4', vendorId='NETAPP', productId='LUN C-Mode', lunConnections='[StorageServerConnections:{id='null', connection='10.46.16.9', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='null', connection='10.46.16.10', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}]', deviceSize='50', pvSize='49', peCount='null', peAllocatedCount='null', vendorName='NETAPP', pathsDictionary='[sdf=true, sdm=true]', pathsCapacity='[sdf=50, sdm=50]', lunType='ISCSI', status='Unknown', diskId='null', diskAlias='null', storageDomainId='null', storageDomainName='null', discardMaxSize='8388608'}, LUNs:{id='3600a09803830447a4f244c4657595050', physicalVolumeId='UDouw3-NQGY-zSu0-y5NZ-EFn2-3R93-llax23', volumeGroupId='FZwCUM-nIcs-1uAp-Yeod-jp2w-B5wu-HWsoV7', serial='SNETAPP_LUN_C-Mode_80DzO_LFWYPP', lunMapping='0', vendorId='NETAPP', productId='LUN C-Mode', lunConnections='[StorageServerConnections:{id='null', connection='10.46.16.9', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='null', connection='10.46.16.10', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}]', deviceSize='150', pvSize='149', peCount='null', peAllocatedCount='null', vendorName='NETAPP', pathsDictionary='[sdb=true, sdi=true]', pathsCapacity='[sdb=150, sdi=150]', lunType='ISCSI', status='Unknown', diskId='null', diskAlias='null', storageDomainId='null', storageDomainName='null', discardMaxSize='8388608'}, LUNs:{id='3600a09803830447a4f244c4657595055', physicalVolumeId='vK0gsC-0SIc-LCej-Kkcn-TzWP-3RlB-7tf9Hk', volumeGroupId='', serial='SNETAPP_LUN_C-Mode_80DzO_LFWYPU', lunMapping='5', vendorId='NETAPP', productId='LUN C-Mode', lunConnections='[StorageServerConnections:{id='null', connection='10.46.16.9', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='null', connection='10.46.16.10', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}]', deviceSize='50', pvSize='50', peCount='null', peAllocatedCount='null', vendorName='NETAPP', pathsDictionary='[sdg=true, sdn=true]', pathsCapacity='[sdg=50, sdn=50]', lunType='ISCSI', status='Unknown', diskId='null', diskAlias='null', storageDomainId='null', storageDomainName='null', discardMaxSize='8388608'}, LUNs:{id='3600a09803830447a4f244c4657595053', physicalVolumeId='9SWTRl-33tO-jj5q-T65z-4rVG-RROE-839nhZ', volumeGroupId='', serial='SNETAPP_LUN_C-Mode_80DzO_LFWYPS', lunMapping='3', vendorId='NETAPP', productId='LUN C-Mode', lunConnections='[StorageServerConnections:{id='null', connection='10.46.16.9', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='null', connection='10.46.16.10', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}]', deviceSize='50', pvSize='50', peCount='null', peAllocatedCount='null', vendorName='NETAPP', pathsDictionary='[sde=true, sdl=true]', pathsCapacity='[sde=50, sdl=50]', lunType='ISCSI', status='Unknown', diskId='null', diskAlias='null', storageDomainId='null', storageDomainName='null', discardMaxSize='8388608'}, LUNs:{id='3600a09803830447a4f244c4657595051', physicalVolumeId='2dfEU4-rDmk-YLe0-Az0C-ta6I-EFXn-KEyX3i', volumeGroupId='trME8t-UcNA-agjM-bZ3b-fPkE-WjnR-ga3iWL', serial='SNETAPP_LUN_C-Mode_80DzO_LFWYPQ', lunMapping='1', vendorId='NETAPP', productId='LUN C-Mode', lunConnections='[StorageServerConnections:{id='null', connection='10.46.16.9', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='null', connection='10.46.16.10', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}]', deviceSize='150', pvSize='149', peCount='null', peAllocatedCount='null', vendorName='NETAPP', pathsDictionary='[sdc=true, sdj=true]', pathsCapacity='[sdc=150, sdj=150]', lunType='ISCSI', status='Unknown', diskId='null', diskAlias='null', storageDomainId='null', storageDomainName='null', discardMaxSize='8388608'}, LUNs:{id='3600a09803830447a4f244c4657595052', physicalVolumeId='oHQcyk-61zb-2jpB-nZue-okkh-gZTG-0QzSqH', volumeGroupId='JdHpFT-HHOh-NMzU-fN5m-1Wzq-72JV-v0jfeh', serial='SNETAPP_LUN_C-Mode_80DzO_LFWYPR', lunMapping='2', vendorId='NETAPP', productId='LUN C-Mode', lunConnections='[StorageServerConnections:{id='null', connection='10.46.16.9', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='null', connection='10.46.16.10', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}]', deviceSize='150', pvSize='149', peCount='null', peAllocatedCount='null', vendorName='NETAPP', pathsDictionary='[sdd=true, sdk=true]', pathsCapacity='[sdd=150, sdk=150]', lunType='ISCSI', status='Unknown', diskId='null', diskAlias='null', storageDomainId='null', storageDomainName='null', discardMaxSize='8388608'}, LUNs:{id='3600a09803830447a4f244c4657595056', physicalVolumeId='FNme2p-qHSX-TdAX-6A3a-j0xT-5dx6-O6k09d', volumeGroupId='wHflzk-MPfz-80zk-cTmd-sruv-UD0S-cbUMsa', serial='SNETAPP_LUN_C-Mode_80DzO_LFWYPV', lunMapping='6', vendorId='NETAPP', productId='LUN C-Mode', lunConnections='[StorageServerConnections:{id='null', connection='10.46.16.9', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='null', connection='10.46.16.10', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}]', deviceSize='130', pvSize='129', peCount='null', peAllocatedCount='null', vendorName='NETAPP', pathsDictionary='[sdh=true, sdo=true]', pathsCapacity='[sdh=130, sdo=130]', lunType='ISCSI', status='Unknown', diskId='null', diskAlias='null', storageDomainId='null', storageDomainName='null', discardMaxSize='8388608'}], log id: 6413a7e6 >2018-09-21 22:07:03,631+03 INFO [org.ovirt.engine.core.bll.storage.domain.SyncLunsInfoForBlockStorageDomainCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [39538965] Lock Acquired to object 'EngineLock:{exclusiveLocks='[0ff03194-c839-447b-9b6b-22e7c0497c53=STORAGE]', sharedLocks=''}' >2018-09-21 22:07:03,659+03 INFO [org.ovirt.engine.core.bll.storage.domain.SyncLunsInfoForBlockStorageDomainCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [39538965] Running command: SyncLunsInfoForBlockStorageDomainCommand internal: true. Entities affected : ID: 0ff03194-c839-447b-9b6b-22e7c0497c53 Type: Storage >2018-09-21 22:07:03,675+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetStorageDomainInfoVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [39538965] START, HSMGetStorageDomainInfoVDSCommand(HostName = host_mixed_2, HSMGetStorageDomainInfoVDSCommandParameters:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', storageDomainId='0ff03194-c839-447b-9b6b-22e7c0497c53'}), log id: 4b465559 >2018-09-21 22:07:04,196+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetStorageDomainInfoVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [39538965] FINISH, HSMGetStorageDomainInfoVDSCommand, return: <StorageDomainStatic:{name='iscsi_1', id='0ff03194-c839-447b-9b6b-22e7c0497c53'}, 636f1fce-bdba-11e8-89e0-001a4a168bfb>, log id: 4b465559 >2018-09-21 22:07:04,197+03 INFO [org.ovirt.engine.core.bll.storage.domain.SyncLunsInfoForBlockStorageDomainCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [39538965] Lock freed to object 'EngineLock:{exclusiveLocks='[0ff03194-c839-447b-9b6b-22e7c0497c53=STORAGE]', sharedLocks=''}' >2018-09-21 22:07:04,201+03 INFO [org.ovirt.engine.core.bll.storage.domain.SyncLunsInfoForBlockStorageDomainCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [6e7afcfd] Lock Acquired to object 'EngineLock:{exclusiveLocks='[6d08026e-998a-4eda-8959-66daf8643693=STORAGE]', sharedLocks=''}' >2018-09-21 22:07:04,225+03 INFO [org.ovirt.engine.core.bll.storage.domain.SyncLunsInfoForBlockStorageDomainCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [6e7afcfd] Running command: SyncLunsInfoForBlockStorageDomainCommand internal: true. Entities affected : ID: 6d08026e-998a-4eda-8959-66daf8643693 Type: Storage >2018-09-21 22:07:04,230+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetStorageDomainInfoVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [6e7afcfd] START, HSMGetStorageDomainInfoVDSCommand(HostName = host_mixed_2, HSMGetStorageDomainInfoVDSCommandParameters:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', storageDomainId='6d08026e-998a-4eda-8959-66daf8643693'}), log id: 1489126a >2018-09-21 22:07:04,318+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-47) [1e4206b5] FINISH, DisconnectStorageServerVDSCommand, return: {bfc28ded-77e8-4024-bcf2-14f87d727ff5=0, 0a352502-59f1-4ce0-9b80-b140c7dbf350=0, 7b416557-c145-4e68-9fc4-d17eefdba6af=0, c784238a-6f15-4c80-871d-14343adbce82=0}, log id: 36f94a7c >2018-09-21 22:07:04,325+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-47) [1e4206b5] START, DisconnectStorageServerVDSCommand(HostName = host_mixed_1, StorageServerConnectionManagementVDSParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', storagePoolId='636f1fce-bdba-11e8-89e0-001a4a168bfb', storageType='GLUSTERFS', connectionList='[StorageServerConnections:{id='26f34e4e-473e-4f9a-9158-66830eb2d298', connection='gluster01.lab.eng.tlv2.redhat.com:/GE_he5_volume01', iqn='null', vfsType='glusterfs', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='e1f27b29-b523-4ed3-8466-48d96aa6ff86', connection='gluster01.lab.eng.tlv2.redhat.com:/GE_he5_volume02', iqn='null', vfsType='glusterfs', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='6c7417c6-ba54-4a36-85aa-354a7f81cafc', connection='gluster01.lab.eng.tlv2.redhat.com:/GE_he5_volume03', iqn='null', vfsType='glusterfs', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}]', sendNetworkEventOnFailure='true'}), log id: 1008fd1f >2018-09-21 22:07:04,754+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetStorageDomainInfoVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [6e7afcfd] FINISH, HSMGetStorageDomainInfoVDSCommand, return: <StorageDomainStatic:{name='iscsi_2', id='6d08026e-998a-4eda-8959-66daf8643693'}, 636f1fce-bdba-11e8-89e0-001a4a168bfb>, log id: 1489126a >2018-09-21 22:07:04,755+03 INFO [org.ovirt.engine.core.bll.storage.domain.SyncLunsInfoForBlockStorageDomainCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [6e7afcfd] Lock freed to object 'EngineLock:{exclusiveLocks='[6d08026e-998a-4eda-8959-66daf8643693=STORAGE]', sharedLocks=''}' >2018-09-21 22:07:04,759+03 INFO [org.ovirt.engine.core.bll.storage.domain.SyncLunsInfoForBlockStorageDomainCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [671d1d23] Lock Acquired to object 'EngineLock:{exclusiveLocks='[6ea108d4-a74b-48a4-bed0-f80ed266e1f8=STORAGE]', sharedLocks=''}' >2018-09-21 22:07:04,782+03 INFO [org.ovirt.engine.core.bll.storage.domain.SyncLunsInfoForBlockStorageDomainCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [671d1d23] Running command: SyncLunsInfoForBlockStorageDomainCommand internal: true. Entities affected : ID: 6ea108d4-a74b-48a4-bed0-f80ed266e1f8 Type: Storage >2018-09-21 22:07:04,788+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetStorageDomainInfoVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [671d1d23] START, HSMGetStorageDomainInfoVDSCommand(HostName = host_mixed_2, HSMGetStorageDomainInfoVDSCommandParameters:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', storageDomainId='6ea108d4-a74b-48a4-bed0-f80ed266e1f8'}), log id: 3eb75296 >2018-09-21 22:07:04,941+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-47) [1e4206b5] FINISH, DisconnectStorageServerVDSCommand, return: {6c7417c6-ba54-4a36-85aa-354a7f81cafc=0, 26f34e4e-473e-4f9a-9158-66830eb2d298=0, e1f27b29-b523-4ed3-8466-48d96aa6ff86=0}, log id: 1008fd1f >2018-09-21 22:07:04,954+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-47) [1e4206b5] START, DisconnectStorageServerVDSCommand(HostName = host_mixed_1, StorageServerConnectionManagementVDSParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', storagePoolId='636f1fce-bdba-11e8-89e0-001a4a168bfb', storageType='ISCSI', connectionList='[StorageServerConnections:{id='537a7eb2-e8ac-4216-8a0b-7cae97b02c7e', connection='mantis-iscsi-lif2.lab.eng.tlv2.redhat.com', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='7af24dfe-be93-456e-a227-1e6bdc9b1412', connection='mantis-iscsi-lif2.lab.eng.tlv2.redhat.com', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}]', sendNetworkEventOnFailure='true'}), log id: 4b8702dd >2018-09-21 22:07:05,305+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetStorageDomainInfoVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [671d1d23] FINISH, HSMGetStorageDomainInfoVDSCommand, return: <StorageDomainStatic:{name='hosted_storage', id='6ea108d4-a74b-48a4-bed0-f80ed266e1f8'}, 636f1fce-bdba-11e8-89e0-001a4a168bfb>, log id: 3eb75296 >2018-09-21 22:07:05,306+03 INFO [org.ovirt.engine.core.bll.storage.domain.SyncLunsInfoForBlockStorageDomainCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [671d1d23] Lock freed to object 'EngineLock:{exclusiveLocks='[6ea108d4-a74b-48a4-bed0-f80ed266e1f8=STORAGE]', sharedLocks=''}' >2018-09-21 22:07:05,310+03 INFO [org.ovirt.engine.core.bll.storage.domain.SyncLunsInfoForBlockStorageDomainCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [17a351ce] Lock Acquired to object 'EngineLock:{exclusiveLocks='[d07490bb-849c-49de-931b-71d9c94ddaef=STORAGE]', sharedLocks=''}' >2018-09-21 22:07:05,334+03 INFO [org.ovirt.engine.core.bll.storage.domain.SyncLunsInfoForBlockStorageDomainCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [17a351ce] Running command: SyncLunsInfoForBlockStorageDomainCommand internal: true. Entities affected : ID: d07490bb-849c-49de-931b-71d9c94ddaef Type: Storage >2018-09-21 22:07:05,339+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetStorageDomainInfoVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [17a351ce] START, HSMGetStorageDomainInfoVDSCommand(HostName = host_mixed_2, HSMGetStorageDomainInfoVDSCommandParameters:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', storageDomainId='d07490bb-849c-49de-931b-71d9c94ddaef'}), log id: d94be79 >2018-09-21 22:07:05,847+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-47) [1e4206b5] FINISH, DisconnectStorageServerVDSCommand, return: {7af24dfe-be93-456e-a227-1e6bdc9b1412=0, 537a7eb2-e8ac-4216-8a0b-7cae97b02c7e=0}, log id: 4b8702dd >2018-09-21 22:07:05,862+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetStorageDomainInfoVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [17a351ce] FINISH, HSMGetStorageDomainInfoVDSCommand, return: <StorageDomainStatic:{name='iscsi_0', id='d07490bb-849c-49de-931b-71d9c94ddaef'}, 636f1fce-bdba-11e8-89e0-001a4a168bfb>, log id: d94be79 >2018-09-21 22:07:05,863+03 INFO [org.ovirt.engine.core.bll.storage.domain.SyncLunsInfoForBlockStorageDomainCommand] (EE-ManagedThreadFactory-engine-Thread-2337) [17a351ce] Lock freed to object 'EngineLock:{exclusiveLocks='[d07490bb-849c-49de-931b-71d9c94ddaef=STORAGE]', sharedLocks=''}' >2018-09-21 22:08:47,509+03 INFO [org.ovirt.engine.core.bll.provider.network.SyncNetworkProviderCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-43) [96f6820] Lock Acquired to object 'EngineLock:{exclusiveLocks='[6a2b313e-281f-4c5a-98bf-8d4cff75b671=PROVIDER]', sharedLocks=''}' >2018-09-21 22:08:47,520+03 INFO [org.ovirt.engine.core.bll.provider.network.SyncNetworkProviderCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-43) [96f6820] Running command: SyncNetworkProviderCommand internal: true. >2018-09-21 22:08:47,644+03 INFO [org.ovirt.engine.core.sso.utils.AuthenticationUtils] (default task-12) [] 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-09-21 22:08:47,807+03 INFO [org.ovirt.engine.core.bll.provider.network.SyncNetworkProviderCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-43) [96f6820] Lock freed to object 'EngineLock:{exclusiveLocks='[6a2b313e-281f-4c5a-98bf-8d4cff75b671=PROVIDER]', sharedLocks=''}' >2018-09-21 22:12:12,819+03 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (default task-42) [hosts_syncAction_ac45d34c-3359-4b5a] Lock Acquired to object 'EngineLock:{exclusiveLocks='[a6ebcb78-bc75-4342-927f-cdf57be26a25=VDS]', sharedLocks=''}' >2018-09-21 22:12:12,880+03 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (default task-42) [hosts_syncAction_ac45d34c-3359-4b5a] Running command: ActivateVdsCommand internal: false. Entities affected : ID: a6ebcb78-bc75-4342-927f-cdf57be26a25 Type: VDSAction group MANIPULATE_HOST with role type ADMIN >2018-09-21 22:12:12,880+03 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (default task-42) [hosts_syncAction_ac45d34c-3359-4b5a] Before acquiring lock in order to prevent monitoring for host 'host_mixed_1' from data-center 'golden_env_mixed' >2018-09-21 22:12:12,881+03 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (default task-42) [hosts_syncAction_ac45d34c-3359-4b5a] Lock acquired, from now a monitoring of host will be skipped for host 'host_mixed_1' from data-center 'golden_env_mixed' >2018-09-21 22:12:12,892+03 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (default task-42) [hosts_syncAction_ac45d34c-3359-4b5a] START, SetVdsStatusVDSCommand(HostName = host_mixed_1, SetVdsStatusVDSCommandParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', status='Unassigned', nonOperationalReason='NONE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 579e6681 >2018-09-21 22:12:12,897+03 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (default task-42) [hosts_syncAction_ac45d34c-3359-4b5a] FINISH, SetVdsStatusVDSCommand, log id: 579e6681 >2018-09-21 22:12:12,903+03 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (default task-42) [hosts_syncAction_ac45d34c-3359-4b5a] Activate host finished. Lock released. Monitoring can run now for host 'host_mixed_1' from data-center 'golden_env_mixed' >2018-09-21 22:12:12,912+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-42) [hosts_syncAction_ac45d34c-3359-4b5a] EVENT_ID: VDS_ACTIVATE(16), Activation of host host_mixed_1 initiated by admin@internal-authz. >2018-09-21 22:12:12,916+03 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (default task-42) [hosts_syncAction_ac45d34c-3359-4b5a] Lock freed to object 'EngineLock:{exclusiveLocks='[a6ebcb78-bc75-4342-927f-cdf57be26a25=VDS]', sharedLocks=''}' >2018-09-21 22:12:15,489+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoAsyncVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-48) [] START, GetHardwareInfoAsyncVDSCommand(HostName = host_mixed_1, VdsIdAndVdsVDSCommandParametersBase:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', vds='Host[host_mixed_1,a6ebcb78-bc75-4342-927f-cdf57be26a25]'}), log id: 309abaf3 >2018-09-21 22:12:15,489+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoAsyncVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-48) [] FINISH, GetHardwareInfoAsyncVDSCommand, log id: 309abaf3 >2018-09-21 22:12:15,529+03 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-48) [78e98cb5] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: a6ebcb78-bc75-4342-927f-cdf57be26a25 Type: VDS >2018-09-21 22:12:15,696+03 INFO [org.ovirt.engine.core.bll.InitVdsOnUpCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [2995a007] Running command: InitVdsOnUpCommand internal: true. Entities affected : ID: 636f1fce-bdba-11e8-89e0-001a4a168bfb Type: StoragePool >2018-09-21 22:12:15,709+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetHaMaintenanceModeVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [2995a007] START, SetHaMaintenanceModeVDSCommand(HostName = host_mixed_1, SetHaMaintenanceModeVDSCommandParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25'}), log id: 13b72aeb >2018-09-21 22:12:15,714+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetHaMaintenanceModeVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [2995a007] FINISH, SetHaMaintenanceModeVDSCommand, log id: 13b72aeb >2018-09-21 22:12:15,736+03 INFO [org.ovirt.engine.core.bll.storage.pool.ConnectHostToStoragePoolServersCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [25cd4d0b] Running command: ConnectHostToStoragePoolServersCommand internal: true. Entities affected : ID: 636f1fce-bdba-11e8-89e0-001a4a168bfb Type: StoragePool >2018-09-21 22:12:15,761+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [25cd4d0b] START, ConnectStorageServerVDSCommand(HostName = host_mixed_1, StorageServerConnectionManagementVDSParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', storagePoolId='636f1fce-bdba-11e8-89e0-001a4a168bfb', storageType='NFS', connectionList='[StorageServerConnections:{id='c784238a-6f15-4c80-871d-14343adbce82', connection='mantis-nfs-lif2.lab.eng.tlv2.redhat.com:/nas01/ge_4_nfs_0', iqn='null', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='7b416557-c145-4e68-9fc4-d17eefdba6af', connection='mantis-nfs-lif2.lab.eng.tlv2.redhat.com:/nas01/ge_4_nfs_2', iqn='null', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='0a352502-59f1-4ce0-9b80-b140c7dbf350', connection='mantis-nfs-lif2.lab.eng.tlv2.redhat.com:/nas01/ge_4_nfs_1', iqn='null', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}]', sendNetworkEventOnFailure='true'}), log id: 2c6d247f >2018-09-21 22:12:16,196+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [25cd4d0b] FINISH, ConnectStorageServerVDSCommand, return: {0a352502-59f1-4ce0-9b80-b140c7dbf350=0, 7b416557-c145-4e68-9fc4-d17eefdba6af=0, c784238a-6f15-4c80-871d-14343adbce82=0}, log id: 2c6d247f >2018-09-21 22:12:16,200+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [25cd4d0b] START, ConnectStorageServerVDSCommand(HostName = host_mixed_1, StorageServerConnectionManagementVDSParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', storagePoolId='636f1fce-bdba-11e8-89e0-001a4a168bfb', storageType='NFS', connectionList='[StorageServerConnections:{id='bfc28ded-77e8-4024-bcf2-14f87d727ff5', connection='mantis-nfs-lif2.lab.eng.tlv2.redhat.com:/nas01/ge_4_export', iqn='null', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}]', sendNetworkEventOnFailure='false'}), log id: 73eb1329 >2018-09-21 22:12:16,324+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [25cd4d0b] FINISH, ConnectStorageServerVDSCommand, return: {bfc28ded-77e8-4024-bcf2-14f87d727ff5=0}, log id: 73eb1329 >2018-09-21 22:12:16,336+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [25cd4d0b] START, ConnectStorageServerVDSCommand(HostName = host_mixed_1, StorageServerConnectionManagementVDSParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', storagePoolId='636f1fce-bdba-11e8-89e0-001a4a168bfb', storageType='GLUSTERFS', connectionList='[StorageServerConnections:{id='26f34e4e-473e-4f9a-9158-66830eb2d298', connection='gluster01.lab.eng.tlv2.redhat.com:/GE_he5_volume01', iqn='null', vfsType='glusterfs', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='e1f27b29-b523-4ed3-8466-48d96aa6ff86', connection='gluster01.lab.eng.tlv2.redhat.com:/GE_he5_volume02', iqn='null', vfsType='glusterfs', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='6c7417c6-ba54-4a36-85aa-354a7f81cafc', connection='gluster01.lab.eng.tlv2.redhat.com:/GE_he5_volume03', iqn='null', vfsType='glusterfs', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}]', sendNetworkEventOnFailure='true'}), log id: 36cee21f >2018-09-21 22:12:18,311+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [25cd4d0b] FINISH, ConnectStorageServerVDSCommand, return: {6c7417c6-ba54-4a36-85aa-354a7f81cafc=0, 26f34e4e-473e-4f9a-9158-66830eb2d298=0, e1f27b29-b523-4ed3-8466-48d96aa6ff86=0}, log id: 36cee21f >2018-09-21 22:12:18,319+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [25cd4d0b] START, ConnectStorageServerVDSCommand(HostName = host_mixed_1, StorageServerConnectionManagementVDSParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', storagePoolId='636f1fce-bdba-11e8-89e0-001a4a168bfb', storageType='ISCSI', connectionList='[StorageServerConnections:{id='537a7eb2-e8ac-4216-8a0b-7cae97b02c7e', connection='mantis-iscsi-lif2.lab.eng.tlv2.redhat.com', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}, StorageServerConnections:{id='7af24dfe-be93-456e-a227-1e6bdc9b1412', connection='mantis-iscsi-lif2.lab.eng.tlv2.redhat.com', iqn='iqn.1992-08.com.netapp:vserver-rhv-qe', vfsType='null', mountOptions='null', nfsVersion='null', nfsRetrans='null', nfsTimeo='null', iface='null', netIfaceName='null'}]', sendNetworkEventOnFailure='true'}), log id: 6692546a >2018-09-21 22:12:18,353+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher] (EE-ManagedThreadFactory-engineScheduled-Thread-37) [] Fetched 0 VMs from VDS 'a6ebcb78-bc75-4342-927f-cdf57be26a25' >2018-09-21 22:12:21,601+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [25cd4d0b] FINISH, ConnectStorageServerVDSCommand, return: {7af24dfe-be93-456e-a227-1e6bdc9b1412=0, 537a7eb2-e8ac-4216-8a0b-7cae97b02c7e=0}, log id: 6692546a >2018-09-21 22:12:21,606+03 INFO [org.ovirt.engine.core.bll.storage.pool.ConnectHostToStoragePoolServersCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [25cd4d0b] Host 'host_mixed_1' storage connection was succeeded >2018-09-21 22:12:21,623+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2421) [25cd4d0b] START, ConnectStoragePoolVDSCommand(HostName = host_mixed_1, ConnectStoragePoolVDSCommandParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', vdsId='a6ebcb78-bc75-4342-927f-cdf57be26a25', storagePoolId='636f1fce-bdba-11e8-89e0-001a4a168bfb', masterVersion='1'}), log id: 236a92bd >2018-09-21 22:12:21,625+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2421) [25cd4d0b] Executing with domain map: {0ff03194-c839-447b-9b6b-22e7c0497c53=active, 496562a7-da01-4b33-851d-2ba6c58d636a=active, d49ff3ce-c509-424f-a461-3e3d21c8bb03=active, 444d20aa-057d-4dd8-8551-5af62b5da5b4=active, 6d08026e-998a-4eda-8959-66daf8643693=active, d07490bb-849c-49de-931b-71d9c94ddaef=active, 5301bfc2-6b70-44ba-8f89-9aa181a6cb28=active, a55a328a-da76-4e58-99aa-bcd914a01a4d=active, 727f775a-5d4c-4e80-a6ff-bb99e18daa7a=active, e90100f0-8901-433c-b50c-9bd03653c309=active, 6ea108d4-a74b-48a4-bed0-f80ed266e1f8=active} >2018-09-21 22:12:23,139+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (EE-ManagedThreadFactory-engine-Thread-2421) [25cd4d0b] FINISH, ConnectStoragePoolVDSCommand, log id: 236a92bd >2018-09-21 22:12:23,210+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engine-Thread-2421) [25cd4d0b] EVENT_ID: NO_FAULTY_MULTIPATHS_ON_HOST(11,501), No faulty multipath paths on host host_mixed_1 >2018-09-21 22:12:23,211+03 WARN [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engine-Thread-2421) [25cd4d0b] Domain 'd07490bb-849c-49de-931b-71d9c94ddaef:iscsi_0' report isn't an actual report >2018-09-21 22:12:23,211+03 WARN [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engine-Thread-2421) [25cd4d0b] Domain '6d08026e-998a-4eda-8959-66daf8643693:iscsi_2' report isn't an actual report >2018-09-21 22:12:23,212+03 WARN [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engine-Thread-2421) [25cd4d0b] Domain '0ff03194-c839-447b-9b6b-22e7c0497c53:iscsi_1' report isn't an actual report >2018-09-21 22:12:23,255+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetMOMPolicyParametersVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [25cd4d0b] START, SetMOMPolicyParametersVDSCommand(HostName = host_mixed_1, MomPolicyVDSParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25'}), log id: 2c2658b9 >2018-09-21 22:12:23,351+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetMOMPolicyParametersVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [25cd4d0b] FINISH, SetMOMPolicyParametersVDSCommand, log id: 2c2658b9 >2018-09-21 22:12:23,371+03 INFO [org.ovirt.engine.core.bll.hostdev.RefreshHostDevicesCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [4c0248c5] Running command: RefreshHostDevicesCommand internal: true. Entities affected : ID: a6ebcb78-bc75-4342-927f-cdf57be26a25 Type: VDSAction group MANIPULATE_HOST with role type ADMIN >2018-09-21 22:12:24,685+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [4c0248c5] EVENT_ID: VDS_DETECTED(13), Status of host host_mixed_1 was set to Up. >2018-09-21 22:12:24,689+03 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [4c0248c5] EVENT_ID: VDS_ALERT_FENCE_IS_NOT_CONFIGURED(9,000), Failed to verify Power Management configuration for Host host_mixed_1. >2018-09-21 22:12:24,717+03 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [14e41c3b] Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: a6ebcb78-bc75-4342-927f-cdf57be26a25 Type: VDS >2018-09-21 22:12:24,726+03 WARN [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [14e41c3b] Domain 'd07490bb-849c-49de-931b-71d9c94ddaef:iscsi_0' report isn't an actual report >2018-09-21 22:12:24,726+03 WARN [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [14e41c3b] Domain '6d08026e-998a-4eda-8959-66daf8643693:iscsi_2' report isn't an actual report >2018-09-21 22:12:24,727+03 WARN [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxy] (EE-ManagedThreadFactory-engineScheduled-Thread-91) [14e41c3b] Domain '0ff03194-c839-447b-9b6b-22e7c0497c53:iscsi_1' report isn't an actual report >2018-09-21 22:12:46,334+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-55) [vms_update_091b0421-ec7e-4a5c] Lock Acquired to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_0=VM_NAME]', sharedLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]'}' >2018-09-21 22:12:46,373+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-55) [vms_update_091b0421-ec7e-4a5c] Running command: UpdateVmCommand internal: false. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_VM_PROPERTIES with role type USER, ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_ADMIN_VM_PROPERTIES with role type ADMIN >2018-09-21 22:12:46,415+03 INFO [org.ovirt.engine.core.bll.UpdateGraphicsDeviceCommand] (default task-55) [53ea23e2] Running command: UpdateGraphicsDeviceCommand internal: true. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_VM_PROPERTIES with role type USER >2018-09-21 22:12:46,421+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-55) [53ea23e2] Pinned host changed for VM: golden_env_mixed_virtio_1_0. Dropping configured host devices. >2018-09-21 22:12:46,432+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-55) [53ea23e2] EVENT_ID: USER_UPDATE_VM(35), VM golden_env_mixed_virtio_1_0 configuration was updated by admin@internal-authz. >2018-09-21 22:12:46,436+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-55) [53ea23e2] Lock freed to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_0=VM_NAME]', sharedLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]'}' >2018-09-21 22:12:46,835+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-56) [vms_update_172421c5-871d-4cab] Lock Acquired to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_0=VM_NAME]', sharedLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]'}' >2018-09-21 22:12:46,875+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-56) [vms_update_172421c5-871d-4cab] Running command: UpdateVmCommand internal: false. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_VM_PROPERTIES with role type USER, ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_ADMIN_VM_PROPERTIES with role type ADMIN >2018-09-21 22:12:46,894+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-56) [vms_update_172421c5-871d-4cab] Pinned host changed for VM: golden_env_mixed_virtio_1_0. Dropping configured host devices. >2018-09-21 22:12:46,904+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-56) [vms_update_172421c5-871d-4cab] EVENT_ID: USER_UPDATE_VM(35), VM golden_env_mixed_virtio_1_0 configuration was updated by admin@internal-authz. >2018-09-21 22:12:46,908+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-56) [vms_update_172421c5-871d-4cab] Lock freed to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_0=VM_NAME]', sharedLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]'}' >2018-09-21 22:12:47,139+03 INFO [org.ovirt.engine.core.bll.RunVmCommand] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] Lock Acquired to object 'EngineLock:{exclusiveLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]', sharedLocks=''}' >2018-09-21 22:12:47,163+03 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] START, IsVmDuringInitiatingVDSCommand( IsVmDuringInitiatingVDSCommandParameters:{vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796'}), log id: 4a403b38 >2018-09-21 22:12:47,163+03 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] FINISH, IsVmDuringInitiatingVDSCommand, return: false, log id: 4a403b38 >2018-09-21 22:12:47,183+03 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] Candidate host 'host_mixed_3' ('a7e45cf7-2174-42c5-a730-d5c3c568409a') was filtered out by 'VAR__FILTERTYPE__INTERNAL' filter 'PinToHost' (correlation id: null) >2018-09-21 22:12:47,217+03 INFO [org.ovirt.engine.core.bll.RunVmCommand] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] Running command: RunVmCommand internal: false. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group RUN_VM with role type USER >2018-09-21 22:12:47,231+03 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] Candidate host 'host_mixed_3' ('a7e45cf7-2174-42c5-a730-d5c3c568409a') was filtered out by 'VAR__FILTERTYPE__INTERNAL' filter 'PinToHost' (correlation id: vms_syncAction_c31552c6-cde9-4ce6) >2018-09-21 22:12:47,265+03 INFO [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] START, UpdateVmDynamicDataVDSCommand( UpdateVmDynamicDataVDSCommandParameters:{hostId='null', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', vmDynamic='org.ovirt.engine.core.common.businessentities.VmDynamic@c6402a80'}), log id: 36816d30 >2018-09-21 22:12:47,269+03 INFO [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] FINISH, UpdateVmDynamicDataVDSCommand, log id: 36816d30 >2018-09-21 22:12:47,274+03 INFO [org.ovirt.engine.core.vdsbroker.CreateVDSCommand] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] START, CreateVDSCommand( CreateVDSCommandParameters:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', vm='VM [golden_env_mixed_virtio_1_0]'}), log id: 62c1bfc3 >2018-09-21 22:12:47,277+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] START, CreateBrokerVDSCommand(HostName = host_mixed_2, CreateVDSCommandParameters:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', vm='VM [golden_env_mixed_virtio_1_0]'}), log id: 79b1d3d2 >2018-09-21 22:12:47,294+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] 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>golden_env_mixed_virtio_1_0</name> > <uuid>b43f9124-f743-47e9-a0f3-a15c83a8e796</uuid> > <memory>1048576</memory> > <currentMemory>1048576</currentMemory> > <maxMemory slots="16">4194304</maxMemory> > <vcpu current="1">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">b43f9124-f743-47e9-a0f3-a15c83a8e796</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>Westmere</model> > <topology cores="1" threads="1" sockets="16"/> > <numa> > <cell id="0" cpus="0" memory="1048576"/> > </numa> > </cpu> > <cputune/> > <devices> > <input type="mouse" bus="ps2"/> > <channel type="unix"> > <target type="virtio" name="ovirt-guest-agent.0"/> > <source mode="bind" path="/var/lib/libvirt/qemu/channels/b43f9124-f743-47e9-a0f3-a15c83a8e796.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/b43f9124-f743-47e9-a0f3-a15c83a8e796.org.qemu.guest_agent.0"/> > </channel> > <controller type="scsi" model="virtio-scsi" index="0"> > <alias name="ua-307922cc-9927-4f02-9720-649435a950a1"/> > </controller> > <sound model="ich6"> > <alias name="ua-3e6956fd-dd98-4d66-91fc-f91e52be4b0c"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x04" type="pci"/> > </sound> > <controller type="virtio-serial" index="0" ports="16"> > <alias name="ua-4f6e44c4-cb76-459f-ac3e-082eefcf3925"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x05" type="pci"/> > </controller> > <memballoon model="virtio"> > <stats period="5"/> > <alias name="ua-57427a8e-1cd6-4913-b8ca-eabbc824aed9"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x08" type="pci"/> > </memballoon> > <video> > <model type="qxl" vram="8192" heads="1" ram="65536" vgamem="16384"/> > <alias name="ua-8abe45ec-483c-4661-80eb-ddf3f33e1628"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x02" type="pci"/> > </video> > <controller type="ide" index="0"> > <address bus="0x00" domain="0x0000" function="0x1" slot="0x01" type="pci"/> > </controller> > <graphics type="spice" port="-1" autoport="yes" passwd="*****" passwdValidTo="1970-01-01T00:00:01" tlsPort="-1"> > <channel name="main" mode="secure"/> > <channel name="inputs" mode="secure"/> > <channel name="cursor" mode="secure"/> > <channel name="playback" mode="secure"/> > <channel name="record" mode="secure"/> > <channel name="display" mode="secure"/> > <channel name="smartcard" mode="secure"/> > <channel name="usbredir" mode="secure"/> > <listen type="network" network="vdsm-ovirtmgmt"/> > </graphics> > <rng model="virtio"> > <backend model="random">/dev/urandom</backend> > <alias name="ua-bbff748a-6eea-4a22-8074-c4324b0eaa4d"/> > </rng> > <controller type="usb" model="piix3-uhci" index="0"> > <address bus="0x00" domain="0x0000" function="0x2" slot="0x01" type="pci"/> > </controller> > <channel type="spicevmc"> > <target type="virtio" name="com.redhat.spice.0"/> > </channel> > <interface type="bridge"> > <model type="virtio"/> > <link state="up"/> > <source bridge="ovirtmgmt"/> > <alias name="ua-face3b7e-cea7-4bae-92ac-f1b9f498995f"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x03" type="pci"/> > <mac address="00:1a:4a:16:88:c9"/> > <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-892dceaf-0e49-480e-aa27-12a35bc55da6"/> > <address bus="1" controller="0" unit="0" type="drive" target="0"/> > </disk> > <disk snapshot="no" type="file" device="disk"> > <target dev="vda" bus="virtio"/> > <source file="/rhev/data-center/636f1fce-bdba-11e8-89e0-001a4a168bfb/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd"/> > <driver name="qemu" io="threads" type="qcow2" error_policy="stop" cache="none"/> > <alias name="ua-f002a528-68aa-4013-8c14-7b330f932412"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x07" type="pci"/> > <boot order="1"/> > <serial>f002a528-68aa-4013-8c14-7b330f932412</serial> > </disk> > </devices> > <pm> > <suspend-to-disk enabled="no"/> > <suspend-to-mem enabled="no"/> > </pm> > <os> > <type arch="x86_64" machine="pc-i440fx-rhel7.5.0">hvm</type> > <smbios mode="sysinfo"/> > </os> > <metadata> > <ovirt-tune:qos/> > <ovirt-vm:vm> > <minGuaranteedMemoryMb type="int">1024</minGuaranteedMemoryMb> > <clusterVersion>4.2</clusterVersion> > <ovirt-vm:custom/> > <ovirt-vm:device mac_address="00:1a:4a:16:88:c9"> > <ovirt-vm:custom/> > </ovirt-vm:device> > <ovirt-vm:device devtype="disk" name="vda"> > <ovirt-vm:poolID>636f1fce-bdba-11e8-89e0-001a4a168bfb</ovirt-vm:poolID> > <ovirt-vm:volumeID>2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd</ovirt-vm:volumeID> > <ovirt-vm:imageID>f002a528-68aa-4013-8c14-7b330f932412</ovirt-vm:imageID> > <ovirt-vm:domainID>727f775a-5d4c-4e80-a6ff-bb99e18daa7a</ovirt-vm:domainID> > </ovirt-vm:device> > <launchPaused>false</launchPaused> > <resumeBehavior>auto_resume</resumeBehavior> > </ovirt-vm:vm> > </metadata> ></domain> > >2018-09-21 22:12:47,323+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] FINISH, CreateBrokerVDSCommand, log id: 79b1d3d2 >2018-09-21 22:12:47,326+03 INFO [org.ovirt.engine.core.vdsbroker.CreateVDSCommand] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] FINISH, CreateVDSCommand, return: WaitForLaunch, log id: 62c1bfc3 >2018-09-21 22:12:47,326+03 INFO [org.ovirt.engine.core.bll.RunVmCommand] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] Lock freed to object 'EngineLock:{exclusiveLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]', sharedLocks=''}' >2018-09-21 22:12:47,339+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-61) [vms_syncAction_c31552c6-cde9-4ce6] EVENT_ID: USER_STARTED_VM(153), VM golden_env_mixed_virtio_1_0 was started by admin@internal-authz (Host: host_mixed_2). >2018-09-21 22:12:52,035+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (ForkJoinPool-1-worker-2) [] VM 'b43f9124-f743-47e9-a0f3-a15c83a8e796'(golden_env_mixed_virtio_1_0) moved from 'WaitForLaunch' --> 'PoweringUp' >2018-09-21 22:12:52,052+03 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (ForkJoinPool-1-worker-2) [] VMs initialization finished for Host: 'host_mixed_2:a2254d74-4e35-4ae9-b8d5-8945ed12dd01' >2018-09-21 22:12:52,054+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DumpXmlsVDSCommand] (ForkJoinPool-1-worker-2) [] START, DumpXmlsVDSCommand(HostName = host_mixed_2, Params:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', vmIds='[b43f9124-f743-47e9-a0f3-a15c83a8e796]'}), log id: ef23446 >2018-09-21 22:12:52,059+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DumpXmlsVDSCommand] (ForkJoinPool-1-worker-2) [] FINISH, DumpXmlsVDSCommand, return: {b43f9124-f743-47e9-a0f3-a15c83a8e796=<domain type='kvm' id='1'> > <name>golden_env_mixed_virtio_1_0</name> > <uuid>b43f9124-f743-47e9-a0f3-a15c83a8e796</uuid> > <metadata xmlns:ns0="http://ovirt.org/vm/tune/1.0" xmlns:ovirt-vm="http://ovirt.org/vm/1.0"> > <ns0:qos/> > <ovirt-vm:vm xmlns:ovirt-vm="http://ovirt.org/vm/1.0"> > <ovirt-vm:clusterVersion>4.2</ovirt-vm:clusterVersion> > <ovirt-vm:destroy_on_reboot type="bool">False</ovirt-vm:destroy_on_reboot> > <ovirt-vm:launchPaused>false</ovirt-vm:launchPaused> > <ovirt-vm:memGuaranteedSize type="int">1024</ovirt-vm:memGuaranteedSize> > <ovirt-vm:minGuaranteedMemoryMb type="int">1024</ovirt-vm:minGuaranteedMemoryMb> > <ovirt-vm:resumeBehavior>auto_resume</ovirt-vm:resumeBehavior> > <ovirt-vm:startTime type="float">1537557167.31</ovirt-vm:startTime> > <ovirt-vm:device mac_address="00:1a:4a:16:88:c9"> > <ovirt-vm:network>ovirtmgmt</ovirt-vm:network> > <ovirt-vm:specParams/> > <ovirt-vm:vm_custom/> > </ovirt-vm:device> > <ovirt-vm:device devtype="disk" name="vda"> > <ovirt-vm:domainID>727f775a-5d4c-4e80-a6ff-bb99e18daa7a</ovirt-vm:domainID> > <ovirt-vm:imageID>f002a528-68aa-4013-8c14-7b330f932412</ovirt-vm:imageID> > <ovirt-vm:poolID>636f1fce-bdba-11e8-89e0-001a4a168bfb</ovirt-vm:poolID> > <ovirt-vm:volumeID>2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd</ovirt-vm:volumeID> > <ovirt-vm:specParams/> > <ovirt-vm:vm_custom/> > <ovirt-vm:volumeChain> > <ovirt-vm:volumeChainNode> > <ovirt-vm:domainID>727f775a-5d4c-4e80-a6ff-bb99e18daa7a</ovirt-vm:domainID> > <ovirt-vm:imageID>f002a528-68aa-4013-8c14-7b330f932412</ovirt-vm:imageID> > <ovirt-vm:leaseOffset type="int">0</ovirt-vm:leaseOffset> > <ovirt-vm:leasePath>/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd.lease</ovirt-vm:leasePath> > <ovirt-vm:path>/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd</ovirt-vm:path> > <ovirt-vm:volumeID>2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd</ovirt-vm:volumeID> > </ovirt-vm:volumeChainNode> > <ovirt-vm:volumeChainNode> > <ovirt-vm:domainID>727f775a-5d4c-4e80-a6ff-bb99e18daa7a</ovirt-vm:domainID> > <ovirt-vm:imageID>f002a528-68aa-4013-8c14-7b330f932412</ovirt-vm:imageID> > <ovirt-vm:leaseOffset type="int">0</ovirt-vm:leaseOffset> > <ovirt-vm:leasePath>/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/d7e7907f-79cf-48c1-a5f9-6d4ac2b111b6.lease</ovirt-vm:leasePath> > <ovirt-vm:path>/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/d7e7907f-79cf-48c1-a5f9-6d4ac2b111b6</ovirt-vm:path> > <ovirt-vm:volumeID>d7e7907f-79cf-48c1-a5f9-6d4ac2b111b6</ovirt-vm:volumeID> > </ovirt-vm:volumeChainNode> > </ovirt-vm:volumeChain> > </ovirt-vm:device> > <ovirt-vm:device devtype="disk" name="hdc"> > <ovirt-vm:specParams/> > <ovirt-vm:vm_custom/> > </ovirt-vm:device> ></ovirt-vm:vm> > </metadata> > <maxMemory slots='16' unit='KiB'>4194304</maxMemory> > <memory unit='KiB'>1048576</memory> > <currentMemory unit='KiB'>1048576</currentMemory> > <vcpu placement='static' current='1'>16</vcpu> > <resource> > <partition>/machine</partition> > </resource> > <sysinfo type='smbios'> > <system> > <entry name='manufacturer'>oVirt</entry> > <entry name='product'>RHEV Hypervisor</entry> > <entry name='version'>7.6-7.0.el7</entry> > <entry name='serial'>4c4c4544-0053-3810-8057-b3c04f563232</entry> > <entry name='uuid'>b43f9124-f743-47e9-a0f3-a15c83a8e796</entry> > </system> > </sysinfo> > <os> > <type arch='x86_64' machine='pc-i440fx-rhel7.5.0'>hvm</type> > <smbios mode='sysinfo'/> > </os> > <features> > <acpi/> > </features> > <cpu mode='custom' match='exact' check='full'> > <model fallback='forbid'>Westmere</model> > <topology sockets='16' cores='1' threads='1'/> > <feature policy='require' name='vme'/> > <feature policy='require' name='pclmuldq'/> > <feature policy='require' name='x2apic'/> > <feature policy='require' name='hypervisor'/> > <feature policy='require' name='arat'/> > <numa> > <cell id='0' cpus='0' memory='1048576' unit='KiB'/> > </numa> > </cpu> > <clock offset='variable' adjustment='0' basis='utc'> > <timer name='rtc' tickpolicy='catchup'/> > <timer name='pit' tickpolicy='delay'/> > <timer name='hpet' present='no'/> > </clock> > <on_poweroff>destroy</on_poweroff> > <on_reboot>restart</on_reboot> > <on_crash>destroy</on_crash> > <pm> > <suspend-to-mem enabled='no'/> > <suspend-to-disk enabled='no'/> > </pm> > <devices> > <emulator>/usr/libexec/qemu-kvm</emulator> > <disk type='file' device='cdrom'> > <driver name='qemu' error_policy='report'/> > <source startupPolicy='optional'/> > <target dev='hdc' bus='ide'/> > <readonly/> > <alias name='ua-892dceaf-0e49-480e-aa27-12a35bc55da6'/> > <address type='drive' controller='0' bus='1' target='0' unit='0'/> > </disk> > <disk type='file' device='disk' snapshot='no'> > <driver name='qemu' type='qcow2' cache='none' error_policy='stop' io='threads'/> > <source file='/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd'/> > <backingStore type='file' index='1'> > <format type='qcow2'/> > <source file='/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/d7e7907f-79cf-48c1-a5f9-6d4ac2b111b6'/> > <backingStore/> > </backingStore> > <target dev='vda' bus='virtio'/> > <serial>f002a528-68aa-4013-8c14-7b330f932412</serial> > <boot order='1'/> > <alias name='ua-f002a528-68aa-4013-8c14-7b330f932412'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x07' function='0x0'/> > </disk> > <controller type='scsi' index='0' model='virtio-scsi'> > <alias name='ua-307922cc-9927-4f02-9720-649435a950a1'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x06' function='0x0'/> > </controller> > <controller type='virtio-serial' index='0' ports='16'> > <alias name='ua-4f6e44c4-cb76-459f-ac3e-082eefcf3925'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x05' function='0x0'/> > </controller> > <controller type='ide' index='0'> > <alias name='ide'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x01' function='0x1'/> > </controller> > <controller type='usb' index='0' model='piix3-uhci'> > <alias name='usb'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x01' function='0x2'/> > </controller> > <controller type='pci' index='0' model='pci-root'> > <alias name='pci.0'/> > </controller> > <interface type='bridge'> > <mac address='00:1a:4a:16:88:c9'/> > <source bridge='ovirtmgmt'/> > <target dev='vnet0'/> > <model type='virtio'/> > <filterref filter='vdsm-no-mac-spoofing'/> > <link state='up'/> > <mtu size='1500'/> > <alias name='ua-face3b7e-cea7-4bae-92ac-f1b9f498995f'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x03' function='0x0'/> > </interface> > <channel type='unix'> > <source mode='bind' path='/var/lib/libvirt/qemu/channels/b43f9124-f743-47e9-a0f3-a15c83a8e796.ovirt-guest-agent.0'/> > <target type='virtio' name='ovirt-guest-agent.0' state='disconnected'/> > <alias name='channel0'/> > <address type='virtio-serial' controller='0' bus='0' port='1'/> > </channel> > <channel type='unix'> > <source mode='bind' path='/var/lib/libvirt/qemu/channels/b43f9124-f743-47e9-a0f3-a15c83a8e796.org.qemu.guest_agent.0'/> > <target type='virtio' name='org.qemu.guest_agent.0' state='disconnected'/> > <alias name='channel1'/> > <address type='virtio-serial' controller='0' bus='0' port='2'/> > </channel> > <channel type='spicevmc'> > <target type='virtio' name='com.redhat.spice.0' state='disconnected'/> > <alias name='channel2'/> > <address type='virtio-serial' controller='0' bus='0' port='3'/> > </channel> > <input type='mouse' bus='ps2'> > <alias name='input0'/> > </input> > <input type='keyboard' bus='ps2'> > <alias name='input1'/> > </input> > <graphics type='spice' port='5900' tlsPort='5901' autoport='yes' listen='10.46.16.30' passwdValidTo='1970-01-01T00:00:01'> > <listen type='network' address='10.46.16.30' network='vdsm-ovirtmgmt'/> > <channel name='main' mode='secure'/> > <channel name='display' mode='secure'/> > <channel name='inputs' mode='secure'/> > <channel name='cursor' mode='secure'/> > <channel name='playback' mode='secure'/> > <channel name='record' mode='secure'/> > <channel name='smartcard' mode='secure'/> > <channel name='usbredir' mode='secure'/> > </graphics> > <sound model='ich6'> > <alias name='ua-3e6956fd-dd98-4d66-91fc-f91e52be4b0c'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x04' function='0x0'/> > </sound> > <video> > <model type='qxl' ram='65536' vram='8192' vgamem='16384' heads='1' primary='yes'/> > <alias name='ua-8abe45ec-483c-4661-80eb-ddf3f33e1628'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x02' function='0x0'/> > </video> > <memballoon model='virtio'> > <stats period='5'/> > <alias name='ua-57427a8e-1cd6-4913-b8ca-eabbc824aed9'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x08' function='0x0'/> > </memballoon> > <rng model='virtio'> > <backend model='random'>/dev/urandom</backend> > <alias name='ua-bbff748a-6eea-4a22-8074-c4324b0eaa4d'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x09' function='0x0'/> > </rng> > </devices> > <seclabel type='dynamic' model='selinux' relabel='yes'> > <label>system_u:system_r:svirt_t:s0:c774,c911</label> > <imagelabel>system_u:object_r:svirt_image_t:s0:c774,c911</imagelabel> > </seclabel> > <seclabel type='dynamic' model='dac' relabel='yes'> > <label>+107:+107</label> > <imagelabel>+107:+107</imagelabel> > </seclabel> ></domain> >}, log id: ef23446 >2018-09-21 22:12:57,600+03 INFO [org.ovirt.engine.core.bll.MigrateVmCommand] (default task-64) [vms_syncAction_5bd2d7bb-5842-486f] Lock Acquired to object 'EngineLock:{exclusiveLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]', sharedLocks=''}' >2018-09-21 22:12:57,632+03 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-64) [vms_syncAction_5bd2d7bb-5842-486f] EVENT_ID: VM_MIGRATION_FAILED(65), Migration failed due to a failed validation: [Cannot migrate VM. VM is pinned to Host.] (VM: golden_env_mixed_virtio_1_0, Source: host_mixed_2). >2018-09-21 22:12:57,632+03 WARN [org.ovirt.engine.core.bll.MigrateVmCommand] (default task-64) [vms_syncAction_5bd2d7bb-5842-486f] Validation of action 'MigrateVm' failed for user admin@internal-authz. Reasons: VAR__ACTION__MIGRATE,VAR__TYPE__VM,ACTION_TYPE_FAILED_VM_IS_PINNED_TO_HOST >2018-09-21 22:12:57,633+03 INFO [org.ovirt.engine.core.bll.MigrateVmCommand] (default task-64) [vms_syncAction_5bd2d7bb-5842-486f] Lock freed to object 'EngineLock:{exclusiveLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]', sharedLocks=''}' >2018-09-21 22:12:57,640+03 ERROR [org.ovirt.engine.api.restapi.resource.AbstractBackendResource] (default task-64) [] Operation Failed: [Cannot migrate VM. VM is pinned to Host.] >2018-09-21 22:12:57,950+03 INFO [org.ovirt.engine.core.bll.StopVmCommand] (default task-3) [vms_syncAction_047726c4-deb0-40f9] Running command: StopVmCommand internal: false. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group STOP_VM with role type USER >2018-09-21 22:12:57,956+03 INFO [org.ovirt.engine.core.vdsbroker.DestroyVmVDSCommand] (default task-3) [vms_syncAction_047726c4-deb0-40f9] START, DestroyVmVDSCommand( DestroyVmVDSCommandParameters:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', secondsToWait='0', gracefully='false', reason='', ignoreNoVm='false'}), log id: 3c0c38cf >2018-09-21 22:12:57,959+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (default task-3) [vms_syncAction_047726c4-deb0-40f9] START, DestroyVDSCommand(HostName = host_mixed_2, DestroyVmVDSCommandParameters:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', secondsToWait='0', gracefully='false', reason='', ignoreNoVm='false'}), log id: 3129d3ae >2018-09-21 22:12:58,218+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher] (EE-ManagedThreadFactory-engineScheduled-Thread-99) [] Fetched 1 VMs from VDS 'a2254d74-4e35-4ae9-b8d5-8945ed12dd01' >2018-09-21 22:12:58,218+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (EE-ManagedThreadFactory-engineScheduled-Thread-99) [] VM 'b43f9124-f743-47e9-a0f3-a15c83a8e796'(golden_env_mixed_virtio_1_0) moved from 'PoweringUp' --> 'PoweringDown' >2018-09-21 22:12:59,305+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (default task-3) [vms_syncAction_047726c4-deb0-40f9] FINISH, DestroyVDSCommand, log id: 3129d3ae >2018-09-21 22:12:59,305+03 INFO [org.ovirt.engine.core.vdsbroker.DestroyVmVDSCommand] (default task-3) [vms_syncAction_047726c4-deb0-40f9] FINISH, DestroyVmVDSCommand, log id: 3c0c38cf >2018-09-21 22:12:59,309+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (ForkJoinPool-1-worker-11) [] VM 'b43f9124-f743-47e9-a0f3-a15c83a8e796' was reported as Down on VDS 'a2254d74-4e35-4ae9-b8d5-8945ed12dd01'(host_mixed_2) >2018-09-21 22:12:59,311+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (ForkJoinPool-1-worker-11) [] START, DestroyVDSCommand(HostName = host_mixed_2, DestroyVmVDSCommandParameters:{hostId='a2254d74-4e35-4ae9-b8d5-8945ed12dd01', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', secondsToWait='0', gracefully='false', reason='', ignoreNoVm='true'}), log id: 7a93b35f >2018-09-21 22:12:59,317+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (ForkJoinPool-1-worker-11) [] Failed to destroy VM 'b43f9124-f743-47e9-a0f3-a15c83a8e796' because VM does not exist, ignoring >2018-09-21 22:12:59,317+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (ForkJoinPool-1-worker-11) [] FINISH, DestroyVDSCommand, log id: 7a93b35f >2018-09-21 22:12:59,317+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-3) [vms_syncAction_047726c4-deb0-40f9] EVENT_ID: USER_STOP_VM(33), VM golden_env_mixed_virtio_1_0 powered off by admin@internal-authz (Host: host_mixed_2). >2018-09-21 22:12:59,317+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (ForkJoinPool-1-worker-11) [] VM 'b43f9124-f743-47e9-a0f3-a15c83a8e796'(golden_env_mixed_virtio_1_0) moved from 'PoweringDown' --> 'Down' >2018-09-21 22:12:59,333+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ForkJoinPool-1-worker-11) [] EVENT_ID: VM_DOWN(61), VM golden_env_mixed_virtio_1_0 is down. >2018-09-21 22:12:59,349+03 INFO [org.ovirt.engine.core.bll.ProcessDownVmCommand] (EE-ManagedThreadFactory-engine-Thread-2443) [7a401715] Running command: ProcessDownVmCommand internal: true. >2018-09-21 22:13:13,229+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher] (EE-ManagedThreadFactory-engineScheduled-Thread-77) [] Fetched 0 VMs from VDS 'a2254d74-4e35-4ae9-b8d5-8945ed12dd01' >2018-09-21 22:13:14,702+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-9) [vms_update_60d41a85-ffe0-4b79] Lock Acquired to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_0=VM_NAME]', sharedLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]'}' >2018-09-21 22:13:14,747+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-9) [vms_update_60d41a85-ffe0-4b79] Running command: UpdateVmCommand internal: false. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_VM_PROPERTIES with role type USER, ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_ADMIN_VM_PROPERTIES with role type ADMIN >2018-09-21 22:13:14,787+03 INFO [org.ovirt.engine.core.bll.UpdateGraphicsDeviceCommand] (default task-9) [5a7d39f6] Running command: UpdateGraphicsDeviceCommand internal: true. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_VM_PROPERTIES with role type USER >2018-09-21 22:13:14,792+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-9) [5a7d39f6] Pinned host changed for VM: golden_env_mixed_virtio_1_0. Dropping configured host devices. >2018-09-21 22:13:14,808+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-9) [5a7d39f6] EVENT_ID: USER_UPDATE_VM(35), VM golden_env_mixed_virtio_1_0 configuration was updated by admin@internal-authz. >2018-09-21 22:13:14,812+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-9) [5a7d39f6] Lock freed to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_0=VM_NAME]', sharedLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]'}' >2018-09-21 22:13:15,189+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-22) [vms_update_27873840-d954-4286] Lock Acquired to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_0=VM_NAME]', sharedLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]'}' >2018-09-21 22:13:15,233+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-22) [vms_update_27873840-d954-4286] Running command: UpdateVmCommand internal: false. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_VM_PROPERTIES with role type USER, ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_ADMIN_VM_PROPERTIES with role type ADMIN >2018-09-21 22:13:15,253+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-22) [vms_update_27873840-d954-4286] Pinned host changed for VM: golden_env_mixed_virtio_1_0. Dropping configured host devices. >2018-09-21 22:13:15,265+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-22) [vms_update_27873840-d954-4286] EVENT_ID: USER_UPDATE_VM(35), VM golden_env_mixed_virtio_1_0 configuration was updated by admin@internal-authz. >2018-09-21 22:13:15,269+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-22) [vms_update_27873840-d954-4286] Lock freed to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_0=VM_NAME]', sharedLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]'}' >2018-09-21 22:13:15,509+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-18) [vms_update_3a92c503-8a0a-43af] Lock Acquired to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_0=VM_NAME]', sharedLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]'}' >2018-09-21 22:13:15,556+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-18) [vms_update_3a92c503-8a0a-43af] Running command: UpdateVmCommand internal: false. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group EDIT_VM_PROPERTIES with role type USER >2018-09-21 22:13:15,587+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-18) [vms_update_3a92c503-8a0a-43af] EVENT_ID: USER_UPDATE_VM(35), VM golden_env_mixed_virtio_1_0 configuration was updated by admin@internal-authz. >2018-09-21 22:13:15,592+03 INFO [org.ovirt.engine.core.bll.UpdateVmCommand] (default task-18) [vms_update_3a92c503-8a0a-43af] Lock freed to object 'EngineLock:{exclusiveLocks='[golden_env_mixed_virtio_1_0=VM_NAME]', sharedLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]'}' >2018-09-21 22:13:15,857+03 INFO [org.ovirt.engine.core.bll.RunVmCommand] (default task-13) [vms_syncAction_01d90111-62af-4f6f] Lock Acquired to object 'EngineLock:{exclusiveLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]', sharedLocks=''}' >2018-09-21 22:13:15,880+03 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default task-13) [vms_syncAction_01d90111-62af-4f6f] START, IsVmDuringInitiatingVDSCommand( IsVmDuringInitiatingVDSCommandParameters:{vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796'}), log id: 6457b302 >2018-09-21 22:13:15,882+03 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (default task-13) [vms_syncAction_01d90111-62af-4f6f] FINISH, IsVmDuringInitiatingVDSCommand, return: false, log id: 6457b302 >2018-09-21 22:13:15,897+03 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (default task-13) [vms_syncAction_01d90111-62af-4f6f] Candidate host 'host_mixed_3' ('a7e45cf7-2174-42c5-a730-d5c3c568409a') was filtered out by 'VAR__FILTERTYPE__INTERNAL' filter 'PinToHost' (correlation id: null) >2018-09-21 22:13:15,927+03 INFO [org.ovirt.engine.core.bll.RunVmCommand] (default task-13) [vms_syncAction_01d90111-62af-4f6f] Running command: RunVmCommand internal: false. Entities affected : ID: b43f9124-f743-47e9-a0f3-a15c83a8e796 Type: VMAction group RUN_VM with role type USER >2018-09-21 22:13:15,937+03 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (default task-13) [vms_syncAction_01d90111-62af-4f6f] Candidate host 'host_mixed_3' ('a7e45cf7-2174-42c5-a730-d5c3c568409a') was filtered out by 'VAR__FILTERTYPE__INTERNAL' filter 'PinToHost' (correlation id: vms_syncAction_01d90111-62af-4f6f) >2018-09-21 22:13:15,966+03 INFO [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (default task-13) [vms_syncAction_01d90111-62af-4f6f] START, UpdateVmDynamicDataVDSCommand( UpdateVmDynamicDataVDSCommandParameters:{hostId='null', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', vmDynamic='org.ovirt.engine.core.common.businessentities.VmDynamic@4b1e84a7'}), log id: 7052a4da >2018-09-21 22:13:15,970+03 INFO [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (default task-13) [vms_syncAction_01d90111-62af-4f6f] FINISH, UpdateVmDynamicDataVDSCommand, log id: 7052a4da >2018-09-21 22:13:15,975+03 INFO [org.ovirt.engine.core.vdsbroker.CreateVDSCommand] (default task-13) [vms_syncAction_01d90111-62af-4f6f] START, CreateVDSCommand( CreateVDSCommandParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', vm='VM [golden_env_mixed_virtio_1_0]'}), log id: 7078e9f7 >2018-09-21 22:13:15,979+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand] (default task-13) [vms_syncAction_01d90111-62af-4f6f] START, CreateBrokerVDSCommand(HostName = host_mixed_1, CreateVDSCommandParameters:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', vmId='b43f9124-f743-47e9-a0f3-a15c83a8e796', vm='VM [golden_env_mixed_virtio_1_0]'}), log id: 2baf5340 >2018-09-21 22:13:15,999+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand] (default task-13) [vms_syncAction_01d90111-62af-4f6f] 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>golden_env_mixed_virtio_1_0</name> > <uuid>b43f9124-f743-47e9-a0f3-a15c83a8e796</uuid> > <memory>1048576</memory> > <currentMemory>1048576</currentMemory> > <maxMemory slots="16">4194304</maxMemory> > <vcpu current="1">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">b43f9124-f743-47e9-a0f3-a15c83a8e796</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>Westmere</model> > <topology cores="1" threads="1" sockets="16"/> > <numa> > <cell id="0" cpus="0" memory="1048576"/> > </numa> > </cpu> > <cputune/> > <devices> > <input type="mouse" bus="ps2"/> > <channel type="unix"> > <target type="virtio" name="ovirt-guest-agent.0"/> > <source mode="bind" path="/var/lib/libvirt/qemu/channels/b43f9124-f743-47e9-a0f3-a15c83a8e796.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/b43f9124-f743-47e9-a0f3-a15c83a8e796.org.qemu.guest_agent.0"/> > </channel> > <controller type="scsi" model="virtio-scsi" index="0"> > <alias name="ua-32035a34-aa4a-4bd0-afc4-cde8c357b339"/> > </controller> > <sound model="ich6"> > <alias name="ua-3e6956fd-dd98-4d66-91fc-f91e52be4b0c"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x04" type="pci"/> > </sound> > <controller type="virtio-serial" index="0" ports="16"> > <alias name="ua-4f6e44c4-cb76-459f-ac3e-082eefcf3925"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x05" type="pci"/> > </controller> > <memballoon model="virtio"> > <stats period="5"/> > <alias name="ua-57427a8e-1cd6-4913-b8ca-eabbc824aed9"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x08" type="pci"/> > </memballoon> > <video> > <model type="qxl" vram="8192" heads="1" ram="65536" vgamem="16384"/> > <alias name="ua-8abe45ec-483c-4661-80eb-ddf3f33e1628"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x02" type="pci"/> > </video> > <controller type="ide" index="0"> > <address bus="0x00" domain="0x0000" function="0x1" slot="0x01" type="pci"/> > </controller> > <graphics type="spice" port="-1" autoport="yes" passwd="*****" passwdValidTo="1970-01-01T00:00:01" tlsPort="-1"> > <channel name="main" mode="secure"/> > <channel name="inputs" mode="secure"/> > <channel name="cursor" mode="secure"/> > <channel name="playback" mode="secure"/> > <channel name="record" mode="secure"/> > <channel name="display" mode="secure"/> > <channel name="smartcard" mode="secure"/> > <channel name="usbredir" mode="secure"/> > <listen type="network" network="vdsm-ovirtmgmt"/> > </graphics> > <rng model="virtio"> > <backend model="random">/dev/urandom</backend> > <alias name="ua-bbff748a-6eea-4a22-8074-c4324b0eaa4d"/> > </rng> > <controller type="usb" model="piix3-uhci" index="0"> > <address bus="0x00" domain="0x0000" function="0x2" slot="0x01" type="pci"/> > </controller> > <channel type="spicevmc"> > <target type="virtio" name="com.redhat.spice.0"/> > </channel> > <interface type="bridge"> > <model type="virtio"/> > <link state="up"/> > <source bridge="ovirtmgmt"/> > <alias name="ua-face3b7e-cea7-4bae-92ac-f1b9f498995f"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x03" type="pci"/> > <mac address="00:1a:4a:16:88:c9"/> > <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-892dceaf-0e49-480e-aa27-12a35bc55da6"/> > <address bus="1" controller="0" unit="0" type="drive" target="0"/> > </disk> > <disk snapshot="no" type="file" device="disk"> > <target dev="vda" bus="virtio"/> > <source file="/rhev/data-center/636f1fce-bdba-11e8-89e0-001a4a168bfb/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd"/> > <driver name="qemu" io="threads" type="qcow2" error_policy="stop" cache="none"/> > <alias name="ua-f002a528-68aa-4013-8c14-7b330f932412"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x07" type="pci"/> > <boot order="1"/> > <serial>f002a528-68aa-4013-8c14-7b330f932412</serial> > </disk> > </devices> > <pm> > <suspend-to-disk enabled="no"/> > <suspend-to-mem enabled="no"/> > </pm> > <os> > <type arch="x86_64" machine="pc-i440fx-rhel7.5.0">hvm</type> > <smbios mode="sysinfo"/> > </os> > <metadata> > <ovirt-tune:qos/> > <ovirt-vm:vm> > <minGuaranteedMemoryMb type="int">1024</minGuaranteedMemoryMb> > <clusterVersion>4.2</clusterVersion> > <ovirt-vm:custom/> > <ovirt-vm:device mac_address="00:1a:4a:16:88:c9"> > <ovirt-vm:custom/> > </ovirt-vm:device> > <ovirt-vm:device devtype="disk" name="vda"> > <ovirt-vm:poolID>636f1fce-bdba-11e8-89e0-001a4a168bfb</ovirt-vm:poolID> > <ovirt-vm:volumeID>2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd</ovirt-vm:volumeID> > <ovirt-vm:imageID>f002a528-68aa-4013-8c14-7b330f932412</ovirt-vm:imageID> > <ovirt-vm:domainID>727f775a-5d4c-4e80-a6ff-bb99e18daa7a</ovirt-vm:domainID> > </ovirt-vm:device> > <launchPaused>false</launchPaused> > <resumeBehavior>auto_resume</resumeBehavior> > </ovirt-vm:vm> > </metadata> ></domain> > >2018-09-21 22:13:16,029+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateBrokerVDSCommand] (default task-13) [vms_syncAction_01d90111-62af-4f6f] FINISH, CreateBrokerVDSCommand, log id: 2baf5340 >2018-09-21 22:13:16,032+03 INFO [org.ovirt.engine.core.vdsbroker.CreateVDSCommand] (default task-13) [vms_syncAction_01d90111-62af-4f6f] FINISH, CreateVDSCommand, return: WaitForLaunch, log id: 7078e9f7 >2018-09-21 22:13:16,032+03 INFO [org.ovirt.engine.core.bll.RunVmCommand] (default task-13) [vms_syncAction_01d90111-62af-4f6f] Lock freed to object 'EngineLock:{exclusiveLocks='[b43f9124-f743-47e9-a0f3-a15c83a8e796=VM]', sharedLocks=''}' >2018-09-21 22:13:16,039+03 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-13) [vms_syncAction_01d90111-62af-4f6f] EVENT_ID: USER_STARTED_VM(153), VM golden_env_mixed_virtio_1_0 was started by admin@internal-authz (Host: host_mixed_1). >2018-09-21 22:13:18,388+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher] (EE-ManagedThreadFactory-engineScheduled-Thread-99) [] Fetched 1 VMs from VDS 'a6ebcb78-bc75-4342-927f-cdf57be26a25' >2018-09-21 22:13:18,397+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DumpXmlsVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-99) [] START, DumpXmlsVDSCommand(HostName = host_mixed_1, Params:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', vmIds='[b43f9124-f743-47e9-a0f3-a15c83a8e796]'}), log id: 66ef5a5e >2018-09-21 22:13:18,404+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DumpXmlsVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-99) [] FINISH, DumpXmlsVDSCommand, return: {b43f9124-f743-47e9-a0f3-a15c83a8e796=<?xml version="1.0" encoding="utf-8"?><domain type="kvm" xmlns:ns0="http://ovirt.org/vm/tune/1.0" xmlns:ovirt-vm="http://ovirt.org/vm/1.0"> > <name>golden_env_mixed_virtio_1_0</name> > <uuid>b43f9124-f743-47e9-a0f3-a15c83a8e796</uuid> > <memory>1048576</memory> > <currentMemory>1048576</currentMemory> > <maxMemory slots="16">4194304</maxMemory> > <vcpu current="1">16</vcpu> > <sysinfo type="smbios"> > <system> > <entry name="manufacturer">oVirt</entry> > <entry name="product">RHEV Hypervisor</entry> > <entry name="version">7.6-7.0.el7</entry> > <entry name="serial">4c4c4544-0056-3010-8056-c8c04f563232</entry> > <entry name="uuid">b43f9124-f743-47e9-a0f3-a15c83a8e796</entry> > </system> > </sysinfo> > <clock adjustment="0" offset="variable"> > <timer name="rtc" tickpolicy="catchup"/> > <timer name="pit" tickpolicy="delay"/> > <timer name="hpet" present="no"/> > </clock> > <features> > <acpi/> > </features> > <cpu match="exact"> > <model>Westmere</model> > <topology cores="1" sockets="16" threads="1"/> > <numa> > <cell cpus="0" id="0" memory="1048576"/> > </numa> > </cpu> > <cputune/> > <devices> > <input bus="ps2" type="mouse"/> > <channel type="unix"> > <target name="ovirt-guest-agent.0" type="virtio"/> > <source mode="bind" path="/var/lib/libvirt/qemu/channels/b43f9124-f743-47e9-a0f3-a15c83a8e796.ovirt-guest-agent.0"/> > </channel> > <channel type="unix"> > <target name="org.qemu.guest_agent.0" type="virtio"/> > <source mode="bind" path="/var/lib/libvirt/qemu/channels/b43f9124-f743-47e9-a0f3-a15c83a8e796.org.qemu.guest_agent.0"/> > </channel> > <controller index="0" model="virtio-scsi" type="scsi"> > <alias name="ua-32035a34-aa4a-4bd0-afc4-cde8c357b339"/> > </controller> > <sound model="ich6"> > <alias name="ua-3e6956fd-dd98-4d66-91fc-f91e52be4b0c"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x04" type="pci"/> > </sound> > <controller index="0" ports="16" type="virtio-serial"> > <alias name="ua-4f6e44c4-cb76-459f-ac3e-082eefcf3925"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x05" type="pci"/> > </controller> > <memballoon model="virtio"> > <stats period="5"/> > <alias name="ua-57427a8e-1cd6-4913-b8ca-eabbc824aed9"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x08" type="pci"/> > </memballoon> > <video> > <model heads="1" ram="65536" type="qxl" vgamem="16384" vram="8192"/> > <alias name="ua-8abe45ec-483c-4661-80eb-ddf3f33e1628"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x02" type="pci"/> > </video> > <controller index="0" type="ide"> > <address bus="0x00" domain="0x0000" function="0x1" slot="0x01" type="pci"/> > </controller> > <graphics autoport="yes" passwd="*****" passwdValidTo="1970-01-01T00:00:01" port="-1" tlsPort="-1" type="spice"> > <channel mode="secure" name="main"/> > <channel mode="secure" name="inputs"/> > <channel mode="secure" name="cursor"/> > <channel mode="secure" name="playback"/> > <channel mode="secure" name="record"/> > <channel mode="secure" name="display"/> > <channel mode="secure" name="smartcard"/> > <channel mode="secure" name="usbredir"/> > <listen network="vdsm-ovirtmgmt" type="network"/> > </graphics> > <rng model="virtio"> > <backend model="random">/dev/urandom</backend> > <alias name="ua-bbff748a-6eea-4a22-8074-c4324b0eaa4d"/> > </rng> > <controller index="0" model="piix3-uhci" type="usb"> > <address bus="0x00" domain="0x0000" function="0x2" slot="0x01" type="pci"/> > </controller> > <channel type="spicevmc"> > <target name="com.redhat.spice.0" type="virtio"/> > </channel> > <disk device="cdrom" snapshot="no" type="file"> > <driver error_policy="report" name="qemu" type="raw"/> > <source file="" startupPolicy="optional"/> > <target bus="ide" dev="hdc"/> > <readonly/> > <alias name="ua-892dceaf-0e49-480e-aa27-12a35bc55da6"/> > <address bus="1" controller="0" target="0" type="drive" unit="0"/> > </disk> > <disk device="disk" snapshot="no" type="file"> > <target bus="virtio" dev="vda"/> > <source file="/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd"/> > <driver cache="none" error_policy="stop" io="threads" name="qemu" type="qcow2"/> > <alias name="ua-f002a528-68aa-4013-8c14-7b330f932412"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x07" type="pci"/> > <boot order="1"/> > <serial>f002a528-68aa-4013-8c14-7b330f932412</serial> > </disk> > <interface type="bridge"> > <model type="virtio"/> > <link state="up"/> > <source bridge="ovirtmgmt"/> > <alias name="ua-face3b7e-cea7-4bae-92ac-f1b9f498995f"/> > <address bus="0x00" domain="0x0000" function="0x0" slot="0x03" type="pci"/> > <mac address="00:1a:4a:16:88:c9"/> > <mtu size="1500"/> > <filterref filter="vdsm-no-mac-spoofing"/> > <bandwidth/> > </interface> > </devices> > <pm> > <suspend-to-disk enabled="no"/> > <suspend-to-mem enabled="no"/> > </pm> > <os> > <type arch="x86_64" machine="pc-i440fx-rhel7.5.0">hvm</type> > <smbios mode="sysinfo"/> > </os> > <metadata> > <ns0:qos/> > <ovirt-vm:vm> > <minGuaranteedMemoryMb type="int">1024</minGuaranteedMemoryMb> > <clusterVersion>4.2</clusterVersion> > <ovirt-vm:custom/> > <ovirt-vm:device mac_address="00:1a:4a:16:88:c9"> > <ovirt-vm:custom/> > </ovirt-vm:device> > <ovirt-vm:device devtype="disk" name="vda"> > <ovirt-vm:poolID>636f1fce-bdba-11e8-89e0-001a4a168bfb</ovirt-vm:poolID> > <ovirt-vm:volumeID>2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd</ovirt-vm:volumeID> > <ovirt-vm:imageID>f002a528-68aa-4013-8c14-7b330f932412</ovirt-vm:imageID> > <ovirt-vm:domainID>727f775a-5d4c-4e80-a6ff-bb99e18daa7a</ovirt-vm:domainID> > </ovirt-vm:device> > <launchPaused>false</launchPaused> > <resumeBehavior>auto_resume</resumeBehavior> > </ovirt-vm:vm> > </metadata> ></domain>}, log id: 66ef5a5e >2018-09-21 22:13:20,106+03 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (ForkJoinPool-1-worker-11) [] VM 'b43f9124-f743-47e9-a0f3-a15c83a8e796'(golden_env_mixed_virtio_1_0) moved from 'WaitForLaunch' --> 'PoweringUp' >2018-09-21 22:13:20,116+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DumpXmlsVDSCommand] (ForkJoinPool-1-worker-11) [] START, DumpXmlsVDSCommand(HostName = host_mixed_1, Params:{hostId='a6ebcb78-bc75-4342-927f-cdf57be26a25', vmIds='[b43f9124-f743-47e9-a0f3-a15c83a8e796]'}), log id: 619ef2a1 >2018-09-21 22:13:20,121+03 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DumpXmlsVDSCommand] (ForkJoinPool-1-worker-11) [] FINISH, DumpXmlsVDSCommand, return: {b43f9124-f743-47e9-a0f3-a15c83a8e796=<domain type='kvm' id='18'> > <name>golden_env_mixed_virtio_1_0</name> > <uuid>b43f9124-f743-47e9-a0f3-a15c83a8e796</uuid> > <metadata xmlns:ns0="http://ovirt.org/vm/tune/1.0" xmlns:ovirt-vm="http://ovirt.org/vm/1.0"> > <ns0:qos/> > <ovirt-vm:vm xmlns:ovirt-vm="http://ovirt.org/vm/1.0"> > <ovirt-vm:clusterVersion>4.2</ovirt-vm:clusterVersion> > <ovirt-vm:destroy_on_reboot type="bool">False</ovirt-vm:destroy_on_reboot> > <ovirt-vm:launchPaused>false</ovirt-vm:launchPaused> > <ovirt-vm:memGuaranteedSize type="int">1024</ovirt-vm:memGuaranteedSize> > <ovirt-vm:minGuaranteedMemoryMb type="int">1024</ovirt-vm:minGuaranteedMemoryMb> > <ovirt-vm:resumeBehavior>auto_resume</ovirt-vm:resumeBehavior> > <ovirt-vm:startTime type="float">1537557196.02</ovirt-vm:startTime> > <ovirt-vm:device mac_address="00:1a:4a:16:88:c9"> > <ovirt-vm:network>ovirtmgmt</ovirt-vm:network> > <ovirt-vm:specParams/> > <ovirt-vm:vm_custom/> > </ovirt-vm:device> > <ovirt-vm:device devtype="disk" name="vda"> > <ovirt-vm:domainID>727f775a-5d4c-4e80-a6ff-bb99e18daa7a</ovirt-vm:domainID> > <ovirt-vm:imageID>f002a528-68aa-4013-8c14-7b330f932412</ovirt-vm:imageID> > <ovirt-vm:poolID>636f1fce-bdba-11e8-89e0-001a4a168bfb</ovirt-vm:poolID> > <ovirt-vm:volumeID>2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd</ovirt-vm:volumeID> > <ovirt-vm:specParams/> > <ovirt-vm:vm_custom/> > <ovirt-vm:volumeChain> > <ovirt-vm:volumeChainNode> > <ovirt-vm:domainID>727f775a-5d4c-4e80-a6ff-bb99e18daa7a</ovirt-vm:domainID> > <ovirt-vm:imageID>f002a528-68aa-4013-8c14-7b330f932412</ovirt-vm:imageID> > <ovirt-vm:leaseOffset type="int">0</ovirt-vm:leaseOffset> > <ovirt-vm:leasePath>/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd.lease</ovirt-vm:leasePath> > <ovirt-vm:path>/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd</ovirt-vm:path> > <ovirt-vm:volumeID>2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd</ovirt-vm:volumeID> > </ovirt-vm:volumeChainNode> > <ovirt-vm:volumeChainNode> > <ovirt-vm:domainID>727f775a-5d4c-4e80-a6ff-bb99e18daa7a</ovirt-vm:domainID> > <ovirt-vm:imageID>f002a528-68aa-4013-8c14-7b330f932412</ovirt-vm:imageID> > <ovirt-vm:leaseOffset type="int">0</ovirt-vm:leaseOffset> > <ovirt-vm:leasePath>/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/d7e7907f-79cf-48c1-a5f9-6d4ac2b111b6.lease</ovirt-vm:leasePath> > <ovirt-vm:path>/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/d7e7907f-79cf-48c1-a5f9-6d4ac2b111b6</ovirt-vm:path> > <ovirt-vm:volumeID>d7e7907f-79cf-48c1-a5f9-6d4ac2b111b6</ovirt-vm:volumeID> > </ovirt-vm:volumeChainNode> > </ovirt-vm:volumeChain> > </ovirt-vm:device> > <ovirt-vm:device devtype="disk" name="hdc"> > <ovirt-vm:specParams/> > <ovirt-vm:vm_custom/> > </ovirt-vm:device> ></ovirt-vm:vm> > </metadata> > <maxMemory slots='16' unit='KiB'>4194304</maxMemory> > <memory unit='KiB'>1048576</memory> > <currentMemory unit='KiB'>1048576</currentMemory> > <vcpu placement='static' current='1'>16</vcpu> > <resource> > <partition>/machine</partition> > </resource> > <sysinfo type='smbios'> > <system> > <entry name='manufacturer'>oVirt</entry> > <entry name='product'>RHEV Hypervisor</entry> > <entry name='version'>7.6-7.0.el7</entry> > <entry name='serial'>4c4c4544-0056-3010-8056-c8c04f563232</entry> > <entry name='uuid'>b43f9124-f743-47e9-a0f3-a15c83a8e796</entry> > </system> > </sysinfo> > <os> > <type arch='x86_64' machine='pc-i440fx-rhel7.5.0'>hvm</type> > <smbios mode='sysinfo'/> > </os> > <features> > <acpi/> > </features> > <cpu mode='custom' match='exact' check='full'> > <model fallback='forbid'>Westmere</model> > <topology sockets='16' cores='1' threads='1'/> > <feature policy='require' name='vme'/> > <feature policy='require' name='pclmuldq'/> > <feature policy='require' name='x2apic'/> > <feature policy='require' name='hypervisor'/> > <feature policy='require' name='arat'/> > <numa> > <cell id='0' cpus='0' memory='1048576' unit='KiB'/> > </numa> > </cpu> > <clock offset='variable' adjustment='0' basis='utc'> > <timer name='rtc' tickpolicy='catchup'/> > <timer name='pit' tickpolicy='delay'/> > <timer name='hpet' present='no'/> > </clock> > <on_poweroff>destroy</on_poweroff> > <on_reboot>restart</on_reboot> > <on_crash>destroy</on_crash> > <pm> > <suspend-to-mem enabled='no'/> > <suspend-to-disk enabled='no'/> > </pm> > <devices> > <emulator>/usr/libexec/qemu-kvm</emulator> > <disk type='file' device='cdrom'> > <driver name='qemu' error_policy='report'/> > <source startupPolicy='optional'/> > <target dev='hdc' bus='ide'/> > <readonly/> > <alias name='ua-892dceaf-0e49-480e-aa27-12a35bc55da6'/> > <address type='drive' controller='0' bus='1' target='0' unit='0'/> > </disk> > <disk type='file' device='disk' snapshot='no'> > <driver name='qemu' type='qcow2' cache='none' error_policy='stop' io='threads'/> > <source file='/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/2d8a16ad-3460-46d1-a8f0-e36ebf62f8cd'/> > <backingStore type='file' index='1'> > <format type='qcow2'/> > <source file='/rhev/data-center/mnt/mantis-nfs-lif2.lab.eng.tlv2.redhat.com:_nas01_ge__4__nfs__0/727f775a-5d4c-4e80-a6ff-bb99e18daa7a/images/f002a528-68aa-4013-8c14-7b330f932412/d7e7907f-79cf-48c1-a5f9-6d4ac2b111b6'/> > <backingStore/> > </backingStore> > <target dev='vda' bus='virtio'/> > <serial>f002a528-68aa-4013-8c14-7b330f932412</serial> > <boot order='1'/> > <alias name='ua-f002a528-68aa-4013-8c14-7b330f932412'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x07' function='0x0'/> > </disk> > <controller type='scsi' index='0' model='virtio-scsi'> > <alias name='ua-32035a34-aa4a-4bd0-afc4-cde8c357b339'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x06' function='0x0'/> > </controller> > <controller type='virtio-serial' index='0' ports='16'> > <alias name='ua-4f6e44c4-cb76-459f-ac3e-082eefcf3925'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x05' function='0x0'/> > </controller> > <controller type='ide' index='0'> > <alias name='ide'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x01' function='0x1'/> > </controller> > <controller type='usb' index='0' model='piix3-uhci'> > <alias name='usb'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x01' function='0x2'/> > </controller> > <controller type='pci' index='0' model='pci-root'> > <alias name='pci.0'/> > </controller> > <interface type='bridge'> > <mac address='00:1a:4a:16:88:c9'/> > <source bridge='ovirtmgmt'/> > <target dev='vnet0'/> > <model type='virtio'/> > <filterref filter='vdsm-no-mac-spoofing'/> > <link state='up'/> > <mtu size='1500'/> > <alias name='ua-face3b7e-cea7-4bae-92ac-f1b9f498995f'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x03' function='0x0'/> > </interface> > <channel type='unix'> > <source mode='bind' path='/var/lib/libvirt/qemu/channels/b43f9124-f743-47e9-a0f3-a15c83a8e796.ovirt-guest-agent.0'/> > <target type='virtio' name='ovirt-guest-agent.0' state='disconnected'/> > <alias name='channel0'/> > <address type='virtio-serial' controller='0' bus='0' port='1'/> > </channel> > <channel type='unix'> > <source mode='bind' path='/var/lib/libvirt/qemu/channels/b43f9124-f743-47e9-a0f3-a15c83a8e796.org.qemu.guest_agent.0'/> > <target type='virtio' name='org.qemu.guest_agent.0' state='disconnected'/> > <alias name='channel1'/> > <address type='virtio-serial' controller='0' bus='0' port='2'/> > </channel> > <channel type='spicevmc'> > <target type='virtio' name='com.redhat.spice.0' state='disconnected'/> > <alias name='channel2'/> > <address type='virtio-serial' controller='0' bus='0' port='3'/> > </channel> > <input type='mouse' bus='ps2'> > <alias name='input0'/> > </input> > <input type='keyboard' bus='ps2'> > <alias name='input1'/> > </input> > <graphics type='spice' port='5900' tlsPort='5901' autoport='yes' listen='10.46.16.27' passwdValidTo='1970-01-01T00:00:01'> > <listen type='network' address='10.46.16.27' network='vdsm-ovirtmgmt'/> > <channel name='main' mode='secure'/> > <channel name='display' mode='secure'/> > <channel name='inputs' mode='secure'/> > <channel name='cursor' mode='secure'/> > <channel name='playback' mode='secure'/> > <channel name='record' mode='secure'/> > <channel name='smartcard' mode='secure'/> > <channel name='usbredir' mode='secure'/> > </graphics> > <sound model='ich6'> > <alias name='ua-3e6956fd-dd98-4d66-91fc-f91e52be4b0c'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x04' function='0x0'/> > </sound> > <video> > <model type='qxl' ram='65536' vram='8192' vgamem='16384' heads='1' primary='yes'/> > <alias name='ua-8abe45ec-483c-4661-80eb-ddf3f33e1628'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x02' function='0x0'/> > </video> > <memballoon model='virtio'> > <stats period='5'/> > <alias name='ua-57427a8e-1cd6-4913-b8ca-eabbc824aed9'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x08' function='0x0'/> > </memballoon> > <rng model='virtio'> > <backend model='random'>/dev/urandom</backend> > <alias name='ua-bbff748a-6eea-4a22-8074-c4324b0eaa4d'/> > <address type='pci' domain='0x0000' bus='0x00' slot='0x09' function='0x0'/> > </rng> > </devices> > <seclabel type='dynamic' model='selinux' relabel='yes'> > <label>system_u:system_r:svirt_t:s0:c126,c256</label> > <imagelabel>system_u:object_r:svirt_image_t:s0:c126,c256</imagelabel> > </seclabel> > <seclabel type='dynamic' model='dac' relabel='yes'> > <label>+107:+107</label> > <imagelabel>+107:+107</imagelabel> > </seclabel> ></domain> >}, log id: 619ef2a1 >2018-09-21 22:13:37,333+03 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-09-21 22:13:37,333+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engine' is using 0 threads out of 500, 25 threads waiting for tasks and 0 tasks in queue. >2018-09-21 22:13:37,333+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineScheduled' is using 0 threads out of 100, 100 threads waiting for tasks. >2018-09-21 22:13:37,333+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineThreadMonitoring' is using 1 threads out of 1, 0 threads waiting for tasks. >2018-09-21 22:13:37,333+03 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'hostUpdatesChecker' is using 0 threads out of 5, 3 threads waiting for tasks.
You cannot view the attachment while viewing its details because your browser does not support IFRAMEs.
View the attachment on a separate page
.
View Attachment As Raw
Actions:
View
Attachments on
bug 1599616
:
1457718
|
1459428
|
1459429
|
1489483
| 1490117 |
1508441
|
1701406