migration failed - "Cannot get interface MTU on 'vdsmbr_...'
Hi, All. We have a new oVirt 4.1.1 cluster up with the OVS switch type. Everything seems to be working great, except for live migration. I believe the red flag in vdsm.log on the source is: Cannot get interface MTU on 'vdsmbr_QwORbsw2': No such device (migration:287) Which results from vdsm assigning an arbitrary bridge name to each ovs bridge. Please see below for more details on the bridges and excerpts from the logs. Any help would be greatly appreciated. Many thanks, Devin SOURCE OVS BRIDGES: # ovs-vsctl show 6d96d9a5-e30d-455b-90c7-9e9632574695 Bridge "vdsmbr_QwORbsw2" Port "vdsmbr_QwORbsw2" Interface "vdsmbr_QwORbsw2" type: internal Port "vnet0" Interface "vnet0" Port classepublic Interface classepublic type: internal Port "ens1f0" Interface "ens1f0" Bridge "vdsmbr_9P7ZYKWn" Port ovirtmgmt Interface ovirtmgmt type: internal Port "ens1f1" Interface "ens1f1" Port "vdsmbr_9P7ZYKWn" Interface "vdsmbr_9P7ZYKWn" type: internal ovs_version: "2.7.0" DESTINATION OVS BRIDGES: # ovs-vsctl show f66d765d-712a-4c81-b18e-da1acc9cfdde Bridge "vdsmbr_vdpp0dOd" Port "vdsmbr_vdpp0dOd" Interface "vdsmbr_vdpp0dOd" type: internal Port "ens1f0" Interface "ens1f0" Port classepublic Interface classepublic type: internal Bridge "vdsmbr_3sEwEKd1" Port "vdsmbr_3sEwEKd1" Interface "vdsmbr_3sEwEKd1" type: internal Port "ens1f1" Interface "ens1f1" Port ovirtmgmt Interface ovirtmgmt type: internal ovs_version: "2.7.0" SOURCE VDSM LOG: ... 2017-03-27 10:57:02,567-0400 INFO (jsonrpc/1) [vdsm.api] START migrate args=(<virt.vm.Vm object at 0x3410810>, {u'incomingLimit': 2, u'src': u'192.168.55.84', u'dstqemu': u'192.168.55.81', u'autoConverge': u'false', u'tunneled': u'false', u'enableGuestEvents': False, u'dst': u'lnxvirt01-p55.classe.cornell.edu:54321', u'vmId': u'cf9c5dbf-3924-47c6-b323-22ac90a1f682', u'abortOnError': u'true', u'outgoingLimit': 2, u'compressed': u'false', u'maxBandwidth': 5000, u'method': u'online', 'mode': 'remote'}) kwargs={} (api:37) 2017-03-27 10:57:02,570-0400 INFO (jsonrpc/1) [vdsm.api] FINISH migrate return={'status': {'message': 'Migration in progress', 'code': 0}, 'progress': 0} (api:43) 2017-03-27 10:57:02,570-0400 INFO (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call VM.migrate succeeded in 0.01 seconds (__init__:515) 2017-03-27 10:57:03,028-0400 INFO (migsrc/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Creation of destination VM took: 0 seconds (migration:455) 2017-03-27 10:57:03,028-0400 INFO (migsrc/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') starting migration to qemu+tls://lnxvirt01-p55.classe.cornell.edu/system with miguri tcp://192.168.55.81 (migration:480) 2017-03-27 10:57:03,224-0400 ERROR (migsrc/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Cannot get interface MTU on 'vdsmbr_QwORbsw2': No such device (migration:287) 2017-03-27 10:57:03,322-0400 ERROR (migsrc/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Failed to migrate (migration:429) Traceback (most recent call last): File "/usr/lib/python2.7/site-packages/vdsm/virt/migration.py", line 411, in run self._startUnderlyingMigration(time.time()) File "/usr/lib/python2.7/site-packages/vdsm/virt/migration.py", line 489, in _startUnderlyingMigration self._perform_with_downtime_thread(duri, muri) File "/usr/lib/python2.7/site-packages/vdsm/virt/migration.py", line 555, in _perform_with_downtime_thread self._perform_migration(duri, muri) File "/usr/lib/python2.7/site-packages/vdsm/virt/migration.py", line 528, in _perform_migration self._vm._dom.migrateToURI3(duri, params, flags) File "/usr/lib/python2.7/site-packages/vdsm/virt/virdomain.py", line 69, in f ret = attr(*args, **kwargs) File "/usr/lib/python2.7/site-packages/vdsm/libvirtconnection.py", line 123, in wrapper ret = f(*args, **kwargs) File "/usr/lib/python2.7/site-packages/vdsm/utils.py", line 941, in wrapper return func(inst, *args, **kwargs) File "/usr/lib64/python2.7/site-packages/libvirt.py", line 1939, in migrateToURI3 if ret == -1: raise libvirtError ('virDomainMigrateToURI3() failed', dom=self) libvirtError: Cannot get interface MTU on 'vdsmbr_QwORbsw2': No such device 2017-03-27 10:57:03,435-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:33716 (protocoldetector:72) 2017-03-27 10:57:03,452-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:33716 (protocoldetector:127) 2017-03-27 10:57:03,452-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:03,456-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:03,589-0400 INFO (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.01 seconds (__init__:515) 2017-03-27 10:57:03,592-0400 INFO (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call VM.getStats failed (error 1) in 0.00 seconds (__init__:515) 2017-03-27 10:57:04,494-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:33718 (protocoldetector:72) 2017-03-27 10:57:04,500-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:33718 (protocoldetector:127) 2017-03-27 10:57:04,500-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:04,501-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:04,559-0400 INFO (periodic/2) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:04,559-0400 INFO (periodic/2) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000262909', 'lastCheck': '5.3', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000342019', 'lastCheck': '5.3', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000239611', 'lastCheck': '0.6', 'valid': True}} (logUtils:54) 2017-03-27 10:57:04,669-0400 INFO (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.01 seconds (__init__:515) 2017-03-27 10:57:04,684-0400 INFO (jsonrpc/0) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:04,684-0400 INFO (jsonrpc/0) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000262909', 'lastCheck': '5.4', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000342019', 'lastCheck': '5.4', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000239611', 'lastCheck': '0.7', 'valid': True}} (logUtils:54) 2017-03-27 10:57:04,770-0400 INFO (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.09 seconds (__init__:515) ... DESTINATION VDSM LOG: ... 2017-03-27 10:57:01,515-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:01,652-0400 INFO (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:02,572-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::ffff:192.168.55.84:44582 (protocoldetector:72) 2017-03-27 10:57:02,577-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::ffff:192.168.55.84:44582 (protocoldetector:127) 2017-03-27 10:57:02,578-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:02,579-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:02,748-0400 INFO (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.ping succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:02,774-0400 INFO (jsonrpc/4) [vdsm.api] START __init__ args=(<virt.vm.Vm object at 0x4132e50>, <clientIF.clientIF object at 0x7f453c01e650>, {u'guestFQDN': u'lnx16.classe.cornell.edu', u'acpiEnable': u'true', u'emulatedMachine': u'pc-i440fx-rhel7.3.0', u'afterMigrationStatus': u'', u'enableGuestEvents': False, u'vmId': u'cf9c5dbf-3924-47c6-b323-22ac90a1f682', u'elapsedTimeOffset': 1321.2906959056854, u'guestDiskMapping': {u'0QEMU_QEMU_HARDDISK_21d18729-279f-435b-9': {u'name': u'/dev/sda'}, u'QEMU_DVD-ROM_QM00003': {u'name': u'/dev/sr0'}}, u'transparentHugePages': u'true', u'timeOffset': u'0', u'cpuType': u'Haswell-noTSX', u'custom': {u'device_9d15a0c8-a122-43b9-89c2-3ad530ebc985': u"VmDevice:{id='VmDeviceId:{deviceId='9d15a0c8-a122-43b9-89c2-3ad530ebc985', vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682'}', device='ide', type='CONTROLLER', bootOrder='0', specParams='[]', address='{slot=0x01, bus=0x00, domain=0x0000, type=pci, function=0x1}', managed='false', plugged='true', readOnly='false', deviceAlias='ide', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}", u'device_9d15a0c8-a122-43b9-89c2-3ad530ebc985device_0bbb6377-22db-4d04-a501-64de81bab622device_758565a5-4378-4412-8ec1-2df7bb231c14device_7ead63f7-b119-434d-a2f7-081fd06229e4': u"VmDevice:{id='VmDeviceId:{deviceId='7ead63f7-b119-434d-a2f7-081fd06229e4', vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682'}', device='spicevmc', type='CHANNEL', bootOrder='0', specParams='[]', address='{bus=0, controller=0, type=virtio-serial, port=3}', managed='false', plugged='true', readOnly='false', deviceAlias='channel2', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}", u'device_9d15a0c8-a122-43b9-89c2-3ad530ebc985device_0bbb6377-22db-4d04-a501-64de81bab622': u"VmDevice:{id='VmDeviceId:{deviceId='0bbb6377-22db-4d04-a501-64de81bab622', vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682'}', device='unix', type='CHANNEL', bootOrder='0', specParams='[]', address='{bus=0, controller=0, type=virtio-serial, port=2}', managed='false', plugged='true', readOnly='false', deviceAlias='channel1', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}", u'device_9d15a0c8-a122-43b9-89c2-3ad530ebc985device_0bbb6377-22db-4d04-a501-64de81bab622device_758565a5-4378-4412-8ec1-2df7bb231c14': u"VmDevice:{id='VmDeviceId:{deviceId='758565a5-4378-4412-8ec1-2df7bb231c14', vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682'}', device='unix', type='CHANNEL', bootOrder='0', specParams='[]', address='{bus=0, controller=0, type=virtio-serial, port=1}', managed='false', plugged='true', readOnly='false', deviceAlias='channel0', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}"}, u'pauseCode': u'NOERR', u'migrationDest': u'libvirt', u'guestNumaNodes': [{u'nodeIndex': 0, u'cpus': u'0', u'memory': u'1024'}], u'display': u'qxl', u'smp': u'1', u'vmType': u'kvm', u'_srcDomXML': u'<domain type=\'kvm\' id=\'4\'>\n <name>lnx16</name>\n <uuid>cf9c5dbf-3924-47c6-b323-22ac90a1f682</uuid>\n <metadata xmlns:ovirt="http://ovirt.org/vm/tune/1.0">\n <ovirt:qos/>\n </metadata>\n <maxMemory slots=\'16\' unit=\'KiB\'>4194304</maxMemory>\n <memory unit=\'KiB\'>1048576</memory>\n <currentMemory unit=\'KiB\'>1048576</currentMemory>\n <vcpu placement=\'static\' current=\'1\'>16</vcpu>\n <cputune>\n <shares>1020</shares>\n </cputune>\n <resource>\n <partition>/machine</partition>\n </resource>\n <sysinfo type=\'smbios\'>\n <system>\n <entry name=\'manufacturer\'>oVirt</entry>\n <entry name=\'product\'>oVirt Node</entry>\n <entry name=\'version\'>7.3-4.sl7</entry>\n <entry name=\'serial\'>38C15485-D270-11E6-8752-0090FAEDD7C8</entry>\n <entry name=\'uuid\'>cf9c5dbf-3924-47c6-b323-22ac90a1f682</entry>\n </system>\n </sysinfo>\n <os>\n <type arch=\'x86_64\' machine=\'pc-i440fx-rhel7.3.0\'>hvm</type>\n <smbios mode=\'sysinfo\'/>\n </os>\n <features>\n <acpi/>\n </features>\n <cpu mode=\'custom\' match=\'exact\'>\n <model fallback=\'allow\'>Haswell-noTSX</model>\n <topology sockets=\'16\' cores=\'1\' threads=\'1\'/>\n <numa>\n <cell id=\'0\' cpus=\'0\' memory=\'1048576\' unit=\'KiB\'/>\n </numa>\n </cpu>\n <clock offset=\'variable\' adjustment=\'0\' basis=\'utc\'>\n <timer name=\'rtc\' tickpolicy=\'catchup\'/>\n <timer name=\'pit\' tickpolicy=\'delay\'/>\n <timer name=\'hpet\' present=\'no\'/>\n </clock>\n <on_poweroff>destroy</on_poweroff>\n <on_reboot>restart</on_reboot>\n <on_crash>destroy</on_crash>\n <devices>\n <emulator>/usr/libexec/qemu-kvm</emulator>\n <disk type=\'file\' device=\'cdrom\'>\n <driver name=\'qemu\' type=\'raw\'/>\n <source startupPolicy=\'optional\'/>\n <backingStore/>\n <target dev=\'hdc\' bus=\'ide\'/>\n <readonly/>\n <alias name=\'ide0-1-0\'/>\n <address type=\'drive\' controller=\'0\' bus=\'1\' target=\'0\' unit=\'0\'/>\n </disk>\n <disk type=\'block\' device=\'disk\' snapshot=\'no\'>\n <driver name=\'qemu\' type=\'raw\' cache=\'none\' error_policy=\'stop\' io=\'native\'/>\n <source dev=\'/rhev/data-center/00000001-0001-0001-0001-000000000311/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794\'/>\n <backingStore/>\n <target dev=\'sda\' bus=\'scsi\'/>\n <serial>21d18729-279f-435b-90ab-a2995f041bc6</serial>\n <boot order=\'1\'/>\n <alias name=\'scsi0-0-0-0\'/>\n <address type=\'drive\' controller=\'0\' bus=\'0\' target=\'0\' unit=\'0\'/>\n </disk>\n <controller type=\'usb\' index=\'0\' model=\'piix3-uhci\'>\n <alias name=\'usb\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x01\' function=\'0x2\'/>\n </controller>\n <controller type=\'scsi\' index=\'0\' model=\'virtio-scsi\'>\n <alias name=\'scsi0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x04\' function=\'0x0\'/>\n </controller>\n <controller type=\'virtio-serial\' index=\'0\' ports=\'16\'>\n <alias name=\'virtio-serial0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x05\' function=\'0x0\'/>\n </controller>\n <controller type=\'pci\' index=\'0\' model=\'pci-root\'>\n <alias name=\'pci.0\'/>\n </controller>\n <controller type=\'ide\' index=\'0\'>\n <alias name=\'ide\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x01\' function=\'0x1\'/>\n </controller>\n <interface type=\'bridge\'>\n <mac address=\'00:1a:4a:16:01:51\'/>\n <source bridge=\'vdsmbr_QwORbsw2\'/>\n <virtualport type=\'openvswitch\'>\n <parameters interfaceid=\'3a24e764-32c8-4a2e-8dfd-02a776c3bef6\'/>\n </virtualport>\n <target dev=\'vnet0\'/>\n <model type=\'virtio\'/>\n <filterref filter=\'vdsm-no-mac-spoofing\'/>\n <link state=\'up\'/>\n <alias name=\'net0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x03\' function=\'0x0\'/>\n </interface>\n <channel type=\'unix\'>\n <source mode=\'bind\' path=\'/var/lib/libvirt/qemu/channels/cf9c5dbf-3924-47c6-b323-22ac90a1f682.com.redhat.rhevm.vdsm\'/>\n <target type=\'virtio\' name=\'com.redhat.rhevm.vdsm\' state=\'connected\'/>\n <alias name=\'channel0\'/>\n <address type=\'virtio-serial\' controller=\'0\' bus=\'0\' port=\'1\'/>\n </channel>\n <channel type=\'unix\'>\n <source mode=\'bind\' path=\'/var/lib/libvirt/qemu/channels/cf9c5dbf-3924-47c6-b323-22ac90a1f682.org.qemu.guest_agent.0\'/>\n <target type=\'virtio\' name=\'org.qemu.guest_agent.0\' state=\'connected\'/>\n <alias name=\'channel1\'/>\n <address type=\'virtio-serial\' controller=\'0\' bus=\'0\' port=\'2\'/>\n </channel>\n <channel type=\'spicevmc\'>\n <target type=\'virtio\' name=\'com.redhat.spice.0\' state=\'connected\'/>\n <alias name=\'channel2\'/>\n <address type=\'virtio-serial\' controller=\'0\' bus=\'0\' port=\'3\'/>\n </channel>\n <input type=\'mouse\' bus=\'ps2\'>\n <alias name=\'input0\'/>\n </input>\n <input type=\'keyboard\' bus=\'ps2\'>\n <alias name=\'input1\'/>\n </input>\n <graphics type=\'spice\' tlsPort=\'5900\' autoport=\'yes\' listen=\'128.84.46.164\' defaultMode=\'secure\' passwdValidTo=\'2017-03-27T14:37:09\'>\n <listen type=\'address\' address=\'128.84.46.164\'/>\n <channel name=\'main\' mode=\'secure\'/>\n <channel name=\'display\' mode=\'secure\'/>\n <channel name=\'inputs\' mode=\'secure\'/>\n <channel name=\'cursor\' mode=\'secure\'/>\n <channel name=\'playback\' mode=\'secure\'/>\n <channel name=\'record\' mode=\'secure\'/>\n <channel name=\'smartcard\' mode=\'secure\'/>\n <channel name=\'usbredir\' mode=\'secure\'/>\n </graphics>\n <video>\n <model type=\'qxl\' ram=\'65536\' vram=\'8192\' vgamem=\'16384\' heads=\'1\' primary=\'yes\'/>\n <alias name=\'video0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x02\' function=\'0x0\'/>\n </video>\n <memballoon model=\'virtio\'>\n <alias name=\'balloon0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x06\' function=\'0x0\'/>\n </memballoon>\n <rng model=\'virtio\'>\n <backend model=\'random\'>/dev/urandom</backend>\n <alias name=\'rng0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x07\' function=\'0x0\'/>\n </rng>\n </devices>\n <seclabel type=\'none\' model=\'none\'/>\n <seclabel type=\'dynamic\' model=\'dac\' relabel=\'yes\'>\n <label>+265:+107</label>\n <imagelabel>+265:+107</imagelabel>\n </seclabel>\n</domain>\n', u'memSize': 1024, u'smpCoresPerSocket': u'1', u'vmName': u'lnx16', u'nice': u'0', u'username': u'(unknown)', u'maxMemSize': 4096, u'bootMenuEnable': u'false', u'smpThreadsPerCore': u'1', u'smartcardEnable': u'false', u'clientIp': u'', u'guestAgentAPIVersion': 3, u'kvmEnable': u'true', u'pitReinjection': u'false', u'displayNetwork': u'classepublic', u'devices': [{u'target': 1048576, u'alias': u'balloon0', u'specParams': {u'model': u'virtio'}, u'deviceId': u'ee3ebcbf-08d9-481e-907c-efe32b8ee869', u'address': {u'function': u'0x0', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'slot': u'0x06'}, u'device': u'memballoon', u'type': u'balloon'}, {u'alias': u'rng0', u'specParams': {u'source': u'urandom'}, u'deviceId': u'0c522e52-a4c9-4bd9-a367-7b6fddedc931', u'address': {u'slot': u'0x07', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'virtio', u'model': u'virtio', u'type': u'rng'}, {u'index': u'0', u'alias': u'usb', u'specParams': {}, u'deviceId': u'3d4cbbda-4aa6-424e-95c6-bfae37e466b7', u'address': {u'slot': u'0x01', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x2'}, u'device': u'usb', u'model': u'piix3-uhci', u'type': u'controller'}, {u'index': u'0', u'alias': u'scsi0', u'specParams': {}, u'deviceId': u'0db369d1-81d8-4534-8437-105b851670c5', u'address': {u'slot': u'0x04', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'scsi', u'model': u'virtio-scsi', u'type': u'controller'}, {u'alias': u'virtio-serial0', u'specParams': {}, u'deviceId': u'553f9e1c-d811-4cb6-82bc-d567cd8e50bd', u'address': {u'slot': u'0x05', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'virtio-serial', u'type': u'controller'}, {u'alias': u'video0', u'specParams': {u'vram': u'8192', u'vgamem': u'16384', u'heads': u'1', u'ram': u'65536'}, u'deviceId': u'2ece7a34-22ec-49bc-b48c-df4660d13d71', u'address': {u'slot': u'0x02', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'qxl', u'type': u'video'}, {u'device': u'spice', u'specParams': {u'fileTransferEnable': u'true', u'spiceSecureChannels': u'smain,sinputs,scursor,splayback,srecord,sdisplay,ssmartcard,susbredir', u'displayNetwork': u'classepublic', u'displayIp': u'128.84.46.164', u'copyPasteEnable': u'true'}, u'type': u'graphics', u'deviceId': u'a7076b55-ddbb-4932-aca4-c567d9576c54', u'tlsPort': u'5900'}, {u'nicModel': u'pv', u'macAddr': u'00:1a:4a:16:01:51', u'linkActive': True, u'network': u'classepublic', u'alias': u'net0', u'filter': u'vdsm-no-mac-spoofing', u'specParams': {u'inbound': {}, u'outbound': {}}, u'deviceId': u'5110646a-b5d4-4b62-8188-b18cec8c15df', u'address': {u'slot': u'0x03', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'bridge', u'type': u'interface', u'name': u'vnet0'}, {u'index': u'2', u'iface': u'ide', u'name': u'hdc', u'alias': u'ide0-1-0', u'specParams': {u'path': u''}, u'readonly': u'True', u'deviceId': u'75deba88-b39d-478c-83d3-cc535b43bb28', u'address': {u'bus': u'1', u'controller': u'0', u'type': u'drive', u'target': u'0', u'unit': u'0'}, u'device': u'cdrom', u'shared': u'false', u'path': u'', u'type': u'disk'}, {u'poolID': u'00000001-0001-0001-0001-000000000311', u'volumeInfo': {u'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', u'volType': u'path', u'leaseOffset': 111149056, u'volumeID': u'67b12700-5faf-49b2-af40-6178023b3794', u'leasePath': u'/dev/016ceee8-9117-4e8a-b611-f58f6763a098/leases', u'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6', u'path': u'/rhev/data-center/mnt/blockSD/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794'}, u'index': 0, u'iface': u'scsi', u'apparentsize': u'107374182400', u'alias': u'scsi0-0-0-0', u'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6', u'readonly': u'False', u'shared': u'false', u'truesize': u'107374182400', u'type': u'disk', u'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', u'reqsize': u'0', u'format': u'raw', u'deviceId': u'21d18729-279f-435b-90ab-a2995f041bc6', u'address': {u'bus': u'0', u'controller': u'0', u'type': u'drive', u'target': u'0', u'unit': u'0'}, u'device': u'disk', u'path': u'/rhev/data-center/00000001-0001-0001-0001-000000000311/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794', u'propagateErrors': u'off', u'optional': u'false', u'name': u'sda', u'bootOrder': u'1', u'volumeID': u'67b12700-5faf-49b2-af40-6178023b3794', u'specParams': {}, u'discard': False, u'volumeChain': [{u'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', u'volType': u'path', u'leaseOffset': 111149056, u'volumeID': u'67b12700-5faf-49b2-af40-6178023b3794', u'leasePath': u'/dev/016ceee8-9117-4e8a-b611-f58f6763a098/leases', u'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6', u'path': u'/rhev/data-center/mnt/blockSD/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794'}]}, {u'device': u'ide', u'alias': u'ide', u'type': u'controller', u'address': {u'slot': u'0x01', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x1'}}, {u'device': u'unix', u'alias': u'channel0', u'type': u'channel', u'address': {u'bus': u'0', u'controller': u'0', u'type': u'virtio-serial', u'port': u'1'}}, {u'device': u'unix', u'alias': u'channel1', u'type': u'channel', u'address': {u'bus': u'0', u'controller': u'0', u'type': u'virtio-serial', u'port': u'2'}}, {u'device': u'spicevmc', u'alias': u'channel2', u'type': u'channel', u'address': {u'bus': u'0', u'controller': u'0', u'type': u'virtio-serial', u'port': u'3'}}], u'memGuaranteedSize': 1024, u'status': u'Up', u'maxVCpus': u'16', u'guestIPs': u'128.84.46.16 192.168.122.1', u'statusTime': u'4528256170', u'maxMemSlots': 16}, False) kwargs={} (api:37) 2017-03-27 10:57:02,776-0400 INFO (jsonrpc/4) [vdsm.api] FINISH __init__ return=None (api:43) 2017-03-27 10:57:02,777-0400 INFO (vm/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') VM wrapper has started (vm:1915) 2017-03-27 10:57:02,778-0400 INFO (vm/cf9c5dbf) [dispatcher] Run and protect: getVolumeSize(sdUUID=u'016ceee8-9117-4e8a-b611-f58f6763a098', spUUID=u'00000001-0001-0001-0001-000000000311', imgUUID=u'21d18729-279f-435b-90ab-a2995f041bc6', volUUID=u'67b12700-5faf-49b2-af40-6178023b3794', options=None) (logUtils:51) 2017-03-27 10:57:02,809-0400 INFO (vm/cf9c5dbf) [dispatcher] Run and protect: getVolumeSize, Return response: {'truesize': '107374182400', 'apparentsize': '107374182400'} (logUtils:54) 2017-03-27 10:57:02,809-0400 INFO (vm/cf9c5dbf) [vds] prepared volume path: (clientIF:374) 2017-03-27 10:57:02,810-0400 INFO (vm/cf9c5dbf) [dispatcher] Run and protect: prepareImage(sdUUID=u'016ceee8-9117-4e8a-b611-f58f6763a098', spUUID=u'00000001-0001-0001-0001-000000000311', imgUUID=u'21d18729-279f-435b-90ab-a2995f041bc6', leafUUID=u'67b12700-5faf-49b2-af40-6178023b3794', allowIllegal=False) (logUtils:51) 2017-03-27 10:57:02,859-0400 INFO (vm/cf9c5dbf) [storage.LVM] Activating lvs: vg=016ceee8-9117-4e8a-b611-f58f6763a098 lvs=['67b12700-5faf-49b2-af40-6178023b3794'] (lvm:1289) 2017-03-27 10:57:02,947-0400 INFO (vm/cf9c5dbf) [storage.LVM] Refreshing lvs: vg=016ceee8-9117-4e8a-b611-f58f6763a098 lvs=['leases'] (lvm:1285) 2017-03-27 10:57:02,998-0400 INFO (vm/cf9c5dbf) [dispatcher] Run and protect: prepareImage, Return response: {'info': {'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', 'volType': 'path', 'leaseOffset': 111149056, 'path': u'/rhev/data-center/mnt/blockSD/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794', 'volumeID': '67b12700-5faf-49b2-af40-6178023b3794', 'leasePath': '/dev/016ceee8-9117-4e8a-b611-f58f6763a098/leases', 'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6'}, 'path': u'/rhev/data-center/00000001-0001-0001-0001-000000000311/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794', 'imgVolumesInfo': [{'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', 'volType': 'path', 'leaseOffset': 111149056, 'path': u'/rhev/data-center/mnt/blockSD/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794', 'volumeID': '67b12700-5faf-49b2-af40-6178023b3794', 'leasePath': '/dev/016ceee8-9117-4e8a-b611-f58f6763a098/leases', 'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6'}]} (logUtils:54) 2017-03-27 10:57:02,998-0400 INFO (vm/cf9c5dbf) [vds] prepared volume path: /rhev/data-center/00000001-0001-0001-0001-000000000311/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794 (clientIF:374) 2017-03-27 10:57:03,026-0400 INFO (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call VM.migrationCreate succeeded in 0.27 seconds (__init__:515) 2017-03-27 10:57:03,225-0400 INFO (jsonrpc/7) [vdsm.api] START destroy args=(<virt.vm.Vm object at 0x4132e50>, 1) kwargs={} (api:37) 2017-03-27 10:57:03,225-0400 INFO (jsonrpc/7) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Release VM resources (vm:4199) 2017-03-27 10:57:03,226-0400 INFO (jsonrpc/7) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Stopping connection (guestagent:430) 2017-03-27 10:57:03,227-0400 INFO (jsonrpc/7) [dispatcher] Run and protect: teardownImage(sdUUID=u'016ceee8-9117-4e8a-b611-f58f6763a098', spUUID=u'00000001-0001-0001-0001-000000000311', imgUUID=u'21d18729-279f-435b-90ab-a2995f041bc6', volUUID=None) (logUtils:51) 2017-03-27 10:57:03,237-0400 INFO (vm/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Changed state to Down: VM destroyed during the startup (code=10) (vm:1207) 2017-03-27 10:57:03,238-0400 INFO (vm/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Stopping connection (guestagent:430) 2017-03-27 10:57:03,260-0400 INFO (jsonrpc/7) [storage.LVM] Deactivating lvs: vg=016ceee8-9117-4e8a-b611-f58f6763a098 lvs=['67b12700-5faf-49b2-af40-6178023b3794'] (lvm:1297) 2017-03-27 10:57:03,311-0400 INFO (jsonrpc/7) [dispatcher] Run and protect: teardownImage, Return response: None (logUtils:54) 2017-03-27 10:57:03,312-0400 INFO (jsonrpc/7) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Stopping connection (guestagent:430) 2017-03-27 10:57:03,312-0400 WARN (jsonrpc/7) [root] File: /var/lib/libvirt/qemu/channels/cf9c5dbf-3924-47c6-b323-22ac90a1f682.com.redhat.rhevm.vdsm already removed (utils:120) 2017-03-27 10:57:03,312-0400 WARN (jsonrpc/7) [root] File: /var/lib/libvirt/qemu/channels/cf9c5dbf-3924-47c6-b323-22ac90a1f682.org.qemu.guest_agent.0 already removed (utils:120) 2017-03-27 10:57:03,313-0400 WARN (jsonrpc/7) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') timestamp already removed from stats cache (vm:1729) 2017-03-27 10:57:03,313-0400 INFO (jsonrpc/7) [dispatcher] Run and protect: inappropriateDevices(thiefId=u'cf9c5dbf-3924-47c6-b323-22ac90a1f682') (logUtils:51) 2017-03-27 10:57:03,314-0400 INFO (jsonrpc/7) [dispatcher] Run and protect: inappropriateDevices, Return response: None (logUtils:54) 2017-03-27 10:57:03,314-0400 INFO (jsonrpc/7) [vdsm.api] FINISH destroy return={'status': {'message': 'Done', 'code': 0}} (api:43) 2017-03-27 10:57:03,315-0400 INFO (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call VM.destroy succeeded in 0.09 seconds (__init__:515) 2017-03-27 10:57:03,937-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53024 (protocoldetector:72) 2017-03-27 10:57:03,943-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53024 (protocoldetector:127) 2017-03-27 10:57:03,944-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:03,945-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:04,084-0400 INFO (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:04,086-0400 INFO (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call VM.getStats failed (error 1) in 0.00 seconds (__init__:515) 2017-03-27 10:57:04,767-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53026 (protocoldetector:72) 2017-03-27 10:57:04,772-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53026 (protocoldetector:127) 2017-03-27 10:57:04,773-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:04,774-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:04,913-0400 INFO (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:05,126-0400 INFO (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getCapabilities succeeded in 0.22 seconds (__init__:515) 2017-03-27 10:57:06,040-0400 INFO (periodic/0) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:06,040-0400 INFO (periodic/0) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000426872', 'lastCheck': '4.6', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000387272', 'lastCheck': '4.5', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000353399', 'lastCheck': '0.5', 'valid': True}} (logUtils:54) 2017-03-27 10:57:08,170-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53028 (protocoldetector:72) 2017-03-27 10:57:08,176-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53028 (protocoldetector:127) 2017-03-27 10:57:08,176-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:08,177-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:08,321-0400 INFO (jsonrpc/6) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:08,322-0400 INFO (jsonrpc/6) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000426872', 'lastCheck': '2.1', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000387272', 'lastCheck': '1.2', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000353399', 'lastCheck': '2.8', 'valid': True}} (logUtils:54) 2017-03-27 10:57:08,324-0400 INFO (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:08,327-0400 INFO (jsonrpc/4) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:08,328-0400 INFO (jsonrpc/4) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000426872', 'lastCheck': '2.1', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000387272', 'lastCheck': '1.2', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000353399', 'lastCheck': '2.8', 'valid': True}} (logUtils:54) 2017-03-27 10:57:08,619-0400 INFO (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.29 seconds (__init__:515) 2017-03-27 10:57:08,625-0400 INFO (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.30 seconds (__init__:515) 2017-03-27 10:57:08,848-0400 INFO (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:09,370-0400 INFO (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:10,927-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53030 (protocoldetector:72) 2017-03-27 10:57:10,932-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53030 (protocoldetector:127) 2017-03-27 10:57:10,932-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:10,933-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:11,077-0400 INFO (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:11,080-0400 INFO (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call VM.getStats failed (error 1) in 0.00 seconds (__init__:515) 2017-03-27 10:57:13,802-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53034 (protocoldetector:72) 2017-03-27 10:57:13,808-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53034 (protocoldetector:127) 2017-03-27 10:57:13,809-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:13,810-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:14,015-0400 INFO (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:14,019-0400 INFO (jsonrpc/5) [dispatcher] Run and protect: getImagesList(sdUUID=u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a', options=None) (logUtils:51) 2017-03-27 10:57:14,050-0400 INFO (jsonrpc/5) [dispatcher] Run and protect: getImagesList, Return response: {'imageslist': ['a1d7f855-40d4-4f07-bf25-625284682b40', 'c61297c5-367b-4c98-a44b-de0318848a24', 'c2fc0c7c-596e-4011-8471-7f67408ea633', 'b2bb3396-a8fb-4ed7-89c7-4cc7d22aa26a', '6d594f05-c2c2-4ef0-849f-28da46b8f87e', '5fc548e6-51a8-44ee-a14b-92e0e924d7b8']} (logUtils:54) 2017-03-27 10:57:14,051-0400 INFO (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call StorageDomain.getImages succeeded in 0.03 seconds (__init__:515) 2017-03-27 10:57:14,083-0400 INFO (jsonrpc/4) [dispatcher] Run and protect: getVolumesList(sdUUID=u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a', spUUID=u'00000000-0000-0000-0000-000000000000', imgUUID=u'a1d7f855-40d4-4f07-bf25-625284682b40', options=None) (logUtils:51) ...
Just incase anyone else runs into this, you need to set "migration_ovs_hook_enabled=True" in vdsm.conf. It seems the vdsm.conf created by "hosted-engine --deploy" did not list all of the options, so I overlooked this one. Thanks for all the help, Devin On Mar 27, 2017, at 11:10 AM, Devin A. Bougie <devin.bougie@cornell.edu> wrote:
Hi, All. We have a new oVirt 4.1.1 cluster up with the OVS switch type. Everything seems to be working great, except for live migration.
I believe the red flag in vdsm.log on the source is: Cannot get interface MTU on 'vdsmbr_QwORbsw2': No such device (migration:287)
Which results from vdsm assigning an arbitrary bridge name to each ovs bridge.
Please see below for more details on the bridges and excerpts from the logs. Any help would be greatly appreciated.
Many thanks, Devin
SOURCE OVS BRIDGES: # ovs-vsctl show 6d96d9a5-e30d-455b-90c7-9e9632574695 Bridge "vdsmbr_QwORbsw2" Port "vdsmbr_QwORbsw2" Interface "vdsmbr_QwORbsw2" type: internal Port "vnet0" Interface "vnet0" Port classepublic Interface classepublic type: internal Port "ens1f0" Interface "ens1f0" Bridge "vdsmbr_9P7ZYKWn" Port ovirtmgmt Interface ovirtmgmt type: internal Port "ens1f1" Interface "ens1f1" Port "vdsmbr_9P7ZYKWn" Interface "vdsmbr_9P7ZYKWn" type: internal ovs_version: "2.7.0"
DESTINATION OVS BRIDGES: # ovs-vsctl show f66d765d-712a-4c81-b18e-da1acc9cfdde Bridge "vdsmbr_vdpp0dOd" Port "vdsmbr_vdpp0dOd" Interface "vdsmbr_vdpp0dOd" type: internal Port "ens1f0" Interface "ens1f0" Port classepublic Interface classepublic type: internal Bridge "vdsmbr_3sEwEKd1" Port "vdsmbr_3sEwEKd1" Interface "vdsmbr_3sEwEKd1" type: internal Port "ens1f1" Interface "ens1f1" Port ovirtmgmt Interface ovirtmgmt type: internal ovs_version: "2.7.0"
SOURCE VDSM LOG: ... 2017-03-27 10:57:02,567-0400 INFO (jsonrpc/1) [vdsm.api] START migrate args=(<virt.vm.Vm object at 0x3410810>, {u'incomingLimit': 2, u'src': u'192.168.55.84', u'dstqemu': u'192.168.55.81', u'autoConverge': u'false', u'tunneled': u'false', u'enableGuestEvents': False, u'dst': u'lnxvirt01-p55.classe.cornell.edu:54321', u'vmId': u'cf9c5dbf-3924-47c6-b323-22ac90a1f682', u'abortOnError': u'true', u'outgoingLimit': 2, u'compressed': u'false', u'maxBandwidth': 5000, u'method': u'online', 'mode': 'remote'}) kwargs={} (api:37) 2017-03-27 10:57:02,570-0400 INFO (jsonrpc/1) [vdsm.api] FINISH migrate return={'status': {'message': 'Migration in progress', 'code': 0}, 'progress': 0} (api:43) 2017-03-27 10:57:02,570-0400 INFO (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call VM.migrate succeeded in 0.01 seconds (__init__:515) 2017-03-27 10:57:03,028-0400 INFO (migsrc/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Creation of destination VM took: 0 seconds (migration:455) 2017-03-27 10:57:03,028-0400 INFO (migsrc/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') starting migration to qemu+tls://lnxvirt01-p55.classe.cornell.edu/system with miguri tcp://192.168.55.81 (migration:480) 2017-03-27 10:57:03,224-0400 ERROR (migsrc/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Cannot get interface MTU on 'vdsmbr_QwORbsw2': No such device (migration:287) 2017-03-27 10:57:03,322-0400 ERROR (migsrc/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Failed to migrate (migration:429) Traceback (most recent call last): File "/usr/lib/python2.7/site-packages/vdsm/virt/migration.py", line 411, in run self._startUnderlyingMigration(time.time()) File "/usr/lib/python2.7/site-packages/vdsm/virt/migration.py", line 489, in _startUnderlyingMigration self._perform_with_downtime_thread(duri, muri) File "/usr/lib/python2.7/site-packages/vdsm/virt/migration.py", line 555, in _perform_with_downtime_thread self._perform_migration(duri, muri) File "/usr/lib/python2.7/site-packages/vdsm/virt/migration.py", line 528, in _perform_migration self._vm._dom.migrateToURI3(duri, params, flags) File "/usr/lib/python2.7/site-packages/vdsm/virt/virdomain.py", line 69, in f ret = attr(*args, **kwargs) File "/usr/lib/python2.7/site-packages/vdsm/libvirtconnection.py", line 123, in wrapper ret = f(*args, **kwargs) File "/usr/lib/python2.7/site-packages/vdsm/utils.py", line 941, in wrapper return func(inst, *args, **kwargs) File "/usr/lib64/python2.7/site-packages/libvirt.py", line 1939, in migrateToURI3 if ret == -1: raise libvirtError ('virDomainMigrateToURI3() failed', dom=self) libvirtError: Cannot get interface MTU on 'vdsmbr_QwORbsw2': No such device 2017-03-27 10:57:03,435-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:33716 (protocoldetector:72) 2017-03-27 10:57:03,452-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:33716 (protocoldetector:127) 2017-03-27 10:57:03,452-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:03,456-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:03,589-0400 INFO (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.01 seconds (__init__:515) 2017-03-27 10:57:03,592-0400 INFO (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call VM.getStats failed (error 1) in 0.00 seconds (__init__:515) 2017-03-27 10:57:04,494-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:33718 (protocoldetector:72) 2017-03-27 10:57:04,500-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:33718 (protocoldetector:127) 2017-03-27 10:57:04,500-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:04,501-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:04,559-0400 INFO (periodic/2) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:04,559-0400 INFO (periodic/2) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000262909', 'lastCheck': '5.3', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000342019', 'lastCheck': '5.3', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000239611', 'lastCheck': '0.6', 'valid': True}} (logUtils:54) 2017-03-27 10:57:04,669-0400 INFO (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.01 seconds (__init__:515) 2017-03-27 10:57:04,684-0400 INFO (jsonrpc/0) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:04,684-0400 INFO (jsonrpc/0) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000262909', 'lastCheck': '5.4', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000342019', 'lastCheck': '5.4', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000239611', 'lastCheck': '0.7', 'valid': True}} (logUtils:54) 2017-03-27 10:57:04,770-0400 INFO (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.09 seconds (__init__:515) ...
DESTINATION VDSM LOG: ... 2017-03-27 10:57:01,515-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:01,652-0400 INFO (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:02,572-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::ffff:192.168.55.84:44582 (protocoldetector:72) 2017-03-27 10:57:02,577-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::ffff:192.168.55.84:44582 (protocoldetector:127) 2017-03-27 10:57:02,578-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:02,579-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:02,748-0400 INFO (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.ping succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:02,774-0400 INFO (jsonrpc/4) [vdsm.api] START __init__ args=(<virt.vm.Vm object at 0x4132e50>, <clientIF.clientIF object at 0x7f453c01e650>, {u'guestFQDN': u'lnx16.classe.cornell.edu', u'acpiEnable': u'true', u'emulatedMachine': u'pc-i440fx-rhel7.3.0', u'afterMigrationStatus': u'', u'enableGuestEvents': False, u'vmId': u'cf9c5dbf-3924-47c6-b323-22ac90a1f682', u'elapsedTimeOffset': 1321.2906959056854, u'guestDiskMapping': {u'0QEMU_QEMU_HARDDISK_21d18729-279f-435b-9': {u'name': u'/dev/sda'}, u'QEMU_DVD-ROM_QM00003': {u'name': u'/dev/sr0'}}, u'transparentHugePages': u'true', u'timeOffset': u'0', u'cpuType': u'Haswell-noTSX', u'custom': {u'device_9d15a0c8-a122-43b9-89c2-3ad530ebc985': u"VmDevice:{id='VmDeviceId:{deviceId='9d15a0c8-a122-43b9-89c2-3ad530ebc985', vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682'}', device='ide', type='CONTROLLER', bootOrder='0', specParams='[]', address='{slot=0x01, bus=0x00, domain=0x0000, type=pci, function=0x1}', managed='false', plug ged='true', readOnly='false', deviceAlias='ide', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}", u'device_9d15a0c8-a122-43b9-89c2-3ad530ebc985device_0bbb6377-22db-4d04-a501-64de81bab622device_758565a5-4378-4412-8ec1-2df7bb231c14device_7ead63f7-b119-434d-a2f7-081fd06229e4': u"VmDevice:{id='VmDeviceId:{deviceId='7ead63f7-b119-434d-a2f7-081fd06229e4', vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682'}', device='spicevmc', type='CHANNEL', bootOrder='0', specParams='[]', address='{bus=0, controller=0, type=virtio-serial, port=3}', managed='false', plugged='true', readOnly='false', deviceAlias='channel2', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}", u'device_9d15a0c8-a122-43b9-89c2-3ad530ebc985device_0bbb6377-22db-4d04-a501-64de81bab622': u"VmDevice:{id='VmDeviceId:{deviceId='0bbb6377-22db-4d04-a501-64de81bab622', vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682'}', device='unix', type='CHANNEL', bootOrder='0', specParam s='[]', address='{bus=0, controller=0, type=virtio-serial, port=2}', managed='false', plugged='true', readOnly='false', deviceAlias='channel1', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}", u'device_9d15a0c8-a122-43b9-89c2-3ad530ebc985device_0bbb6377-22db-4d04-a501-64de81bab622device_758565a5-4378-4412-8ec1-2df7bb231c14': u"VmDevice:{id='VmDeviceId:{deviceId='758565a5-4378-4412-8ec1-2df7bb231c14', vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682'}', device='unix', type='CHANNEL', bootOrder='0', specParams='[]', address='{bus=0, controller=0, type=virtio-serial, port=1}', managed='false', plugged='true', readOnly='false', deviceAlias='channel0', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}"}, u'pauseCode': u'NOERR', u'migrationDest': u'libvirt', u'guestNumaNodes': [{u'nodeIndex': 0, u'cpus': u'0', u'memory': u'1024'}], u'display': u'qxl', u'smp': u'1', u'vmType': u'kvm', u'_srcDomXML': u'<domain type=\'kvm\' i d=\'4\'>\n <name>lnx16</name>\n <uuid>cf9c5dbf-3924-47c6-b323-22ac90a1f682</uuid>\n <metadata xmlns:ovirt="http://ovirt.org/vm/tune/1.0">\n <ovirt:qos/>\n </metadata>\n <maxMemory slots=\'16\' unit=\'KiB\'>4194304</maxMemory>\n <memory unit=\'KiB\'>1048576</memory>\n <currentMemory unit=\'KiB\'>1048576</currentMemory>\n <vcpu placement=\'static\' current=\'1\'>16</vcpu>\n <cputune>\n <shares>1020</shares>\n </cputune>\n <resource>\n <partition>/machine</partition>\n </resource>\n <sysinfo type=\'smbios\'>\n <system>\n <entry name=\'manufacturer\'>oVirt</entry>\n <entry name=\'product\'>oVirt Node</entry>\n <entry name=\'version\'>7.3-4.sl7</entry>\n <entry name=\'serial\'>38C15485-D270-11E6-8752-0090FAEDD7C8</entry>\n <entry name=\'uuid\'>cf9c5dbf-3924-47c6-b323-22ac90a1f682</entry>\n </system>\n </sysinfo>\n <os>\n <type arch=\'x86_64\' machine=\'pc-i440fx-rhel7.3.0\'>hvm</type>\n <smbios mode=\'sysinfo\'/>\n </o s>\n <features>\n <acpi/>\n </features>\n <cpu mode=\'custom\' match=\'exact\'>\n <model fallback=\'allow\'>Haswell-noTSX</model>\n <topology sockets=\'16\' cores=\'1\' threads=\'1\'/>\n <numa>\n <cell id=\'0\' cpus=\'0\' memory=\'1048576\' unit=\'KiB\'/>\n </numa>\n </cpu>\n <clock offset=\'variable\' adjustment=\'0\' basis=\'utc\'>\n <timer name=\'rtc\' tickpolicy=\'catchup\'/>\n <timer name=\'pit\' tickpolicy=\'delay\'/>\n <timer name=\'hpet\' present=\'no\'/>\n </clock>\n <on_poweroff>destroy</on_poweroff>\n <on_reboot>restart</on_reboot>\n <on_crash>destroy</on_crash>\n <devices>\n <emulator>/usr/libexec/qemu-kvm</emulator>\n <disk type=\'file\' device=\'cdrom\'>\n <driver name=\'qemu\' type=\'raw\'/>\n <source startupPolicy=\'optional\'/>\n <backingStore/>\n <target dev=\'hdc\' bus=\'ide\'/>\n <readonly/>\n <alias name=\'ide0-1-0\'/>\n <address type=\'drive\' controller=\'0\' bus=\'1\' targ et=\'0\' unit=\'0\'/>\n </disk>\n <disk type=\'block\' device=\'disk\' snapshot=\'no\'>\n <driver name=\'qemu\' type=\'raw\' cache=\'none\' error_policy=\'stop\' io=\'native\'/>\n <source dev=\'/rhev/data-center/00000001-0001-0001-0001-000000000311/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794\'/>\n <backingStore/>\n <target dev=\'sda\' bus=\'scsi\'/>\n <serial>21d18729-279f-435b-90ab-a2995f041bc6</serial>\n <boot order=\'1\'/>\n <alias name=\'scsi0-0-0-0\'/>\n <address type=\'drive\' controller=\'0\' bus=\'0\' target=\'0\' unit=\'0\'/>\n </disk>\n <controller type=\'usb\' index=\'0\' model=\'piix3-uhci\'>\n <alias name=\'usb\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x01\' function=\'0x2\'/>\n </controller>\n <controller type=\'scsi\' index=\'0\' model=\'virtio-scsi\'>\n <alias name=\'scsi0\'/>\n <addre ss type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x04\' function=\'0x0\'/>\n </controller>\n <controller type=\'virtio-serial\' index=\'0\' ports=\'16\'>\n <alias name=\'virtio-serial0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x05\' function=\'0x0\'/>\n </controller>\n <controller type=\'pci\' index=\'0\' model=\'pci-root\'>\n <alias name=\'pci.0\'/>\n </controller>\n <controller type=\'ide\' index=\'0\'>\n <alias name=\'ide\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x01\' function=\'0x1\'/>\n </controller>\n <interface type=\'bridge\'>\n <mac address=\'00:1a:4a:16:01:51\'/>\n <source bridge=\'vdsmbr_QwORbsw2\'/>\n <virtualport type=\'openvswitch\'>\n <parameters interfaceid=\'3a24e764-32c8-4a2e-8dfd-02a776c3bef6\'/>\n </virtualport>\n <target dev=\'vnet0\'/>\n <model type=\'virtio\'/>\n <filterref filter=\'vdsm-no-mac-spoofing\'/>\ n <link state=\'up\'/>\n <alias name=\'net0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x03\' function=\'0x0\'/>\n </interface>\n <channel type=\'unix\'>\n <source mode=\'bind\' path=\'/var/lib/libvirt/qemu/channels/cf9c5dbf-3924-47c6-b323-22ac90a1f682.com.redhat.rhevm.vdsm\'/>\n <target type=\'virtio\' name=\'com.redhat.rhevm.vdsm\' state=\'connected\'/>\n <alias name=\'channel0\'/>\n <address type=\'virtio-serial\' controller=\'0\' bus=\'0\' port=\'1\'/>\n </channel>\n <channel type=\'unix\'>\n <source mode=\'bind\' path=\'/var/lib/libvirt/qemu/channels/cf9c5dbf-3924-47c6-b323-22ac90a1f682.org.qemu.guest_agent.0\'/>\n <target type=\'virtio\' name=\'org.qemu.guest_agent.0\' state=\'connected\'/>\n <alias name=\'channel1\'/>\n <address type=\'virtio-serial\' controller=\'0\' bus=\'0\' port=\'2\'/>\n </channel>\n <channel type=\'spicevmc\'>\n <target type=\'virtio\' name=\'com .redhat.spice.0\' state=\'connected\'/>\n <alias name=\'channel2\'/>\n <address type=\'virtio-serial\' controller=\'0\' bus=\'0\' port=\'3\'/>\n </channel>\n <input type=\'mouse\' bus=\'ps2\'>\n <alias name=\'input0\'/>\n </input>\n <input type=\'keyboard\' bus=\'ps2\'>\n <alias name=\'input1\'/>\n </input>\n <graphics type=\'spice\' tlsPort=\'5900\' autoport=\'yes\' listen=\'128.84.46.164\' defaultMode=\'secure\' passwdValidTo=\'2017-03-27T14:37:09\'>\n <listen type=\'address\' address=\'128.84.46.164\'/>\n <channel name=\'main\' mode=\'secure\'/>\n <channel name=\'display\' mode=\'secure\'/>\n <channel name=\'inputs\' mode=\'secure\'/>\n <channel name=\'cursor\' mode=\'secure\'/>\n <channel name=\'playback\' mode=\'secure\'/>\n <channel name=\'record\' mode=\'secure\'/>\n <channel name=\'smartcard\' mode=\'secure\'/>\n <channel name=\'usbredir\' mode=\'secure\'/>\n </graphics>\n <video
\n <model type=\'qxl\' ram=\'65536\' vram=\'8192\' vgamem=\'16384\' heads=\'1\' primary=\'yes\'/>\n <alias name=\'video0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x02\' function=\'0x0\'/>\n </video>\n <memballoon model=\'virtio\'>\n <alias name=\'balloon0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x06\' function=\'0x0\'/>\n </memballoon>\n <rng model=\'virtio\'>\n <backend model=\'random\'>/dev/urandom</backend>\n <alias name=\'rng0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x07\' function=\'0x0\'/>\n </rng>\n </devices>\n <seclabel type=\'none\' model=\'none\'/>\n <seclabel type=\'dynamic\' model=\'dac\' relabel=\'yes\'>\n <label>+265:+107</label>\n <imagelabel>+265:+107</imagelabel>\n </seclabel>\n</domain>\n', u'memSize': 1024, u'smpCoresPerSocket': u'1', u'vmName': u'lnx16', u'nice': u'0', u'username': u'(unknown)', u'maxMemSize': 409 6, u'bootMenuEnable': u'false', u'smpThreadsPerCore': u'1', u'smartcardEnable': u'false', u'clientIp': u'', u'guestAgentAPIVersion': 3, u'kvmEnable': u'true', u'pitReinjection': u'false', u'displayNetwork': u'classepublic', u'devices': [{u'target': 1048576, u'alias': u'balloon0', u'specParams': {u'model': u'virtio'}, u'deviceId': u'ee3ebcbf-08d9-481e-907c-efe32b8ee869', u'address': {u'function': u'0x0', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'slot': u'0x06'}, u'device': u'memballoon', u'type': u'balloon'}, {u'alias': u'rng0', u'specParams': {u'source': u'urandom'}, u'deviceId': u'0c522e52-a4c9-4bd9-a367-7b6fddedc931', u'address': {u'slot': u'0x07', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'virtio', u'model': u'virtio', u'type': u'rng'}, {u'index': u'0', u'alias': u'usb', u'specParams': {}, u'deviceId': u'3d4cbbda-4aa6-424e-95c6-bfae37e466b7', u'address': {u'slot': u'0x01', u'bus': u'0x00', u'domain': u'0x0000 ', u'type': u'pci', u'function': u'0x2'}, u'device': u'usb', u'model': u'piix3-uhci', u'type': u'controller'}, {u'index': u'0', u'alias': u'scsi0', u'specParams': {}, u'deviceId': u'0db369d1-81d8-4534-8437-105b851670c5', u'address': {u'slot': u'0x04', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'scsi', u'model': u'virtio-scsi', u'type': u'controller'}, {u'alias': u'virtio-serial0', u'specParams': {}, u'deviceId': u'553f9e1c-d811-4cb6-82bc-d567cd8e50bd', u'address': {u'slot': u'0x05', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'virtio-serial', u'type': u'controller'}, {u'alias': u'video0', u'specParams': {u'vram': u'8192', u'vgamem': u'16384', u'heads': u'1', u'ram': u'65536'}, u'deviceId': u'2ece7a34-22ec-49bc-b48c-df4660d13d71', u'address': {u'slot': u'0x02', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'qxl', u'type': u'video'}, {u'devic e': u'spice', u'specParams': {u'fileTransferEnable': u'true', u'spiceSecureChannels': u'smain,sinputs,scursor,splayback,srecord,sdisplay,ssmartcard,susbredir', u'displayNetwork': u'classepublic', u'displayIp': u'128.84.46.164', u'copyPasteEnable': u'true'}, u'type': u'graphics', u'deviceId': u'a7076b55-ddbb-4932-aca4-c567d9576c54', u'tlsPort': u'5900'}, {u'nicModel': u'pv', u'macAddr': u'00:1a:4a:16:01:51', u'linkActive': True, u'network': u'classepublic', u'alias': u'net0', u'filter': u'vdsm-no-mac-spoofing', u'specParams': {u'inbound': {}, u'outbound': {}}, u'deviceId': u'5110646a-b5d4-4b62-8188-b18cec8c15df', u'address': {u'slot': u'0x03', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'bridge', u'type': u'interface', u'name': u'vnet0'}, {u'index': u'2', u'iface': u'ide', u'name': u'hdc', u'alias': u'ide0-1-0', u'specParams': {u'path': u''}, u'readonly': u'True', u'deviceId': u'75deba88-b39d-478c-83d3-cc535b43bb28', u'address': { u'bus': u'1', u'controller': u'0', u'type': u'drive', u'target': u'0', u'unit': u'0'}, u'device': u'cdrom', u'shared': u'false', u'path': u'', u'type': u'disk'}, {u'poolID': u'00000001-0001-0001-0001-000000000311', u'volumeInfo': {u'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', u'volType': u'path', u'leaseOffset': 111149056, u'volumeID': u'67b12700-5faf-49b2-af40-6178023b3794', u'leasePath': u'/dev/016ceee8-9117-4e8a-b611-f58f6763a098/leases', u'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6', u'path': u'/rhev/data-center/mnt/blockSD/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794'}, u'index': 0, u'iface': u'scsi', u'apparentsize': u'107374182400', u'alias': u'scsi0-0-0-0', u'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6', u'readonly': u'False', u'shared': u'false', u'truesize': u'107374182400', u'type': u'disk', u'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', u'reqsize': u'0', u'format': u'raw', u'deviceId': u'21d18729-279f-435b-90ab-a2995f041bc6', u'address': {u'bus': u'0', u'controller': u'0', u'type': u'drive', u'target': u'0', u'unit': u'0'}, u'device': u'disk', u'path': u'/rhev/data-center/00000001-0001-0001-0001-000000000311/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794', u'propagateErrors': u'off', u'optional': u'false', u'name': u'sda', u'bootOrder': u'1', u'volumeID': u'67b12700-5faf-49b2-af40-6178023b3794', u'specParams': {}, u'discard': False, u'volumeChain': [{u'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', u'volType': u'path', u'leaseOffset': 111149056, u'volumeID': u'67b12700-5faf-49b2-af40-6178023b3794', u'leasePath': u'/dev/016ceee8-9117-4e8a-b611-f58f6763a098/leases', u'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6', u'path': u'/rhev/data-center/mnt/blockSD/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6 178023b3794'}]}, {u'device': u'ide', u'alias': u'ide', u'type': u'controller', u'address': {u'slot': u'0x01', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x1'}}, {u'device': u'unix', u'alias': u'channel0', u'type': u'channel', u'address': {u'bus': u'0', u'controller': u'0', u'type': u'virtio-serial', u'port': u'1'}}, {u'device': u'unix', u'alias': u'channel1', u'type': u'channel', u'address': {u'bus': u'0', u'controller': u'0', u'type': u'virtio-serial', u'port': u'2'}}, {u'device': u'spicevmc', u'alias': u'channel2', u'type': u'channel', u'address': {u'bus': u'0', u'controller': u'0', u'type': u'virtio-serial', u'port': u'3'}}], u'memGuaranteedSize': 1024, u'status': u'Up', u'maxVCpus': u'16', u'guestIPs': u'128.84.46.16 192.168.122.1', u'statusTime': u'4528256170', u'maxMemSlots': 16}, False) kwargs={} (api:37) 2017-03-27 10:57:02,776-0400 INFO (jsonrpc/4) [vdsm.api] FINISH __init__ return=None (api:43) 2017-03-27 10:57:02,777-0400 INFO (vm/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') VM wrapper has started (vm:1915) 2017-03-27 10:57:02,778-0400 INFO (vm/cf9c5dbf) [dispatcher] Run and protect: getVolumeSize(sdUUID=u'016ceee8-9117-4e8a-b611-f58f6763a098', spUUID=u'00000001-0001-0001-0001-000000000311', imgUUID=u'21d18729-279f-435b-90ab-a2995f041bc6', volUUID=u'67b12700-5faf-49b2-af40-6178023b3794', options=None) (logUtils:51) 2017-03-27 10:57:02,809-0400 INFO (vm/cf9c5dbf) [dispatcher] Run and protect: getVolumeSize, Return response: {'truesize': '107374182400', 'apparentsize': '107374182400'} (logUtils:54) 2017-03-27 10:57:02,809-0400 INFO (vm/cf9c5dbf) [vds] prepared volume path: (clientIF:374) 2017-03-27 10:57:02,810-0400 INFO (vm/cf9c5dbf) [dispatcher] Run and protect: prepareImage(sdUUID=u'016ceee8-9117-4e8a-b611-f58f6763a098', spUUID=u'00000001-0001-0001-0001-000000000311', imgUUID=u'21d18729-279f-435b-90ab-a2995f041bc6', leafUUID=u'67b12700-5faf-49b2-af40-6178023b3794', allowIllegal=False) (logUtils:51) 2017-03-27 10:57:02,859-0400 INFO (vm/cf9c5dbf) [storage.LVM] Activating lvs: vg=016ceee8-9117-4e8a-b611-f58f6763a098 lvs=['67b12700-5faf-49b2-af40-6178023b3794'] (lvm:1289) 2017-03-27 10:57:02,947-0400 INFO (vm/cf9c5dbf) [storage.LVM] Refreshing lvs: vg=016ceee8-9117-4e8a-b611-f58f6763a098 lvs=['leases'] (lvm:1285) 2017-03-27 10:57:02,998-0400 INFO (vm/cf9c5dbf) [dispatcher] Run and protect: prepareImage, Return response: {'info': {'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', 'volType': 'path', 'leaseOffset': 111149056, 'path': u'/rhev/data-center/mnt/blockSD/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794', 'volumeID': '67b12700-5faf-49b2-af40-6178023b3794', 'leasePath': '/dev/016ceee8-9117-4e8a-b611-f58f6763a098/leases', 'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6'}, 'path': u'/rhev/data-center/00000001-0001-0001-0001-000000000311/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794', 'imgVolumesInfo': [{'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', 'volType': 'path', 'leaseOffset': 111149056, 'path': u'/rhev/data-center/mnt/blockSD/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2 -af40-6178023b3794', 'volumeID': '67b12700-5faf-49b2-af40-6178023b3794', 'leasePath': '/dev/016ceee8-9117-4e8a-b611-f58f6763a098/leases', 'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6'}]} (logUtils:54) 2017-03-27 10:57:02,998-0400 INFO (vm/cf9c5dbf) [vds] prepared volume path: /rhev/data-center/00000001-0001-0001-0001-000000000311/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794 (clientIF:374) 2017-03-27 10:57:03,026-0400 INFO (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call VM.migrationCreate succeeded in 0.27 seconds (__init__:515) 2017-03-27 10:57:03,225-0400 INFO (jsonrpc/7) [vdsm.api] START destroy args=(<virt.vm.Vm object at 0x4132e50>, 1) kwargs={} (api:37) 2017-03-27 10:57:03,225-0400 INFO (jsonrpc/7) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Release VM resources (vm:4199) 2017-03-27 10:57:03,226-0400 INFO (jsonrpc/7) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Stopping connection (guestagent:430) 2017-03-27 10:57:03,227-0400 INFO (jsonrpc/7) [dispatcher] Run and protect: teardownImage(sdUUID=u'016ceee8-9117-4e8a-b611-f58f6763a098', spUUID=u'00000001-0001-0001-0001-000000000311', imgUUID=u'21d18729-279f-435b-90ab-a2995f041bc6', volUUID=None) (logUtils:51) 2017-03-27 10:57:03,237-0400 INFO (vm/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Changed state to Down: VM destroyed during the startup (code=10) (vm:1207) 2017-03-27 10:57:03,238-0400 INFO (vm/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Stopping connection (guestagent:430) 2017-03-27 10:57:03,260-0400 INFO (jsonrpc/7) [storage.LVM] Deactivating lvs: vg=016ceee8-9117-4e8a-b611-f58f6763a098 lvs=['67b12700-5faf-49b2-af40-6178023b3794'] (lvm:1297) 2017-03-27 10:57:03,311-0400 INFO (jsonrpc/7) [dispatcher] Run and protect: teardownImage, Return response: None (logUtils:54) 2017-03-27 10:57:03,312-0400 INFO (jsonrpc/7) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Stopping connection (guestagent:430) 2017-03-27 10:57:03,312-0400 WARN (jsonrpc/7) [root] File: /var/lib/libvirt/qemu/channels/cf9c5dbf-3924-47c6-b323-22ac90a1f682.com.redhat.rhevm.vdsm already removed (utils:120) 2017-03-27 10:57:03,312-0400 WARN (jsonrpc/7) [root] File: /var/lib/libvirt/qemu/channels/cf9c5dbf-3924-47c6-b323-22ac90a1f682.org.qemu.guest_agent.0 already removed (utils:120) 2017-03-27 10:57:03,313-0400 WARN (jsonrpc/7) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') timestamp already removed from stats cache (vm:1729) 2017-03-27 10:57:03,313-0400 INFO (jsonrpc/7) [dispatcher] Run and protect: inappropriateDevices(thiefId=u'cf9c5dbf-3924-47c6-b323-22ac90a1f682') (logUtils:51) 2017-03-27 10:57:03,314-0400 INFO (jsonrpc/7) [dispatcher] Run and protect: inappropriateDevices, Return response: None (logUtils:54) 2017-03-27 10:57:03,314-0400 INFO (jsonrpc/7) [vdsm.api] FINISH destroy return={'status': {'message': 'Done', 'code': 0}} (api:43) 2017-03-27 10:57:03,315-0400 INFO (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call VM.destroy succeeded in 0.09 seconds (__init__:515) 2017-03-27 10:57:03,937-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53024 (protocoldetector:72) 2017-03-27 10:57:03,943-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53024 (protocoldetector:127) 2017-03-27 10:57:03,944-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:03,945-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:04,084-0400 INFO (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:04,086-0400 INFO (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call VM.getStats failed (error 1) in 0.00 seconds (__init__:515) 2017-03-27 10:57:04,767-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53026 (protocoldetector:72) 2017-03-27 10:57:04,772-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53026 (protocoldetector:127) 2017-03-27 10:57:04,773-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:04,774-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:04,913-0400 INFO (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:05,126-0400 INFO (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getCapabilities succeeded in 0.22 seconds (__init__:515) 2017-03-27 10:57:06,040-0400 INFO (periodic/0) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:06,040-0400 INFO (periodic/0) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000426872', 'lastCheck': '4.6', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000387272', 'lastCheck': '4.5', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000353399', 'lastCheck': '0.5', 'valid': True}} (logUtils:54) 2017-03-27 10:57:08,170-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53028 (protocoldetector:72) 2017-03-27 10:57:08,176-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53028 (protocoldetector:127) 2017-03-27 10:57:08,176-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:08,177-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:08,321-0400 INFO (jsonrpc/6) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:08,322-0400 INFO (jsonrpc/6) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000426872', 'lastCheck': '2.1', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000387272', 'lastCheck': '1.2', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000353399', 'lastCheck': '2.8', 'valid': True}} (logUtils:54) 2017-03-27 10:57:08,324-0400 INFO (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:08,327-0400 INFO (jsonrpc/4) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:08,328-0400 INFO (jsonrpc/4) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000426872', 'lastCheck': '2.1', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000387272', 'lastCheck': '1.2', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000353399', 'lastCheck': '2.8', 'valid': True}} (logUtils:54) 2017-03-27 10:57:08,619-0400 INFO (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.29 seconds (__init__:515) 2017-03-27 10:57:08,625-0400 INFO (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.30 seconds (__init__:515) 2017-03-27 10:57:08,848-0400 INFO (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:09,370-0400 INFO (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:10,927-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53030 (protocoldetector:72) 2017-03-27 10:57:10,932-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53030 (protocoldetector:127) 2017-03-27 10:57:10,932-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:10,933-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:11,077-0400 INFO (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:11,080-0400 INFO (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call VM.getStats failed (error 1) in 0.00 seconds (__init__:515) 2017-03-27 10:57:13,802-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53034 (protocoldetector:72) 2017-03-27 10:57:13,808-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53034 (protocoldetector:127) 2017-03-27 10:57:13,809-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:13,810-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:14,015-0400 INFO (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:14,019-0400 INFO (jsonrpc/5) [dispatcher] Run and protect: getImagesList(sdUUID=u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a', options=None) (logUtils:51) 2017-03-27 10:57:14,050-0400 INFO (jsonrpc/5) [dispatcher] Run and protect: getImagesList, Return response: {'imageslist': ['a1d7f855-40d4-4f07-bf25-625284682b40', 'c61297c5-367b-4c98-a44b-de0318848a24', 'c2fc0c7c-596e-4011-8471-7f67408ea633', 'b2bb3396-a8fb-4ed7-89c7-4cc7d22aa26a', '6d594f05-c2c2-4ef0-849f-28da46b8f87e', '5fc548e6-51a8-44ee-a14b-92e0e924d7b8']} (logUtils:54) 2017-03-27 10:57:14,051-0400 INFO (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call StorageDomain.getImages succeeded in 0.03 seconds (__init__:515) 2017-03-27 10:57:14,083-0400 INFO (jsonrpc/4) [dispatcher] Run and protect: getVolumesList(sdUUID=u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a', spUUID=u'00000000-0000-0000-0000-000000000000', imgUUID=u'a1d7f855-40d4-4f07-bf25-625284682b40', options=None) (logUtils:51) ...
Users mailing list Users@ovirt.org http://lists.ovirt.org/mailman/listinfo/users
Thanks for following up on this. We need to put a little more effort on Bug 1400952 - [RFE] Resolve listen IP for graphics attached to Open vSwitch network so that the hook is no longer needed. Please let us know how oVirt+OvS is working for you! On Wed, Mar 29, 2017 at 6:17 PM, Devin A. Bougie <devin.bougie@cornell.edu> wrote:
Just incase anyone else runs into this, you need to set "migration_ovs_hook_enabled=True" in vdsm.conf. It seems the vdsm.conf created by "hosted-engine --deploy" did not list all of the options, so I overlooked this one.
Thanks for all the help, Devin
On Mar 27, 2017, at 11:10 AM, Devin A. Bougie <devin.bougie@cornell.edu> wrote:
Hi, All. We have a new oVirt 4.1.1 cluster up with the OVS switch type. Everything seems to be working great, except for live migration.
I believe the red flag in vdsm.log on the source is: Cannot get interface MTU on 'vdsmbr_QwORbsw2': No such device (migration:287)
Which results from vdsm assigning an arbitrary bridge name to each ovs bridge.
Please see below for more details on the bridges and excerpts from the logs. Any help would be greatly appreciated.
Many thanks, Devin
SOURCE OVS BRIDGES: # ovs-vsctl show 6d96d9a5-e30d-455b-90c7-9e9632574695 Bridge "vdsmbr_QwORbsw2" Port "vdsmbr_QwORbsw2" Interface "vdsmbr_QwORbsw2" type: internal Port "vnet0" Interface "vnet0" Port classepublic Interface classepublic type: internal Port "ens1f0" Interface "ens1f0" Bridge "vdsmbr_9P7ZYKWn" Port ovirtmgmt Interface ovirtmgmt type: internal Port "ens1f1" Interface "ens1f1" Port "vdsmbr_9P7ZYKWn" Interface "vdsmbr_9P7ZYKWn" type: internal ovs_version: "2.7.0"
DESTINATION OVS BRIDGES: # ovs-vsctl show f66d765d-712a-4c81-b18e-da1acc9cfdde Bridge "vdsmbr_vdpp0dOd" Port "vdsmbr_vdpp0dOd" Interface "vdsmbr_vdpp0dOd" type: internal Port "ens1f0" Interface "ens1f0" Port classepublic Interface classepublic type: internal Bridge "vdsmbr_3sEwEKd1" Port "vdsmbr_3sEwEKd1" Interface "vdsmbr_3sEwEKd1" type: internal Port "ens1f1" Interface "ens1f1" Port ovirtmgmt Interface ovirtmgmt type: internal ovs_version: "2.7.0"
SOURCE VDSM LOG: ... 2017-03-27 10:57:02,567-0400 INFO (jsonrpc/1) [vdsm.api] START migrate args=(<virt.vm.Vm object at 0x3410810>, {u'incomingLimit': 2, u'src': u'192.168.55.84', u'dstqemu': u'192.168.55.81', u'autoConverge': u'false', u'tunneled': u'false', u'enableGuestEvents': False, u'dst': u'lnxvirt01-p55.classe.cornell.edu:54321', u'vmId': u'cf9c5dbf-3924-47c6-b323-22ac90a1f682', u'abortOnError': u'true', u'outgoingLimit': 2, u'compressed': u'false', u'maxBandwidth': 5000, u'method': u'online', 'mode': 'remote'}) kwargs={} (api:37) 2017-03-27 10:57:02,570-0400 INFO (jsonrpc/1) [vdsm.api] FINISH migrate return={'status': {'message': 'Migration in progress', 'code': 0}, 'progress': 0} (api:43) 2017-03-27 10:57:02,570-0400 INFO (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call VM.migrate succeeded in 0.01 seconds (__init__:515) 2017-03-27 10:57:03,028-0400 INFO (migsrc/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Creation of destination VM took: 0 seconds (migration:455) 2017-03-27 10:57:03,028-0400 INFO (migsrc/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') starting migration to qemu+tls://lnxvirt01-p55.classe.cornell.edu/system with miguri tcp://192.168.55.81 (migration:480) 2017-03-27 10:57:03,224-0400 ERROR (migsrc/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Cannot get interface MTU on 'vdsmbr_QwORbsw2': No such device (migration:287) 2017-03-27 10:57:03,322-0400 ERROR (migsrc/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Failed to migrate (migration:429) Traceback (most recent call last): File "/usr/lib/python2.7/site-packages/vdsm/virt/migration.py", line 411, in run self._startUnderlyingMigration(time.time()) File "/usr/lib/python2.7/site-packages/vdsm/virt/migration.py", line 489, in _startUnderlyingMigration self._perform_with_downtime_thread(duri, muri) File "/usr/lib/python2.7/site-packages/vdsm/virt/migration.py", line 555, in _perform_with_downtime_thread self._perform_migration(duri, muri) File "/usr/lib/python2.7/site-packages/vdsm/virt/migration.py", line 528, in _perform_migration self._vm._dom.migrateToURI3(duri, params, flags) File "/usr/lib/python2.7/site-packages/vdsm/virt/virdomain.py", line 69, in f ret = attr(*args, **kwargs) File "/usr/lib/python2.7/site-packages/vdsm/libvirtconnection.py", line 123, in wrapper ret = f(*args, **kwargs) File "/usr/lib/python2.7/site-packages/vdsm/utils.py", line 941, in wrapper return func(inst, *args, **kwargs) File "/usr/lib64/python2.7/site-packages/libvirt.py", line 1939, in migrateToURI3 if ret == -1: raise libvirtError ('virDomainMigrateToURI3() failed', dom=self) libvirtError: Cannot get interface MTU on 'vdsmbr_QwORbsw2': No such device 2017-03-27 10:57:03,435-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:33716 (protocoldetector:72) 2017-03-27 10:57:03,452-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:33716 (protocoldetector:127) 2017-03-27 10:57:03,452-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:03,456-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:03,589-0400 INFO (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.01 seconds (__init__:515) 2017-03-27 10:57:03,592-0400 INFO (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call VM.getStats failed (error 1) in 0.00 seconds (__init__:515) 2017-03-27 10:57:04,494-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:33718 (protocoldetector:72) 2017-03-27 10:57:04,500-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:33718 (protocoldetector:127) 2017-03-27 10:57:04,500-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:04,501-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:04,559-0400 INFO (periodic/2) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:04,559-0400 INFO (periodic/2) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000262909', 'lastCheck': '5.3', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000342019', 'lastCheck': '5.3', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000239611', 'lastCheck': '0.6', 'valid': True}} (logUtils:54) 2017-03-27 10:57:04,669-0400 INFO (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.01 seconds (__init__:515) 2017-03-27 10:57:04,684-0400 INFO (jsonrpc/0) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:04,684-0400 INFO (jsonrpc/0) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000262909', 'lastCheck': '5.4', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000342019', 'lastCheck': '5.4', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000239611', 'lastCheck': '0.7', 'valid': True}} (logUtils:54) 2017-03-27 10:57:04,770-0400 INFO (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.09 seconds (__init__:515) ...
DESTINATION VDSM LOG: ... 2017-03-27 10:57:01,515-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:01,652-0400 INFO (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:02,572-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::ffff:192.168.55.84:44582 (protocoldetector:72) 2017-03-27 10:57:02,577-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::ffff:192.168.55.84:44582 (protocoldetector:127) 2017-03-27 10:57:02,578-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:02,579-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:02,748-0400 INFO (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.ping succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:02,774-0400 INFO (jsonrpc/4) [vdsm.api] START __init__ args=(<virt.vm.Vm object at 0x4132e50>, <clientIF.clientIF object at 0x7f453c01e650>, {u'guestFQDN': u'lnx16.classe.cornell.edu', u'acpiEnable': u'true', u'emulatedMachine': u'pc-i440fx-rhel7.3.0', u'afterMigrationStatus': u'', u'enableGuestEvents': False, u'vmId': u'cf9c5dbf-3924-47c6-b323-22ac90a1f682', u'elapsedTimeOffset': 1321.2906959056854, u'guestDiskMapping': {u'0QEMU_QEMU_HARDDISK_21d18729-279f-435b-9': {u'name': u'/dev/sda'}, u'QEMU_DVD-ROM_QM00003': {u'name': u'/dev/sr0'}}, u'transparentHugePages': u'true', u'timeOffset': u'0', u'cpuType': u'Haswell-noTSX', u'custom': {u'device_9d15a0c8-a122-43b9-89c2-3ad530ebc985': u"VmDevice:{id='VmDeviceId:{deviceId='9d15a0c8-a122-43b9-89c2-3ad530ebc985', vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682'}', device='ide', type='CONTROLLER', bootOrder='0', specParams='[]', address='{slot=0x01, bus=0x00, domain=0x0000, type=pci, function=0x1}', managed='false', pl ug ged='true', readOnly='false', deviceAlias='ide', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}", u'device_9d15a0c8-a122-43b9-89c2-3ad530ebc985device_0bbb6377-22db-4d04-a501-64de81bab622device_758565a5-4378-4412-8ec1-2df7bb231c14device_7ead63f7-b119-434d-a2f7-081fd06229e4': u"VmDevice:{id='VmDeviceId:{deviceId='7ead63f7-b119-434d-a2f7-081fd06229e4', vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682'}', device='spicevmc', type='CHANNEL', bootOrder='0', specParams='[]', address='{bus=0, controller=0, type=virtio-serial, port=3}', managed='false', plugged='true', readOnly='false', deviceAlias='channel2', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}", u'device_9d15a0c8-a122-43b9-89c2-3ad530ebc985device_0bbb6377-22db-4d04-a501-64de81bab622': u"VmDevice:{id='VmDeviceId:{deviceId='0bbb6377-22db-4d04-a501-64de81bab622', vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682'}', device='unix', type='CHANNEL', bootOrder='0', specPara m s='[]', address='{bus=0, controller=0, type=virtio-serial, port=2}', managed='false', plugged='true', readOnly='false', deviceAlias='channel1', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}", u'device_9d15a0c8-a122-43b9-89c2-3ad530ebc985device_0bbb6377-22db-4d04-a501-64de81bab622device_758565a5-4378-4412-8ec1-2df7bb231c14': u"VmDevice:{id='VmDeviceId:{deviceId='758565a5-4378-4412-8ec1-2df7bb231c14', vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682'}', device='unix', type='CHANNEL', bootOrder='0', specParams='[]', address='{bus=0, controller=0, type=virtio-serial, port=1}', managed='false', plugged='true', readOnly='false', deviceAlias='channel0', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}"}, u'pauseCode': u'NOERR', u'migrationDest': u'libvirt', u'guestNumaNodes': [{u'nodeIndex': 0, u'cpus': u'0', u'memory': u'1024'}], u'display': u'qxl', u'smp': u'1', u'vmType': u'kvm', u'_srcDomXML': u'<domain type=\'kvm\' i d=\'4\'>\n <name>lnx16</name>\n <uuid>cf9c5dbf-3924-47c6-b323-22ac90a1f682</uuid>\n <metadata xmlns:ovirt="http://ovirt.org/vm/tune/1.0">\n <ovirt:qos/>\n </metadata>\n <maxMemory slots=\'16\' unit=\'KiB\'>4194304</maxMemory>\n <memory unit=\'KiB\'>1048576</memory>\n <currentMemory unit=\'KiB\'>1048576</currentMemory>\n <vcpu placement=\'static\' current=\'1\'>16</vcpu>\n <cputune>\n <shares>1020</shares>\n </cputune>\n <resource>\n <partition>/machine</partition>\n </resource>\n <sysinfo type=\'smbios\'>\n <system>\n <entry name=\'manufacturer\'>oVirt</entry>\n <entry name=\'product\'>oVirt Node</entry>\n <entry name=\'version\'>7.3-4.sl7</entry>\n <entry name=\'serial\'>38C15485-D270-11E6-8752-0090FAEDD7C8</entry>\n <entry name=\'uuid\'>cf9c5dbf-3924-47c6-b323-22ac90a1f682</entry>\n </system>\n </sysinfo>\n <os>\n <type arch=\'x86_64\' machine=\'pc-i440fx-rhel7.3.0\'>hvm</type>\n <smbios mode=\'sysinfo\'/>\n </ o s>\n <features>\n <acpi/>\n </features>\n <cpu mode=\'custom\' match=\'exact\'>\n <model fallback=\'allow\'>Haswell-noTSX</model>\n <topology sockets=\'16\' cores=\'1\' threads=\'1\'/>\n <numa>\n <cell id=\'0\' cpus=\'0\' memory=\'1048576\' unit=\'KiB\'/>\n </numa>\n </cpu>\n <clock offset=\'variable\' adjustment=\'0\' basis=\'utc\'>\n <timer name=\'rtc\' tickpolicy=\'catchup\'/>\n <timer name=\'pit\' tickpolicy=\'delay\'/>\n <timer name=\'hpet\' present=\'no\'/>\n </clock>\n <on_poweroff>destroy</on_poweroff>\n <on_reboot>restart</on_reboot>\n <on_crash>destroy</on_crash>\n <devices>\n <emulator>/usr/libexec/qemu-kvm</emulator>\n <disk type=\'file\' device=\'cdrom\'>\n <driver name=\'qemu\' type=\'raw\'/>\n <source startupPolicy=\'optional\'/>\n <backingStore/>\n <target dev=\'hdc\' bus=\'ide\'/>\n <readonly/>\n <alias name=\'ide0-1-0\'/>\n <address type=\'drive\' controller=\'0\' bus=\'1\' tar g et=\'0\' unit=\'0\'/>\n </disk>\n <disk type=\'block\' device=\'disk\' snapshot=\'no\'>\n <driver name=\'qemu\' type=\'raw\' cache=\'none\' error_policy=\'stop\' io=\'native\'/>\n <source dev=\'/rhev/data-center/00000001-0001-0001-0001-000000000311/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794\'/>\n <backingStore/>\n <target dev=\'sda\' bus=\'scsi\'/>\n <serial>21d18729-279f-435b-90ab-a2995f041bc6</serial>\n <boot order=\'1\'/>\n <alias name=\'scsi0-0-0-0\'/>\n <address type=\'drive\' controller=\'0\' bus=\'0\' target=\'0\' unit=\'0\'/>\n </disk>\n <controller type=\'usb\' index=\'0\' model=\'piix3-uhci\'>\n <alias name=\'usb\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x01\' function=\'0x2\'/>\n </controller>\n <controller type=\'scsi\' index=\'0\' model=\'virtio-scsi\'>\n <alias name=\'scsi0\'/>\n <addr e ss type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x04\' function=\'0x0\'/>\n </controller>\n <controller type=\'virtio-serial\' index=\'0\' ports=\'16\'>\n <alias name=\'virtio-serial0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x05\' function=\'0x0\'/>\n </controller>\n <controller type=\'pci\' index=\'0\' model=\'pci-root\'>\n <alias name=\'pci.0\'/>\n </controller>\n <controller type=\'ide\' index=\'0\'>\n <alias name=\'ide\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x01\' function=\'0x1\'/>\n </controller>\n <interface type=\'bridge\'>\n <mac address=\'00:1a:4a:16:01:51\'/>\n <source bridge=\'vdsmbr_QwORbsw2\'/>\n <virtualport type=\'openvswitch\'>\n <parameters interfaceid=\'3a24e764-32c8-4a2e-8dfd-02a776c3bef6\'/>\n </virtualport>\n <target dev=\'vnet0\'/>\n <model type=\'virtio\'/>\n <filterref filter=\'vdsm-no-mac-spoofing\'/> \ n <link state=\'up\'/>\n <alias name=\'net0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x03\' function=\'0x0\'/>\n </interface>\n <channel type=\'unix\'>\n <source mode=\'bind\' path=\'/var/lib/libvirt/qemu/channels/cf9c5dbf-3924-47c6-b323-22ac90a1f682.com.redhat.rhevm.vdsm\'/>\n <target type=\'virtio\' name=\'com.redhat.rhevm.vdsm\' state=\'connected\'/>\n <alias name=\'channel0\'/>\n <address type=\'virtio-serial\' controller=\'0\' bus=\'0\' port=\'1\'/>\n </channel>\n <channel type=\'unix\'>\n <source mode=\'bind\' path=\'/var/lib/libvirt/qemu/channels/cf9c5dbf-3924-47c6-b323-22ac90a1f682.org.qemu.guest_agent.0\'/>\n <target type=\'virtio\' name=\'org.qemu.guest_agent.0\' state=\'connected\'/>\n <alias name=\'channel1\'/>\n <address type=\'virtio-serial\' controller=\'0\' bus=\'0\' port=\'2\'/>\n </channel>\n <channel type=\'spicevmc\'>\n <target type=\'virtio\' name=\'co m .redhat.spice.0\' state=\'connected\'/>\n <alias name=\'channel2\'/>\n <address type=\'virtio-serial\' controller=\'0\' bus=\'0\' port=\'3\'/>\n </channel>\n <input type=\'mouse\' bus=\'ps2\'>\n <alias name=\'input0\'/>\n </input>\n <input type=\'keyboard\' bus=\'ps2\'>\n <alias name=\'input1\'/>\n </input>\n <graphics type=\'spice\' tlsPort=\'5900\' autoport=\'yes\' listen=\'128.84.46.164\' defaultMode=\'secure\' passwdValidTo=\'2017-03-27T14:37:09\'>\n <listen type=\'address\' address=\'128.84.46.164\'/>\n <channel name=\'main\' mode=\'secure\'/>\n <channel name=\'display\' mode=\'secure\'/>\n <channel name=\'inputs\' mode=\'secure\'/>\n <channel name=\'cursor\' mode=\'secure\'/>\n <channel name=\'playback\' mode=\'secure\'/>\n <channel name=\'record\' mode=\'secure\'/>\n <channel name=\'smartcard\' mode=\'secure\'/>\n <channel name=\'usbredir\' mode=\'secure\'/>\n </graphics>\n <vide o
\n <model type=\'qxl\' ram=\'65536\' vram=\'8192\' vgamem=\'16384\' heads=\'1\' primary=\'yes\'/>\n <alias name=\'video0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x02\' function=\'0x0\'/>\n </video>\n <memballoon model=\'virtio\'>\n <alias name=\'balloon0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x06\' function=\'0x0\'/>\n </memballoon>\n <rng model=\'virtio\'>\n <backend model=\'random\'>/dev/urandom</backend>\n <alias name=\'rng0\'/>\n <address type=\'pci\' domain=\'0x0000\' bus=\'0x00\' slot=\'0x07\' function=\'0x0\'/>\n </rng>\n </devices>\n <seclabel type=\'none\' model=\'none\'/>\n <seclabel type=\'dynamic\' model=\'dac\' relabel=\'yes\'>\n <label>+265:+107</label>\n <imagelabel>+265:+107</imagelabel>\n </seclabel>\n</domain>\n', u'memSize': 1024, u'smpCoresPerSocket': u'1', u'vmName': u'lnx16', u'nice': u'0', u'username': u'(unknown)', u'maxMemSize': 40 9 6, u'bootMenuEnable': u'false', u'smpThreadsPerCore': u'1', u'smartcardEnable': u'false', u'clientIp': u'', u'guestAgentAPIVersion': 3, u'kvmEnable': u'true', u'pitReinjection': u'false', u'displayNetwork': u'classepublic', u'devices': [{u'target': 1048576, u'alias': u'balloon0', u'specParams': {u'model': u'virtio'}, u'deviceId': u'ee3ebcbf-08d9-481e-907c-efe32b8ee869', u'address': {u'function': u'0x0', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'slot': u'0x06'}, u'device': u'memballoon', u'type': u'balloon'}, {u'alias': u'rng0', u'specParams': {u'source': u'urandom'}, u'deviceId': u'0c522e52-a4c9-4bd9-a367-7b6fddedc931', u'address': {u'slot': u'0x07', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'virtio', u'model': u'virtio', u'type': u'rng'}, {u'index': u'0', u'alias': u'usb', u'specParams': {}, u'deviceId': u'3d4cbbda-4aa6-424e-95c6-bfae37e466b7', u'address': {u'slot': u'0x01', u'bus': u'0x00', u'domain': u'0x000 0 ', u'type': u'pci', u'function': u'0x2'}, u'device': u'usb', u'model': u'piix3-uhci', u'type': u'controller'}, {u'index': u'0', u'alias': u'scsi0', u'specParams': {}, u'deviceId': u'0db369d1-81d8-4534-8437-105b851670c5', u'address': {u'slot': u'0x04', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'scsi', u'model': u'virtio-scsi', u'type': u'controller'}, {u'alias': u'virtio-serial0', u'specParams': {}, u'deviceId': u'553f9e1c-d811-4cb6-82bc-d567cd8e50bd', u'address': {u'slot': u'0x05', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'virtio-serial', u'type': u'controller'}, {u'alias': u'video0', u'specParams': {u'vram': u'8192', u'vgamem': u'16384', u'heads': u'1', u'ram': u'65536'}, u'deviceId': u'2ece7a34-22ec-49bc-b48c-df4660d13d71', u'address': {u'slot': u'0x02', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'qxl', u'type': u'video'}, {u'devi c e': u'spice', u'specParams': {u'fileTransferEnable': u'true', u'spiceSecureChannels': u'smain,sinputs,scursor,splayback,srecord,sdisplay,ssmartcard,susbredir', u'displayNetwork': u'classepublic', u'displayIp': u'128.84.46.164', u'copyPasteEnable': u'true'}, u'type': u'graphics', u'deviceId': u'a7076b55-ddbb-4932-aca4-c567d9576c54', u'tlsPort': u'5900'}, {u'nicModel': u'pv', u'macAddr': u'00:1a:4a:16:01:51', u'linkActive': True, u'network': u'classepublic', u'alias': u'net0', u'filter': u'vdsm-no-mac-spoofing', u'specParams': {u'inbound': {}, u'outbound': {}}, u'deviceId': u'5110646a-b5d4-4b62-8188-b18cec8c15df', u'address': {u'slot': u'0x03', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x0'}, u'device': u'bridge', u'type': u'interface', u'name': u'vnet0'}, {u'index': u'2', u'iface': u'ide', u'name': u'hdc', u'alias': u'ide0-1-0', u'specParams': {u'path': u''}, u'readonly': u'True', u'deviceId': u'75deba88-b39d-478c-83d3-cc535b43bb28', u'address': { u'bus': u'1', u'controller': u'0', u'type': u'drive', u'target': u'0', u'unit': u'0'}, u'device': u'cdrom', u'shared': u'false', u'path': u'', u'type': u'disk'}, {u'poolID': u'00000001-0001-0001-0001-000000000311', u'volumeInfo': {u'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', u'volType': u'path', u'leaseOffset': 111149056, u'volumeID': u'67b12700-5faf-49b2-af40-6178023b3794', u'leasePath': u'/dev/016ceee8-9117-4e8a-b611-f58f6763a098/leases', u'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6', u'path': u'/rhev/data-center/mnt/blockSD/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794'}, u'index': 0, u'iface': u'scsi', u'apparentsize': u'107374182400', u'alias': u'scsi0-0-0-0', u'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6', u'readonly': u'False', u'shared': u'false', u'truesize': u'107374182400', u'type': u'disk', u'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', u'reqsize': u'0', u'format':
u'raw', u'deviceId': u'21d18729-279f-435b-90ab-a2995f041bc6', u'address': {u'bus': u'0', u'controller': u'0', u'type': u'drive', u'target': u'0', u'unit': u'0'}, u'device': u'disk', u'path': u'/rhev/data-center/00000001-0001-0001-0001-000000000311/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794', u'propagateErrors': u'off', u'optional': u'false', u'name': u'sda', u'bootOrder': u'1', u'volumeID': u'67b12700-5faf-49b2-af40-6178023b3794', u'specParams': {}, u'discard': False, u'volumeChain': [{u'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', u'volType': u'path', u'leaseOffset': 111149056, u'volumeID': u'67b12700-5faf-49b2-af40-6178023b3794', u'leasePath': u'/dev/016ceee8-9117-4e8a-b611-f58f6763a098/leases', u'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6', u'path': u'/rhev/data-center/mnt/blockSD/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40- 6 178023b3794'}]}, {u'device': u'ide', u'alias': u'ide', u'type': u'controller', u'address': {u'slot': u'0x01', u'bus': u'0x00', u'domain': u'0x0000', u'type': u'pci', u'function': u'0x1'}}, {u'device': u'unix', u'alias': u'channel0', u'type': u'channel', u'address': {u'bus': u'0', u'controller': u'0', u'type': u'virtio-serial', u'port': u'1'}}, {u'device': u'unix', u'alias': u'channel1', u'type': u'channel', u'address': {u'bus': u'0', u'controller': u'0', u'type': u'virtio-serial', u'port': u'2'}}, {u'device': u'spicevmc', u'alias': u'channel2', u'type': u'channel', u'address': {u'bus': u'0', u'controller': u'0', u'type': u'virtio-serial', u'port': u'3'}}], u'memGuaranteedSize': 1024, u'status': u'Up', u'maxVCpus': u'16', u'guestIPs': u'128.84.46.16 192.168.122.1', u'statusTime': u'4528256170', u'maxMemSlots': 16}, False) kwargs={} (api:37) 2017-03-27 10:57:02,776-0400 INFO (jsonrpc/4) [vdsm.api] FINISH __init__ return=None (api:43) 2017-03-27 10:57:02,777-0400 INFO (vm/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') VM wrapper has started (vm:1915) 2017-03-27 10:57:02,778-0400 INFO (vm/cf9c5dbf) [dispatcher] Run and protect: getVolumeSize(sdUUID=u'016ceee8-9117-4e8a-b611-f58f6763a098', spUUID=u'00000001-0001-0001-0001-000000000311', imgUUID=u'21d18729-279f-435b-90ab-a2995f041bc6', volUUID=u'67b12700-5faf-49b2-af40-6178023b3794', options=None) (logUtils:51) 2017-03-27 10:57:02,809-0400 INFO (vm/cf9c5dbf) [dispatcher] Run and protect: getVolumeSize, Return response: {'truesize': '107374182400', 'apparentsize': '107374182400'} (logUtils:54) 2017-03-27 10:57:02,809-0400 INFO (vm/cf9c5dbf) [vds] prepared volume path: (clientIF:374) 2017-03-27 10:57:02,810-0400 INFO (vm/cf9c5dbf) [dispatcher] Run and protect: prepareImage(sdUUID=u'016ceee8-9117-4e8a-b611-f58f6763a098', spUUID=u'00000001-0001-0001-0001-000000000311', imgUUID=u'21d18729-279f-435b-90ab-a2995f041bc6', leafUUID=u'67b12700-5faf-49b2-af40-6178023b3794', allowIllegal=False) (logUtils:51) 2017-03-27 10:57:02,859-0400 INFO (vm/cf9c5dbf) [storage.LVM] Activating lvs: vg=016ceee8-9117-4e8a-b611-f58f6763a098 lvs=['67b12700-5faf-49b2-af40-6178023b3794'] (lvm:1289) 2017-03-27 10:57:02,947-0400 INFO (vm/cf9c5dbf) [storage.LVM] Refreshing lvs: vg=016ceee8-9117-4e8a-b611-f58f6763a098 lvs=['leases'] (lvm:1285) 2017-03-27 10:57:02,998-0400 INFO (vm/cf9c5dbf) [dispatcher] Run and protect: prepareImage, Return response: {'info': {'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', 'volType': 'path', 'leaseOffset': 111149056, 'path': u'/rhev/data-center/mnt/blockSD/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794', 'volumeID': '67b12700-5faf-49b2-af40-6178023b3794', 'leasePath': '/dev/016ceee8-9117-4e8a-b611-f58f6763a098/leases', 'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6'}, 'path': u'/rhev/data-center/00000001-0001-0001-0001-000000000311/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794', 'imgVolumesInfo': [{'domainID': u'016ceee8-9117-4e8a-b611-f58f6763a098', 'volType': 'path', 'leaseOffset': 111149056, 'path': u'/rhev/data-center/mnt/blockSD/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49 b2 -af40-6178023b3794', 'volumeID': '67b12700-5faf-49b2-af40-6178023b3794', 'leasePath': '/dev/016ceee8-9117-4e8a-b611-f58f6763a098/leases', 'imageID': u'21d18729-279f-435b-90ab-a2995f041bc6'}]} (logUtils:54) 2017-03-27 10:57:02,998-0400 INFO (vm/cf9c5dbf) [vds] prepared volume path: /rhev/data-center/00000001-0001-0001-0001-000000000311/016ceee8-9117-4e8a-b611-f58f6763a098/images/21d18729-279f-435b-90ab-a2995f041bc6/67b12700-5faf-49b2-af40-6178023b3794 (clientIF:374) 2017-03-27 10:57:03,026-0400 INFO (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call VM.migrationCreate succeeded in 0.27 seconds (__init__:515) 2017-03-27 10:57:03,225-0400 INFO (jsonrpc/7) [vdsm.api] START destroy args=(<virt.vm.Vm object at 0x4132e50>, 1) kwargs={} (api:37) 2017-03-27 10:57:03,225-0400 INFO (jsonrpc/7) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Release VM resources (vm:4199) 2017-03-27 10:57:03,226-0400 INFO (jsonrpc/7) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Stopping connection (guestagent:430) 2017-03-27 10:57:03,227-0400 INFO (jsonrpc/7) [dispatcher] Run and protect: teardownImage(sdUUID=u'016ceee8-9117-4e8a-b611-f58f6763a098', spUUID=u'00000001-0001-0001-0001-000000000311', imgUUID=u'21d18729-279f-435b-90ab-a2995f041bc6', volUUID=None) (logUtils:51) 2017-03-27 10:57:03,237-0400 INFO (vm/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Changed state to Down: VM destroyed during the startup (code=10) (vm:1207) 2017-03-27 10:57:03,238-0400 INFO (vm/cf9c5dbf) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Stopping connection (guestagent:430) 2017-03-27 10:57:03,260-0400 INFO (jsonrpc/7) [storage.LVM] Deactivating lvs: vg=016ceee8-9117-4e8a-b611-f58f6763a098 lvs=['67b12700-5faf-49b2-af40-6178023b3794'] (lvm:1297) 2017-03-27 10:57:03,311-0400 INFO (jsonrpc/7) [dispatcher] Run and protect: teardownImage, Return response: None (logUtils:54) 2017-03-27 10:57:03,312-0400 INFO (jsonrpc/7) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') Stopping connection (guestagent:430) 2017-03-27 10:57:03,312-0400 WARN (jsonrpc/7) [root] File: /var/lib/libvirt/qemu/channels/cf9c5dbf-3924-47c6-b323-22ac90a1f682.com.redhat.rhevm.vdsm already removed (utils:120) 2017-03-27 10:57:03,312-0400 WARN (jsonrpc/7) [root] File: /var/lib/libvirt/qemu/channels/cf9c5dbf-3924-47c6-b323-22ac90a1f682.org.qemu.guest_agent.0 already removed (utils:120) 2017-03-27 10:57:03,313-0400 WARN (jsonrpc/7) [virt.vm] (vmId='cf9c5dbf-3924-47c6-b323-22ac90a1f682') timestamp already removed from stats cache (vm:1729) 2017-03-27 10:57:03,313-0400 INFO (jsonrpc/7) [dispatcher] Run and protect: inappropriateDevices(thiefId=u'cf9c5dbf-3924-47c6-b323-22ac90a1f682') (logUtils:51) 2017-03-27 10:57:03,314-0400 INFO (jsonrpc/7) [dispatcher] Run and protect: inappropriateDevices, Return response: None (logUtils:54) 2017-03-27 10:57:03,314-0400 INFO (jsonrpc/7) [vdsm.api] FINISH destroy return={'status': {'message': 'Done', 'code': 0}} (api:43) 2017-03-27 10:57:03,315-0400 INFO (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call VM.destroy succeeded in 0.09 seconds (__init__:515) 2017-03-27 10:57:03,937-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53024 (protocoldetector:72) 2017-03-27 10:57:03,943-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53024 (protocoldetector:127) 2017-03-27 10:57:03,944-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:03,945-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:04,084-0400 INFO (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:04,086-0400 INFO (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call VM.getStats failed (error 1) in 0.00 seconds (__init__:515) 2017-03-27 10:57:04,767-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53026 (protocoldetector:72) 2017-03-27 10:57:04,772-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53026 (protocoldetector:127) 2017-03-27 10:57:04,773-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:04,774-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:04,913-0400 INFO (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:05,126-0400 INFO (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getCapabilities succeeded in 0.22 seconds (__init__:515) 2017-03-27 10:57:06,040-0400 INFO (periodic/0) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:06,040-0400 INFO (periodic/0) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000426872', 'lastCheck': '4.6', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000387272', 'lastCheck': '4.5', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000353399', 'lastCheck': '0.5', 'valid': True}} (logUtils:54) 2017-03-27 10:57:08,170-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53028 (protocoldetector:72) 2017-03-27 10:57:08,176-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53028 (protocoldetector:127) 2017-03-27 10:57:08,176-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:08,177-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:08,321-0400 INFO (jsonrpc/6) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:08,322-0400 INFO (jsonrpc/6) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000426872', 'lastCheck': '2.1', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000387272', 'lastCheck': '1.2', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000353399', 'lastCheck': '2.8', 'valid': True}} (logUtils:54) 2017-03-27 10:57:08,324-0400 INFO (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:08,327-0400 INFO (jsonrpc/4) [dispatcher] Run and protect: repoStats(options=None) (logUtils:51) 2017-03-27 10:57:08,328-0400 INFO (jsonrpc/4) [dispatcher] Run and protect: repoStats, Return response: {u'016ceee8-9117-4e8a-b611-f58f6763a098': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000426872', 'lastCheck': '2.1', 'valid': True}, u'2438f819-e7f5-4bb1-ad0d-5349fa371e6e': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.000387272', 'lastCheck': '1.2', 'valid': True}, u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.000353399', 'lastCheck': '2.8', 'valid': True}} (logUtils:54) 2017-03-27 10:57:08,619-0400 INFO (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.29 seconds (__init__:515) 2017-03-27 10:57:08,625-0400 INFO (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.30 seconds (__init__:515) 2017-03-27 10:57:08,848-0400 INFO (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:09,370-0400 INFO (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:10,927-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53030 (protocoldetector:72) 2017-03-27 10:57:10,932-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53030 (protocoldetector:127) 2017-03-27 10:57:10,932-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:10,933-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:11,077-0400 INFO (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:11,080-0400 INFO (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call VM.getStats failed (error 1) in 0.00 seconds (__init__:515) 2017-03-27 10:57:13,802-0400 INFO (Reactor thread) [ProtocolDetector.AcceptorImpl] Accepted connection from ::1:53034 (protocoldetector:72) 2017-03-27 10:57:13,808-0400 INFO (Reactor thread) [ProtocolDetector.Detector] Detected protocol stomp from ::1:53034 (protocoldetector:127) 2017-03-27 10:57:13,809-0400 INFO (Reactor thread) [Broker.StompAdapter] Processing CONNECT request (stompreactor:102) 2017-03-27 10:57:13,810-0400 INFO (JsonRpc (StompReactor)) [Broker.StompAdapter] Subscribe command received (stompreactor:129) 2017-03-27 10:57:14,015-0400 INFO (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getHardwareInfo succeeded in 0.00 seconds (__init__:515) 2017-03-27 10:57:14,019-0400 INFO (jsonrpc/5) [dispatcher] Run and protect: getImagesList(sdUUID=u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a', options=None) (logUtils:51) 2017-03-27 10:57:14,050-0400 INFO (jsonrpc/5) [dispatcher] Run and protect: getImagesList, Return response: {'imageslist': ['a1d7f855-40d4-4f07-bf25-625284682b40', 'c61297c5-367b-4c98-a44b-de0318848a24', 'c2fc0c7c-596e-4011-8471-7f67408ea633', 'b2bb3396-a8fb-4ed7-89c7-4cc7d22aa26a', '6d594f05-c2c2-4ef0-849f-28da46b8f87e', '5fc548e6-51a8-44ee-a14b-92e0e924d7b8']} (logUtils:54) 2017-03-27 10:57:14,051-0400 INFO (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call StorageDomain.getImages succeeded in 0.03 seconds (__init__:515) 2017-03-27 10:57:14,083-0400 INFO (jsonrpc/4) [dispatcher] Run and protect: getVolumesList(sdUUID=u'48d4f45d-0bdd-4f4a-90b6-35efe2da935a', spUUID=u'00000000-0000-0000-0000-000000000000', imgUUID=u'a1d7f855-40d4-4f07-bf25-625284682b40', options=None) (logUtils:51) ... _______________________________________________ Users mailing list Users@ovirt.org http://lists.ovirt.org/mailman/listinfo/users
_______________________________________________ Users mailing list Users@ovirt.org http://lists.ovirt.org/mailman/listinfo/users
participants (2)
-
Dan Kenigsberg -
Devin A. Bougie