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
<[email protected]> 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 <[email protected]> 
> 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', p
 l
>  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', specPar
 a
>  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\' ta
 r
>  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      <add
 r
>  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=\'c
 o
>  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    <vid
 e
>  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': 4
 0
>  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'0x00
 0
>  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'dev
 i
>  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-4
 9
>  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
>> [email protected]
>> http://lists.ovirt.org/mailman/listinfo/users
>
> _______________________________________________
> Users mailing list
> [email protected]
> http://lists.ovirt.org/mailman/listinfo/users
_______________________________________________
Users mailing list
[email protected]
http://lists.ovirt.org/mailman/listinfo/users

Reply via email to