in engine.log

2017-03-21 10:37:26,209+01 INFO  [org.ovirt.engine.core.bll.MigrateVmToServerCommand] (default task-26) [f0cea507-608b-4f36-ac4e-606faec35cd9] Lock Acquired to object 'EngineLock:{exclusiveLocks='[2e571c77-bae1-4c1c-bf98-effaf9fed741=<VM, ACTION_TYPE_FAILED_VM_IS_BEING_MIGRATED$VmName c7service>]', sharedLocks='null'}'

2017-03-21 10:37:26,499+01 INFO  [org.ovirt.engine.core.bll.MigrateVmToServerCommand] (org.ovirt.thread.pool-6-thread-43) [f0cea507-608b-4f36-ac4e-606faec35cd9] Running command: MigrateVmToServerCommand internal: false. Entities affected :  ID: 2e571c77-bae1-4c1c-bf98-effaf9fed741 Type: VMAction group MIGRATE_VM with role type USER

2017-03-21 10:37:26,786+01 INFO  [org.ovirt.engine.core.vdsbroker.MigrateVDSCommand] (org.ovirt.thread.pool-6-thread-43) [f0cea507-608b-4f36-ac4e-606faec35cd9] START, MigrateVDSCommand( MigrateVDSCommandParameters:{runAsync='true', hostId='30677d2c-4eb8-4ed9-ba54-0b89945a45fd', vmId='2e571c77-bae1-4c1c-bf98-effaf9fed741', srcHost='ovmsrv07.mydomain', dstVdsId='02bb501a-b641-4ee1-bab1-5e640804e65f', dstHost='ovmsrv05.mydomain:54321', migrationMethod='ONLINE', tunnelMigration='false', migrationDowntime='0', autoConverge='true', migrateCompressed='false', consoleAddress='null', maxBandwidth='null', enableGuestEvents='true', maxIncomingMigrations='2', maxOutgoingMigrations='2', convergenceSchedule='[init=[{name=setDowntime, params=[100]}], stalling=[{limit=1, action={name=setDowntime, params=[150]}}, {limit=2, action={name=setDowntime, params=[200]}}, {limit=3, action={name=setDowntime, params=[300]}}, {limit=4, action={name=setDowntime, params=[400]}}, {limit=6, action={name=setDowntime, params=[500]}}, {limit=-1, action={name=abort, params=[]}}]]'}), log id: 14390155

2017-03-21 10:37:26,787+01 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.MigrateBrokerVDSCommand] (org.ovirt.thread.pool-6-thread-43) [f0cea507-608b-4f36-ac4e-606faec35cd9] START, MigrateBrokerVDSCommand(HostName = ovmsrv07, MigrateVDSCommandParameters:{runAsync='true', hostId='30677d2c-4eb8-4ed9-ba54-0b89945a45fd', vmId='2e571c77-bae1-4c1c-bf98-effaf9fed741', srcHost='ovmsrv07.mydomain', dstVdsId='02bb501a-b641-4ee1-bab1-5e640804e65f', dstHost='ovmsrv05.mydomain:54321', migrationMethod='ONLINE', tunnelMigration='false', migrationDowntime='0', autoConverge='true', migrateCompressed='false', consoleAddress='null', maxBandwidth='null', enableGuestEvents='true', maxIncomingMigrations='2', maxOutgoingMigrations='2', convergenceSchedule='[init=[{name=setDowntime, params=[100]}], stalling=[{limit=1, action={name=setDowntime, params=[150]}}, {limit=2, action={name=setDowntime, params=[200]}}, {limit=3, action={name=setDowntime, params=[300]}}, {limit=4, action={name=setDowntime, params=[400]}}, {limit=6, action={name=setDowntime, params=[500]}}, {limit=-1, action={name=abort, params=[]}}]]'}), log id: 5fd9f196

2017-03-21 10:37:27,386+01 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.MigrateBrokerVDSCommand] (org.ovirt.thread.pool-6-thread-43) [f0cea507-608b-4f36-ac4e-606faec35cd9] FINISH, MigrateBrokerVDSCommand, log id: 5fd9f196

2017-03-21 10:37:27,445+01 INFO  [org.ovirt.engine.core.vdsbroker.MigrateVDSCommand] (org.ovirt.thread.pool-6-thread-43) [f0cea507-608b-4f36-ac4e-606faec35cd9] FINISH, MigrateVDSCommand, return: MigratingFrom, log id: 14390155

2017-03-21 10:37:27,475+01 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-6-thread-43) [f0cea507-608b-4f36-ac4e-606faec35cd9] EVENT_ID: VM_MIGRATION_START(62), Correlation ID: f0cea507-608b-4f36-ac4e-606faec35cd9, Job ID: 514c0562-de81-44a1-bde3-58027662b536, Call Stack: null, Custom Event ID: -1, Message: Migration started (VM: c7service, Source: ovmsrv07, Destination: ovmsrv05, User: g.cecchi@internal-authz). 

2017-03-21 10:37:30,341+01 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVDSCommand] (DefaultQuartzScheduler4) [53ea57f2] START, FullListVDSCommand(HostName = ovmsrv07, FullListVDSCommandParameters:{runAsync='true', hostId='30677d2c-4eb8-4ed9-ba54-0b89945a45fd', vmIds='[2e571c77-bae1-4c1c-bf98-effaf9fed741]'}), log id: 46e85505

2017-03-21 10:37:30,526+01 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVDSCommand] (DefaultQuartzScheduler4) [53ea57f2] FINISH, FullListVDSCommand, return: [{acpiEnable=true, emulatedMachine=pc-i440fx-rhel7.3.0, vmId=2e571c77-bae1-4c1c-bf98-effaf9fed741, guestDiskMapping={0QEMU_QEMU_HARDDISK_6af3dfe5-6da7-48e3-9={name=/dev/sda}, QEMU_DVD-ROM_QM00003={name=/dev/sr0}}, transparentHugePages=true, timeOffset=0, cpuType=Opteron_G2, smp=1, pauseCode=NOERR, guestNumaNodes=[Ljava.lang.Object;@31e4f47d, smartcardEnable=false, custom={device_39acb1f5-c31e-4810-a4c3-26d460a6e374=VmDevice:{id='VmDeviceId:{deviceId='39acb1f5-c31e-4810-a4c3-26d460a6e374', vmId='2e571c77-bae1-4c1c-bf98-effaf9fed741'}', 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'}, device_39acb1f5-c31e-4810-a4c3-26d460a6e374device_c45a9213-8f12-46c7-b749-27a4fcb02c67=VmDevice:{id='VmDeviceId:{deviceId='c45a9213-8f12-46c7-b749-27a4fcb02c67', vmId='2e571c77-bae1-4c1c-bf98-effaf9fed741'}', device='unix', type='CHANNEL', bootOrder='0', specParams='[]', address='{bus=0, controller=0, type=virtio-serial, port=1}', managed='false', plugged='true', readOnly='false', deviceAlias='channel0', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}, device_39acb1f5-c31e-4810-a4c3-26d460a6e374device_c45a9213-8f12-46c7-b749-27a4fcb02c67device_22513430-5212-4d6a-a413-4c42a216dc9ddevice_f22e3921-5426-403e-9dab-eaf23b0c628e=VmDevice:{id='VmDeviceId:{deviceId='f22e3921-5426-403e-9dab-eaf23b0c628e', vmId='2e571c77-bae1-4c1c-bf98-effaf9fed741'}', 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'}, device_39acb1f5-c31e-4810-a4c3-26d460a6e374device_c45a9213-8f12-46c7-b749-27a4fcb02c67device_22513430-5212-4d6a-a413-4c42a216dc9d=VmDevice:{id='VmDeviceId:{deviceId='22513430-5212-4d6a-a413-4c42a216dc9d', vmId='2e571c77-bae1-4c1c-bf98-effaf9fed741'}', 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'}}, vmType=kvm, memSize=4096, smpCoresPerSocket=1, vmName=c7service, nice=0, status=Migration Source, maxMemSize=16384, bootMenuEnable=false, pid=4504, smpThreadsPerCore=1, memGuaranteedSize=2048, kvmEnable=true, pitReinjection=false, displayNetwork=ovirtmgmt, devices=[Ljava.lang.Object;@3f3610df, display=qxl, maxVCpus=16, clientIp=, statusTime=4533149590, maxMemSlots=16}], log id: 46e85505

2017-03-21 10:37:30,536+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmDevicesMonitoring] (DefaultQuartzScheduler4) [53ea57f2] Received a console Device without an address when processing VM 2e571c77-bae1-4c1c-bf98-effaf9fed741 devices, skipping device: {device=console, specParams={consoleType=serial, enableSocket=true}, type=console, deviceId=dcfbd20d-65f4-47d3-ac7f-5c2cc60e561f, alias=serial0}

2017-03-21 10:37:30,536+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmDevicesMonitoring] (DefaultQuartzScheduler4) [53ea57f2] Received a spice Device without an address when processing VM 2e571c77-bae1-4c1c-bf98-effaf9fed741 devices, skipping device: {device=spice, specParams={fileTransferEnable=true, displayNetwork=ovirtmgmt, copyPasteEnable=true, displayIp=10.4.168.76, spiceSecureChannels=smain,sinputs,scursor,splayback,srecord,sdisplay,ssmartcard,susbredir}, type=graphics, deviceId=5cf3ed21-1471-44d0-81d8-653044fdf51f, tlsPort=5900}

2017-03-21 10:37:30,537+01 ERROR [org.ovirt.engine.core.vdsbroker.monitoring.VmDevicesMonitoring] (DefaultQuartzScheduler4) [53ea57f2] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741' managed non pluggable device was removed unexpectedly from libvirt: 'VmDevice:{id='VmDeviceId:{deviceId='dcfbd20d-65f4-47d3-ac7f-5c2cc60e561f', vmId='2e571c77-bae1-4c1c-bf98-effaf9fed741'}', device='console', type='CONSOLE', bootOrder='0', specParams='[enableSocket=true, consoleType=serial]', address='', managed='true', plugged='false', readOnly='false', deviceAlias='', customProperties='[]', snapshotId='null', logicalName='null', hostDevice='null'}'

2017-03-21 10:37:40,966+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher] (DefaultQuartzScheduler10) [1949f0c7] Fetched 2 VMs from VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'

2017-03-21 10:37:40,968+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler10) [1949f0c7] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741'(c7service) was unexpectedly detected as 'MigratingTo' on VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) (expected on '30677d2c-4eb8-4ed9-ba54-0b89945a45fd')

2017-03-21 10:37:40,968+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler10) [1949f0c7] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741' is migrating to VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) ignoring it in the refresh until migration is done

2017-03-21 10:37:55,992+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler2) [560703e7] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741'(c7service) was unexpectedly detected as 'MigratingTo' on VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) (expected on '30677d2c-4eb8-4ed9-ba54-0b89945a45fd')

2017-03-21 10:37:55,992+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler2) [560703e7] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741' is migrating to VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) ignoring it in the refresh until migration is done

2017-03-21 10:38:11,018+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler2) [560703e7] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741'(c7service) was unexpectedly detected as 'MigratingTo' on VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) (expected on '30677d2c-4eb8-4ed9-ba54-0b89945a45fd')

2017-03-21 10:38:11,018+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler2) [560703e7] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741' is migrating to VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) ignoring it in the refresh until migration is done

2017-03-21 10:38:26,345+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler7) [707b57d] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741'(c7service) was unexpectedly detected as 'MigratingTo' on VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) (expected on '30677d2c-4eb8-4ed9-ba54-0b89945a45fd')

2017-03-21 10:38:26,345+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler7) [707b57d] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741' is migrating to VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) ignoring it in the refresh until migration is done

2017-03-21 10:38:42,371+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler9) [44770476] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741'(c7service) was unexpectedly detected as 'MigratingTo' on VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) (expected on '30677d2c-4eb8-4ed9-ba54-0b89945a45fd')

2017-03-21 10:38:42,371+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler9) [44770476] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741' is migrating to VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) ignoring it in the refresh until migration is done

2017-03-21 10:38:57,397+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler6) [46677852] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741'(c7service) was unexpectedly detected as 'MigratingTo' on VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) (expected on '30677d2c-4eb8-4ed9-ba54-0b89945a45fd')

2017-03-21 10:38:57,397+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler6) [46677852] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741' is migrating to VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) ignoring it in the refresh until migration is done

2017-03-21 10:39:12,632+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler7) [707b57d] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741'(c7service) was unexpectedly detected as 'MigratingTo' on VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) (expected on '30677d2c-4eb8-4ed9-ba54-0b89945a45fd')

2017-03-21 10:39:12,632+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler7) [707b57d] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741' is migrating to VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) ignoring it in the refresh until migration is done

2017-03-21 10:39:12,849+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (ForkJoinPool-1-worker-1) [] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741' was reported as Down on VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05)

2017-03-21 10:39:12,849+01 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (ForkJoinPool-1-worker-1) [] START, DestroyVDSCommand(HostName = ovmsrv05, DestroyVmVDSCommandParameters:{runAsync='true', hostId='02bb501a-b641-4ee1-bab1-5e640804e65f', vmId='2e571c77-bae1-4c1c-bf98-effaf9fed741', force='false', secondsToWait='0', gracefully='false', reason='', ignoreNoVm='true'}), log id: 6fa6dc7f

2017-03-21 10:39:13,856+01 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (ForkJoinPool-1-worker-1) [] Failed to destroy VM '2e571c77-bae1-4c1c-bf98-effaf9fed741' because VM does not exist, ignoring

2017-03-21 10:39:13,856+01 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (ForkJoinPool-1-worker-1) [] FINISH, DestroyVDSCommand, log id: 6fa6dc7f

2017-03-21 10:39:13,856+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (ForkJoinPool-1-worker-1) [] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741'(c7service) was unexpectedly detected as 'Down' on VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'(ovmsrv05) (expected on '30677d2c-4eb8-4ed9-ba54-0b89945a45fd')

2017-03-21 10:39:22,138+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler7) [707b57d] VM '2e571c77-bae1-4c1c-bf98-effaf9fed741'(c7service) moved from 'MigratingFrom' --> 'Up'

2017-03-21 10:39:22,139+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmAnalyzer] (DefaultQuartzScheduler7) [707b57d] Adding VM '2e571c77-bae1-4c1c-bf98-effaf9fed741'(c7service) to re-run list

2017-03-21 10:39:22,161+01 ERROR [org.ovirt.engine.core.vdsbroker.monitoring.VmsMonitoring] (DefaultQuartzScheduler7) [707b57d] Rerun VM '2e571c77-bae1-4c1c-bf98-effaf9fed741'. Called from VDS 'ovmsrv07'

2017-03-21 10:39:22,273+01 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.MigrateStatusVDSCommand] (org.ovirt.thread.pool-6-thread-36) [707b57d] START, MigrateStatusVDSCommand(HostName = ovmsrv07, MigrateStatusVDSCommandParameters:{runAsync='true', hostId='30677d2c-4eb8-4ed9-ba54-0b89945a45fd', vmId='2e571c77-bae1-4c1c-bf98-effaf9fed741'}), log id: 53f46b57

2017-03-21 10:39:22,577+01 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.MigrateStatusVDSCommand] (org.ovirt.thread.pool-6-thread-36) [707b57d] FINISH, MigrateStatusVDSCommand, log id: 53f46b57

2017-03-21 10:39:22,589+01 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-6-thread-36) [707b57d] EVENT_ID: VM_MIGRATION_TO_SERVER_FAILED(120), Correlation ID: f0cea507-608b-4f36-ac4e-606faec35cd9, Job ID: 514c0562-de81-44a1-bde3-58027662b536, Call Stack: null, Custom Event ID: -1, Message: Migration failed  (VM: c7service, Source: ovmsrv07, Destination: ovmsrv05).

2017-03-21 10:39:22,595+01 INFO  [org.ovirt.engine.core.bll.MigrateVmToServerCommand] (org.ovirt.thread.pool-6-thread-36) [707b57d] Lock freed to object 'EngineLock:{exclusiveLocks='[2e571c77-bae1-4c1c-bf98-effaf9fed741=<VM, ACTION_TYPE_FAILED_VM_IS_BEING_MIGRATED$VmName c7service>]', sharedLocks='null'}'

2017-03-21 10:39:27,658+01 INFO  [org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher] (DefaultQuartzScheduler2) [560703e7] Fetched 1 VMs from VDS '02bb501a-b641-4ee1-bab1-5e640804e65f'

[root@ovmgr1 ovirt-engine-notifier]# 

on target host vdsm.log some of these (perhaps related to retries):

017-03-21 10:37:39,826 INFO  (jsonrpc/4) [dispatcher] Run and protect: repoStats, Return response: {u'5e11aa05-9a40-43d8-b173

-c2294cb0c1be': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00054575', 'lastCheck': '5.0', 'valid'

: True}, u'8846db3f-6e07-4468-bbfc-bf5fbc3f8eef': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.0006

64548', 'lastCheck': '5.0', 'valid': True}, u'5ed04196-87f1-480e-9fee-9dd450a3b53b': {'code': 0, 'actual': True, 'version': 4,

 'acquired': True, 'delay': '0.000413433', 'lastCheck': '7.0', 'valid': True}, u'922b5269-ab56-4c4d-838f-49d33427e2ab': {'code

': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00136826', 'lastCheck': '3.3', 'valid': True}} (logUtils:52)

2017-03-21 10:37:39,839 INFO  (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.02 seconds (__init__:5

15)

2017-03-21 10:37:40,953 ERROR (jsonrpc/2) [jsonrpc.JsonRpcServer] Internal server error (__init__:552)

Traceback (most recent call last):

  File "/usr/lib/python2.7/site-packages/yajsonrpc/__init__.py", line 547, in _handle_request

    res = method(**params)

  File "/usr/lib/python2.7/site-packages/vdsm/rpc/Bridge.py", line 202, in _dynamicMethod

    result = fn(*methodArgs)

  File "/usr/share/vdsm/API.py", line 1410, in getAllVmIoTunePolicies

    io_tune_policies_dict = self._cif.getAllVmIoTunePolicies()

  File "/usr/share/vdsm/clientIF.py", line 447, in getAllVmIoTunePolicies

    vm_io_tune_policies[v.id] = {'policy': v.getIoTunePolicy(),

  File "/usr/share/vdsm/virt/vm.py", line 2730, in getIoTunePolicy

    qos = self._getVmPolicy()

  File "/usr/share/vdsm/virt/vm.py", line 2704, in _getVmPolicy

    metadata_xml = self._dom.metadata(

  File "/usr/lib/python2.7/site-packages/vdsm/virt/virdomain.py", line 47, in __getattr__

    % self.vmid)

NotConnectedError: VM u'2e571c77-bae1-4c1c-bf98-effaf9fed741' was not started yet or was shut down

2017-03-21 10:37:40,954 INFO  (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies failed (error -32603) in 0.00 seconds (__init__:515)

2017-03-21 10:37:40,959 INFO  (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.01 seconds (__init__:515)

2017-03-21 10:38:10,999 ERROR (jsonrpc/4) [jsonrpc.JsonRpcServer] Internal server error (__init__:552)

Traceback (most recent call last):

  File "/usr/lib/python2.7/site-packages/yajsonrpc/__init__.py", line 547, in _handle_request

    res = method(**params)

  File "/usr/lib/python2.7/site-packages/vdsm/rpc/Bridge.py", line 202, in _dynamicMethod

    result = fn(*methodArgs)

  File "/usr/share/vdsm/API.py", line 1410, in getAllVmIoTunePolicies

    io_tune_policies_dict = self._cif.getAllVmIoTunePolicies()

  File "/usr/share/vdsm/clientIF.py", line 447, in getAllVmIoTunePolicies

    vm_io_tune_policies[v.id] = {'policy': v.getIoTunePolicy(),

  File "/usr/share/vdsm/virt/vm.py", line 2730, in getIoTunePolicy

    qos = self._getVmPolicy()

  File "/usr/share/vdsm/virt/vm.py", line 2704, in _getVmPolicy

    metadata_xml = self._dom.metadata(

  File "/usr/lib/python2.7/site-packages/vdsm/virt/virdomain.py", line 47, in __getattr__

    % self.vmid)

NotConnectedError: VM u'2e571c77-bae1-4c1c-bf98-effaf9fed741' was not started yet or was shut down