I could reproduce customer's problem

Packages:
rhv:4.1.3-0.1.el7
vdsm-4.19.20-1.el7ev.x86_64
virt-v2v-1.36.3-6.el7.x86_64
libguestfs-1.36.3-6.el7.x86_64

Steps:
1.Prepare a guest which is not listed storage pool
# virsh dumpxml avocado-vt-vm1
....
   <disk type='file' device='disk'>
      <driver name='qemu' type='qcow2'/>
      <source file='/root/RHEL-7.3-x86_64-latest.qcow2'/>
      <target dev='vda' bus='virtio'/>
      <address type='pci' domain='0x0000' bus='0x00' slot='0x06' 
function='0x0'/>
    </disk>
.....
2.Try to import this guest in rhv4.1 from KVM host but failed to import the 
guest as screenshot and get error info from vdsm.log
....
2017-07-07 14:41:22,176+0800 ERROR (jsonrpc/6) [root] Error getting disk size 
(v2v:1089)
Traceback (most recent call last):
  File "/usr/lib/python2.7/site-packages/vdsm/v2v.py", line 1078, in 
_get_disk_info
    vol = conn.storageVolLookupByPath(disk['alias'])
  File "/usr/lib64/python2.7/site-packages/libvirt.py", line 4555, in 
storageVolLookupByPath
    if ret is None:raise libvirtError('virStorageVolLookupByPath() failed', 
conn=self)
libvirtError: Storage volume not found: no storage vol with matching path 
'/root/RHEL-7.3-x86_64-latest.qcow2'
....


3.Try to convert this guest to rhv by virt-v2v on v2v conversion server,could 
import the guest from export domain to data domain on rhv4.1 after finishing 
conversion
# virt-v2v avocado-vt-vm1 -o rhv -os 10.73.131.93:/home/nfs_export
[   0.0] Opening the source -i libvirt avocado-vt-vm1
[   0.0] Creating an overlay to protect the source from being modified
[   0.4] Initializing the target -o rhv -os 10.73.131.93:/home/nfs_export
[   0.7] Opening the overlay
[   6.1] Inspecting the overlay
[  13.8] Checking for sufficient free disk space in the guest
[  13.8] Estimating space required on target for each disk
[  13.8] Converting Red Hat Enterprise Linux Server 7.3 (Maipo) to run on KVM
virt-v2v: This guest has virtio drivers installed.
[  52.2] Mapping filesystem data to avoid copying unused and blank areas
[  52.4] Closing the overlay
[  52.7] Checking if the guest needs BIOS or UEFI to boot
[  52.7] Assigning disks to buses
[  52.7] Copying disk 1/1 to 
/tmp/v2v.Zzc4KD/c9cfeba7-73f8-428a-aa77-9a2a1acf0063/images/c8eb039e-3007-4e08-9580-c49da8b73d55/f76d16ea-5e66-4987-a496-8f378b127986
 (qcow2)
    (100.00/100%)
[ 152.4] Creating output metadata
[ 152.6] Finishing off


Result:
So this problem is caused by vdsm or ovirt

Regards
Ming Xie

----- Original Message -----
From: "Richard W.M. Jones" <rjo...@redhat.com>
To: "Matthias Leopold" <matthias.leop...@meduniwien.ac.at>
Cc: users@ovirt.org, libgues...@redhat.com
Sent: Wednesday, July 5, 2017 9:15:16 PM
Subject: Re: [Libguestfs] virt-v2v import from KVM without storage-pool ?

On Wed, Jul 05, 2017 at 11:14:09AM +0200, Matthias Leopold wrote:
> hi,
> 
> i'm trying to import a VM in oVirt from a KVM host that doesn't use
> storage pools. this fails with the following message in
> /var/log/vdsm/vdsm.log:
> 
> 2017-07-05 09:34:20,513+0200 ERROR (jsonrpc/5) [root] Error getting
> disk size (v2v:1089)
> Traceback (most recent call last):
>   File "/usr/lib/python2.7/site-packages/vdsm/v2v.py", line 1078, in
> _get_disk_info
>     vol = conn.storageVolLookupByPath(disk['alias'])
>   File "/usr/lib64/python2.7/site-packages/libvirt.py", line 4770,
> in storageVolLookupByPath
>     if ret is None:raise libvirtError('virStorageVolLookupByPath()
> failed', conn=self)
> libvirtError: Storage volume not found: no storage vol with matching path
> 
> the disks in the origin VM are defined as
> 
>     <disk type='file' device='disk'>
>       <driver name='qemu' type='raw' cache='writethrough'/>
>       <source file='/dev/kvm108/kvm108_img'/>
> 
>     <disk type='file' device='cdrom'>
>       <driver name='qemu' type='raw'/>
>       <source file='/some/path/CentOS-7-x86_64-Minimal-1611.iso'/>
> 
> is this a virt-v2v or oVirt problem?

Well the stack trace is in the oVirt code, so I guess it's an oVirt
problem.  Adding ovirt-users mailing list.

Rich.

-- 
Richard Jones, Virtualization Group, Red Hat http://people.redhat.com/~rjones
Read my programming and virtualization blog: http://rwmj.wordpress.com
virt-df lists disk usage of guests without needing to install any
software inside the virtual machine.  Supports Linux and Windows.
http://people.redhat.com/~rjones/virt-df/

_______________________________________________
Libguestfs mailing list
libgues...@redhat.com
https://www.redhat.com/mailman/listinfo/libguestfs
2017-07-07 14:41:10,345+08 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVmsNamesFromExternalProviderVDSCommand] (default task-8) [f8166d03-f053-4832-8833-aa39142385a5] START, GetVmsNamesFromExternalProviderVDSCommand(HostName = 10.66.144.40, GetVmsFromExternalProviderParameters:{runAsync='true', hostId='5081b809-0779-41ba-9c86-a01049e41ed4', url='qemu+tcp://10.66.4.242/system', username='root', originType='KVM', namesOfVms='null'}), log id: f703286
2017-07-07 14:41:11,412+08 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVmsNamesFromExternalProviderVDSCommand] (default task-8) [f8166d03-f053-4832-8833-aa39142385a5] FINISH, GetVmsNamesFromExternalProviderVDSCommand, return: [VM [rhel7.4-v2v], VM [win10-v2v], VM [avocado-vt-vm1], VM [win2k12-file-virtio], VM [rhel7.4-home], VM [esx6.0-win2012-x86_64], VM [rhel6.9-4disk-lvm], VM [esx6.0-win7-x86_64], VM [Auto-esx6.0-win7-efi], VM [multiple-linux-lvm], VM [win10], VM [rhel6.9], VM [win2008r2-raw-q35], VM [2016], VM [rhel7.4], VM [esx6.0-win8.1-i386], VM [win7-virtio-file], VM [kvm-win2016-x86_64-qcow2], VM [esx6.0-rhel7.4-uefi], VM [rhel7.4-lvm-4disks], VM [rhel6.9-lvms], VM [esx6.0-win2016-x86_64]], log id: f703286
2017-07-07 14:41:22,066+08 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVmsFullInfoFromExternalProviderVDSCommand] (default task-126) [abf96adf-7087-4706-a31e-8cfb0a54e2b5] START, GetVmsFullInfoFromExternalProviderVDSCommand(HostName = 10.66.144.40, GetVmsFromExternalProviderParameters:{runAsync='true', hostId='5081b809-0779-41ba-9c86-a01049e41ed4', url='qemu+tcp://10.66.4.242/system', username='root', originType='KVM', namesOfVms='[avocado-vt-vm1]'}), log id: 47b82b43
2017-07-07 14:41:23,189+08 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVmsFullInfoFromExternalProviderVDSCommand] (default task-126) [abf96adf-7087-4706-a31e-8cfb0a54e2b5] FINISH, GetVmsFullInfoFromExternalProviderVDSCommand, return: [], log id: 47b82b43
2017-07-07 14:41:49,514+08 INFO  [org.ovirt.engine.core.bll.aaa.SessionDataContainer] (DefaultQuartzScheduler1) [5e421b8] Not removing session 'Q5tu9omqATR8fy8oGmt/n2lfUdXcZru+YE7XKN+n707kl1cghnvhG0sIweugJvxgc7t4A9S/WkAtK4q+bu7h3g==', session has running commands for user 'admin@internal-authz'.
2017-07-07 14:41:49,514+08 INFO  [org.ovirt.engine.core.bll.aaa.SessionDataContainer] (DefaultQuartzScheduler1) [5e421b8] Not removing session 'vIBqxQ8+XhLyHT6T8oK7F96hsqHe0JMPHqS5tKFYo3X993XALrl77LGCCXZrCQGfLs3fnU+GRnDYrcuvcwWWrg==', session has running commands for user 'admin@internal-authz'.
2017-07-07 14:42:49,529+08 INFO  [org.ovirt.engine.core.bll.aaa.SessionDataContainer] (DefaultQuartzScheduler2) [53e71b45] Not removing session 'Q5tu9omqATR8fy8oGmt/n2lfUdXcZru+YE7XKN+n707kl1cghnvhG0sIweugJvxgc7t4A9S/WkAtK4q+bu7h3g==', session has running commands for user 'admin@internal-authz'.
2017-07-07 14:42:49,529+08 INFO  [org.ovirt.engine.core.bll.aaa.SessionDataContainer] (DefaultQuartzScheduler2) [53e71b45] Not removing session 'vIBqxQ8+XhLyHT6T8oK7F96hsqHe0JMPHqS5tKFYo3X993XALrl77LGCCXZrCQGfLs3fnU+GRnDYrcuvcwWWrg==', session has running commands for user 'admin@internal-authz'.
2017-07-07 14:43:49,541+08 INFO  [org.ovirt.engine.core.bll.aaa.SessionDataContainer] (DefaultQuartzScheduler10) [3a7ca24a] Not removing session 'Q5tu9omqATR8fy8oGmt/n2lfUdXcZru+YE7XKN+n707kl1cghnvhG0sIweugJvxgc7t4A9S/WkAtK4q+bu7h3g==', session has running commands for user 'admin@internal-authz'.
2017-07-07 14:43:49,541+08 INFO  [org.ovirt.engine.core.bll.aaa.SessionDataContainer] (DefaultQuartzScheduler10) [3a7ca24a] Not removing session 'vIBqxQ8+XhLyHT6T8oK7F96hsqHe0JMPHqS5tKFYo3X993XALrl77LGCCXZrCQGfLs3fnU+GRnDYrcuvcwWWrg==', session has running commands for user 'admin@internal-authz'.
2017-07-07 14:44:49,552+08 INFO  [org.ovirt.engine.core.bll.aaa.SessionDataContainer] (DefaultQuartzScheduler10) [3700896e] Not removing session 'Q5tu9omqATR8fy8oGmt/n2lfUdXcZru+YE7XKN+n707kl1cghnvhG0sIweugJvxgc7t4A9S/WkAtK4q+bu7h3g==', session has running commands for user 'admin@internal-authz'.
2017-07-07 14:44:49,552+08 INFO  [org.ovirt.engine.core.bll.aaa.SessionDataContainer] (DefaultQuartzScheduler10) [3700896e] Not removing session 'vIBqxQ8+XhLyHT6T8oK7F96hsqHe0JMPHqS5tKFYo3X993XALrl77LGCCXZrCQGfLs3fnU+GRnDYrcuvcwWWrg==', session has running commands for user 'admin@internal-authz'.
2017-07-07 14:45:49,563+08 INFO  [org.ovirt.engine.core.bll.aaa.SessionDataContainer] (DefaultQuartzScheduler10) [750fb35b] Not removing session 'Q5tu9omqATR8fy8oGmt/n2lfUdXcZru+YE7XKN+n707kl1cghnvhG0sIweugJvxgc7t4A9S/WkAtK4q+bu7h3g==', session has running commands for user 'admin@internal-authz'.
2017-07-07 14:45:49,563+08 INFO  [org.ovirt.engine.core.bll.aaa.SessionDataContainer] (DefaultQuartzScheduler10) [750fb35b] Not removing session 'vIBqxQ8+XhLyHT6T8oK7F96hsqHe0JMPHqS5tKFYo3X993XALrl77LGCCXZrCQGfLs3fnU+GRnDYrcuvcwWWrg==', session has running commands for user 'admin@internal-authz'.

2017-07-07 14:41:22,176+0800 ERROR (jsonrpc/6) [root] Error getting disk size (v2v:1089)
Traceback (most recent call last):
  File "/usr/lib/python2.7/site-packages/vdsm/v2v.py", line 1078, in _get_disk_info
    vol = conn.storageVolLookupByPath(disk['alias'])
  File "/usr/lib64/python2.7/site-packages/libvirt.py", line 4555, in storageVolLookupByPath
    if ret is None:raise libvirtError('virStorageVolLookupByPath() failed', conn=self)
libvirtError: Storage volume not found: no storage vol with matching path '/root/RHEL-7.3-x86_64-latest.qcow2'
2017-07-07 14:41:22,176+0800 WARN  (jsonrpc/6) [root] Cannot add VM avocado-vt-vm1 due to disk storage error (v2v:1020)
2017-07-07 14:41:22,187+0800 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getExternalVMs succeeded in 0.12 seconds (__init__:539)
2017-07-07 14:41:23,737+0800 INFO  (jsonrpc/1) [vdsm.api] START repoStats(options=None) from=::ffff:10.73.2.1,40262, flow_id=35292c8a (api:46)
2017-07-07 14:41:23,737+0800 INFO  (jsonrpc/1) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00160969', 'lastCheck': '1.8', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00150906', 'lastCheck': '1.7', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.001521', 'lastCheck': '1.7', 'valid': True}} from=::ffff:10.73.2.1,40262, flow_id=35292c8a (api:52)
2017-07-07 14:41:23,744+0800 INFO  (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:41:25,393+0800 INFO  (jsonrpc/4) [vdsm.api] START getSpmStatus(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40262, flow_id=20faf57a (api:46)
2017-07-07 14:41:25,409+0800 INFO  (jsonrpc/4) [vdsm.api] FINISH getSpmStatus return={'spm_st': {'spmId': 1, 'spmStatus': 'SPM', 'spmLver': 3L}} from=::ffff:10.73.2.1,40262, flow_id=20faf57a (api:52)
2017-07-07 14:41:25,410+0800 INFO  (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call StoragePool.getSpmStatus succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:41:26,294+0800 INFO  (periodic/0) [vdsm.api] START repoStats(options=None) from=internal (api:46)
2017-07-07 14:41:26,295+0800 INFO  (periodic/0) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00160969', 'lastCheck': '4.3', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00150906', 'lastCheck': '1.4', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.001521', 'lastCheck': '1.4', 'valid': True}} from=internal (api:52)
2017-07-07 14:41:26,416+0800 INFO  (jsonrpc/7) [vdsm.api] START getStoragePoolInfo(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40272, flow_id=20faf57a (api:46)
2017-07-07 14:41:26,435+0800 INFO  (jsonrpc/7) [vdsm.api] FINISH getStoragePoolInfo return={'info': {'name': 'No Description', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'pool_status': 'connected', 'lver': 3L, 'domains': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd:Active,9cf6b67b-40b7-4532-8806-3746ebf098a6:Active,c9cfeba7-73f8-428a-aa77-9a2a1acf0063:Active', 'master_uuid': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', 'version': '4', 'spm_id': 1, 'type': 'NFS', 'master_ver': 1}, 'dominfo': {u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'status': u'Active', 'diskfree': '1607911604224', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 4}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'status': u'Active', 'diskfree': '1607864418304', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'status': u'Active', 'diskfree': '1607864418304', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}}} from=::ffff:10.73.2.1,40272, flow_id=20faf57a (api:52)
2017-07-07 14:41:26,436+0800 INFO  (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call StoragePool.getInfo succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:41:34,504+0800 INFO  (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:41:34,510+0800 INFO  (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:41:35,358+0800 INFO  (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:41:37,458+0800 INFO  (jsonrpc/0) [vdsm.api] START getSpmStatus(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40262, flow_id=db31d6d (api:46)
2017-07-07 14:41:37,474+0800 INFO  (jsonrpc/0) [vdsm.api] FINISH getSpmStatus return={'spm_st': {'spmId': 1, 'spmStatus': 'SPM', 'spmLver': 3L}} from=::ffff:10.73.2.1,40262, flow_id=db31d6d (api:52)
2017-07-07 14:41:37,475+0800 INFO  (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call StoragePool.getSpmStatus succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:41:38,481+0800 INFO  (jsonrpc/6) [vdsm.api] START getStoragePoolInfo(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40272, flow_id=db31d6d (api:46)
2017-07-07 14:41:38,498+0800 INFO  (jsonrpc/6) [vdsm.api] FINISH getStoragePoolInfo return={'info': {'name': 'No Description', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'pool_status': 'connected', 'lver': 3L, 'domains': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd:Active,9cf6b67b-40b7-4532-8806-3746ebf098a6:Active,c9cfeba7-73f8-428a-aa77-9a2a1acf0063:Active', 'master_uuid': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', 'version': '4', 'spm_id': 1, 'type': 'NFS', 'master_ver': 1}, 'dominfo': {u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'status': u'Active', 'diskfree': '1607793115136', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 4}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'status': u'Active', 'diskfree': '1607764803584', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'status': u'Active', 'diskfree': '1607764803584', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}}} from=::ffff:10.73.2.1,40272, flow_id=db31d6d (api:52)
2017-07-07 14:41:38,498+0800 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call StoragePool.getInfo succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:41:39,774+0800 INFO  (jsonrpc/1) [vdsm.api] START repoStats(options=None) from=::ffff:10.73.2.1,40262, flow_id=2314c052 (api:46)
2017-07-07 14:41:39,774+0800 INFO  (jsonrpc/1) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00156224', 'lastCheck': '7.8', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00161377', 'lastCheck': '4.9', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00167577', 'lastCheck': '4.9', 'valid': True}} from=::ffff:10.73.2.1,40262, flow_id=2314c052 (api:52)
2017-07-07 14:41:39,783+0800 INFO  (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:41:41,309+0800 INFO  (periodic/0) [vdsm.api] START repoStats(options=None) from=internal (api:46)
2017-07-07 14:41:41,310+0800 INFO  (periodic/0) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00156224', 'lastCheck': '0.3', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00161377', 'lastCheck': '6.4', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00167577', 'lastCheck': '6.4', 'valid': True}} from=internal (api:52)
2017-07-07 14:41:49,506+0800 INFO  (jsonrpc/4) [vdsm.api] START getSpmStatus(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40262, flow_id=6e6c66db (api:46)
2017-07-07 14:41:49,519+0800 INFO  (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:41:49,522+0800 INFO  (jsonrpc/4) [vdsm.api] FINISH getSpmStatus return={'spm_st': {'spmId': 1, 'spmStatus': 'SPM', 'spmLver': 3L}} from=::ffff:10.73.2.1,40262, flow_id=6e6c66db (api:52)
2017-07-07 14:41:49,523+0800 INFO  (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call StoragePool.getSpmStatus succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:41:49,524+0800 INFO  (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:41:50,567+0800 INFO  (jsonrpc/2) [vdsm.api] START getStoragePoolInfo(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40272, flow_id=6e6c66db (api:46)
2017-07-07 14:41:50,584+0800 INFO  (jsonrpc/2) [vdsm.api] FINISH getStoragePoolInfo return={'info': {'name': 'No Description', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'pool_status': 'connected', 'lver': 3L, 'domains': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd:Active,9cf6b67b-40b7-4532-8806-3746ebf098a6:Active,c9cfeba7-73f8-428a-aa77-9a2a1acf0063:Active', 'master_uuid': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', 'version': '4', 'spm_id': 1, 'type': 'NFS', 'master_ver': 1}, 'dominfo': {u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'status': u'Active', 'diskfree': '1607694548992', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 4}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'status': u'Active', 'diskfree': '1607648411648', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'status': u'Active', 'diskfree': '1607648411648', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}}} from=::ffff:10.73.2.1,40272, flow_id=6e6c66db (api:52)
2017-07-07 14:41:50,584+0800 INFO  (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call StoragePool.getInfo succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:41:51,367+0800 INFO  (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:41:55,804+0800 INFO  (jsonrpc/0) [vdsm.api] START repoStats(options=None) from=::ffff:10.73.2.1,40262, flow_id=6c474f2b (api:46)
2017-07-07 14:41:55,804+0800 INFO  (jsonrpc/0) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00472137', 'lastCheck': '3.8', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.0015652', 'lastCheck': '0.9', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00164507', 'lastCheck': '0.9', 'valid': True}} from=::ffff:10.73.2.1,40262, flow_id=6c474f2b (api:52)
2017-07-07 14:41:55,812+0800 INFO  (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:41:56,315+0800 INFO  (periodic/1) [vdsm.api] START repoStats(options=None) from=internal (api:46)
2017-07-07 14:41:56,315+0800 INFO  (periodic/1) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00472137', 'lastCheck': '4.3', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.0015652', 'lastCheck': '1.4', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00164507', 'lastCheck': '1.4', 'valid': True}} from=internal (api:52)
2017-07-07 14:42:01,373+0800 INFO  (jsonrpc/6) [vdsm.api] START getSpmStatus(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40262, flow_id=74a9f566 (api:46)
2017-07-07 14:42:01,388+0800 INFO  (jsonrpc/6) [vdsm.api] FINISH getSpmStatus return={'spm_st': {'spmId': 1, 'spmStatus': 'SPM', 'spmLver': 3L}} from=::ffff:10.73.2.1,40262, flow_id=74a9f566 (api:52)
2017-07-07 14:42:01,388+0800 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call StoragePool.getSpmStatus succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:42:02,434+0800 INFO  (jsonrpc/1) [vdsm.api] START getStoragePoolInfo(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40272, flow_id=74a9f566 (api:46)
2017-07-07 14:42:02,451+0800 INFO  (jsonrpc/1) [vdsm.api] FINISH getStoragePoolInfo return={'info': {'name': 'No Description', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'pool_status': 'connected', 'lver': 3L, 'domains': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd:Active,9cf6b67b-40b7-4532-8806-3746ebf098a6:Active,c9cfeba7-73f8-428a-aa77-9a2a1acf0063:Active', 'master_uuid': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', 'version': '4', 'spm_id': 1, 'type': 'NFS', 'master_ver': 1}, 'dominfo': {u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'status': u'Active', 'diskfree': '1607459667968', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 4}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'status': u'Active', 'diskfree': '1607530971136', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'status': u'Active', 'diskfree': '1607530971136', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}}} from=::ffff:10.73.2.1,40272, flow_id=74a9f566 (api:52)
2017-07-07 14:42:02,451+0800 INFO  (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call StoragePool.getInfo succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:42:04,541+0800 INFO  (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:42:04,547+0800 INFO  (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:42:05,254+0800 INFO  (periodic/2) [vdsm.api] START getVolumeSize(sdUUID=u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', imgUUID=u'bf954d9f-0be5-4c85-b3b0-5eaccd73ee52', volUUID=u'f8d30077-e1c6-4246-9bf9-2f6a66cee0fb', options=None) from=internal (api:46)
2017-07-07 14:42:05,254+0800 INFO  (periodic/0) [vdsm.api] START getVolumeSize(sdUUID=u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', imgUUID=u'e6ad4a01-d30d-4363-ba1b-ec834812e557', volUUID=u'09c5e6a7-d824-4253-a9bd-8acb761673f9', options=None) from=internal (api:46)
2017-07-07 14:42:05,255+0800 INFO  (periodic/3) [vdsm.api] START getVolumeSize(sdUUID=u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', imgUUID=u'9eb70633-cb44-4ff0-a270-6555e37eff11', volUUID=u'42a5cdc2-51d4-4ff0-a39a-ced7412bbe07', options=None) from=internal (api:46)
2017-07-07 14:42:05,256+0800 INFO  (periodic/2) [vdsm.api] FINISH getVolumeSize return={'truesize': '1040732160', 'apparentsize': '10737418240'} from=internal (api:52)
2017-07-07 14:42:05,257+0800 INFO  (periodic/0) [vdsm.api] FINISH getVolumeSize return={'truesize': '10739335168', 'apparentsize': '10739318784'} from=internal (api:52)
2017-07-07 14:42:05,259+0800 INFO  (periodic/3) [vdsm.api] FINISH getVolumeSize return={'truesize': '3315073024', 'apparentsize': '17179869184'} from=internal (api:52)
2017-07-07 14:42:07,377+0800 INFO  (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:42:11,329+0800 INFO  (periodic/3) [vdsm.api] START repoStats(options=None) from=internal (api:46)
2017-07-07 14:42:11,330+0800 INFO  (periodic/3) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.0015334', 'lastCheck': '0.3', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00150214', 'lastCheck': '6.4', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00151349', 'lastCheck': '6.4', 'valid': True}} from=internal (api:52)
2017-07-07 14:42:11,841+0800 INFO  (jsonrpc/2) [vdsm.api] START repoStats(options=None) from=::ffff:10.73.2.1,40262, flow_id=2fd6dfda (api:46)
2017-07-07 14:42:11,841+0800 INFO  (jsonrpc/2) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.0015334', 'lastCheck': '0.8', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00150214', 'lastCheck': '6.9', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00151349', 'lastCheck': '6.9', 'valid': True}} from=::ffff:10.73.2.1,40262, flow_id=2fd6dfda (api:52)
2017-07-07 14:42:11,848+0800 INFO  (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:42:13,462+0800 INFO  (jsonrpc/3) [vdsm.api] START getSpmStatus(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40262, flow_id=3b67d6b5 (api:46)
2017-07-07 14:42:13,480+0800 INFO  (jsonrpc/3) [vdsm.api] FINISH getSpmStatus return={'spm_st': {'spmId': 1, 'spmStatus': 'SPM', 'spmLver': 3L}} from=::ffff:10.73.2.1,40262, flow_id=3b67d6b5 (api:52)
2017-07-07 14:42:13,480+0800 INFO  (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call StoragePool.getSpmStatus succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:42:14,487+0800 INFO  (jsonrpc/0) [vdsm.api] START getStoragePoolInfo(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40272, flow_id=3b67d6b5 (api:46)
2017-07-07 14:42:14,504+0800 INFO  (jsonrpc/0) [vdsm.api] FINISH getStoragePoolInfo return={'info': {'name': 'No Description', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'pool_status': 'connected', 'lver': 3L, 'domains': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd:Active,9cf6b67b-40b7-4532-8806-3746ebf098a6:Active,c9cfeba7-73f8-428a-aa77-9a2a1acf0063:Active', 'master_uuid': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', 'version': '4', 'spm_id': 1, 'type': 'NFS', 'master_ver': 1}, 'dominfo': {u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 4}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'status': u'Active', 'diskfree': '1607421919232', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'status': u'Active', 'diskfree': '1607421919232', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}}} from=::ffff:10.73.2.1,40272, flow_id=3b67d6b5 (api:52)
2017-07-07 14:42:14,505+0800 INFO  (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call StoragePool.getInfo succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:42:19,565+0800 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:42:19,570+0800 INFO  (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:42:23,399+0800 INFO  (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:42:25,513+0800 INFO  (jsonrpc/4) [vdsm.api] START getSpmStatus(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40262, flow_id=5cccda3e (api:46)
2017-07-07 14:42:25,530+0800 INFO  (jsonrpc/4) [vdsm.api] FINISH getSpmStatus return={'spm_st': {'spmId': 1, 'spmStatus': 'SPM', 'spmLver': 3L}} from=::ffff:10.73.2.1,40262, flow_id=5cccda3e (api:52)
2017-07-07 14:42:25,530+0800 INFO  (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call StoragePool.getSpmStatus succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:42:26,344+0800 INFO  (periodic/1) [vdsm.api] START repoStats(options=None) from=internal (api:46)
2017-07-07 14:42:26,344+0800 INFO  (periodic/1) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00178061', 'lastCheck': '4.4', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00173223', 'lastCheck': '1.4', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00176609', 'lastCheck': '1.4', 'valid': True}} from=internal (api:52)
2017-07-07 14:42:26,537+0800 INFO  (jsonrpc/5) [vdsm.api] START getStoragePoolInfo(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40272, flow_id=5cccda3e (api:46)
2017-07-07 14:42:26,558+0800 INFO  (jsonrpc/5) [vdsm.api] FINISH getStoragePoolInfo return={'info': {'name': 'No Description', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'pool_status': 'connected', 'lver': 3L, 'domains': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd:Active,9cf6b67b-40b7-4532-8806-3746ebf098a6:Active,c9cfeba7-73f8-428a-aa77-9a2a1acf0063:Active', 'master_uuid': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', 'version': '4', 'spm_id': 1, 'type': 'NFS', 'master_ver': 1}, 'dominfo': {u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 4}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}}} from=::ffff:10.73.2.1,40272, flow_id=5cccda3e (api:52)
2017-07-07 14:42:26,558+0800 INFO  (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call StoragePool.getInfo succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:42:27,863+0800 INFO  (jsonrpc/2) [vdsm.api] START repoStats(options=None) from=::ffff:10.73.2.1,40262, flow_id=36af8e6f (api:46)
2017-07-07 14:42:27,863+0800 INFO  (jsonrpc/2) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00178061', 'lastCheck': '5.9', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00173223', 'lastCheck': '3.0', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00176609', 'lastCheck': '2.9', 'valid': True}} from=::ffff:10.73.2.1,40262, flow_id=36af8e6f (api:52)
2017-07-07 14:42:27,870+0800 INFO  (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:42:34,587+0800 INFO  (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:42:34,593+0800 INFO  (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:42:34,913+0800 INFO  (itmap/0) [IOProcessClient] Starting client ioprocess-1187 (__init__:325)
2017-07-07 14:42:34,919+0800 INFO  (ioprocess communication (11995)) [IOProcess] Starting ioprocess (__init__:447)
2017-07-07 14:42:34,919+0800 INFO  (itmap/1) [IOProcessClient] Starting client ioprocess-1188 (__init__:325)
2017-07-07 14:42:34,926+0800 INFO  (itmap/2) [IOProcessClient] Starting client ioprocess-1189 (__init__:325)
2017-07-07 14:42:34,932+0800 INFO  (ioprocess communication (12003)) [IOProcess] Starting ioprocess (__init__:447)
2017-07-07 14:42:34,934+0800 INFO  (itmap/3) [IOProcessClient] Starting client ioprocess-1190 (__init__:325)
2017-07-07 14:42:34,941+0800 INFO  (ioprocess communication (12012)) [IOProcess] Starting ioprocess (__init__:447)
2017-07-07 14:42:34,945+0800 INFO  (ioprocess communication (12020)) [IOProcess] Starting ioprocess (__init__:447)
2017-07-07 14:42:34,972+0800 INFO  (monitor/9cf6b67) [storage.StorageDomain] Resource namespace 01_img_9cf6b67b-40b7-4532-8806-3746ebf098a6 already registered (sd:727)
2017-07-07 14:42:34,972+0800 INFO  (monitor/9cf6b67) [storage.StorageDomain] Resource namespace 02_vol_9cf6b67b-40b7-4532-8806-3746ebf098a6 already registered (sd:736)
2017-07-07 14:42:34,989+0800 INFO  (monitor/c9cfeba) [storage.StorageDomain] Resource namespace 01_img_c9cfeba7-73f8-428a-aa77-9a2a1acf0063 already registered (sd:727)
2017-07-07 14:42:34,989+0800 INFO  (monitor/c9cfeba) [storage.StorageDomain] Resource namespace 02_vol_c9cfeba7-73f8-428a-aa77-9a2a1acf0063 already registered (sd:736)
2017-07-07 14:42:37,566+0800 INFO  (jsonrpc/6) [vdsm.api] START getSpmStatus(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40262, flow_id=2db6a238 (api:46)
2017-07-07 14:42:37,582+0800 INFO  (jsonrpc/6) [vdsm.api] FINISH getSpmStatus return={'spm_st': {'spmId': 1, 'spmStatus': 'SPM', 'spmLver': 3L}} from=::ffff:10.73.2.1,40262, flow_id=2db6a238 (api:52)
2017-07-07 14:42:37,583+0800 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call StoragePool.getSpmStatus succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:42:38,589+0800 INFO  (jsonrpc/1) [vdsm.api] START getStoragePoolInfo(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40272, flow_id=2db6a238 (api:46)
2017-07-07 14:42:38,607+0800 INFO  (jsonrpc/1) [vdsm.api] FINISH getStoragePoolInfo return={'info': {'name': 'No Description', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'pool_status': 'connected', 'lver': 3L, 'domains': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd:Active,9cf6b67b-40b7-4532-8806-3746ebf098a6:Active,c9cfeba7-73f8-428a-aa77-9a2a1acf0063:Active', 'master_uuid': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', 'version': '4', 'spm_id': 1, 'type': 'NFS', 'master_ver': 1}, 'dominfo': {u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 4}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}}} from=::ffff:10.73.2.1,40272, flow_id=2db6a238 (api:52)
2017-07-07 14:42:38,608+0800 INFO  (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call StoragePool.getInfo succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:42:39,409+0800 INFO  (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:42:41,352+0800 INFO  (periodic/1) [vdsm.api] START repoStats(options=None) from=internal (api:46)
2017-07-07 14:42:41,353+0800 INFO  (periodic/1) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00171612', 'lastCheck': '0.3', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00159658', 'lastCheck': '6.4', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00180725', 'lastCheck': '6.4', 'valid': True}} from=internal (api:52)
2017-07-07 14:42:43,886+0800 INFO  (jsonrpc/4) [vdsm.api] START repoStats(options=None) from=::ffff:10.73.2.1,40262, flow_id=52d863ab (api:46)
2017-07-07 14:42:43,886+0800 INFO  (jsonrpc/4) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00175799', 'lastCheck': '1.9', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00166333', 'lastCheck': '1.9', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00164253', 'lastCheck': '1.8', 'valid': True}} from=::ffff:10.73.2.1,40262, flow_id=52d863ab (api:52)
2017-07-07 14:42:43,894+0800 INFO  (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:42:49,416+0800 INFO  (jsonrpc/5) [vdsm.api] START getSpmStatus(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40262, flow_id=31ebd8db (api:46)
2017-07-07 14:42:49,431+0800 INFO  (jsonrpc/5) [vdsm.api] FINISH getSpmStatus return={'spm_st': {'spmId': 1, 'spmStatus': 'SPM', 'spmLver': 3L}} from=::ffff:10.73.2.1,40262, flow_id=31ebd8db (api:52)
2017-07-07 14:42:49,432+0800 INFO  (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call StoragePool.getSpmStatus succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:42:49,610+0800 INFO  (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:42:49,616+0800 INFO  (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:42:50,438+0800 INFO  (jsonrpc/0) [vdsm.api] START getStoragePoolInfo(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40272, flow_id=31ebd8db (api:46)
2017-07-07 14:42:50,456+0800 INFO  (jsonrpc/0) [vdsm.api] FINISH getStoragePoolInfo return={'info': {'name': 'No Description', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'pool_status': 'connected', 'lver': 3L, 'domains': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd:Active,9cf6b67b-40b7-4532-8806-3746ebf098a6:Active,c9cfeba7-73f8-428a-aa77-9a2a1acf0063:Active', 'master_uuid': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', 'version': '4', 'spm_id': 1, 'type': 'NFS', 'master_ver': 1}, 'dominfo': {u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 4}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}}} from=::ffff:10.73.2.1,40272, flow_id=31ebd8db (api:52)
2017-07-07 14:42:50,456+0800 INFO  (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call StoragePool.getInfo succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:42:51,050+0800 INFO  (monitor/370f675) [storage.StorageDomain] Resource namespace 01_img_370f675c-18a3-4830-9f0c-2ed3c8f0f4bd already registered (sd:727)
2017-07-07 14:42:51,050+0800 INFO  (monitor/370f675) [storage.StorageDomain] Resource namespace 02_vol_370f675c-18a3-4830-9f0c-2ed3c8f0f4bd already registered (sd:736)
2017-07-07 14:42:55,418+0800 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:42:56,367+0800 INFO  (periodic/2) [vdsm.api] START repoStats(options=None) from=internal (api:46)
2017-07-07 14:42:56,367+0800 INFO  (periodic/2) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00179868', 'lastCheck': '4.4', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00197415', 'lastCheck': '1.4', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.0016693', 'lastCheck': '1.4', 'valid': True}} from=internal (api:52)
2017-07-07 14:42:59,921+0800 INFO  (jsonrpc/1) [vdsm.api] START repoStats(options=None) from=::ffff:10.73.2.1,40262, flow_id=7d98905 (api:46)
2017-07-07 14:42:59,921+0800 INFO  (jsonrpc/1) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00179868', 'lastCheck': '8.0', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00197415', 'lastCheck': '4.9', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.0016693', 'lastCheck': '4.9', 'valid': True}} from=::ffff:10.73.2.1,40262, flow_id=7d98905 (api:52)
2017-07-07 14:42:59,929+0800 INFO  (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:43:01,468+0800 INFO  (jsonrpc/7) [vdsm.api] START getSpmStatus(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40262, flow_id=7aa1a1b0 (api:46)
2017-07-07 14:43:01,483+0800 INFO  (jsonrpc/7) [vdsm.api] FINISH getSpmStatus return={'spm_st': {'spmId': 1, 'spmStatus': 'SPM', 'spmLver': 3L}} from=::ffff:10.73.2.1,40262, flow_id=7aa1a1b0 (api:52)
2017-07-07 14:43:01,483+0800 INFO  (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call StoragePool.getSpmStatus succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:43:02,490+0800 INFO  (jsonrpc/4) [vdsm.api] START getStoragePoolInfo(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40272, flow_id=7aa1a1b0 (api:46)
2017-07-07 14:43:02,507+0800 INFO  (jsonrpc/4) [vdsm.api] FINISH getStoragePoolInfo return={'info': {'name': 'No Description', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'pool_status': 'connected', 'lver': 3L, 'domains': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd:Active,9cf6b67b-40b7-4532-8806-3746ebf098a6:Active,c9cfeba7-73f8-428a-aa77-9a2a1acf0063:Active', 'master_uuid': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', 'version': '4', 'spm_id': 1, 'type': 'NFS', 'master_ver': 1}, 'dominfo': {u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 4}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}}} from=::ffff:10.73.2.1,40272, flow_id=7aa1a1b0 (api:52)
2017-07-07 14:43:02,508+0800 INFO  (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call StoragePool.getInfo succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:43:04,626+0800 INFO  (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:43:04,632+0800 INFO  (jsonrpc/2) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:43:05,257+0800 INFO  (periodic/3) [vdsm.api] START getVolumeSize(sdUUID=u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', imgUUID=u'bf954d9f-0be5-4c85-b3b0-5eaccd73ee52', volUUID=u'f8d30077-e1c6-4246-9bf9-2f6a66cee0fb', options=None) from=internal (api:46)
2017-07-07 14:43:05,258+0800 INFO  (periodic/1) [vdsm.api] START getVolumeSize(sdUUID=u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', imgUUID=u'e6ad4a01-d30d-4363-ba1b-ec834812e557', volUUID=u'09c5e6a7-d824-4253-a9bd-8acb761673f9', options=None) from=internal (api:46)
2017-07-07 14:43:05,259+0800 INFO  (periodic/0) [vdsm.api] START getVolumeSize(sdUUID=u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', imgUUID=u'9eb70633-cb44-4ff0-a270-6555e37eff11', volUUID=u'42a5cdc2-51d4-4ff0-a39a-ced7412bbe07', options=None) from=internal (api:46)
2017-07-07 14:43:05,260+0800 INFO  (periodic/3) [vdsm.api] FINISH getVolumeSize return={'truesize': '1040732160', 'apparentsize': '10737418240'} from=internal (api:52)
2017-07-07 14:43:05,262+0800 INFO  (periodic/1) [vdsm.api] FINISH getVolumeSize return={'truesize': '10739335168', 'apparentsize': '10739318784'} from=internal (api:52)
2017-07-07 14:43:05,262+0800 INFO  (periodic/0) [vdsm.api] FINISH getVolumeSize return={'truesize': '3315073024', 'apparentsize': '17179869184'} from=internal (api:52)
2017-07-07 14:43:11,373+0800 INFO  (periodic/3) [vdsm.api] START repoStats(options=None) from=internal (api:46)
2017-07-07 14:43:11,373+0800 INFO  (periodic/3) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00198044', 'lastCheck': '0.3', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00164649', 'lastCheck': '6.4', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00205373', 'lastCheck': '6.4', 'valid': True}} from=internal (api:52)
2017-07-07 14:43:11,427+0800 INFO  (jsonrpc/3) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:43:13,516+0800 INFO  (jsonrpc/0) [vdsm.api] START getSpmStatus(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40262, flow_id=1dae5b06 (api:46)
2017-07-07 14:43:13,531+0800 INFO  (jsonrpc/0) [vdsm.api] FINISH getSpmStatus return={'spm_st': {'spmId': 1, 'spmStatus': 'SPM', 'spmLver': 3L}} from=::ffff:10.73.2.1,40262, flow_id=1dae5b06 (api:52)
2017-07-07 14:43:13,532+0800 INFO  (jsonrpc/0) [jsonrpc.JsonRpcServer] RPC call StoragePool.getSpmStatus succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:43:14,538+0800 INFO  (jsonrpc/6) [vdsm.api] START getStoragePoolInfo(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40272, flow_id=1dae5b06 (api:46)
2017-07-07 14:43:14,557+0800 INFO  (jsonrpc/6) [vdsm.api] FINISH getStoragePoolInfo return={'info': {'name': 'No Description', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'pool_status': 'connected', 'lver': 3L, 'domains': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd:Active,9cf6b67b-40b7-4532-8806-3746ebf098a6:Active,c9cfeba7-73f8-428a-aa77-9a2a1acf0063:Active', 'master_uuid': u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd', 'version': '4', 'spm_id': 1, 'type': 'NFS', 'master_ver': 1}, 'dominfo': {u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 4}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': u'/rhev/data-center/mnt/10.73.131.93:_home_nfs__iso/9cf6b67b-40b7-4532-8806-3746ebf098a6/images/11111111-1111-1111-1111-111111111111', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'status': u'Active', 'diskfree': '1607401996288', 'isoprefix': '', 'alerts': [], 'disktotal': '1869014368256', 'version': 0}}} from=::ffff:10.73.2.1,40272, flow_id=1dae5b06 (api:52)
2017-07-07 14:43:14,557+0800 INFO  (jsonrpc/6) [jsonrpc.JsonRpcServer] RPC call StoragePool.getInfo succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:43:15,950+0800 INFO  (jsonrpc/1) [vdsm.api] START repoStats(options=None) from=::ffff:10.73.2.1,40262, flow_id=1b303015 (api:46)
2017-07-07 14:43:15,950+0800 INFO  (jsonrpc/1) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00167013', 'lastCheck': '4.0', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00180837', 'lastCheck': '1.0', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00178121', 'lastCheck': '0.9', 'valid': True}} from=::ffff:10.73.2.1,40262, flow_id=1b303015 (api:52)
2017-07-07 14:43:15,958+0800 INFO  (jsonrpc/1) [jsonrpc.JsonRpcServer] RPC call Host.getStats succeeded in 0.01 seconds (__init__:539)
2017-07-07 14:43:19,646+0800 INFO  (jsonrpc/7) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmStats succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:43:19,652+0800 INFO  (jsonrpc/4) [jsonrpc.JsonRpcServer] RPC call Host.getAllVmIoTunePolicies succeeded in 0.00 seconds (__init__:539)
2017-07-07 14:43:25,565+0800 INFO  (jsonrpc/5) [vdsm.api] START getSpmStatus(spUUID=u'f783f420-a0ab-42cc-9756-21613794b2de', options=None) from=::ffff:10.73.2.1,40262, flow_id=28de462e (api:46)
2017-07-07 14:43:25,580+0800 INFO  (jsonrpc/5) [vdsm.api] FINISH getSpmStatus return={'spm_st': {'spmId': 1, 'spmStatus': 'SPM', 'spmLver': 3L}} from=::ffff:10.73.2.1,40262, flow_id=28de462e (api:52)
2017-07-07 14:43:25,580+0800 INFO  (jsonrpc/5) [jsonrpc.JsonRpcServer] RPC call StoragePool.getSpmStatus succeeded in 0.02 seconds (__init__:539)
2017-07-07 14:43:26,388+0800 INFO  (periodic/2) [vdsm.api] START repoStats(options=None) from=internal (api:46)
2017-07-07 14:43:26,389+0800 INFO  (periodic/2) [vdsm.api] FINISH repoStats return={u'370f675c-18a3-4830-9f0c-2ed3c8f0f4bd': {'code': 0, 'actual': True, 'version': 4, 'acquired': True, 'delay': '0.00176116', 'lastCheck': '4.4', 'valid': True}, u'9cf6b67b-40b7-4532-8806-3746ebf098a6': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.00165258', 'lastCheck': '1.4', 'valid': True}, u'c9cfeba7-73f8-428a-aa77-9a2a1acf0063': {'code': 0, 'actual': True, 'version': 0, 'acquired': True, 'delay': '0.001716', 'lastCheck': '1.4', 'valid': True}} from=internal (api:52)

_______________________________________________
Users mailing list
Users@ovirt.org
http://lists.ovirt.org/mailman/listinfo/users

Reply via email to