--Apple-Mail=_B565CEDD-E856-4748-912B-7B9679AB82CE
Content-Transfer-Encoding: quoted-printable
Content-Type: text/plain;
charset=utf-8
Hi David,
Thanks for your reaction.
I=E2=80=99m using IPv4 addressing.
I upgraded to oVirt 3.6.4.1-1.el7.centos, but that did not solve the =
problem.
When i use the setupnetworks from the Python SDK it looks like the that =
the XML that send to the oVirt engine has the ip address settings but =
they are not send to the host (hypervisor). But the VDSM removes the =
network configuration. After that the communication between the engine =
and the host is gone, obviously.
I include some logs.
--Apple-Mail=_B565CEDD-E856-4748-912B-7B9679AB82CE
Content-Disposition: attachment;
filename=nets.xml
Content-Type: application/xml;
name="nets.xml"
Content-Transfer-Encoding: 7bit
<action>
<host_nics>
<host_nic>
<name>ens1f0</name>
<network>
<name>ovirtmgmt</name>
</network>
<ip netmask="255.255.255.0" gateway="10.149.133.1"
address="10.149.133.27"/>
<boot_protocol>none</boot_protocol>
<check_connectivity>1</check_connectivity>
<status>
<state>up</state>
</status>
<mtu>1500</mtu>
<bridged>false</bridged>
<custom_configuration>false</custom_configuration>
<override_configuration>1</override_configuration>
</host_nic>
<host_nic>
<name>bond0</name>
<ip/>
<bonding>
<options>
<option name="miimon" value="100"/>
<option name="mode" value="4"/>
</options>
<slaves>
<host_nic>
<name>eno1</name>
</host_nic>
<host_nic>
<name>eno2</name>
</host_nic>
</slaves>
</bonding>
<boot_protocol>none</boot_protocol>
<status>
<state>up</state>
</status>
<mtu>1504</mtu>
<bridged>false</bridged>
<override_configuration>1</override_configuration>
</host_nic>
<host_nic>
<name>bond0.602</name>
<network>
<name>VLAN602</name>
</network>
<ip netmask="255.255.255.0" address="10.149.2.27"/>
<boot_protocol>none</boot_protocol>
<status>
<state>up</state>
</status>
<mtu>1500</mtu>
<bridged>true</bridged>
<custom_configuration>false</custom_configuration>
<override_configuration>1</override_configuration>
</host_nic>
</host_nics>
<check_connectivity>0</check_connectivity>
<force>1</force>
</action>
--Apple-Mail=_B565CEDD-E856-4748-912B-7B9679AB82CE
Content-Disposition: attachment;
filename=supervdsm.log
Content-Type: application/octet-stream;
name="supervdsm.log"
Content-Transfer-Encoding: 7bit
MainThread::DEBUG::2016-04-04 15:07:33,248::supervdsmServer::582::SuperVdsm.Server::(main)
Terminated normally
MainThread::DEBUG::2016-04-04 15:07:42,785::supervdsmServer::542::SuperVdsm.Server::(main)
Making sure I'm root - SuperVdsm
MainThread::DEBUG::2016-04-04 15:07:42,785::supervdsmServer::551::SuperVdsm.Server::(main)
Parsing cmd args
MainThread::DEBUG::2016-04-04 15:07:42,785::supervdsmServer::554::SuperVdsm.Server::(main)
Cleaning old socket /var/run/vdsm/svdsm.sock
MainThread::DEBUG::2016-04-04 15:07:42,786::supervdsmServer::558::SuperVdsm.Server::(main)
Setting up keep alive thread
MainThread::DEBUG::2016-04-04 15:07:42,786::supervdsmServer::564::SuperVdsm.Server::(main)
Creating remote object manager
MainThread::DEBUG::2016-04-04 15:07:42,786::fileUtils::192::Storage.fileUtils::(chown)
Changing owner for /var/run/vdsm/svdsm.sock, to (36:36)
MainThread::DEBUG::2016-04-04 15:07:42,786::supervdsmServer::575::SuperVdsm.Server::(main)
Started serving super vdsm object
sourceRoute::DEBUG::2016-04-04
15:07:42,786::sourceroutethread::79::root::(_subscribeToInotifyLoop)
sourceRouteThread.subscribeToInotifyLoop started
restore-net::INFO::2016-04-04 15:07:43,435::vdsm-restore-net-config::384::root::(restore)
networks already restored. doing nothing.
MainProcess|storageRefresh::DEBUG::2016-04-04
15:07:44,718::supervdsmServer::116::SuperVdsm.ServerCallback::(wrapper) call hbaRescan
with () {}
MainProcess|storageRefresh::DEBUG::2016-04-04
15:07:44,718::utils::671::Storage.HBA::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/libexec/vdsm/fc-scan (cwd None)
MainProcess|storageRefresh::DEBUG::2016-04-04
15:07:44,766::supervdsmServer::123::SuperVdsm.ServerCallback::(wrapper) return hbaRescan
with None
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:07:47,399::supervdsmServer::116::SuperVdsm.ServerCallback::(wrapper) call
getHardwareInfo with () {}
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:07:47,436::supervdsmServer::123::SuperVdsm.ServerCallback::(wrapper) return
getHardwareInfo with {'systemProductName': 'SYS-2028TP-HC1TR',
'systemSerialNumber': 'S16549025214470', 'systemFamily': 'To
be filled by O.E.M.', 'systemVersion': '0123456789',
'systemUUID': '00000000-0000-0000-0000-002590FA5BF8',
'systemManufacturer': 'Supermicro'}
MainProcess|jsonrpc.Executor/6::DEBUG::2016-04-04
15:07:47,938::supervdsmServer::116::SuperVdsm.ServerCallback::(wrapper) call
getHardwareInfo with () {}
MainProcess|jsonrpc.Executor/6::DEBUG::2016-04-04
15:07:47,938::supervdsmServer::123::SuperVdsm.ServerCallback::(wrapper) return
getHardwareInfo with {'systemProductName': 'SYS-2028TP-HC1TR',
'systemSerialNumber': 'S16549025214470', 'systemFamily': 'To
be filled by O.E.M.', 'systemVersion': '0123456789',
'systemUUID': '00000000-0000-0000-0000-002590FA5BF8',
'systemManufacturer': 'Supermicro'}
MainProcess|jsonrpc.Executor/1::DEBUG::2016-04-04
15:07:55,501::supervdsmServer::116::SuperVdsm.ServerCallback::(wrapper) call hbaRescan
with () {}
MainProcess|jsonrpc.Executor/1::DEBUG::2016-04-04
15:07:55,502::utils::671::Storage.HBA::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/libexec/vdsm/fc-scan (cwd None)
MainProcess|jsonrpc.Executor/1::DEBUG::2016-04-04
15:07:55,554::supervdsmServer::123::SuperVdsm.ServerCallback::(wrapper) return hbaRescan
with None
MainProcess|jsonrpc.Executor/2::DEBUG::2016-04-04
15:07:55,704::supervdsmServer::116::SuperVdsm.ServerCallback::(wrapper) call hbaRescan
with () {}
MainProcess|jsonrpc.Executor/2::DEBUG::2016-04-04
15:07:55,705::utils::671::Storage.HBA::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/libexec/vdsm/fc-scan (cwd None)
MainProcess|jsonrpc.Executor/2::DEBUG::2016-04-04
15:07:55,751::supervdsmServer::123::SuperVdsm.ServerCallback::(wrapper) return hbaRescan
with None
MainProcess|Thread-14::DEBUG::2016-04-04
15:07:59,614::supervdsmServer::116::SuperVdsm.ServerCallback::(wrapper) call ksmTune with
({'run': 0, 'merge_across_nodes': 1},) {}
MainProcess|Thread-14::DEBUG::2016-04-04
15:07:59,615::supervdsmServer::123::SuperVdsm.ServerCallback::(wrapper) return ksmTune
with None
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,087::supervdsmServer::116::SuperVdsm.ServerCallback::(wrapper) call setupNetworks
with ({u'ovirtmgmt': {u'nic': u'ens1f0', u'mtu':
u'1500', u'bridged': u'false', u'custom': {}},
u'VLAN602': {u'mtu': u'1500', u'bonding':
u'bond0', u'vlan': u'602', u'bridged': u'false',
u'custom': {}}}, {u'bond0': {u'nics': [u'eno1',
u'eno2'], u'options': u'miimon=100 mode=4'}},
{u'connectivityCheck': u'false'}) {}
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,087::api::886::setupNetworks::(setupNetworks) Setting up network according to
configuration: networks:{u'ovirtmgmt': {u'nic': u'ens1f0',
u'mtu': u'1500', u'bridged': u'false', u'custom':
{}}, u'VLAN602': {u'mtu': u'1500', u'bonding':
u'bond0', u'vlan': u'602', u'bridged': u'false',
u'custom': {}}}, bondings:{u'bond0': {u'nics': [u'eno1',
u'eno2'], u'options': u'miimon=100 mode=4'}},
options:{u'connectivityCheck': u'false'}
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,087::api::890::root::(setupNetworks) Validating configuration
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,090::libvirtconnection::161::root::(get) trying to connect libvirt
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,096::netinfo::453::root::(_dhcp_used) There is no VDSM network configured on
ens1f0.
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,097::netinfo::453::root::(_dhcp_used) There is no VDSM network configured on
ens1f0.
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,097::netinfo::453::root::(_dhcp_used) There is no VDSM network configured on
bond0.602.
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,097::netinfo::453::root::(_dhcp_used) There is no VDSM network configured on
bond0.602.
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:02,097::netinfo::495::root::(_getNetInfo) Obtaining info for net bond0.602.
Traceback (most recent call last):
File "/usr/lib/python2.7/site-packages/vdsm/netinfo.py", line 492, in
_getNetInfo
'mtu': str(getMtu(iface))})
File "/usr/lib/python2.7/site-packages/vdsm/netinfo.py", line 191, in getMtu
with open('/sys/class/net/%s/mtu' % iface) as f:
IOError: [Errno 2] No such file or directory: '/sys/class/net/bond0.602/mtu'
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,103::api::900::setupNetworks::(setupNetworks) Applying...
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:02,103::netconfpersistence::62::root::(setNetwork) Adding network
ovirtmgmt({'nic': 'ens1f0', 'dhcpv6': False, 'ipaddr':
'10.149.133.27', 'mtu': '1500', 'netmask':
'255.255.255.0', 'bootproto': 'none', 'bridged': False,
'gateway': '10.149.133.1', 'defaultRoute': False})
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:02,103::netconfpersistence::73::root::(setBonding) Adding bond0({'nics': [],
'options': 'mode=0'})
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,104::api::909::setupNetworks::(setupNetworks) Removing network
u'ovirtmgmt'
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:02,104::api::462::root::(_delNetwork) Removing network ovirtmgmt with vlan=None,
bonding=None, nics=['ens1f0'],keep_bridge=True options={}
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,104::ifcfg::332::root::(_atomicNetworkBackup) Backed up ovirtmgmt
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:02,105::api::495::root::(_delNetwork) Removing network entity ens1f0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,106::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/sbin/ifdown ens1f0 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,392::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> =
0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,393::__init__::144::root::(_removeSourceRoute) Removing source route for device
ens1f0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,393::ifcfg::416::root::(_persistentBackup) backing up rule-ens1f0: # original
file did not exist
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,393::ifcfg::321::root::(writeBackupFile) Persistently backed up
/var/lib/vdsm/netconfback/rule-ens1f0 (until next 'set safe config')
MainProcess|jsonrpc.Executor/4::WARNING::2016-04-04
15:08:02,393::utils::140::root::(rmFile) File: /etc/sysconfig/network-scripts/rule-ens1f0
already removed
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,393::ifcfg::289::root::(_removeFile) Removed file
/etc/sysconfig/network-scripts/rule-ens1f0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,393::ifcfg::416::root::(_persistentBackup) backing up route-ens1f0: # original
file did not exist
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,394::ifcfg::321::root::(writeBackupFile) Persistently backed up
/var/lib/vdsm/netconfback/route-ens1f0 (until next 'set safe config')
MainProcess|jsonrpc.Executor/4::WARNING::2016-04-04
15:08:02,394::utils::140::root::(rmFile) File: /etc/sysconfig/network-scripts/route-ens1f0
already removed
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,394::ifcfg::289::root::(_removeFile) Removed file
/etc/sysconfig/network-scripts/route-ens1f0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,394::ifcfg::379::root::(_atomicBackup) Backed up
/etc/sysconfig/network-scripts/ifcfg-ens1f0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,394::ifcfg::416::root::(_persistentBackup) backing up ifcfg-ens1f0: # Generated
by dracut initrd
DEVICE="ens1f0"
ONBOOT=yes
NETBOOT=yes
UUID="a6e93be4-5fa5-4567-b205-adfd3fa96c45"
IPV6INIT=yes
BOOTPROTO=none
TYPE=Ethernet
NAME="ens1f0"
IPADDR0=10.149.133.27
PREFIX0=24
GATEWAY0=10.149.133.1
DNS1=10.148.125.237
DEFROUTE=yes
IPV4_FAILURE_FATAL=no
IPV6_AUTOCONF=yes
IPV6_DEFROUTE=yes
IPV6_FAILURE_FATAL=no
HWADDR=0C:C4:7A:52:DE:06
IPV6_PEERDNS=yes
IPV6_PEERROUTES=yes
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,394::ifcfg::321::root::(writeBackupFile) Persistently backed up
/var/lib/vdsm/netconfback/ifcfg-ens1f0 (until next 'set safe config')
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,395::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/bin/systemd-run --scope --unit=30a5b69a-1687-4b2b-8cf3-3f7d93e85a43
--slice=vdsm-dhclient /usr/sbin/ifup ens1f0 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,833::utils::689::root::(execCmd) SUCCESS: <err> = 'Running scope as
unit 30a5b69a-1687-4b2b-8cf3-3f7d93e85a43.scope.\n'; <rc> = 0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,834::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39 /usr/sbin/tc
filter del dev ens1f0 pref 5000 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,837::utils::689::root::(execCmd) FAILED: <err> = 'RTNETLINK answers:
Operation not supported\nWe have an error talking to the kernel\n'; <rc> = 2
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,837::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39 /usr/sbin/tc
qdisc show dev ens1f0 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,839::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> =
0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,840::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39 /usr/sbin/tc
class del dev ens1f0 classid 0:1388 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,842::utils::689::root::(execCmd) FAILED: <err> = 'RTNETLINK answers: No
such file or directory\n'; <rc> = 2
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,843::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39 /usr/sbin/tc
class show dev ens1f0 parent 0: (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,845::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> =
0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,845::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39 /usr/sbin/tc
qdisc del dev ens1f0 root (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,848::utils::689::root::(execCmd) FAILED: <err> = 'RTNETLINK answers: No
such file or directory\n'; <rc> = 2
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,848::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39 /usr/sbin/tc
qdisc del dev ens1f0 ingress (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,851::utils::689::root::(execCmd) FAILED: <err> = 'RTNETLINK answers: No
such file or directory\n'; <rc> = 2
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,851::netconfpersistence::69::root::(removeNetwork) Network ovirtmgmt not found
for removal
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,855::api::925::setupNetworks::(setupNetworks) Removing broken network
u'VLAN602'
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,857::netinfo::453::root::(_dhcp_used) There is no VDSM network configured on
bond0.602.
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,857::netinfo::453::root::(_dhcp_used) There is no VDSM network configured on
bond0.602.
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:02,858::netinfo::495::root::(_getNetInfo) Obtaining info for net bond0.602.
Traceback (most recent call last):
File "/usr/lib/python2.7/site-packages/vdsm/netinfo.py", line 492, in
_getNetInfo
'mtu': str(getMtu(iface))})
File "/usr/lib/python2.7/site-packages/vdsm/netinfo.py", line 191, in getMtu
with open('/sys/class/net/%s/mtu' % iface) as f:
IOError: [Errno 2] No such file or directory: '/sys/class/net/bond0.602/mtu'
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,861::netconfpersistence::69::root::(removeNetwork) Network VLAN602 not found for
removal
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,870::api::678::_handleBondings::(_handleBondings) Editing bond Bond(bond0:
[Nic(eno1), Nic(eno2)]) with options mode=4 miimon=100
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:02,871::ifcfg::509::root::(_createConfFile) ifcfg _createConfFile with: conf =
u"BONDING_OPTS='mode=4 miimon=100'\nONBOOT=yes\n", name = bond0, ipv4 =
IPv4(None, None, None, None, None), ipv6 = IPv6(None, None, None, None, None), mtu = None,
kwargs = {'hotplug': 'no'}
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,871::ifcfg::416::root::(_persistentBackup) backing up ifcfg-bond0: # original
file did not exist
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,872::ifcfg::321::root::(writeBackupFile) Persistently backed up
/var/lib/vdsm/netconfback/ifcfg-bond0 (until next 'set safe config')
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,872::ifcfg::487::root::(writeConfFile) Writing to file
/etc/sysconfig/network-scripts/ifcfg-bond0 configuration:
# Generated by VDSM version 4.17.23.2-0.el7.centos
DEVICE=bond0
BONDING_OPTS='mode=4 miimon=100'
ONBOOT=yes
NM_CONTROLLED=no
IPV6INIT=no
HOTPLUG=no
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,877::ifcfg::499::root::(writeConfFile) ignoring restorecon error in case SElinux
is disabled
Traceback (most recent call last):
File "/usr/share/vdsm/network/configurators/ifcfg.py", line 496, in
writeConfFile
selinux.restorecon(fileName.encode('utf-8'))
File "/usr/lib64/python2.7/site-packages/selinux/__init__.py", line 88, in
restorecon
status, oldcontext = lgetfilecon(path)
OSError: [Errno 61] No data available
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:02,878::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/sbin/ifdown eno1 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:03,072::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> =
0
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:03,079::ifcfg::509::root::(_createConfFile) ifcfg _createConfFile with: conf =
u'HWADDR=00:25:90:fa:5b:f8\nMASTER=bond0\nSLAVE=yes\nONBOOT=yes\n', name = eno1,
ipv4 = IPv4(None, None, None, None, None), ipv6 = IPv6(None, None, None, None, None), mtu
= None, kwargs = {}
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:03,079::ifcfg::379::root::(_atomicBackup) Backed up
/etc/sysconfig/network-scripts/ifcfg-eno1
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:03,079::ifcfg::416::root::(_persistentBackup) backing up ifcfg-eno1:
HWADDR=00:25:90:FA:5B:F8
TYPE=Ethernet
BOOTPROTO=dhcp
DEFROUTE=yes
PEERDNS=yes
PEERROUTES=yes
IPV4_FAILURE_FATAL=no
IPV6INIT=yes
IPV6_AUTOCONF=yes
IPV6_DEFROUTE=yes
IPV6_PEERDNS=yes
IPV6_PEERROUTES=yes
IPV6_FAILURE_FATAL=no
NAME=eno1
UUID=ad1e4309-419c-4b94-a75c-ebeacf7c811b
ONBOOT=no
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:03,079::ifcfg::321::root::(writeBackupFile) Persistently backed up
/var/lib/vdsm/netconfback/ifcfg-eno1 (until next 'set safe config')
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:03,079::ifcfg::487::root::(writeConfFile) Writing to file
/etc/sysconfig/network-scripts/ifcfg-eno1 configuration:
# Generated by VDSM version 4.17.23.2-0.el7.centos
DEVICE=eno1
HWADDR=00:25:90:fa:5b:f8
MASTER=bond0
SLAVE=yes
ONBOOT=yes
NM_CONTROLLED=no
IPV6INIT=no
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:03,080::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/bin/systemd-run --scope --unit=83dbadd9-5ebf-4e1e-9997-aed694db18b2
--slice=vdsm-dhclient /usr/sbin/ifup eno1 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:03,548::utils::689::root::(execCmd) SUCCESS: <err> = 'Running scope as
unit 83dbadd9-5ebf-4e1e-9997-aed694db18b2.scope.\n'; <rc> = 0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:03,548::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/sbin/ifdown eno2 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:03,745::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> =
0
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:03,752::ifcfg::509::root::(_createConfFile) ifcfg _createConfFile with: conf =
u'HWADDR=00:25:90:fa:5b:f9\nMASTER=bond0\nSLAVE=yes\nONBOOT=yes\n', name = eno2,
ipv4 = IPv4(None, None, None, None, None), ipv6 = IPv6(None, None, None, None, None), mtu
= None, kwargs = {}
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:03,752::ifcfg::379::root::(_atomicBackup) Backed up
/etc/sysconfig/network-scripts/ifcfg-eno2
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:03,752::ifcfg::416::root::(_persistentBackup) backing up ifcfg-eno2:
HWADDR=00:25:90:FA:5B:F9
TYPE=Ethernet
BOOTPROTO=dhcp
DEFROUTE=yes
PEERDNS=yes
PEERROUTES=yes
IPV4_FAILURE_FATAL=no
IPV6INIT=yes
IPV6_AUTOCONF=yes
IPV6_DEFROUTE=yes
IPV6_PEERDNS=yes
IPV6_PEERROUTES=yes
IPV6_FAILURE_FATAL=no
NAME=eno2
UUID=9d958f30-d3c9-42a5-96f9-6362268ce048
ONBOOT=no
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:03,752::ifcfg::321::root::(writeBackupFile) Persistently backed up
/var/lib/vdsm/netconfback/ifcfg-eno2 (until next 'set safe config')
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:03,752::ifcfg::487::root::(writeConfFile) Writing to file
/etc/sysconfig/network-scripts/ifcfg-eno2 configuration:
# Generated by VDSM version 4.17.23.2-0.el7.centos
DEVICE=eno2
HWADDR=00:25:90:fa:5b:f9
MASTER=bond0
SLAVE=yes
ONBOOT=yes
NM_CONTROLLED=no
IPV6INIT=no
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:03,753::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/bin/systemd-run --scope --unit=8043d910-ee54-4af2-81e7-9a0a9e4fc6e0
--slice=vdsm-dhclient /usr/sbin/ifup eno2 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:04,220::utils::689::root::(execCmd) SUCCESS: <err> = 'Running scope as
unit 8043d910-ee54-4af2-81e7-9a0a9e4fc6e0.scope.\n'; <rc> = 0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:04,221::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/sbin/ifdown bond0 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:05,741::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> =
0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:05,742::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/bin/systemd-run --scope --unit=3d37b14a-8341-4188-8015-1ed1cfd4a29a
--slice=vdsm-dhclient /usr/sbin/ifup bond0 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:06,978::utils::689::root::(execCmd) SUCCESS: <err> = 'Running scope as
unit 3d37b14a-8341-4188-8015-1ed1cfd4a29a.scope.\n'; <rc> = 0
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:06,979::netconfpersistence::73::root::(setBonding) Adding bond0({'nics':
[u'eno1', u'eno2'], 'options': u'mode=4 miimon=100'})
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:06,984::api::765::setupNetworks::(_add_missing_networks) Adding network
u'ovirtmgmt'
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:06,984::api::281::root::(_addNetwork) validating network...
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:06,984::api::301::root::(_addNetwork) Adding network ovirtmgmt with vlan=None,
bonding=None, nics=[u'ens1f0'], bondingOptions=None, mtu=1500, bridged=False,
defaultRoute=True,options={'implicitBonding': True, u'custom': {}}
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:06,984::api::331::root::(_addNetwork) Configuring device ens1f0
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:06,990::ifcfg::509::root::(_createConfFile) ifcfg _createConfFile with: conf =
'HWADDR=0c:c4:7a:52:de:06\nONBOOT=yes\n', name = ens1f0, ipv4 = IPv4(None, None,
None, True, None), ipv6 = IPv6(None, None, True, None, None), mtu = 1500, kwargs =
{'implicitBonding': True, u'custom': {}}
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:06,991::ifcfg::416::root::(_persistentBackup) backing up ifcfg-ens1f0: # Generated
by VDSM version 4.17.23.2-0.el7.centos
DEVICE=ens1f0
ONBOOT=yes
MTU=1500
HWADDR=0C:C4:7A:52:DE:06
NM_CONTROLLED=no
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:06,991::ifcfg::487::root::(writeConfFile) Writing to file
/etc/sysconfig/network-scripts/ifcfg-ens1f0 configuration:
# Generated by VDSM version 4.17.23.2-0.el7.centos
DEVICE=ens1f0
HWADDR=0c:c4:7a:52:de:06
ONBOOT=yes
MTU=1500
DEFROUTE=yes
NM_CONTROLLED=no
IPV6INIT=no
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:06,991::__init__::130::root::(_addSourceRoute) Adding source route: name=ens1f0,
addr=None, netmask=None, gateway=None
MainProcess|jsonrpc.Executor/4::WARNING::2016-04-04
15:08:06,991::__init__::137::root::(_addSourceRoute) invalid input for source routing:
name=ens1f0, addr=None, netmask=None, gateway=None
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:06,992::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/sbin/ifdown ens1f0 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:07,233::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> =
0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:07,233::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/bin/systemd-run --scope --unit=1463dcfa-fd91-40ff-a5a6-76f4759a824f
--slice=vdsm-dhclient /usr/sbin/ifup ens1f0 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:07,666::utils::689::root::(execCmd) SUCCESS: <err> = 'Running scope as
unit 1463dcfa-fd91-40ff-a5a6-76f4759a824f.scope.\n'; <rc> = 0
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:07,674::netconfpersistence::62::root::(setNetwork) Adding network
ovirtmgmt({'nic': u'ens1f0', u'custom': {}, u'bridged':
u'false', u'mtu': u'1500'})
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:07,679::api::765::setupNetworks::(_add_missing_networks) Adding network
u'VLAN602'
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:07,679::api::281::root::(_addNetwork) validating network...
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:07,680::api::301::root::(_addNetwork) Adding network VLAN602 with vlan=602,
bonding=bond0, nics=[u'eno1', u'eno2'], bondingOptions=miimon=100 mode=4,
mtu=1500, bridged=False, defaultRoute=False,options={'implicitBonding': True,
u'custom': {}}
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:07,680::api::331::root::(_addNetwork) Configuring device bond0.602
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:07,680::ifcfg::509::root::(_createConfFile) ifcfg _createConfFile with: conf =
'VLAN=yes\nONBOOT=yes\n', name = bond0.602, ipv4 = IPv4(None, None, None, False,
None), ipv6 = IPv6(None, None, False, None, None), mtu = 1500, kwargs =
{'implicitBonding': True, 'hotplug': 'no', u'custom': {}}
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:07,680::ifcfg::416::root::(_persistentBackup) backing up ifcfg-bond0.602: # original
file did not exist
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:07,681::ifcfg::321::root::(writeBackupFile) Persistently backed up
/var/lib/vdsm/netconfback/ifcfg-bond0.602 (until next 'set safe config')
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:07,681::ifcfg::487::root::(writeConfFile) Writing to file
/etc/sysconfig/network-scripts/ifcfg-bond0.602 configuration:
# Generated by VDSM version 4.17.23.2-0.el7.centos
DEVICE=bond0.602
VLAN=yes
ONBOOT=yes
MTU=1500
DEFROUTE=no
NM_CONTROLLED=no
IPV6INIT=no
HOTPLUG=no
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:07,681::ifcfg::499::root::(writeConfFile) ignoring restorecon error in case SElinux
is disabled
Traceback (most recent call last):
File "/usr/share/vdsm/network/configurators/ifcfg.py", line 496, in
writeConfFile
selinux.restorecon(fileName.encode('utf-8'))
File "/usr/lib64/python2.7/site-packages/selinux/__init__.py", line 88, in
restorecon
status, oldcontext = lgetfilecon(path)
OSError: [Errno 61] No data available
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:07,683::ifcfg::509::root::(_createConfFile) ifcfg _createConfFile with: conf =
u"BONDING_OPTS='mode=4 miimon=100'\nONBOOT=yes\n", name = bond0, ipv4 =
IPv4(None, None, None, None, None), ipv6 = IPv6(None, None, None, None, None), mtu = 1500,
kwargs = {'implicitBonding': True, 'hotplug': 'no',
u'custom': {}}
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:07,683::ifcfg::416::root::(_persistentBackup) backing up ifcfg-bond0: # Generated by
VDSM version 4.17.23.2-0.el7.centos
DEVICE=bond0
BONDING_OPTS='mode=4 miimon=100'
ONBOOT=yes
NM_CONTROLLED=no
IPV6INIT=no
HOTPLUG=no
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:07,684::ifcfg::487::root::(writeConfFile) Writing to file
/etc/sysconfig/network-scripts/ifcfg-bond0 configuration:
# Generated by VDSM version 4.17.23.2-0.el7.centos
DEVICE=bond0
BONDING_OPTS='mode=4 miimon=100'
ONBOOT=yes
MTU=1500
NM_CONTROLLED=no
IPV6INIT=no
HOTPLUG=no
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:07,684::ifcfg::499::root::(writeConfFile) ignoring restorecon error in case SElinux
is disabled
Traceback (most recent call last):
File "/usr/share/vdsm/network/configurators/ifcfg.py", line 496, in
writeConfFile
selinux.restorecon(fileName.encode('utf-8'))
File "/usr/lib64/python2.7/site-packages/selinux/__init__.py", line 88, in
restorecon
status, oldcontext = lgetfilecon(path)
OSError: [Errno 61] No data available
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:07,685::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/sbin/ifdown eno1 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:08,362::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> =
0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:08,362::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/sbin/ifdown eno2 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:09,036::utils::689::root::(execCmd) SUCCESS: <err> = ''; <rc> =
0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:09,039::netinfo::453::root::(_dhcp_used) There is no VDSM network configured on
ens1f0.
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:09,039::netinfo::453::root::(_dhcp_used) There is no VDSM network configured on
ens1f0.
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:09,044::ifcfg::509::root::(_createConfFile) ifcfg _createConfFile with: conf =
u'HWADDR=00:25:90:fa:5b:f8\nMASTER=bond0\nSLAVE=yes\nONBOOT=yes\n', name = eno1,
ipv4 = IPv4(None, None, None, None, None), ipv6 = IPv6(None, None, None, None, None), mtu
= 1500, kwargs = {'implicitBonding': True, u'custom': {}}
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:09,044::ifcfg::416::root::(_persistentBackup) backing up ifcfg-eno1: # Generated by
VDSM version 4.17.23.2-0.el7.centos
DEVICE=eno1
HWADDR=00:25:90:fa:5b:f8
MASTER=bond0
SLAVE=yes
ONBOOT=yes
NM_CONTROLLED=no
IPV6INIT=no
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:09,044::ifcfg::487::root::(writeConfFile) Writing to file
/etc/sysconfig/network-scripts/ifcfg-eno1 configuration:
# Generated by VDSM version 4.17.23.2-0.el7.centos
DEVICE=eno1
HWADDR=00:25:90:fa:5b:f8
MASTER=bond0
SLAVE=yes
ONBOOT=yes
MTU=1500
NM_CONTROLLED=no
IPV6INIT=no
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:09,047::netinfo::453::root::(_dhcp_used) There is no VDSM network configured on
ens1f0.
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:09,047::netinfo::453::root::(_dhcp_used) There is no VDSM network configured on
ens1f0.
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:09,052::ifcfg::509::root::(_createConfFile) ifcfg _createConfFile with: conf =
u'HWADDR=00:25:90:fa:5b:f9\nMASTER=bond0\nSLAVE=yes\nONBOOT=yes\n', name = eno2,
ipv4 = IPv4(None, None, None, None, None), ipv6 = IPv6(None, None, None, None, None), mtu
= 1500, kwargs = {'implicitBonding': True, u'custom': {}}
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:09,053::ifcfg::416::root::(_persistentBackup) backing up ifcfg-eno2: # Generated by
VDSM version 4.17.23.2-0.el7.centos
DEVICE=eno2
HWADDR=00:25:90:fa:5b:f9
MASTER=bond0
SLAVE=yes
ONBOOT=yes
NM_CONTROLLED=no
IPV6INIT=no
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:09,053::ifcfg::487::root::(writeConfFile) Writing to file
/etc/sysconfig/network-scripts/ifcfg-eno2 configuration:
# Generated by VDSM version 4.17.23.2-0.el7.centos
DEVICE=eno2
HWADDR=00:25:90:fa:5b:f9
MASTER=bond0
SLAVE=yes
ONBOOT=yes
MTU=1500
NM_CONTROLLED=no
IPV6INIT=no
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:09,053::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/bin/systemd-run --scope --unit=b45706d8-fe5f-4320-bc99-9bd99991d878
--slice=vdsm-dhclient /usr/sbin/ifup bond0 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:10,291::utils::689::root::(execCmd) SUCCESS: <err> = 'Running scope as
unit b45706d8-fe5f-4320-bc99-9bd99991d878.scope.\n'; <rc> = 0
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:10,291::netconfpersistence::73::root::(setBonding) Adding bond0({'nics':
[u'eno1', u'eno2'], 'options': u'mode=4 miimon=100'})
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:10,291::__init__::130::root::(_addSourceRoute) Adding source route: name=bond0.602,
addr=None, netmask=None, gateway=None
MainProcess|jsonrpc.Executor/4::WARNING::2016-04-04
15:08:10,291::__init__::137::root::(_addSourceRoute) invalid input for source routing:
name=bond0.602, addr=None, netmask=None, gateway=None
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:10,292::utils::671::root::(execCmd) /usr/bin/taskset --cpu-list 0-39
/usr/bin/systemd-run --scope --unit=cff02ee0-ee96-4b7e-bc49-706e230bc59a
--slice=vdsm-dhclient /usr/sbin/ifup bond0.602 (cwd None)
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:10,609::utils::689::root::(execCmd) SUCCESS: <err> = 'Running scope as
unit cff02ee0-ee96-4b7e-bc49-706e230bc59a.scope.\nRTNETLINK answers: Network is
unreachable\nRTNETLINK answers: Network is unreachable\n'; <rc> = 0
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:10,610::ifcfg::332::root::(_atomicNetworkBackup) Backed up VLAN602
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:10,616::netconfpersistence::62::root::(setNetwork) Adding network
VLAN602({u'custom': {}, u'bonding': u'bond0', u'vlan':
u'602', u'bridged': u'false', u'mtu': u'1500'})
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:10,621::netconfpersistence::187::root::(_clearDisk) Clearing
/var/run/vdsm/netconf/nets/ and /var/run/vdsm/netconf/bonds/
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:10,621::netconfpersistence::195::root::(_clearDisk) No existent config to clear.
MainProcess|jsonrpc.Executor/4::INFO::2016-04-04
15:08:10,621::netconfpersistence::131::root::(save) Saved new config
RunningConfig({u'ovirtmgmt': {'nic': u'ens1f0', u'custom':
{}, u'bridged': u'false', u'mtu': u'1500'},
u'VLAN602': {u'custom': {}, u'bonding': u'bond0',
u'vlan': u'602', u'bridged': u'false', u'mtu':
u'1500'}}, {u'bond0': {'nics': [u'eno1', u'eno2'],
'options': u'mode=4 miimon=100'}}) to /var/run/vdsm/netconf/nets/ and
/var/run/vdsm/netconf/bonds/
MainProcess|jsonrpc.Executor/4::DEBUG::2016-04-04
15:08:10,622::supervdsmServer::123::SuperVdsm.ServerCallback::(wrapper) return
setupNetworks with None
--Apple-Mail=_B565CEDD-E856-4748-912B-7B9679AB82CE
Content-Disposition: attachment;
filename=vdsm.log
Content-Type: application/octet-stream;
name="vdsm.log"
Content-Transfer-Encoding: quoted-printable
Reactor=20thread::INFO::2016-04-04=20=
15:07:17,671::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37253=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:07:17,675::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:07:17,675::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37253=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:07:17,676::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37253=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:07:17,676::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037253)=0A=
Thread-37::INFO::2016-04-04=20=
15:07:17,676::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37253=20started=0A=
Thread-37::INFO::2016-04-04=20=
15:07:17,677::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37253=20stopped=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,124::vdsm::72::vds::(sigtermHandler)=20Received=20signal=2015=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,124::periodic::162::virt.periodic.Operation::(stop)=20stopping=20=
operation=20<VmDispatcher=20operation=3D<class=20=
'virt.periodic.UpdateVolumes'>=20at=200x7f292c00e910>=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,124::periodic::162::virt.periodic.Operation::(stop)=20stopping=20=
operation=20<VmDispatcher=20operation=3D<class=20=
'virt.periodic.NumaInfoMonitor'>=20at=200x7f292c00eb50>=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,124::periodic::162::virt.periodic.Operation::(stop)=20stopping=20=
operation=20<VmDispatcher=20operation=3D<class=20=
'virt.periodic.BlockjobMonitor'>=20at=200x7f292c00ebd0>=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,124::periodic::162::virt.periodic.Operation::(stop)=20stopping=20=
operation=20<VMBulkSampler=20at=200x7f292c00ec50>=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,125::periodic::162::virt.periodic.Operation::(stop)=20stopping=20=
operation=20<VmDispatcher=20operation=3D<class=20=
'virt.periodic.DriveWatermarkMonitor'>=20at=200x7f292c00ef90>=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,125::executor::78::Executor::(stop)=20Stopping=20executor=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,125::protocoldetector::203::vds.MultiProtocolAcceptor::(stop)=20=
Stopping=20Acceptor=0AMainThread::INFO::2016-04-04=20=
15:07:33,125::__init__::612::jsonrpc.JsonRpcServer::(stop)=20Stopping=20=
JsonRPC=20Server=0AMainThread::DEBUG::2016-04-04=20=
15:07:33,125::executor::78::Executor::(stop)=20Stopping=20executor=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,125::executor::165::Executor::(join)=20Waiting=20for=20worker=20=
jsonrpc.Executor/2=0Ajsonrpc.Executor/0::DEBUG::2016-04-04=20=
15:07:33,126::executor::176::Executor::(_run)=20Worker=20stopped=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:33,126::executor::176::Executor::(_run)=20Worker=20stopped=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:33,126::executor::176::Executor::(_run)=20Worker=20stopped=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,126::executor::165::Executor::(join)=20Waiting=20for=20worker=20=
jsonrpc.Executor/7=0Ajsonrpc.Executor/3::DEBUG::2016-04-04=20=
15:07:33,126::executor::176::Executor::(_run)=20Worker=20stopped=0A=
jsonrpc.Executor/4::DEBUG::2016-04-04=20=
15:07:33,126::executor::176::Executor::(_run)=20Worker=20stopped=0A=
jsonrpc.Executor/5::DEBUG::2016-04-04=20=
15:07:33,127::executor::176::Executor::(_run)=20Worker=20stopped=0A=
jsonrpc.Executor/6::DEBUG::2016-04-04=20=
15:07:33,127::executor::176::Executor::(_run)=20Worker=20stopped=0A=
jsonrpc.Executor/7::DEBUG::2016-04-04=20=
15:07:33,127::executor::176::Executor::(_run)=20Worker=20stopped=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,127::executor::165::Executor::(join)=20Waiting=20for=20worker=20=
jsonrpc.Executor/6=0AMainThread::DEBUG::2016-04-04=20=
15:07:33,127::executor::165::Executor::(join)=20Waiting=20for=20worker=20=
jsonrpc.Executor/4=0AMainThread::DEBUG::2016-04-04=20=
15:07:33,127::executor::165::Executor::(join)=20Waiting=20for=20worker=20=
jsonrpc.Executor/1=0AMainThread::DEBUG::2016-04-04=20=
15:07:33,128::executor::165::Executor::(join)=20Waiting=20for=20worker=20=
jsonrpc.Executor/3=0AMainThread::DEBUG::2016-04-04=20=
15:07:33,128::executor::165::Executor::(join)=20Waiting=20for=20worker=20=
jsonrpc.Executor/0=0AMainThread::DEBUG::2016-04-04=20=
15:07:33,128::executor::165::Executor::(join)=20Waiting=20for=20worker=20=
jsonrpc.Executor/5=0AMainThread::INFO::2016-04-04=20=
15:07:33,128::bindingxmlrpc::85::vds::(stop)=20Stopping=20XMLRPC=20=
server=0ABindingXMLRPC::INFO::2016-04-04=20=
15:07:33,128::bindingxmlrpc::74::vds::(threaded_start)=20XMLRPC=20server=20=
stopped=0AMainThread::INFO::2016-04-04=20=
15:07:33,128::secret::90::root::(clear)=20Unregistering=20all=20secrests=0A=
periodic/0::DEBUG::2016-04-04=20=
15:07:33,128::executor::176::Executor::(_run)=20Worker=20stopped=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,129::vmchannels::207::vds::(stop)=20VM=20channels=20listener=20=
was=20stopped.=0AMainThread::DEBUG::2016-04-04=20=
15:07:33,129::task::595::Storage.TaskManager.Task::(_updateState)=20=
Task=3D`0a3e21a2-1f17-42b6-a741-8c44ee28b500`::moving=20from=20state=20=
init=20->=20state=20preparing=0AMainThread::INFO::2016-04-04=20=
15:07:33,129::logUtils::48::dispatcher::(wrapper)=20Run=20and=20protect:=20=
prepareForShutdown(options=3DNone)=0AThread-11::DEBUG::2016-04-04=20=
15:07:33,130::storageServer::864::Storage.ConnectionMonitor::(_monitorConn=
ections)=20Monitoring=20stopped=0AMainThread::INFO::2016-04-04=20=
15:07:33,157::monitor::156::Storage.Monitor::(shutdown)=20Shutting=20=
down=20domain=20monitors=0AMainThread::DEBUG::2016-04-04=20=
15:07:33,158::taskManager::90::Storage.TaskManager::(prepareForShutdown)=20=
Request=20to=20stop=20all=20tasks=0AMainThread::INFO::2016-04-04=20=
15:07:33,158::logUtils::51::dispatcher::(wrapper)=20Run=20and=20protect:=20=
prepareForShutdown,=20Return=20response:=20None=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,158::task::1191::Storage.TaskManager.Task::(prepare)=20=
Task=3D`0a3e21a2-1f17-42b6-a741-8c44ee28b500`::finished:=20None=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,158::task::595::Storage.TaskManager.Task::(_updateState)=20=
Task=3D`0a3e21a2-1f17-42b6-a741-8c44ee28b500`::moving=20from=20state=20=
preparing=20->=20state=20finished=0AMainThread::DEBUG::2016-04-04=20=
15:07:33,158::resourceManager::943::Storage.ResourceManager.Owner::(releas=
eAll)=20Owner.releaseAll=20requests=20{}=20resources=20{}=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:33,158::resourceManager::980::Storage.ResourceManager.Owner::(cancel=
All)=20Owner.cancelAll=20requests=20{}=0AMainThread::DEBUG::2016-04-04=20=
15:07:33,158::task::993::Storage.TaskManager.Task::(_decref)=20=
Task=3D`0a3e21a2-1f17-42b6-a741-8c44ee28b500`::ref=200=20aborting=20=
False=0AMainThread::DEBUG::2016-04-04=20=
15:07:33,158::schedule::110::Scheduler::(stop)=20Stopping=20scheduler=20=
vdsm.Scheduler=0AMainThread::INFO::2016-04-04=20=
15:07:33,158::vdsm::174::vds::(run)=20VDSM=20main=20thread=20ended.=20=
Waiting=20for=2018=20other=20threads...=0AMainThread::INFO::2016-04-04=20=
15:07:33,158::vdsm::178::vds::(run)=20<Thread(libvirtEventLoop,=20=
started=20daemon=20139816958940928)>=0AMainThread::INFO::2016-04-04=20=
15:07:33,159::vdsm::178::vds::(run)=20<Thread(periodic/2,=20started=20=
daemon=20139814791796480)>=0AMainThread::DEBUG::2016-04-04=20=
15:07:33,159::vmchannels::207::vds::(stop)=20VM=20channels=20listener=20=
was=20stopped.=0AMainThread::INFO::2016-04-04=20=
15:07:33,159::vdsm::178::vds::(run)=20<Listener(VM=20Channels=20=
Listener,=20started=20daemon=20139815796168448)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,159::vdsm::178::vds::(run)=20=
<WorkerThread(Thread-6,=20started=20daemon=20139816908584704)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,159::vdsm::178::vds::(run)=20=
<WorkerThread(Thread-5,=20started=20daemon=20139816916977408)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,159::vdsm::178::vds::(run)=20=
<WorkerThread(Thread-4,=20started=20daemon=20139816925370112)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,159::vdsm::178::vds::(run)=20=
<Thread(periodic/1,=20started=20daemon=20139814800189184)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,159::vdsm::178::vds::(run)=20=
<Thread(vdsm.Scheduler,=20started=20daemon=20139816377231104)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,159::vdsm::178::vds::(run)=20=
<WorkerThread(Thread-7,=20started=20daemon=20139816900192000)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,159::vdsm::178::vds::(run)=20=
<WorkerThread(Thread-1,=20started=20daemon=20139816950548224)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,159::vdsm::178::vds::(run)=20=
<WorkerThread(Thread-10,=20started=20daemon=20139816402409216)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,159::vdsm::178::vds::(run)=20=
<WorkerThread(Thread-9,=20started=20daemon=20139816410801920)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,160::vdsm::178::vds::(run)=20=
<WorkerThread(Thread-8,=20started=20daemon=20139816419194624)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,160::vdsm::178::vds::(run)=20=
<WorkerThread(Thread-2,=20started=20daemon=20139816942155520)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,160::vdsm::178::vds::(run)=20=
<_MainThread(MainThread,=20started=20139817249052480)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,160::vdsm::178::vds::(run)=20=
<Thread(Reactor=20thread,=20started=20daemon=20139815362205440)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,160::vdsm::178::vds::(run)=20=
<Thread(periodic/3,=20started=20daemon=20139814783403776)>=0A=
vdsm.Scheduler::DEBUG::2016-04-04=20=
15:07:33,160::schedule::145::Scheduler::(_run)=20stopped=0A=
MainThread::INFO::2016-04-04=2015:07:33,160::vdsm::178::vds::(run)=20=
<HostStatsThread(Thread-12,=20started=20daemon=20139816360789760)>=0A=
MainThread::INFO::2016-04-04=2015:07:33,160::vdsm::178::vds::(run)=20=
<WorkerThread(Thread-3,=20started=20daemon=20139816933762816)>=0A=
periodic/1::DEBUG::2016-04-04=20=
15:07:33,161::executor::176::Executor::(_run)=20Worker=20stopped=0A=
periodic/2::DEBUG::2016-04-04=20=
15:07:33,161::executor::176::Executor::(_run)=20Worker=20stopped=0A=
periodic/3::DEBUG::2016-04-04=20=
15:07:33,161::executor::176::Executor::(_run)=20Worker=20stopped=0A=
MainThread::INFO::2016-04-04=2015:07:44,569::vdsm::162::vds::(run)=20=
(PID:=205100)=20I=20am=20the=20actual=20vdsm=204.17.23.2-0.el7.centos=20=
twinp105.mgt.exam.org=20(3.10.0-327.10.1.el7.x86_64)=0A=
MainThread::INFO::2016-04-04=20=
15:07:44,569::vdsm::285::vds::(__set_cpu_affinity)=20VDSM=20will=20run=20=
with=20cpu=20affinity:=20frozenset([1])=0AMainThread::DEBUG::2016-04-04=20=
15:07:44,569::utils::671::root::(execCmd)=20/usr/bin/taskset=20=
--all-tasks=20--pid=20--cpu-list=201=205100=20(cwd=20None)=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,571::utils::689::root::(execCmd)=20SUCCESS:=20<err>=20=3D=20'';=20=
<rc>=20=3D=200=0AMainThread::DEBUG::2016-04-04=20=
15:07:44,572::resourceManager::424::Storage.ResourceManager::(registerName=
space)=20Registering=20namespace=20'Storage'=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,572::threadPool::29::Storage.ThreadPool::(__init__)=20Enter=20-=20=
numThreads:=2010,=20waitTimeout:=203,=20maxTasks:=20500=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,574::fileUtils::143::Storage.fileUtils::(createdir)=20Creating=20=
directory:=20/rhev/data-center/mnt=20mode:=20None=0A=
MainThread::WARNING::2016-04-04=20=
15:07:44,574::fileUtils::152::Storage.fileUtils::(createdir)=20Dir=20=
/rhev/data-center/mnt=20already=20exists=0AMainThread::DEBUG::2016-04-04=20=
15:07:44,603::hsm::409::Storage.Misc.excCmd::(__validateLvmLockingType)=20=
/usr/bin/taskset=20--cpu-list=200-39=20/usr/bin/sudo=20-n=20=
/usr/sbin/lvm=20dumpconfig=20global/locking_type=20(cwd=20None)=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,612::hsm::409::Storage.Misc.excCmd::(__validateLvmLockingType)=20=
SUCCESS:=20<err>=20=3D=20'';=20<rc>=20=3D=200=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,612::hsm::433::Storage.HSM::(__cleanStorageRepository)=20=
Started=20cleaning=20storage=20repository=20at=20'/rhev/data-center'=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,614::hsm::465::Storage.HSM::(__cleanStorageRepository)=20White=20=
list:=20['/rhev/data-center/hsm-tasks',=20=
'/rhev/data-center/hsm-tasks/*',=20'/rhev/data-center/mnt']=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,614::hsm::466::Storage.HSM::(__cleanStorageRepository)=20Mount=20=
list:=20[]=0AMainThread::DEBUG::2016-04-04=20=
15:07:44,614::hsm::468::Storage.HSM::(__cleanStorageRepository)=20=
Cleaning=20leftovers=0AMainThread::DEBUG::2016-04-04=20=
15:07:44,615::hsm::511::Storage.HSM::(__cleanStorageRepository)=20=
Finished=20cleaning=20storage=20repository=20at=20'/rhev/data-center'=0A=
MainThread::INFO::2016-04-04=20=
15:07:44,616::dispatcher::46::Storage.Dispatcher::(__init__)=20Starting=20=
StorageDispatcher...=0AMainThread::DEBUG::2016-04-04=20=
15:07:44,616::schedule::98::Scheduler::(start)=20Starting=20scheduler=20=
vdsm.Scheduler=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,616::misc::750::Storage.SamplingMethod::(__call__)=20Trying=20=
to=20enter=20sampling=20method=20(storage.sdc.refreshStorage)=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,616::misc::753::Storage.SamplingMethod::(__call__)=20Got=20in=20=
to=20sampling=20method=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,616::misc::750::Storage.SamplingMethod::(__call__)=20Trying=20=
to=20enter=20sampling=20method=20(storage.iscsi.rescan)=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,616::misc::753::Storage.SamplingMethod::(__call__)=20Got=20in=20=
to=20sampling=20method=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,616::iscsi::434::Storage.ISCSI::(rescan)=20Performing=20SCSI=20=
scan,=20this=20will=20take=20up=20to=2030=20seconds=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,616::iscsiadm::97::Storage.Misc.excCmd::(_runCmd)=20=
/usr/bin/taskset=20--cpu-list=200-39=20/usr/bin/sudo=20-n=20=
/sbin/iscsiadm=20-m=20session=20-R=20(cwd=20None)=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,652::task::595::Storage.TaskManager.Task::(_updateState)=20=
Task=3D`cc66d0a2-2063-4126-b0b9-2d12e44ef4d2`::moving=20from=20state=20=
init=20->=20state=20preparing=0AMainThread::INFO::2016-04-04=20=
15:07:44,652::logUtils::48::dispatcher::(wrapper)=20Run=20and=20protect:=20=
registerDomainStateChangeCallback(callbackFunc=3D<functools.partial=20=
object=20at=200x1fb9158>)=0AMainThread::INFO::2016-04-04=20=
15:07:44,652::logUtils::51::dispatcher::(wrapper)=20Run=20and=20protect:=20=
registerDomainStateChangeCallback,=20Return=20response:=20None=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,652::task::1191::Storage.TaskManager.Task::(prepare)=20=
Task=3D`cc66d0a2-2063-4126-b0b9-2d12e44ef4d2`::finished:=20None=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,652::task::595::Storage.TaskManager.Task::(_updateState)=20=
Task=3D`cc66d0a2-2063-4126-b0b9-2d12e44ef4d2`::moving=20from=20state=20=
preparing=20->=20state=20finished=0AMainThread::DEBUG::2016-04-04=20=
15:07:44,653::resourceManager::943::Storage.ResourceManager.Owner::(releas=
eAll)=20Owner.releaseAll=20requests=20{}=20resources=20{}=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,653::resourceManager::980::Storage.ResourceManager.Owner::(cancel=
All)=20Owner.cancelAll=20requests=20{}=0AMainThread::DEBUG::2016-04-04=20=
15:07:44,653::task::993::Storage.TaskManager.Task::(_decref)=20=
Task=3D`cc66d0a2-2063-4126-b0b9-2d12e44ef4d2`::ref=200=20aborting=20=
False=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,653::misc::760::Storage.SamplingMethod::(__call__)=20Returning=20=
last=20result=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,653::misc::750::Storage.SamplingMethod::(__call__)=20Trying=20=
to=20enter=20sampling=20method=20(storage.hba.rescan)=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,653::misc::753::Storage.SamplingMethod::(__call__)=20Got=20in=20=
to=20sampling=20method=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,653::hba::56::Storage.HBA::(rescan)=20Starting=20scan=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,653::supervdsm::76::SuperVdsmProxy::(_connect)=20Trying=20to=20=
connect=20to=20Super=20Vdsm=0Avdsm.Scheduler::DEBUG::2016-04-04=20=
15:07:44,654::schedule::142::Scheduler::(_run)=20started=0A=
MainThread::INFO::2016-04-04=2015:07:44,654::momIF::46::MOM::(__init__)=20=
Preparing=20MOM=20interface=0AMainThread::INFO::2016-04-04=20=
15:07:44,654::momIF::55::MOM::(__init__)=20Using=20named=20unix=20socket=20=
/var/run/vdsm/mom-vdsm.sock=0AMainThread::INFO::2016-04-04=20=
15:07:44,655::secret::90::root::(clear)=20Unregistering=20all=20secrests=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,655::libvirtconnection::161::root::(get)=20trying=20to=20=
connect=20libvirt=0AMainThread::INFO::2016-04-04=20=
15:07:44,660::vmchannels::211::vds::(settimeout)=20Setting=20channels'=20=
timeout=20to=2030=20seconds.=0AclientIFinit::DEBUG::2016-04-04=20=
15:07:44,660::clientIF::462::vds::(_recoverExistingVms)=20recovery:=20=
started=0AMainThread::INFO::2016-04-04=20=
15:07:44,661::protocoldetector::172::vds.MultiProtocolAcceptor::(__init__)=
=20Listening=20at=200.0.0.0:54321=0AMainThread::DEBUG::2016-04-04=20=
15:07:44,679::protocoldetector::199::vds.MultiProtocolAcceptor::(add_detec=
tor)=20Adding=20detector=20<rpc.bindingxmlrpc.XmlDetector=20instance=20=
at=200x2261710>=0AVM=20Channels=20Listener::DEBUG::2016-04-04=20=
15:07:44,720::vmchannels::193::vds::(run)=20Starting=20VM=20channels=20=
listener=20thread.=0AclientIFinit::INFO::2016-04-04=20=
15:07:44,721::clientIF::553::vds::(_recoverExistingVms)=20recovery:=20=
completed=20in=200s=0AMainThread::DEBUG::2016-04-04=20=
15:07:44,721::protocoldetector::199::vds.MultiProtocolAcceptor::(add_detec=
tor)=20Adding=20detector=20<yajsonrpc.stompreactor.StompDetector=20=
instance=20at=200x1fd3ab8>=0AMainThread::DEBUG::2016-04-04=20=
15:07:44,721::executor::69::Executor::(start)=20Starting=20executor=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,721::executor::157::Executor::(__init__)=20Starting=20worker=20=
jsonrpc.Executor/0=0AMainThread::DEBUG::2016-04-04=20=
15:07:44,721::executor::157::Executor::(__init__)=20Starting=20worker=20=
jsonrpc.Executor/1=0Ajsonrpc.Executor/0::DEBUG::2016-04-04=20=
15:07:44,721::executor::171::Executor::(_run)=20Worker=20started=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,722::executor::157::Executor::(__init__)=20Starting=20worker=20=
jsonrpc.Executor/2=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:44,722::executor::171::Executor::(_run)=20Worker=20started=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,722::executor::157::Executor::(__init__)=20Starting=20worker=20=
jsonrpc.Executor/3=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:44,722::executor::171::Executor::(_run)=20Worker=20started=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,722::executor::157::Executor::(__init__)=20Starting=20worker=20=
jsonrpc.Executor/4=0Ajsonrpc.Executor/3::DEBUG::2016-04-04=20=
15:07:44,722::executor::171::Executor::(_run)=20Worker=20started=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,722::executor::157::Executor::(__init__)=20Starting=20worker=20=
jsonrpc.Executor/5=0Ajsonrpc.Executor/4::DEBUG::2016-04-04=20=
15:07:44,723::executor::171::Executor::(_run)=20Worker=20started=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,723::executor::157::Executor::(__init__)=20Starting=20worker=20=
jsonrpc.Executor/6=0Ajsonrpc.Executor/5::DEBUG::2016-04-04=20=
15:07:44,723::executor::171::Executor::(_run)=20Worker=20started=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,723::executor::157::Executor::(__init__)=20Starting=20worker=20=
jsonrpc.Executor/7=0Ajsonrpc.Executor/6::DEBUG::2016-04-04=20=
15:07:44,723::executor::171::Executor::(_run)=20Worker=20started=0A=
jsonrpc.Executor/7::DEBUG::2016-04-04=20=
15:07:44,724::executor::171::Executor::(_run)=20Worker=20started=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:07:44,724::bindingxmlrpc::62::vds::(threaded_start)=20XMLRPC=20server=20=
running=0AMainThread::DEBUG::2016-04-04=20=
15:07:44,724::executor::69::Executor::(start)=20Starting=20executor=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,724::executor::157::Executor::(__init__)=20Starting=20worker=20=
periodic/0=0AMainThread::DEBUG::2016-04-04=20=
15:07:44,725::executor::157::Executor::(__init__)=20Starting=20worker=20=
periodic/1=0Aperiodic/0::DEBUG::2016-04-04=20=
15:07:44,725::executor::171::Executor::(_run)=20Worker=20started=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,725::executor::157::Executor::(__init__)=20Starting=20worker=20=
periodic/2=0Aperiodic/1::DEBUG::2016-04-04=20=
15:07:44,725::executor::171::Executor::(_run)=20Worker=20started=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,725::executor::157::Executor::(__init__)=20Starting=20worker=20=
periodic/3=0Aperiodic/2::DEBUG::2016-04-04=20=
15:07:44,726::executor::171::Executor::(_run)=20Worker=20started=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,726::libvirtconnection::161::root::(get)=20trying=20to=20=
connect=20libvirt=0Aperiodic/3::DEBUG::2016-04-04=20=
15:07:44,726::executor::171::Executor::(_run)=20Worker=20started=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,728::periodic::153::virt.periodic.Operation::(start)=20starting=20=
operation=20<VmDispatcher=20operation=3D<class=20=
'virt.periodic.UpdateVolumes'>=20at=200x7fd66000e910>=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,729::periodic::153::virt.periodic.Operation::(start)=20starting=20=
operation=20<VmDispatcher=20operation=3D<class=20=
'virt.periodic.NumaInfoMonitor'>=20at=200x7fd66000eb50>=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,729::periodic::153::virt.periodic.Operation::(start)=20starting=20=
operation=20<VmDispatcher=20operation=3D<class=20=
'virt.periodic.BlockjobMonitor'>=20at=200x7fd66000ebd0>=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,729::periodic::153::virt.periodic.Operation::(start)=20starting=20=
operation=20<VMBulkSampler=20at=200x7fd66000ec50>=0A=
MainThread::DEBUG::2016-04-04=20=
15:07:44,729::periodic::153::virt.periodic.Operation::(start)=20starting=20=
operation=20<VmDispatcher=20operation=3D<class=20=
'virt.periodic.DriveWatermarkMonitor'>=20at=200x7fd66000ef90>=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,766::hba::62::Storage.HBA::(rescan)=20Scan=20finished=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,766::misc::760::Storage.SamplingMethod::(__call__)=20Returning=20=
last=20result=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,766::multipath::77::Storage.Misc.excCmd::(rescan)=20=
/usr/bin/taskset=20--cpu-list=200-39=20/usr/bin/sudo=20-n=20=
/usr/sbin/multipath=20(cwd=20None)=0AReactor=20thread::INFO::2016-04-04=20=
15:07:44,806::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=2010.149.133.23:57191=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,813::multipath::77::Storage.Misc.excCmd::(rescan)=20SUCCESS:=20=
<err>=20=3D=20'';=20<rc>=20=3D=200=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,814::utils::671::root::(execCmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20/sbin/udevadm=20settle=20--timeout=3D5=20(cwd=20=
None)=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,819::utils::689::root::(execCmd)=20SUCCESS:=20<err>=20=3D=20'';=20=
<rc>=20=3D=200=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,819::lvm::497::Storage.OperationMutex::(_invalidateAllPvs)=20=
Operation=20'lvm=20invalidate=20operation'=20got=20the=20operation=20=
mutex=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,820::lvm::499::Storage.OperationMutex::(_invalidateAllPvs)=20=
Operation=20'lvm=20invalidate=20operation'=20released=20the=20operation=20=
mutex=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,820::lvm::508::Storage.OperationMutex::(_invalidateAllVgs)=20=
Operation=20'lvm=20invalidate=20operation'=20got=20the=20operation=20=
mutex=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,820::lvm::510::Storage.OperationMutex::(_invalidateAllVgs)=20=
Operation=20'lvm=20invalidate=20operation'=20released=20the=20operation=20=
mutex=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,820::lvm::528::Storage.OperationMutex::(_invalidateAllLvs)=20=
Operation=20'lvm=20invalidate=20operation'=20got=20the=20operation=20=
mutex=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,820::lvm::530::Storage.OperationMutex::(_invalidateAllLvs)=20=
Operation=20'lvm=20invalidate=20operation'=20released=20the=20operation=20=
mutex=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,820::misc::760::Storage.SamplingMethod::(__call__)=20Returning=20=
last=20result=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,820::lvm::319::Storage.OperationMutex::(_reloadpvs)=20Operation=20=
'lvm=20reload=20operation'=20got=20the=20operation=20mutex=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,820::lvm::290::Storage.Misc.excCmd::(cmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20/usr/bin/sudo=20-n=20/usr/sbin/lvm=20pvs=20--config=20=
'=20devices=20{=20preferred_names=20=3D=20["^/dev/mapper/"]=20=
ignore_suspended_devices=3D1=20write_cache_state=3D0=20=
disable_after_error_count=3D3=20filter=20=3D=20[=20'\''r|.*|'\''=20]=20}=20=
=20global=20{=20=20locking_type=3D1=20=20prioritise_write_locks=3D1=20=20=
wait_for_locks=3D1=20=20use_lvmetad=3D0=20}=20=20backup=20{=20=20=
retain_min=20=3D=2050=20=20retain_days=20=3D=200=20}=20'=20--noheadings=20=
--units=20b=20--nosuffix=20--separator=20'|'=20--ignoreskippedcluster=20=
-o=20=
uuid,name,size,vg_name,vg_uuid,pe_start,pe_count,pe_alloc_count,mda_count,=
dev_size=20(cwd=20None)=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,837::lvm::290::Storage.Misc.excCmd::(cmd)=20SUCCESS:=20<err>=20=
=3D=20'=20=20WARNING:=20lvmetad=20is=20running=20but=20disabled.=20=
Restart=20lvmetad=20before=20enabling=20it!\n';=20<rc>=20=3D=200=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,837::lvm::347::Storage.OperationMutex::(_reloadpvs)=20Operation=20=
'lvm=20reload=20operation'=20released=20the=20operation=20mutex=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,838::lvm::370::Storage.OperationMutex::(_reloadvgs)=20Operation=20=
'lvm=20reload=20operation'=20got=20the=20operation=20mutex=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,838::lvm::290::Storage.Misc.excCmd::(cmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20/usr/bin/sudo=20-n=20/usr/sbin/lvm=20vgs=20--config=20=
'=20devices=20{=20preferred_names=20=3D=20["^/dev/mapper/"]=20=
ignore_suspended_devices=3D1=20write_cache_state=3D0=20=
disable_after_error_count=3D3=20filter=20=3D=20[=20'\''r|.*|'\''=20]=20}=20=
=20global=20{=20=20locking_type=3D1=20=20prioritise_write_locks=3D1=20=20=
wait_for_locks=3D1=20=20use_lvmetad=3D0=20}=20=20backup=20{=20=20=
retain_min=20=3D=2050=20=20retain_days=20=3D=200=20}=20'=20--noheadings=20=
--units=20b=20--nosuffix=20--separator=20'|'=20--ignoreskippedcluster=20=
-o=20=
uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_s=
ize,vg_mda_free,lv_count,pv_count,pv_name=20(cwd=20None)=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,851::lvm::290::Storage.Misc.excCmd::(cmd)=20SUCCESS:=20<err>=20=
=3D=20'=20=20WARNING:=20lvmetad=20is=20running=20but=20disabled.=20=
Restart=20lvmetad=20before=20enabling=20it!\n';=20<rc>=20=3D=200=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,852::lvm::415::Storage.OperationMutex::(_reloadvgs)=20Operation=20=
'lvm=20reload=20operation'=20released=20the=20operation=20mutex=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,852::lvm::290::Storage.Misc.excCmd::(cmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20/usr/bin/sudo=20-n=20/usr/sbin/lvm=20lvs=20--config=20=
'=20devices=20{=20preferred_names=20=3D=20["^/dev/mapper/"]=20=
ignore_suspended_devices=3D1=20write_cache_state=3D0=20=
disable_after_error_count=3D3=20filter=20=3D=20[=20'\''r|.*|'\''=20]=20}=20=
=20global=20{=20=20locking_type=3D1=20=20prioritise_write_locks=3D1=20=20=
wait_for_locks=3D1=20=20use_lvmetad=3D0=20}=20=20backup=20{=20=20=
retain_min=20=3D=2050=20=20retain_days=20=3D=200=20}=20'=20--noheadings=20=
--units=20b=20--nosuffix=20--separator=20'|'=20--ignoreskippedcluster=20=
-o=20uuid,name,vg_name,attr,size,seg_start_pe,devices,tags=20(cwd=20=
None)=0AstorageRefresh::DEBUG::2016-04-04=20=
15:07:44,866::lvm::290::Storage.Misc.excCmd::(cmd)=20SUCCESS:=20<err>=20=
=3D=20'=20=20WARNING:=20lvmetad=20is=20running=20but=20disabled.=20=
Restart=20lvmetad=20before=20enabling=20it!\n';=20<rc>=20=3D=200=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,866::lvm::370::Storage.OperationMutex::(_reloadvgs)=20Operation=20=
'lvm=20reload=20operation'=20got=20the=20operation=20mutex=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,867::lvm::290::Storage.Misc.excCmd::(cmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20/usr/bin/sudo=20-n=20/usr/sbin/lvm=20vgs=20--config=20=
'=20devices=20{=20preferred_names=20=3D=20["^/dev/mapper/"]=20=
ignore_suspended_devices=3D1=20write_cache_state=3D0=20=
disable_after_error_count=3D3=20filter=20=3D=20[=20'\''r|.*|'\''=20]=20}=20=
=20global=20{=20=20locking_type=3D1=20=20prioritise_write_locks=3D1=20=20=
wait_for_locks=3D1=20=20use_lvmetad=3D0=20}=20=20backup=20{=20=20=
retain_min=20=3D=2050=20=20retain_days=20=3D=200=20}=20'=20--noheadings=20=
--units=20b=20--nosuffix=20--separator=20'|'=20--ignoreskippedcluster=20=
-o=20=
uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_s=
ize,vg_mda_free,lv_count,pv_count,pv_name=20(cwd=20None)=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:07:44,871::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:07:44,872::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20stomp=20from=2010.149.133.23:57191=0AReactor=20=
thread::INFO::2016-04-04=20=
15:07:44,873::stompreactor::101::Broker.StompAdapter::(_cmd_connect)=20=
Processing=20CONNECT=20request=0AJsonRpc=20=
(StompReactor)::INFO::2016-04-04=20=
15:07:44,873::stompreactor::128::Broker.StompAdapter::(_cmd_subscribe)=20=
Subscribe=20command=20received=0AJsonRpc=20=
(StompReactor)::INFO::2016-04-04=20=
15:07:44,873::stompreactor::128::Broker.StompAdapter::(_cmd_subscribe)=20=
Subscribe=20command=20received=0AReactor=20thread::DEBUG::2016-04-04=20=
15:07:44,874::stompreactor::470::protocoldetector.StompDetector::(handle_s=
ocket)=20Stomp=20detected=20from=20('10.149.133.23',=2057191)=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,880::lvm::290::Storage.Misc.excCmd::(cmd)=20SUCCESS:=20<err>=20=
=3D=20'=20=20WARNING:=20lvmetad=20is=20running=20but=20disabled.=20=
Restart=20lvmetad=20before=20enabling=20it!\n';=20<rc>=20=3D=200=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,880::lvm::415::Storage.OperationMutex::(_reloadvgs)=20Operation=20=
'lvm=20reload=20operation'=20released=20the=20operation=20mutex=0A=
storageRefresh::DEBUG::2016-04-04=20=
15:07:44,880::hsm::379::Storage.HSM::(storageRefresh)=20HSM=20is=20ready=0A=
jsonrpc.Executor/0::DEBUG::2016-04-04=20=
15:07:45,237::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Calling=20'Host.ping'=20in=20bridge=20with=20{}=0A=
jsonrpc.Executor/0::DEBUG::2016-04-04=20=
15:07:45,238::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Return=20'Host.ping'=20in=20bridge=20with=20True=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:45,244::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Calling=20'Host.ping'=20in=20bridge=20with=20{}=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:45,244::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Return=20'Host.ping'=20in=20bridge=20with=20True=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:45,324::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Calling=20'Host.getCapabilities'=20in=20bridge=20with=20{}=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:45,348::netinfo::453::root::(_dhcp_used)=20There=20is=20no=20VDSM=20=
network=20configured=20on=20ens1f0.=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:45,348::netinfo::453::root::(_dhcp_used)=20There=20is=20no=20VDSM=20=
network=20configured=20on=20ens1f0.=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:45,348::netinfo::453::root::(_dhcp_used)=20There=20is=20no=20VDSM=20=
network=20configured=20on=20bond0.602.=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:45,348::netinfo::453::root::(_dhcp_used)=20There=20is=20no=20VDSM=20=
network=20configured=20on=20bond0.602.=0A=
jsonrpc.Executor/2::INFO::2016-04-04=20=
15:07:45,348::netinfo::495::root::(_getNetInfo)=20Obtaining=20info=20for=20=
net=20bond0.602.=0ATraceback=20(most=20recent=20call=20last):=0A=20=20=
File=20"/usr/lib/python2.7/site-packages/vdsm/netinfo.py",=20line=20492,=20=
in=20_getNetInfo=0A=20=20=20=20'mtu':=20str(getMtu(iface))})=0A=20=20=
File=20"/usr/lib/python2.7/site-packages/vdsm/netinfo.py",=20line=20191,=20=
in=20getMtu=0A=20=20=20=20with=20open('/sys/class/net/%s/mtu'=20%=20=
iface)=20as=20f:=0AIOError:=20[Errno=202]=20No=20such=20file=20or=20=
directory:=20'/sys/class/net/bond0.602/mtu'=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:45,352::utils::671::root::(execCmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20/usr/sbin/tc=20qdisc=20show=20(cwd=20None)=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:45,359::utils::689::root::(execCmd)=20SUCCESS:=20<err>=20=3D=20'';=20=
<rc>=20=3D=200=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:45,359::utils::671::root::(execCmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20/usr/sbin/tc=20class=20show=20dev=20ens1f0=20classid=20=
0:1388=20(cwd=20None)=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:45,364::utils::689::root::(execCmd)=20SUCCESS:=20<err>=20=3D=20'';=20=
<rc>=20=3D=200=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:45,386::utils::671::root::(execCmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20numactl=20--hardware=20(cwd=20None)=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:45,391::utils::689::root::(execCmd)=20SUCCESS:=20<err>=20=3D=20'';=20=
<rc>=20=3D=200=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:45,392::utils::671::root::(execCmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20sysctl=20-n=20-e=20kernel.numa_balancing=20(cwd=20=
None)=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:45,396::utils::689::root::(execCmd)=20SUCCESS:=20<err>=20=3D=20'';=20=
<rc>=20=3D=200=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:45,400::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Return=20'Host.getCapabilities'=20in=20bridge=20with=20{'HBAInventory':=20=
{'iSCSI':=20[{'InitiatorName':=20'iqn.1994-05.com.redhat:82cdb6fe1f7'}],=20=
'FC':=20[]},=20'packages2':=20{'kernel':=20{'release':=20=
'327.10.1.el7.x86_64',=20'buildtime':=201455638630.0,=20'version':=20=
'3.10.0'},=20'spice-server':=20{'release':=20'15.el7',=20'buildtime':=20=
1448026017L,=20'version':=20'0.12.4'},=20'librbd1':=20{'release':=20=
'3.el7',=20'buildtime':=201448036424L,=20'version':=20'0.80.7'},=20=
'vdsm':=20{'release':=20'0.el7.centos',=20'buildtime':=201459239759L,=20=
'version':=20'4.17.23.2'},=20'qemu-kvm':=20{'release':=20'31.el7_2.7.1',=20=
'buildtime':=201454322367L,=20'version':=20'2.3.0'},=20'libvirt':=20=
{'release':=20'13.el7_2.3',=20'buildtime':=201455642692L,=20'version':=20=
'1.2.17'},=20'qemu-img':=20{'release':=20'31.el7_2.7.1',=20'buildtime':=20=
1454322367L,=20'version':=20'2.3.0'},=20'mom':=20{'release':=20=
'1.el7.centos',=20'buildtime':=201453738202L,=20'version':=20'0.5.2'},=20=
'glusterfs-cli':=20{'release':=20'16.0.1.el7.centos',=20'buildtime':=20=
1457616516L,=20'version':=20'3.7.1'}},=20'numaNodeDistance':=20{'1':=20=
[21,=2010],=20'0':=20[10,=2021]},=20'cpuModel':=20'Intel(R)=20Xeon(R)=20=
CPU=20E5-2660=20v3=20@=202.60GHz',=20'liveMerge':=20'true',=20'hooks':=20=
{'before_nic_hotplug':=20{'50_vmfex':=20{'md5':=20=
'e05994261acaea7dcf4b88ea0e81f1f5'}},=20'before_vdsm_start':=20=
{'lro_off.sh':=20{'md5':=20'4f8117819fc321e9f7f0c94020b6938b'}},=20=
'before_device_migrate_destination':=20{'50_vmfex':=20{'md5':=20=
'e05994261acaea7dcf4b88ea0e81f1f5'}},=20'before_device_create':=20=
{'50_vmfex':=20{'md5':=20'e05994261acaea7dcf4b88ea0e81f1f5'}}},=20=
'vmTypes':=20['kvm'],=20'selinux':=20{'mode':=20'-1'},=20'liveSnapshot':=20=
'true',=20'kdumpStatus':=201,=20'networks':=20{'ovirtmgmt':=20{'iface':=20=
'ens1f0',=20'addr':=20'10.149.133.27',=20'bridged':=20False,=20=
'ipv6addrs':=20['fe80::ec4:7aff:fe52:de06/64'],=20'mtu':=20'1500',=20=
'dhcpv4':=20False,=20'netmask':=20'255.255.255.0',=20'dhcpv6':=20False,=20=
'ipv4addrs':=20['10.149.133.27/24'],=20'interface':=20'ens1f0',=20=
'ipv6gateway':=20'::',=20'gateway':=20'10.149.133.1'}},=20'bridges':=20=
{},=20'uuid':=20'00000000-0000-0000-0000-002590FA5BF8',=20'onlineCpus':=20=
'0,1,2,3,4,5,6,7,8,9,20,21,22,23,24,25,26,27,28,29,10,11,12,13,14,15,16,17=
,18,19,30,31,32,33,34,35,36,37,38,39',=20'nics':=20{'ens1f1':=20{'addr':=20=
'',=20'ipv6gateway':=20'::',=20'ipv6addrs':=20[],=20'mtu':=20'1500',=20=
'dhcpv4':=20False,=20'netmask':=20'',=20'dhcpv6':=20False,=20=
'ipv4addrs':=20[],=20'cfg':=20{'PEERROUTES':=20'yes',=20'IPV6INIT':=20=
'yes',=20'NAME':=20'ens1f1',=20'IPV6_PEERDNS':=20'yes',=20'DEFROUTE':=20=
'yes',=20'UUID':=20'9083efc6-b54f-4584-92cc-272e0ee2feaf',=20'PEERDNS':=20=
'yes',=20'IPV4_FAILURE_FATAL':=20'no',=20'IPV6_AUTOCONF':=20'yes',=20=
'BOOTPROTO':=20'dhcp',=20'IPV6_DEFROUTE':=20'yes',=20'HWADDR':=20=
'0C:C4:7A:52:DE:07',=20'IPV6_FAILURE_FATAL':=20'no',=20'TYPE':=20=
'Ethernet',=20'ONBOOT':=20'no',=20'IPV6_PEERROUTES':=20'yes'},=20=
'hwaddr':=20'0c:c4:7a:52:de:07',=20'speed':=200,=20'gateway':=20''},=20=
'ens1f0':=20{'addr':=20'10.149.133.27',=20'ipv6gateway':=20'::',=20=
'ipv6addrs':=20['fe80::ec4:7aff:fe52:de06/64'],=20'mtu':=20'1500',=20=
'dhcpv4':=20False,=20'netmask':=20'255.255.255.0',=20'dhcpv6':=20False,=20=
'ipv4addrs':=20['10.149.133.27/24'],=20'cfg':=20{'HWADDR':=20=
'0C:C4:7A:52:DE:06',=20'IPV6INIT':=20'yes',=20'NAME':=20'ens1f0',=20=
'IPV6_PEERROUTES':=20'yes',=20'DEFROUTE':=20'yes',=20'NETBOOT':=20'yes',=20=
'IPV6_PEERDNS':=20'yes',=20'IPADDR':=20'10.149.133.27',=20'GATEWAY':=20=
'10.149.133.1',=20'IPV6_AUTOCONF':=20'yes',=20'PREFIX':=20'24',=20=
'BOOTPROTO':=20'none',=20'IPV6_DEFROUTE':=20'yes',=20'DEVICE':=20=
'ens1f0',=20'IPV6_FAILURE_FATAL':=20'no',=20'DNS1':=20'10.148.125.237',=20=
'IPV4_FAILURE_FATAL':=20'no',=20'TYPE':=20'Ethernet',=20'ONBOOT':=20=
'yes',=20'UUID':=20'a6e93be4-5fa5-4567-b205-adfd3fa96c45'},=20'hwaddr':=20=
'0c:c4:7a:52:de:06',=20'speed':=201000,=20'gateway':=20'10.149.133.1'},=20=
'eno2':=20{'addr':=20'',=20'ipv6gateway':=20'::',=20'ipv6addrs':=20[],=20=
'mtu':=20'1500',=20'dhcpv4':=20False,=20'netmask':=20'',=20'dhcpv6':=20=
False,=20'ipv4addrs':=20[],=20'cfg':=20{'PEERROUTES':=20'yes',=20=
'IPV6INIT':=20'yes',=20'NAME':=20'eno2',=20'IPV6_PEERDNS':=20'yes',=20=
'DEFROUTE':=20'yes',=20'UUID':=20'9d958f30-d3c9-42a5-96f9-6362268ce048',=20=
'PEERDNS':=20'yes',=20'IPV4_FAILURE_FATAL':=20'no',=20'IPV6_AUTOCONF':=20=
'yes',=20'BOOTPROTO':=20'dhcp',=20'IPV6_DEFROUTE':=20'yes',=20'HWADDR':=20=
'00:25:90:FA:5B:F9',=20'IPV6_FAILURE_FATAL':=20'no',=20'TYPE':=20=
'Ethernet',=20'ONBOOT':=20'no',=20'IPV6_PEERROUTES':=20'yes'},=20=
'hwaddr':=20'00:25:90:fa:5b:f9',=20'speed':=200,=20'gateway':=20''},=20=
'eno1':=20{'addr':=20'',=20'ipv6gateway':=20'::',=20'ipv6addrs':=20[],=20=
'mtu':=20'1500',=20'dhcpv4':=20False,=20'netmask':=20'',=20'dhcpv6':=20=
False,=20'ipv4addrs':=20[],=20'cfg':=20{'PEERROUTES':=20'yes',=20=
'IPV6INIT':=20'yes',=20'NAME':=20'eno1',=20'IPV6_PEERDNS':=20'yes',=20=
'DEFROUTE':=20'yes',=20'UUID':=20'ad1e4309-419c-4b94-a75c-ebeacf7c811b',=20=
'PEERDNS':=20'yes',=20'IPV4_FAILURE_FATAL':=20'no',=20'IPV6_AUTOCONF':=20=
'yes',=20'BOOTPROTO':=20'dhcp',=20'IPV6_DEFROUTE':=20'yes',=20'HWADDR':=20=
'00:25:90:FA:5B:F8',=20'IPV6_FAILURE_FATAL':=20'no',=20'TYPE':=20=
'Ethernet',=20'ONBOOT':=20'no',=20'IPV6_PEERROUTES':=20'yes'},=20=
'hwaddr':=20'00:25:90:fa:5b:f8',=20'speed':=200,=20'gateway':=20''}},=20=
'software_revision':=20'0',=20'hostdevPassthrough':=20'false',=20=
'clusterLevels':=20['3.4',=20'3.5',=20'3.6'],=20'cpuFlags':=20=
'fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,c=
lflush,dts,acpi,mmx,fxsr,sse,sse2,ss,ht,tm,pbe,syscall,nx,pdpe1gb,rdtscp,l=
m,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,a=
perfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,smx,est,tm2,sss=
e3,fma,cx16,xtpr,pdcm,pcid,dca,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadl=
ine_timer,xsave,avx,f16c,rdrand,lahf_lm,abm,ida,arat,epb,pln,pts,dtherm,tp=
r_shadow,vnmi,flexpriority,ept,vpid,fsgsbase,tsc_adjust,bmi1,avx2,smep,bmi=
2,erms,invpcid,cqm,xsaveopt,cqm_llc,cqm_occup_llc,model_Nehalem,model_Conr=
oe,model_coreduo,model_core2duo,model_Penryn,model_n270',=20=
'ISCSIInitiatorName':=20'iqn.1994-05.com.redhat:82cdb6fe1f7',=20=
'netConfigDirty':=20'False',=20'supportedENGINEs':=20['3.4',=20'3.5',=20=
'3.6'],=20'autoNumaBalancing':=201,=20'additionalFeatures':=20[],=20=
'reservedMem':=20'321',=20'bondings':=20{'bond0':=20{'ipv4addrs':=20[],=20=
'addr':=20'',=20'cfg':=20{'BOOTPROTO':=20'none',=20'BONDING_OPTS':=20=
'mode=3D0'},=20'ipv6addrs':=20[],=20'active_slave':=20'',=20'mtu':=20=
'1500',=20'dhcpv4':=20False,=20'netmask':=20'',=20'dhcpv6':=20False,=20=
'slaves':=20[],=20'hwaddr':=20'9a:35:a4:87:95:9d',=20'ipv6gateway':=20=
'::',=20'gateway':=20'',=20'opts':=20{'mode':=20'0'}}},=20=
'software_version':=20'4.17',=20'memSize':=20'128665',=20'cpuSpeed':=20=
'2822.421',=20'numaNodes':=20{'1':=20{'totalMemory':=20'65536',=20=
'cpus':=20[10,=2011,=2012,=2013,=2014,=2015,=2016,=2017,=2018,=2019,=20=
30,=2031,=2032,=2033,=2034,=2035,=2036,=2037,=2038,=2039]},=20'0':=20=
{'totalMemory':=20'65428',=20'cpus':=20[0,=201,=202,=203,=204,=205,=206,=20=
7,=208,=209,=2020,=2021,=2022,=2023,=2024,=2025,=2026,=2027,=2028,=20=
29]}},=20'cpuSockets':=20'2',=20'vlans':=20{},=20'lastClientIface':=20=
'ens1f0',=20'cpuCores':=20'20',=20'kvmEnabled':=20'true',=20=
'guestOverhead':=20'65',=20'version_name':=20'Snow=20Man',=20=
'cpuThreads':=20'40',=20'emulatedMachines':=20['pc-i440fx-rhel7.1.0',=20=
'rhel6.3.0',=20'pc-q35-rhel7.2.0',=20'pc-i440fx-rhel7.0.0',=20=
'rhel6.1.0',=20'rhel6.6.0',=20'rhel6.2.0',=20'pc',=20'pc-q35-rhel7.0.0',=20=
'pc-q35-rhel7.1.0',=20'q35',=20'pc-i440fx-rhel7.2.0',=20'rhel6.4.0',=20=
'rhel6.0.0',=20'rhel6.5.0'],=20'rngSources':=20['random'],=20=
'operatingSystem':=20{'release':=20'2.1511.el7.centos.2.10',=20=
'version':=20'7',=20'name':=20'RHEL'}}=0A=
jsonrpc.Executor/3::DEBUG::2016-04-04=20=
15:07:47,285::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Calling=20'Host.getCapabilities'=20in=20bridge=20with=20{}=0A=
jsonrpc.Executor/3::DEBUG::2016-04-04=20=
15:07:47,298::netinfo::453::root::(_dhcp_used)=20There=20is=20no=20VDSM=20=
network=20configured=20on=20ens1f0.=0A=
jsonrpc.Executor/3::DEBUG::2016-04-04=20=
15:07:47,298::netinfo::453::root::(_dhcp_used)=20There=20is=20no=20VDSM=20=
network=20configured=20on=20ens1f0.=0A=
jsonrpc.Executor/3::DEBUG::2016-04-04=20=
15:07:47,298::netinfo::453::root::(_dhcp_used)=20There=20is=20no=20VDSM=20=
network=20configured=20on=20bond0.602.=0A=
jsonrpc.Executor/3::DEBUG::2016-04-04=20=
15:07:47,298::netinfo::453::root::(_dhcp_used)=20There=20is=20no=20VDSM=20=
network=20configured=20on=20bond0.602.=0A=
jsonrpc.Executor/3::INFO::2016-04-04=20=
15:07:47,298::netinfo::495::root::(_getNetInfo)=20Obtaining=20info=20for=20=
net=20bond0.602.=0ATraceback=20(most=20recent=20call=20last):=0A=20=20=
File=20"/usr/lib/python2.7/site-packages/vdsm/netinfo.py",=20line=20492,=20=
in=20_getNetInfo=0A=20=20=20=20'mtu':=20str(getMtu(iface))})=0A=20=20=
File=20"/usr/lib/python2.7/site-packages/vdsm/netinfo.py",=20line=20191,=20=
in=20getMtu=0A=20=20=20=20with=20open('/sys/class/net/%s/mtu'=20%=20=
iface)=20as=20f:=0AIOError:=20[Errno=202]=20No=20such=20file=20or=20=
directory:=20'/sys/class/net/bond0.602/mtu'=0A=
jsonrpc.Executor/3::DEBUG::2016-04-04=20=
15:07:47,302::utils::671::root::(execCmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20/usr/sbin/tc=20qdisc=20show=20(cwd=20None)=0A=
jsonrpc.Executor/3::DEBUG::2016-04-04=20=
15:07:47,309::utils::689::root::(execCmd)=20SUCCESS:=20<err>=20=3D=20'';=20=
<rc>=20=3D=200=0Ajsonrpc.Executor/3::DEBUG::2016-04-04=20=
15:07:47,309::utils::671::root::(execCmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20/usr/sbin/tc=20class=20show=20dev=20ens1f0=20classid=20=
0:1388=20(cwd=20None)=0Ajsonrpc.Executor/3::DEBUG::2016-04-04=20=
15:07:47,314::utils::689::root::(execCmd)=20SUCCESS:=20<err>=20=3D=20'';=20=
<rc>=20=3D=200=0Ajsonrpc.Executor/3::DEBUG::2016-04-04=20=
15:07:47,323::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Return=20'Host.getCapabilities'=20in=20bridge=20with=20{'HBAInventory':=20=
{'iSCSI':=20[{'InitiatorName':=20'iqn.1994-05.com.redhat:82cdb6fe1f7'}],=20=
'FC':=20[]},=20'packages2':=20{'kernel':=20{'release':=20=
'327.10.1.el7.x86_64',=20'buildtime':=201455638630.0,=20'version':=20=
'3.10.0'},=20'spice-server':=20{'release':=20'15.el7',=20'buildtime':=20=
1448026017L,=20'version':=20'0.12.4'},=20'librbd1':=20{'release':=20=
'3.el7',=20'buildtime':=201448036424L,=20'version':=20'0.80.7'},=20=
'vdsm':=20{'release':=20'0.el7.centos',=20'buildtime':=201459239759L,=20=
'version':=20'4.17.23.2'},=20'qemu-kvm':=20{'release':=20'31.el7_2.7.1',=20=
'buildtime':=201454322367L,=20'version':=20'2.3.0'},=20'libvirt':=20=
{'release':=20'13.el7_2.3',=20'buildtime':=201455642692L,=20'version':=20=
'1.2.17'},=20'qemu-img':=20{'release':=20'31.el7_2.7.1',=20'buildtime':=20=
1454322367L,=20'version':=20'2.3.0'},=20'mom':=20{'release':=20=
'1.el7.centos',=20'buildtime':=201453738202L,=20'version':=20'0.5.2'},=20=
'glusterfs-cli':=20{'release':=20'16.0.1.el7.centos',=20'buildtime':=20=
1457616516L,=20'version':=20'3.7.1'}},=20'numaNodeDistance':=20{'1':=20=
[21,=2010],=20'0':=20[10,=2021]},=20'cpuModel':=20'Intel(R)=20Xeon(R)=20=
CPU=20E5-2660=20v3=20@=202.60GHz',=20'liveMerge':=20'true',=20'hooks':=20=
{'before_nic_hotplug':=20{'50_vmfex':=20{'md5':=20=
'e05994261acaea7dcf4b88ea0e81f1f5'}},=20'before_vdsm_start':=20=
{'lro_off.sh':=20{'md5':=20'4f8117819fc321e9f7f0c94020b6938b'}},=20=
'before_device_migrate_destination':=20{'50_vmfex':=20{'md5':=20=
'e05994261acaea7dcf4b88ea0e81f1f5'}},=20'before_device_create':=20=
{'50_vmfex':=20{'md5':=20'e05994261acaea7dcf4b88ea0e81f1f5'}}},=20=
'vmTypes':=20['kvm'],=20'selinux':=20{'mode':=20'-1'},=20'liveSnapshot':=20=
'true',=20'kdumpStatus':=201,=20'networks':=20{'ovirtmgmt':=20{'iface':=20=
'ens1f0',=20'addr':=20'10.149.133.27',=20'bridged':=20False,=20=
'ipv6addrs':=20['fe80::ec4:7aff:fe52:de06/64'],=20'mtu':=20'1500',=20=
'dhcpv4':=20False,=20'netmask':=20'255.255.255.0',=20'dhcpv6':=20False,=20=
'ipv4addrs':=20['10.149.133.27/24'],=20'interface':=20'ens1f0',=20=
'ipv6gateway':=20'::',=20'gateway':=20'10.149.133.1'}},=20'bridges':=20=
{},=20'uuid':=20'00000000-0000-0000-0000-002590FA5BF8',=20'onlineCpus':=20=
'0,1,2,3,4,5,6,7,8,9,20,21,22,23,24,25,26,27,28,29,10,11,12,13,14,15,16,17=
,18,19,30,31,32,33,34,35,36,37,38,39',=20'nics':=20{'ens1f1':=20{'addr':=20=
'',=20'ipv6gateway':=20'::',=20'ipv6addrs':=20[],=20'mtu':=20'1500',=20=
'dhcpv4':=20False,=20'netmask':=20'',=20'dhcpv6':=20False,=20=
'ipv4addrs':=20[],=20'cfg':=20{'PEERROUTES':=20'yes',=20'IPV6INIT':=20=
'yes',=20'NAME':=20'ens1f1',=20'IPV6_PEERDNS':=20'yes',=20'DEFROUTE':=20=
'yes',=20'UUID':=20'9083efc6-b54f-4584-92cc-272e0ee2feaf',=20'PEERDNS':=20=
'yes',=20'IPV4_FAILURE_FATAL':=20'no',=20'IPV6_AUTOCONF':=20'yes',=20=
'BOOTPROTO':=20'dhcp',=20'IPV6_DEFROUTE':=20'yes',=20'HWADDR':=20=
'0C:C4:7A:52:DE:07',=20'IPV6_FAILURE_FATAL':=20'no',=20'TYPE':=20=
'Ethernet',=20'ONBOOT':=20'no',=20'IPV6_PEERROUTES':=20'yes'},=20=
'hwaddr':=20'0c:c4:7a:52:de:07',=20'speed':=200,=20'gateway':=20''},=20=
'ens1f0':=20{'addr':=20'10.149.133.27',=20'ipv6gateway':=20'::',=20=
'ipv6addrs':=20['fe80::ec4:7aff:fe52:de06/64'],=20'mtu':=20'1500',=20=
'dhcpv4':=20False,=20'netmask':=20'255.255.255.0',=20'dhcpv6':=20False,=20=
'ipv4addrs':=20['10.149.133.27/24'],=20'cfg':=20{'HWADDR':=20=
'0C:C4:7A:52:DE:06',=20'IPV6INIT':=20'yes',=20'NAME':=20'ens1f0',=20=
'IPV6_PEERROUTES':=20'yes',=20'DEFROUTE':=20'yes',=20'NETBOOT':=20'yes',=20=
'IPV6_PEERDNS':=20'yes',=20'IPADDR':=20'10.149.133.27',=20'GATEWAY':=20=
'10.149.133.1',=20'IPV6_AUTOCONF':=20'yes',=20'PREFIX':=20'24',=20=
'BOOTPROTO':=20'none',=20'IPV6_DEFROUTE':=20'yes',=20'DEVICE':=20=
'ens1f0',=20'IPV6_FAILURE_FATAL':=20'no',=20'DNS1':=20'10.148.125.237',=20=
'IPV4_FAILURE_FATAL':=20'no',=20'TYPE':=20'Ethernet',=20'ONBOOT':=20=
'yes',=20'UUID':=20'a6e93be4-5fa5-4567-b205-adfd3fa96c45'},=20'hwaddr':=20=
'0c:c4:7a:52:de:06',=20'speed':=201000,=20'gateway':=20'10.149.133.1'},=20=
'eno2':=20{'addr':=20'',=20'ipv6gateway':=20'::',=20'ipv6addrs':=20[],=20=
'mtu':=20'1500',=20'dhcpv4':=20False,=20'netmask':=20'',=20'dhcpv6':=20=
False,=20'ipv4addrs':=20[],=20'cfg':=20{'PEERROUTES':=20'yes',=20=
'IPV6INIT':=20'yes',=20'NAME':=20'eno2',=20'IPV6_PEERDNS':=20'yes',=20=
'DEFROUTE':=20'yes',=20'UUID':=20'9d958f30-d3c9-42a5-96f9-6362268ce048',=20=
'PEERDNS':=20'yes',=20'IPV4_FAILURE_FATAL':=20'no',=20'IPV6_AUTOCONF':=20=
'yes',=20'BOOTPROTO':=20'dhcp',=20'IPV6_DEFROUTE':=20'yes',=20'HWADDR':=20=
'00:25:90:FA:5B:F9',=20'IPV6_FAILURE_FATAL':=20'no',=20'TYPE':=20=
'Ethernet',=20'ONBOOT':=20'no',=20'IPV6_PEERROUTES':=20'yes'},=20=
'hwaddr':=20'00:25:90:fa:5b:f9',=20'speed':=200,=20'gateway':=20''},=20=
'eno1':=20{'addr':=20'',=20'ipv6gateway':=20'::',=20'ipv6addrs':=20[],=20=
'mtu':=20'1500',=20'dhcpv4':=20False,=20'netmask':=20'',=20'dhcpv6':=20=
False,=20'ipv4addrs':=20[],=20'cfg':=20{'PEERROUTES':=20'yes',=20=
'IPV6INIT':=20'yes',=20'NAME':=20'eno1',=20'IPV6_PEERDNS':=20'yes',=20=
'DEFROUTE':=20'yes',=20'UUID':=20'ad1e4309-419c-4b94-a75c-ebeacf7c811b',=20=
'PEERDNS':=20'yes',=20'IPV4_FAILURE_FATAL':=20'no',=20'IPV6_AUTOCONF':=20=
'yes',=20'BOOTPROTO':=20'dhcp',=20'IPV6_DEFROUTE':=20'yes',=20'HWADDR':=20=
'00:25:90:FA:5B:F8',=20'IPV6_FAILURE_FATAL':=20'no',=20'TYPE':=20=
'Ethernet',=20'ONBOOT':=20'no',=20'IPV6_PEERROUTES':=20'yes'},=20=
'hwaddr':=20'00:25:90:fa:5b:f8',=20'speed':=200,=20'gateway':=20''}},=20=
'software_revision':=20'0',=20'hostdevPassthrough':=20'false',=20=
'clusterLevels':=20['3.4',=20'3.5',=20'3.6'],=20'cpuFlags':=20=
'fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,c=
lflush,dts,acpi,mmx,fxsr,sse,sse2,ss,ht,tm,pbe,syscall,nx,pdpe1gb,rdtscp,l=
m,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,a=
perfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,smx,est,tm2,sss=
e3,fma,cx16,xtpr,pdcm,pcid,dca,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadl=
ine_timer,xsave,avx,f16c,rdrand,lahf_lm,abm,ida,arat,epb,pln,pts,dtherm,tp=
r_shadow,vnmi,flexpriority,ept,vpid,fsgsbase,tsc_adjust,bmi1,avx2,smep,bmi=
2,erms,invpcid,cqm,xsaveopt,cqm_llc,cqm_occup_llc,model_Nehalem,model_Conr=
oe,model_coreduo,model_core2duo,model_Penryn,model_n270',=20=
'ISCSIInitiatorName':=20'iqn.1994-05.com.redhat:82cdb6fe1f7',=20=
'netConfigDirty':=20'False',=20'supportedENGINEs':=20['3.4',=20'3.5',=20=
'3.6'],=20'autoNumaBalancing':=201,=20'additionalFeatures':=20[],=20=
'reservedMem':=20'321',=20'bondings':=20{'bond0':=20{'ipv4addrs':=20[],=20=
'addr':=20'',=20'cfg':=20{'BOOTPROTO':=20'none',=20'BONDING_OPTS':=20=
'mode=3D0'},=20'ipv6addrs':=20[],=20'active_slave':=20'',=20'mtu':=20=
'1500',=20'dhcpv4':=20False,=20'netmask':=20'',=20'dhcpv6':=20False,=20=
'slaves':=20[],=20'hwaddr':=20'9a:35:a4:87:95:9d',=20'ipv6gateway':=20=
'::',=20'gateway':=20'',=20'opts':=20{'mode':=20'0'}}},=20=
'software_version':=20'4.17',=20'memSize':=20'128665',=20'cpuSpeed':=20=
'1640.742',=20'numaNodes':=20{'1':=20{'totalMemory':=20'65536',=20=
'cpus':=20[10,=2011,=2012,=2013,=2014,=2015,=2016,=2017,=2018,=2019,=20=
30,=2031,=2032,=2033,=2034,=2035,=2036,=2037,=2038,=2039]},=20'0':=20=
{'totalMemory':=20'65428',=20'cpus':=20[0,=201,=202,=203,=204,=205,=206,=20=
7,=208,=209,=2020,=2021,=2022,=2023,=2024,=2025,=2026,=2027,=2028,=20=
29]}},=20'cpuSockets':=20'2',=20'vlans':=20{},=20'lastClientIface':=20=
'ens1f0',=20'cpuCores':=20'20',=20'kvmEnabled':=20'true',=20=
'guestOverhead':=20'65',=20'version_name':=20'Snow=20Man',=20=
'cpuThreads':=20'40',=20'emulatedMachines':=20['pc-i440fx-rhel7.1.0',=20=
'rhel6.3.0',=20'pc-q35-rhel7.2.0',=20'pc-i440fx-rhel7.0.0',=20=
'rhel6.1.0',=20'rhel6.6.0',=20'rhel6.2.0',=20'pc',=20'pc-q35-rhel7.0.0',=20=
'pc-q35-rhel7.1.0',=20'q35',=20'pc-i440fx-rhel7.2.0',=20'rhel6.4.0',=20=
'rhel6.0.0',=20'rhel6.5.0'],=20'rngSources':=20['random'],=20=
'operatingSystem':=20{'release':=20'2.1511.el7.centos.2.10',=20=
'version':=20'7',=20'name':=20'RHEL'}}=0A=
jsonrpc.Executor/4::DEBUG::2016-04-04=20=
15:07:47,398::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Calling=20'Host.getHardwareInfo'=20in=20bridge=20with=20{}=0A=
jsonrpc.Executor/4::DEBUG::2016-04-04=20=
15:07:47,437::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Return=20'Host.getHardwareInfo'=20in=20bridge=20with=20=
{'systemProductName':=20'SYS-2028TP-HC1TR',=20'systemSerialNumber':=20=
'S16549025214470',=20'systemFamily':=20'To=20be=20filled=20by=20O.E.M.',=20=
'systemVersion':=20'0123456789',=20'systemUUID':=20=
'00000000-0000-0000-0000-002590FA5BF8',=20'systemManufacturer':=20=
'Supermicro'}=0Ajsonrpc.Executor/5::DEBUG::2016-04-04=20=
15:07:47,894::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Calling=20'Host.getCapabilities'=20in=20bridge=20with=20{}=0A=
jsonrpc.Executor/5::DEBUG::2016-04-04=20=
15:07:47,906::netinfo::453::root::(_dhcp_used)=20There=20is=20no=20VDSM=20=
network=20configured=20on=20ens1f0.=0A=
jsonrpc.Executor/5::DEBUG::2016-04-04=20=
15:07:47,906::netinfo::453::root::(_dhcp_used)=20There=20is=20no=20VDSM=20=
network=20configured=20on=20ens1f0.=0A=
jsonrpc.Executor/5::DEBUG::2016-04-04=20=
15:07:47,907::netinfo::453::root::(_dhcp_used)=20There=20is=20no=20VDSM=20=
network=20configured=20on=20bond0.602.=0A=
jsonrpc.Executor/5::DEBUG::2016-04-04=20=
15:07:47,907::netinfo::453::root::(_dhcp_used)=20There=20is=20no=20VDSM=20=
network=20configured=20on=20bond0.602.=0A=
jsonrpc.Executor/5::INFO::2016-04-04=20=
15:07:47,907::netinfo::495::root::(_getNetInfo)=20Obtaining=20info=20for=20=
net=20bond0.602.=0ATraceback=20(most=20recent=20call=20last):=0A=20=20=
File=20"/usr/lib/python2.7/site-packages/vdsm/netinfo.py",=20line=20492,=20=
in=20_getNetInfo=0A=20=20=20=20'mtu':=20str(getMtu(iface))})=0A=20=20=
File=20"/usr/lib/python2.7/site-packages/vdsm/netinfo.py",=20line=20191,=20=
in=20getMtu=0A=20=20=20=20with=20open('/sys/class/net/%s/mtu'=20%=20=
iface)=20as=20f:=0AIOError:=20[Errno=202]=20No=20such=20file=20or=20=
directory:=20'/sys/class/net/bond0.602/mtu'=0A=
jsonrpc.Executor/5::DEBUG::2016-04-04=20=
15:07:47,910::utils::671::root::(execCmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20/usr/sbin/tc=20qdisc=20show=20(cwd=20None)=0A=
jsonrpc.Executor/5::DEBUG::2016-04-04=20=
15:07:47,916::utils::689::root::(execCmd)=20SUCCESS:=20<err>=20=3D=20'';=20=
<rc>=20=3D=200=0Ajsonrpc.Executor/5::DEBUG::2016-04-04=20=
15:07:47,916::utils::671::root::(execCmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20/usr/sbin/tc=20class=20show=20dev=20ens1f0=20classid=20=
0:1388=20(cwd=20None)=0Ajsonrpc.Executor/5::DEBUG::2016-04-04=20=
15:07:47,921::utils::689::root::(execCmd)=20SUCCESS:=20<err>=20=3D=20'';=20=
<rc>=20=3D=200=0Ajsonrpc.Executor/5::DEBUG::2016-04-04=20=
15:07:47,928::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Return=20'Host.getCapabilities'=20in=20bridge=20with=20{'HBAInventory':=20=
{'iSCSI':=20[{'InitiatorName':=20'iqn.1994-05.com.redhat:82cdb6fe1f7'}],=20=
'FC':=20[]},=20'packages2':=20{'kernel':=20{'release':=20=
'327.10.1.el7.x86_64',=20'buildtime':=201455638630.0,=20'version':=20=
'3.10.0'},=20'spice-server':=20{'release':=20'15.el7',=20'buildtime':=20=
1448026017L,=20'version':=20'0.12.4'},=20'librbd1':=20{'release':=20=
'3.el7',=20'buildtime':=201448036424L,=20'version':=20'0.80.7'},=20=
'vdsm':=20{'release':=20'0.el7.centos',=20'buildtime':=201459239759L,=20=
'version':=20'4.17.23.2'},=20'qemu-kvm':=20{'release':=20'31.el7_2.7.1',=20=
'buildtime':=201454322367L,=20'version':=20'2.3.0'},=20'libvirt':=20=
{'release':=20'13.el7_2.3',=20'buildtime':=201455642692L,=20'version':=20=
'1.2.17'},=20'qemu-img':=20{'release':=20'31.el7_2.7.1',=20'buildtime':=20=
1454322367L,=20'version':=20'2.3.0'},=20'mom':=20{'release':=20=
'1.el7.centos',=20'buildtime':=201453738202L,=20'version':=20'0.5.2'},=20=
'glusterfs-cli':=20{'release':=20'16.0.1.el7.centos',=20'buildtime':=20=
1457616516L,=20'version':=20'3.7.1'}},=20'numaNodeDistance':=20{'1':=20=
[21,=2010],=20'0':=20[10,=2021]},=20'cpuModel':=20'Intel(R)=20Xeon(R)=20=
CPU=20E5-2660=20v3=20@=202.60GHz',=20'liveMerge':=20'true',=20'hooks':=20=
{'before_nic_hotplug':=20{'50_vmfex':=20{'md5':=20=
'e05994261acaea7dcf4b88ea0e81f1f5'}},=20'before_vdsm_start':=20=
{'lro_off.sh':=20{'md5':=20'4f8117819fc321e9f7f0c94020b6938b'}},=20=
'before_device_migrate_destination':=20{'50_vmfex':=20{'md5':=20=
'e05994261acaea7dcf4b88ea0e81f1f5'}},=20'before_device_create':=20=
{'50_vmfex':=20{'md5':=20'e05994261acaea7dcf4b88ea0e81f1f5'}}},=20=
'vmTypes':=20['kvm'],=20'selinux':=20{'mode':=20'-1'},=20'liveSnapshot':=20=
'true',=20'kdumpStatus':=201,=20'networks':=20{'ovirtmgmt':=20{'iface':=20=
'ens1f0',=20'addr':=20'10.149.133.27',=20'bridged':=20False,=20=
'ipv6addrs':=20['fe80::ec4:7aff:fe52:de06/64'],=20'mtu':=20'1500',=20=
'dhcpv4':=20False,=20'netmask':=20'255.255.255.0',=20'dhcpv6':=20False,=20=
'ipv4addrs':=20['10.149.133.27/24'],=20'interface':=20'ens1f0',=20=
'ipv6gateway':=20'::',=20'gateway':=20'10.149.133.1'}},=20'bridges':=20=
{},=20'uuid':=20'00000000-0000-0000-0000-002590FA5BF8',=20'onlineCpus':=20=
'0,1,2,3,4,5,6,7,8,9,20,21,22,23,24,25,26,27,28,29,10,11,12,13,14,15,16,17=
,18,19,30,31,32,33,34,35,36,37,38,39',=20'nics':=20{'ens1f1':=20{'addr':=20=
'',=20'ipv6gateway':=20'::',=20'ipv6addrs':=20[],=20'mtu':=20'1500',=20=
'dhcpv4':=20False,=20'netmask':=20'',=20'dhcpv6':=20False,=20=
'ipv4addrs':=20[],=20'cfg':=20{'PEERROUTES':=20'yes',=20'IPV6INIT':=20=
'yes',=20'NAME':=20'ens1f1',=20'IPV6_PEERDNS':=20'yes',=20'DEFROUTE':=20=
'yes',=20'UUID':=20'9083efc6-b54f-4584-92cc-272e0ee2feaf',=20'PEERDNS':=20=
'yes',=20'IPV4_FAILURE_FATAL':=20'no',=20'IPV6_AUTOCONF':=20'yes',=20=
'BOOTPROTO':=20'dhcp',=20'IPV6_DEFROUTE':=20'yes',=20'HWADDR':=20=
'0C:C4:7A:52:DE:07',=20'IPV6_FAILURE_FATAL':=20'no',=20'TYPE':=20=
'Ethernet',=20'ONBOOT':=20'no',=20'IPV6_PEERROUTES':=20'yes'},=20=
'hwaddr':=20'0c:c4:7a:52:de:07',=20'speed':=200,=20'gateway':=20''},=20=
'ens1f0':=20{'addr':=20'10.149.133.27',=20'ipv6gateway':=20'::',=20=
'ipv6addrs':=20['fe80::ec4:7aff:fe52:de06/64'],=20'mtu':=20'1500',=20=
'dhcpv4':=20False,=20'netmask':=20'255.255.255.0',=20'dhcpv6':=20False,=20=
'ipv4addrs':=20['10.149.133.27/24'],=20'cfg':=20{'HWADDR':=20=
'0C:C4:7A:52:DE:06',=20'IPV6INIT':=20'yes',=20'NAME':=20'ens1f0',=20=
'IPV6_PEERROUTES':=20'yes',=20'DEFROUTE':=20'yes',=20'NETBOOT':=20'yes',=20=
'IPV6_PEERDNS':=20'yes',=20'IPADDR':=20'10.149.133.27',=20'GATEWAY':=20=
'10.149.133.1',=20'IPV6_AUTOCONF':=20'yes',=20'PREFIX':=20'24',=20=
'BOOTPROTO':=20'none',=20'IPV6_DEFROUTE':=20'yes',=20'DEVICE':=20=
'ens1f0',=20'IPV6_FAILURE_FATAL':=20'no',=20'DNS1':=20'10.148.125.237',=20=
'IPV4_FAILURE_FATAL':=20'no',=20'TYPE':=20'Ethernet',=20'ONBOOT':=20=
'yes',=20'UUID':=20'a6e93be4-5fa5-4567-b205-adfd3fa96c45'},=20'hwaddr':=20=
'0c:c4:7a:52:de:06',=20'speed':=201000,=20'gateway':=20'10.149.133.1'},=20=
'eno2':=20{'addr':=20'',=20'ipv6gateway':=20'::',=20'ipv6addrs':=20[],=20=
'mtu':=20'1500',=20'dhcpv4':=20False,=20'netmask':=20'',=20'dhcpv6':=20=
False,=20'ipv4addrs':=20[],=20'cfg':=20{'PEERROUTES':=20'yes',=20=
'IPV6INIT':=20'yes',=20'NAME':=20'eno2',=20'IPV6_PEERDNS':=20'yes',=20=
'DEFROUTE':=20'yes',=20'UUID':=20'9d958f30-d3c9-42a5-96f9-6362268ce048',=20=
'PEERDNS':=20'yes',=20'IPV4_FAILURE_FATAL':=20'no',=20'IPV6_AUTOCONF':=20=
'yes',=20'BOOTPROTO':=20'dhcp',=20'IPV6_DEFROUTE':=20'yes',=20'HWADDR':=20=
'00:25:90:FA:5B:F9',=20'IPV6_FAILURE_FATAL':=20'no',=20'TYPE':=20=
'Ethernet',=20'ONBOOT':=20'no',=20'IPV6_PEERROUTES':=20'yes'},=20=
'hwaddr':=20'00:25:90:fa:5b:f9',=20'speed':=200,=20'gateway':=20''},=20=
'eno1':=20{'addr':=20'',=20'ipv6gateway':=20'::',=20'ipv6addrs':=20[],=20=
'mtu':=20'1500',=20'dhcpv4':=20False,=20'netmask':=20'',=20'dhcpv6':=20=
False,=20'ipv4addrs':=20[],=20'cfg':=20{'PEERROUTES':=20'yes',=20=
'IPV6INIT':=20'yes',=20'NAME':=20'eno1',=20'IPV6_PEERDNS':=20'yes',=20=
'DEFROUTE':=20'yes',=20'UUID':=20'ad1e4309-419c-4b94-a75c-ebeacf7c811b',=20=
'PEERDNS':=20'yes',=20'IPV4_FAILURE_FATAL':=20'no',=20'IPV6_AUTOCONF':=20=
'yes',=20'BOOTPROTO':=20'dhcp',=20'IPV6_DEFROUTE':=20'yes',=20'HWADDR':=20=
'00:25:90:FA:5B:F8',=20'IPV6_FAILURE_FATAL':=20'no',=20'TYPE':=20=
'Ethernet',=20'ONBOOT':=20'no',=20'IPV6_PEERROUTES':=20'yes'},=20=
'hwaddr':=20'00:25:90:fa:5b:f8',=20'speed':=200,=20'gateway':=20''}},=20=
'software_revision':=20'0',=20'hostdevPassthrough':=20'false',=20=
'clusterLevels':=20['3.4',=20'3.5',=20'3.6'],=20'cpuFlags':=20=
'fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,c=
lflush,dts,acpi,mmx,fxsr,sse,sse2,ss,ht,tm,pbe,syscall,nx,pdpe1gb,rdtscp,l=
m,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_tsc,a=
perfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,smx,est,tm2,sss=
e3,fma,cx16,xtpr,pdcm,pcid,dca,sse4_1,sse4_2,x2apic,movbe,popcnt,tsc_deadl=
ine_timer,xsave,avx,f16c,rdrand,lahf_lm,abm,ida,arat,epb,pln,pts,dtherm,tp=
r_shadow,vnmi,flexpriority,ept,vpid,fsgsbase,tsc_adjust,bmi1,avx2,smep,bmi=
2,erms,invpcid,cqm,xsaveopt,cqm_llc,cqm_occup_llc,model_Nehalem,model_Conr=
oe,model_coreduo,model_core2duo,model_Penryn,model_n270',=20=
'ISCSIInitiatorName':=20'iqn.1994-05.com.redhat:82cdb6fe1f7',=20=
'netConfigDirty':=20'False',=20'supportedENGINEs':=20['3.4',=20'3.5',=20=
'3.6'],=20'autoNumaBalancing':=201,=20'additionalFeatures':=20[],=20=
'reservedMem':=20'321',=20'bondings':=20{'bond0':=20{'ipv4addrs':=20[],=20=
'addr':=20'',=20'cfg':=20{'BOOTPROTO':=20'none',=20'BONDING_OPTS':=20=
'mode=3D0'},=20'ipv6addrs':=20[],=20'active_slave':=20'',=20'mtu':=20=
'1500',=20'dhcpv4':=20False,=20'netmask':=20'',=20'dhcpv6':=20False,=20=
'slaves':=20[],=20'hwaddr':=20'9a:35:a4:87:95:9d',=20'ipv6gateway':=20=
'::',=20'gateway':=20'',=20'opts':=20{'mode':=20'0'}}},=20=
'software_version':=20'4.17',=20'memSize':=20'128665',=20'cpuSpeed':=20=
'1411.312',=20'numaNodes':=20{'1':=20{'totalMemory':=20'65536',=20=
'cpus':=20[10,=2011,=2012,=2013,=2014,=2015,=2016,=2017,=2018,=2019,=20=
30,=2031,=2032,=2033,=2034,=2035,=2036,=2037,=2038,=2039]},=20'0':=20=
{'totalMemory':=20'65428',=20'cpus':=20[0,=201,=202,=203,=204,=205,=206,=20=
7,=208,=209,=2020,=2021,=2022,=2023,=2024,=2025,=2026,=2027,=2028,=20=
29]}},=20'cpuSockets':=20'2',=20'vlans':=20{},=20'lastClientIface':=20=
'ens1f0',=20'cpuCores':=20'20',=20'kvmEnabled':=20'true',=20=
'guestOverhead':=20'65',=20'version_name':=20'Snow=20Man',=20=
'cpuThreads':=20'40',=20'emulatedMachines':=20['pc-i440fx-rhel7.1.0',=20=
'rhel6.3.0',=20'pc-q35-rhel7.2.0',=20'pc-i440fx-rhel7.0.0',=20=
'rhel6.1.0',=20'rhel6.6.0',=20'rhel6.2.0',=20'pc',=20'pc-q35-rhel7.0.0',=20=
'pc-q35-rhel7.1.0',=20'q35',=20'pc-i440fx-rhel7.2.0',=20'rhel6.4.0',=20=
'rhel6.0.0',=20'rhel6.5.0'],=20'rngSources':=20['random'],=20=
'operatingSystem':=20{'release':=20'2.1511.el7.centos.2.10',=20=
'version':=20'7',=20'name':=20'RHEL'}}=0A=
jsonrpc.Executor/6::DEBUG::2016-04-04=20=
15:07:47,937::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Calling=20'Host.getHardwareInfo'=20in=20bridge=20with=20{}=0A=
jsonrpc.Executor/6::DEBUG::2016-04-04=20=
15:07:47,938::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Return=20'Host.getHardwareInfo'=20in=20bridge=20with=20=
{'systemProductName':=20'SYS-2028TP-HC1TR',=20'systemSerialNumber':=20=
'S16549025214470',=20'systemFamily':=20'To=20be=20filled=20by=20O.E.M.',=20=
'systemVersion':=20'0123456789',=20'systemUUID':=20=
'00000000-0000-0000-0000-002590FA5BF8',=20'systemManufacturer':=20=
'Supermicro'}=0Ajsonrpc.Executor/7::DEBUG::2016-04-04=20=
15:07:55,287::task::595::Storage.TaskManager.Task::(_updateState)=20=
Task=3D`e10f06fe-72fb-445e-bcb1-d0f12266f1bf`::moving=20from=20state=20=
init=20->=20state=20preparing=0Ajsonrpc.Executor/7::INFO::2016-04-04=20=
15:07:55,288::logUtils::48::dispatcher::(wrapper)=20Run=20and=20protect:=20=
repoStats(options=3DNone)=0Ajsonrpc.Executor/7::INFO::2016-04-04=20=
15:07:55,288::logUtils::51::dispatcher::(wrapper)=20Run=20and=20protect:=20=
repoStats,=20Return=20response:=20{}=0A=
jsonrpc.Executor/7::DEBUG::2016-04-04=20=
15:07:55,288::task::1191::Storage.TaskManager.Task::(prepare)=20=
Task=3D`e10f06fe-72fb-445e-bcb1-d0f12266f1bf`::finished:=20{}=0A=
jsonrpc.Executor/7::DEBUG::2016-04-04=20=
15:07:55,288::task::595::Storage.TaskManager.Task::(_updateState)=20=
Task=3D`e10f06fe-72fb-445e-bcb1-d0f12266f1bf`::moving=20from=20state=20=
preparing=20->=20state=20finished=0A=
jsonrpc.Executor/7::DEBUG::2016-04-04=20=
15:07:55,288::resourceManager::943::Storage.ResourceManager.Owner::(releas=
eAll)=20Owner.releaseAll=20requests=20{}=20resources=20{}=0A=
jsonrpc.Executor/7::DEBUG::2016-04-04=20=
15:07:55,288::resourceManager::980::Storage.ResourceManager.Owner::(cancel=
All)=20Owner.cancelAll=20requests=20{}=0A=
jsonrpc.Executor/7::DEBUG::2016-04-04=20=
15:07:55,288::task::993::Storage.TaskManager.Task::(_decref)=20=
Task=3D`e10f06fe-72fb-445e-bcb1-d0f12266f1bf`::ref=200=20aborting=20=
False=0Ajsonrpc.Executor/0::DEBUG::2016-04-04=20=
15:07:55,387::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Calling=20'StoragePool.disconnect'=20in=20bridge=20with=20=
{u'storagepoolID':=20u'5498ceb7-80b1-4d8f-9e74-938478109289',=20=
u'scsiKey':=20u'5498ceb7-80b1-4d8f-9e74-938478109289',=20u'hostID':=204}=0A=
jsonrpc.Executor/0::DEBUG::2016-04-04=20=
15:07:55,387::task::595::Storage.TaskManager.Task::(_updateState)=20=
Task=3D`ba1fe393-2193-4be5-a122-3492eba664b4`::moving=20from=20state=20=
init=20->=20state=20preparing=0Ajsonrpc.Executor/0::INFO::2016-04-04=20=
15:07:55,388::logUtils::48::dispatcher::(wrapper)=20Run=20and=20protect:=20=
disconnectStoragePool(spUUID=3Du'5498ceb7-80b1-4d8f-9e74-938478109289',=20=
hostID=3D4,=20remove=3DFalse,=20options=3DNone)=0A=
jsonrpc.Executor/0::WARNING::2016-04-04=20=
15:07:55,388::hsm::1136::Storage.HSM::(disconnectStoragePool)=20=
disconnect=20sp:=205498ceb7-80b1-4d8f-9e74-938478109289=20failed.=20=
Known=20pools=20{}=0Ajsonrpc.Executor/0::INFO::2016-04-04=20=
15:07:55,388::logUtils::51::dispatcher::(wrapper)=20Run=20and=20protect:=20=
disconnectStoragePool,=20Return=20response:=20None=0A=
jsonrpc.Executor/0::DEBUG::2016-04-04=20=
15:07:55,388::task::1191::Storage.TaskManager.Task::(prepare)=20=
Task=3D`ba1fe393-2193-4be5-a122-3492eba664b4`::finished:=20None=0A=
jsonrpc.Executor/0::DEBUG::2016-04-04=20=
15:07:55,388::task::595::Storage.TaskManager.Task::(_updateState)=20=
Task=3D`ba1fe393-2193-4be5-a122-3492eba664b4`::moving=20from=20state=20=
preparing=20->=20state=20finished=0A=
jsonrpc.Executor/0::DEBUG::2016-04-04=20=
15:07:55,388::resourceManager::943::Storage.ResourceManager.Owner::(releas=
eAll)=20Owner.releaseAll=20requests=20{}=20resources=20{}=0A=
jsonrpc.Executor/0::DEBUG::2016-04-04=20=
15:07:55,388::resourceManager::980::Storage.ResourceManager.Owner::(cancel=
All)=20Owner.cancelAll=20requests=20{}=0A=
jsonrpc.Executor/0::DEBUG::2016-04-04=20=
15:07:55,388::task::993::Storage.TaskManager.Task::(_decref)=20=
Task=3D`ba1fe393-2193-4be5-a122-3492eba664b4`::ref=200=20aborting=20=
False=0Ajsonrpc.Executor/0::DEBUG::2016-04-04=20=
15:07:55,388::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Return=20'StoragePool.disconnect'=20in=20bridge=20with=20True=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,468::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Calling=20'StoragePool.disconnectStorageServer'=20in=20bridge=20with=20=
{u'connectionParams':=20[{u'id':=20=
u'b8287ae9-9831-4e4a-ad5d-72d3d064d973',=20u'connection':=20=
u'superstore235.svc.exam.org:/ovirtiso001',=20u'iqn':=20u'',=20u'user':=20=
u'',=20u'protocol_version':=20u'3',=20u'tpgt':=20u'1',=20u'password':=20=
'********',=20u'port':=20u''}],=20u'storagepoolID':=20=
u'5498ceb7-80b1-4d8f-9e74-938478109289',=20u'domainType':=201}=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,468::task::595::Storage.TaskManager.Task::(_updateState)=20=
Task=3D`972c09c0-53e2-4b6a-883e-df0b87559c29`::moving=20from=20state=20=
init=20->=20state=20preparing=0Ajsonrpc.Executor/1::INFO::2016-04-04=20=
15:07:55,468::logUtils::48::dispatcher::(wrapper)=20Run=20and=20protect:=20=
disconnectStorageServer(domType=3D1,=20=
spUUID=3Du'5498ceb7-80b1-4d8f-9e74-938478109289',=20conList=3D[{u'id':=20=
u'b8287ae9-9831-4e4a-ad5d-72d3d064d973',=20u'connection':=20=
u'superstore235.svc.exam.org:/ovirtiso001',=20u'iqn':=20u'',=20u'user':=20=
u'',=20u'protocol_version':=20u'3',=20u'tpgt':=20u'1',=20u'password':=20=
'********',=20u'port':=20u''}],=20options=3DNone)=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,469::mount::229::Storage.Misc.excCmd::(_runcmd)=20=
/usr/bin/taskset=20--cpu-list=200-39=20/usr/bin/sudo=20-n=20=
/usr/bin/umount=20-f=20-l=20=
/rhev/data-center/mnt/superstore235.svc.exam.org:_ovirtiso001=20(cwd=20=
None)=0Ajsonrpc.Executor/1::ERROR::2016-04-04=20=
15:07:55,482::hsm::2557::Storage.HSM::(disconnectStorageServer)=20Could=20=
not=20disconnect=20from=20storageServer=0ATraceback=20(most=20recent=20=
call=20last):=0A=20=20File=20"/usr/share/vdsm/storage/hsm.py",=20line=20=
2553,=20in=20disconnectStorageServer=0A=20=20=20=20conObj.disconnect()=0A=
=20=20File=20"/usr/share/vdsm/storage/storageServer.py",=20line=20449,=20=
in=20disconnect=0A=20=20=20=20return=20self._mountCon.disconnect()=0A=20=20=
File=20"/usr/share/vdsm/storage/storageServer.py",=20line=20258,=20in=20=
disconnect=0A=20=20=20=20self._mount.umount(True,=20True)=0A=20=20File=20=
"/usr/share/vdsm/storage/mount.py",=20line=20256,=20in=20umount=0A=20=20=20=
=20return=20self._runcmd(cmd,=20timeout)=0A=20=20File=20=
"/usr/share/vdsm/storage/mount.py",=20line=20241,=20in=20_runcmd=0A=20=20=
=20=20raise=20MountError(rc,=20";".join((out,=20err)))=0AMountError:=20=
(32,=20';umount:=20=
/rhev/data-center/mnt/superstore235.svc.exam.org:_ovirtiso001:=20=
mountpoint=20not=20found\n')=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,488::misc::750::Storage.SamplingMethod::(__call__)=20Trying=20=
to=20enter=20sampling=20method=20(storage.sdc.refreshStorage)=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,488::misc::753::Storage.SamplingMethod::(__call__)=20Got=20in=20=
to=20sampling=20method=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,488::misc::750::Storage.SamplingMethod::(__call__)=20Trying=20=
to=20enter=20sampling=20method=20(storage.iscsi.rescan)=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,489::misc::753::Storage.SamplingMethod::(__call__)=20Got=20in=20=
to=20sampling=20method=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,489::iscsi::434::Storage.ISCSI::(rescan)=20Performing=20SCSI=20=
scan,=20this=20will=20take=20up=20to=2030=20seconds=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,489::iscsiadm::97::Storage.Misc.excCmd::(_runCmd)=20=
/usr/bin/taskset=20--cpu-list=200-39=20/usr/bin/sudo=20-n=20=
/sbin/iscsiadm=20-m=20session=20-R=20(cwd=20None)=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,500::misc::760::Storage.SamplingMethod::(__call__)=20Returning=20=
last=20result=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,500::misc::750::Storage.SamplingMethod::(__call__)=20Trying=20=
to=20enter=20sampling=20method=20(storage.hba.rescan)=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,500::misc::753::Storage.SamplingMethod::(__call__)=20Got=20in=20=
to=20sampling=20method=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,500::hba::56::Storage.HBA::(rescan)=20Starting=20scan=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,554::hba::62::Storage.HBA::(rescan)=20Scan=20finished=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,554::misc::760::Storage.SamplingMethod::(__call__)=20Returning=20=
last=20result=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,554::multipath::77::Storage.Misc.excCmd::(rescan)=20=
/usr/bin/taskset=20--cpu-list=200-39=20/usr/bin/sudo=20-n=20=
/usr/sbin/multipath=20(cwd=20None)=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,589::multipath::77::Storage.Misc.excCmd::(rescan)=20SUCCESS:=20=
<err>=20=3D=20'';=20<rc>=20=3D=200=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,590::utils::671::root::(execCmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20/sbin/udevadm=20settle=20--timeout=3D5=20(cwd=20=
None)=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,595::utils::689::root::(execCmd)=20SUCCESS:=20<err>=20=3D=20'';=20=
<rc>=20=3D=200=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,595::lvm::497::Storage.OperationMutex::(_invalidateAllPvs)=20=
Operation=20'lvm=20invalidate=20operation'=20got=20the=20operation=20=
mutex=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,595::lvm::499::Storage.OperationMutex::(_invalidateAllPvs)=20=
Operation=20'lvm=20invalidate=20operation'=20released=20the=20operation=20=
mutex=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,595::lvm::508::Storage.OperationMutex::(_invalidateAllVgs)=20=
Operation=20'lvm=20invalidate=20operation'=20got=20the=20operation=20=
mutex=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,595::lvm::510::Storage.OperationMutex::(_invalidateAllVgs)=20=
Operation=20'lvm=20invalidate=20operation'=20released=20the=20operation=20=
mutex=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,596::lvm::528::Storage.OperationMutex::(_invalidateAllLvs)=20=
Operation=20'lvm=20invalidate=20operation'=20got=20the=20operation=20=
mutex=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,596::lvm::530::Storage.OperationMutex::(_invalidateAllLvs)=20=
Operation=20'lvm=20invalidate=20operation'=20released=20the=20operation=20=
mutex=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,596::misc::760::Storage.SamplingMethod::(__call__)=20Returning=20=
last=20result=0Ajsonrpc.Executor/1::INFO::2016-04-04=20=
15:07:55,596::logUtils::51::dispatcher::(wrapper)=20Run=20and=20protect:=20=
disconnectStorageServer,=20Return=20response:=20{'statuslist':=20=
[{'status':=20477,=20'id':=20u'b8287ae9-9831-4e4a-ad5d-72d3d064d973'}]}=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,596::task::1191::Storage.TaskManager.Task::(prepare)=20=
Task=3D`972c09c0-53e2-4b6a-883e-df0b87559c29`::finished:=20=
{'statuslist':=20[{'status':=20477,=20'id':=20=
u'b8287ae9-9831-4e4a-ad5d-72d3d064d973'}]}=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,596::task::595::Storage.TaskManager.Task::(_updateState)=20=
Task=3D`972c09c0-53e2-4b6a-883e-df0b87559c29`::moving=20from=20state=20=
preparing=20->=20state=20finished=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,596::resourceManager::943::Storage.ResourceManager.Owner::(releas=
eAll)=20Owner.releaseAll=20requests=20{}=20resources=20{}=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,596::resourceManager::980::Storage.ResourceManager.Owner::(cancel=
All)=20Owner.cancelAll=20requests=20{}=0A=
jsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,596::task::993::Storage.TaskManager.Task::(_decref)=20=
Task=3D`972c09c0-53e2-4b6a-883e-df0b87559c29`::ref=200=20aborting=20=
False=0Ajsonrpc.Executor/1::DEBUG::2016-04-04=20=
15:07:55,597::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Return=20'StoragePool.disconnectStorageServer'=20in=20bridge=20with=20=
[{'status':=20477,=20'id':=20u'b8287ae9-9831-4e4a-ad5d-72d3d064d973'}]=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,644::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Calling=20'StoragePool.disconnectStorageServer'=20in=20bridge=20with=20=
{u'connectionParams':=20[{u'password':=20'********',=20u'id':=20=
u'5ea6a340-8e8b-43f5-b7a3-e9786429d968',=20u'connection':=20=
u'superstore235.svc.exam.org:ovirtp001',=20u'mnt_options':=20=
u'backupvolfile-server=3Dsuperstore236.svc.exam.org:superstore237.svc.exam=
.org',=20u'user':=20u'',=20u'tpgt':=20u'1',=20u'vfs_type':=20=
u'glusterfs',=20u'iqn':=20u'',=20u'port':=20u''},=20{u'password':=20=
'********',=20u'id':=20u'154c63b8-eee1-4e6d-a801-d51bfc93b720',=20=
u'connection':=20u'superstore235.svc.exam.org:ovirtd001',=20=
u'mnt_options':=20=
u'backupvolfile-server=3Dsuperstore236.svc.exam.org:superstore237.svc.exam=
.org',=20u'user':=20u'',=20u'tpgt':=20u'1',=20u'vfs_type':=20=
u'glusterfs',=20u'iqn':=20u'',=20u'port':=20u''},=20{u'password':=20=
'********',=20u'id':=20u'c3fb1655-0e9e-4e5c-be26-411638a3700b',=20=
u'connection':=20u'superstore235.svc.exam.org:ovirtt001',=20=
u'mnt_options':=20=
u'backupvolfile-server=3Dsuperstore236.svc.exam.org:superstore237.svc.exam=
.org',=20u'user':=20u'',=20u'tpgt':=20u'1',=20u'vfs_type':=20=
u'glusterfs',=20u'iqn':=20u'',=20u'port':=20u''},=20{u'password':=20=
'********',=20u'id':=20u'79549c5d-2b6d-4ef7-94ff-c041170952a9',=20=
u'connection':=20u'superstore235.svc.exam.org:ovirta001',=20=
u'mnt_options':=20=
u'backupvolfile-server=3Dsuperstore236.svc.exam.org:superstore237.svc.exam=
.org',=20u'user':=20u'',=20u'tpgt':=20u'1',=20u'vfs_type':=20=
u'glusterfs',=20u'iqn':=20u'',=20u'port':=20u''},=20{u'password':=20=
'********',=20u'id':=20u'b2ea5cf8-4772-45c9-8ca4-e12c7bf3f6c7',=20=
u'connection':=20u'superstore235.svc.exam.org:ovirtb001',=20=
u'mnt_options':=20=
u'backupvolfile-server=3Dsuperstore236.svc.exam.org:superstore237.svc.exam=
.org',=20u'user':=20u'',=20u'tpgt':=20u'1',=20u'vfs_type':=20=
u'glusterfs',=20u'iqn':=20u'',=20u'port':=20u''}],=20u'storagepoolID':=20=
u'5498ceb7-80b1-4d8f-9e74-938478109289',=20u'domainType':=207}=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,645::task::595::Storage.TaskManager.Task::(_updateState)=20=
Task=3D`7b579463-bb63-47d8-b750-a21de9233226`::moving=20from=20state=20=
init=20->=20state=20preparing=0Ajsonrpc.Executor/2::INFO::2016-04-04=20=
15:07:55,645::logUtils::48::dispatcher::(wrapper)=20Run=20and=20protect:=20=
disconnectStorageServer(domType=3D7,=20=
spUUID=3Du'5498ceb7-80b1-4d8f-9e74-938478109289',=20=
conList=3D[{u'password':=20'********',=20u'id':=20=
u'5ea6a340-8e8b-43f5-b7a3-e9786429d968',=20u'connection':=20=
u'superstore235.svc.exam.org:ovirtp001',=20u'mnt_options':=20=
u'backupvolfile-server=3Dsuperstore236.svc.exam.org:superstore237.svc.exam=
.org',=20u'user':=20u'',=20u'tpgt':=20u'1',=20u'vfs_type':=20=
u'glusterfs',=20u'iqn':=20u'',=20u'port':=20u''},=20{u'password':=20=
'********',=20u'id':=20u'154c63b8-eee1-4e6d-a801-d51bfc93b720',=20=
u'connection':=20u'superstore235.svc.exam.org:ovirtd001',=20=
u'mnt_options':=20=
u'backupvolfile-server=3Dsuperstore236.svc.exam.org:superstore237.svc.exam=
.org',=20u'user':=20u'',=20u'tpgt':=20u'1',=20u'vfs_type':=20=
u'glusterfs',=20u'iqn':=20u'',=20u'port':=20u''},=20{u'password':=20=
'********',=20u'id':=20u'c3fb1655-0e9e-4e5c-be26-411638a3700b',=20=
u'connection':=20u'superstore235.svc.exam.org:ovirtt001',=20=
u'mnt_options':=20=
u'backupvolfile-server=3Dsuperstore236.svc.exam.org:superstore237.svc.exam=
.org',=20u'user':=20u'',=20u'tpgt':=20u'1',=20u'vfs_type':=20=
u'glusterfs',=20u'iqn':=20u'',=20u'port':=20u''},=20{u'password':=20=
'********',=20u'id':=20u'79549c5d-2b6d-4ef7-94ff-c041170952a9',=20=
u'connection':=20u'superstore235.svc.exam.org:ovirta001',=20=
u'mnt_options':=20=
u'backupvolfile-server=3Dsuperstore236.svc.exam.org:superstore237.svc.exam=
.org',=20u'user':=20u'',=20u'tpgt':=20u'1',=20u'vfs_type':=20=
u'glusterfs',=20u'iqn':=20u'',=20u'port':=20u''},=20{u'password':=20=
'********',=20u'id':=20u'b2ea5cf8-4772-45c9-8ca4-e12c7bf3f6c7',=20=
u'connection':=20u'superstore235.svc.exam.org:ovirtb001',=20=
u'mnt_options':=20=
u'backupvolfile-server=3Dsuperstore236.svc.exam.org:superstore237.svc.exam=
.org',=20u'user':=20u'',=20u'tpgt':=20u'1',=20u'vfs_type':=20=
u'glusterfs',=20u'iqn':=20u'',=20u'port':=20u''}],=20options=3DNone)=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,646::mount::229::Storage.Misc.excCmd::(_runcmd)=20=
/usr/bin/taskset=20--cpu-list=200-39=20/usr/bin/sudo=20-n=20=
/usr/bin/umount=20-f=20-l=20=
/rhev/data-center/mnt/glusterSD/superstore235.svc.exam.org:ovirtp001=20=
(cwd=20None)=0Ajsonrpc.Executor/2::ERROR::2016-04-04=20=
15:07:55,656::hsm::2557::Storage.HSM::(disconnectStorageServer)=20Could=20=
not=20disconnect=20from=20storageServer=0ATraceback=20(most=20recent=20=
call=20last):=0A=20=20File=20"/usr/share/vdsm/storage/hsm.py",=20line=20=
2553,=20in=20disconnectStorageServer=0A=20=20=20=20conObj.disconnect()=0A=
=20=20File=20"/usr/share/vdsm/storage/storageServer.py",=20line=20258,=20=
in=20disconnect=0A=20=20=20=20self._mount.umount(True,=20True)=0A=20=20=
File=20"/usr/share/vdsm/storage/mount.py",=20line=20256,=20in=20umount=0A=
=20=20=20=20return=20self._runcmd(cmd,=20timeout)=0A=20=20File=20=
"/usr/share/vdsm/storage/mount.py",=20line=20241,=20in=20_runcmd=0A=20=20=
=20=20raise=20MountError(rc,=20";".join((out,=20err)))=0AMountError:=20=
(32,=20';umount:=20=
/rhev/data-center/mnt/glusterSD/superstore235.svc.exam.org:ovirtp001:=20=
mountpoint=20not=20found\n')=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,656::mount::229::Storage.Misc.excCmd::(_runcmd)=20=
/usr/bin/taskset=20--cpu-list=200-39=20/usr/bin/sudo=20-n=20=
/usr/bin/umount=20-f=20-l=20=
/rhev/data-center/mnt/glusterSD/superstore235.svc.exam.org:ovirtd001=20=
(cwd=20None)=0Ajsonrpc.Executor/2::ERROR::2016-04-04=20=
15:07:55,665::hsm::2557::Storage.HSM::(disconnectStorageServer)=20Could=20=
not=20disconnect=20from=20storageServer=0ATraceback=20(most=20recent=20=
call=20last):=0A=20=20File=20"/usr/share/vdsm/storage/hsm.py",=20line=20=
2553,=20in=20disconnectStorageServer=0A=20=20=20=20conObj.disconnect()=0A=
=20=20File=20"/usr/share/vdsm/storage/storageServer.py",=20line=20258,=20=
in=20disconnect=0A=20=20=20=20self._mount.umount(True,=20True)=0A=20=20=
File=20"/usr/share/vdsm/storage/mount.py",=20line=20256,=20in=20umount=0A=
=20=20=20=20return=20self._runcmd(cmd,=20timeout)=0A=20=20File=20=
"/usr/share/vdsm/storage/mount.py",=20line=20241,=20in=20_runcmd=0A=20=20=
=20=20raise=20MountError(rc,=20";".join((out,=20err)))=0AMountError:=20=
(32,=20';umount:=20=
/rhev/data-center/mnt/glusterSD/superstore235.svc.exam.org:ovirtd001:=20=
mountpoint=20not=20found\n')=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,666::mount::229::Storage.Misc.excCmd::(_runcmd)=20=
/usr/bin/taskset=20--cpu-list=200-39=20/usr/bin/sudo=20-n=20=
/usr/bin/umount=20-f=20-l=20=
/rhev/data-center/mnt/glusterSD/superstore235.svc.exam.org:ovirtt001=20=
(cwd=20None)=0Ajsonrpc.Executor/2::ERROR::2016-04-04=20=
15:07:55,675::hsm::2557::Storage.HSM::(disconnectStorageServer)=20Could=20=
not=20disconnect=20from=20storageServer=0ATraceback=20(most=20recent=20=
call=20last):=0A=20=20File=20"/usr/share/vdsm/storage/hsm.py",=20line=20=
2553,=20in=20disconnectStorageServer=0A=20=20=20=20conObj.disconnect()=0A=
=20=20File=20"/usr/share/vdsm/storage/storageServer.py",=20line=20258,=20=
in=20disconnect=0A=20=20=20=20self._mount.umount(True,=20True)=0A=20=20=
File=20"/usr/share/vdsm/storage/mount.py",=20line=20256,=20in=20umount=0A=
=20=20=20=20return=20self._runcmd(cmd,=20timeout)=0A=20=20File=20=
"/usr/share/vdsm/storage/mount.py",=20line=20241,=20in=20_runcmd=0A=20=20=
=20=20raise=20MountError(rc,=20";".join((out,=20err)))=0AMountError:=20=
(32,=20';umount:=20=
/rhev/data-center/mnt/glusterSD/superstore235.svc.exam.org:ovirtt001:=20=
mountpoint=20not=20found\n')=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,676::mount::229::Storage.Misc.excCmd::(_runcmd)=20=
/usr/bin/taskset=20--cpu-list=200-39=20/usr/bin/sudo=20-n=20=
/usr/bin/umount=20-f=20-l=20=
/rhev/data-center/mnt/glusterSD/superstore235.svc.exam.org:ovirta001=20=
(cwd=20None)=0Ajsonrpc.Executor/2::ERROR::2016-04-04=20=
15:07:55,685::hsm::2557::Storage.HSM::(disconnectStorageServer)=20Could=20=
not=20disconnect=20from=20storageServer=0ATraceback=20(most=20recent=20=
call=20last):=0A=20=20File=20"/usr/share/vdsm/storage/hsm.py",=20line=20=
2553,=20in=20disconnectStorageServer=0A=20=20=20=20conObj.disconnect()=0A=
=20=20File=20"/usr/share/vdsm/storage/storageServer.py",=20line=20258,=20=
in=20disconnect=0A=20=20=20=20self._mount.umount(True,=20True)=0A=20=20=
File=20"/usr/share/vdsm/storage/mount.py",=20line=20256,=20in=20umount=0A=
=20=20=20=20return=20self._runcmd(cmd,=20timeout)=0A=20=20File=20=
"/usr/share/vdsm/storage/mount.py",=20line=20241,=20in=20_runcmd=0A=20=20=
=20=20raise=20MountError(rc,=20";".join((out,=20err)))=0AMountError:=20=
(32,=20';umount:=20=
/rhev/data-center/mnt/glusterSD/superstore235.svc.exam.org:ovirta001:=20=
mountpoint=20not=20found\n')=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,685::mount::229::Storage.Misc.excCmd::(_runcmd)=20=
/usr/bin/taskset=20--cpu-list=200-39=20/usr/bin/sudo=20-n=20=
/usr/bin/umount=20-f=20-l=20=
/rhev/data-center/mnt/glusterSD/superstore235.svc.exam.org:ovirtb001=20=
(cwd=20None)=0Ajsonrpc.Executor/2::ERROR::2016-04-04=20=
15:07:55,694::hsm::2557::Storage.HSM::(disconnectStorageServer)=20Could=20=
not=20disconnect=20from=20storageServer=0ATraceback=20(most=20recent=20=
call=20last):=0A=20=20File=20"/usr/share/vdsm/storage/hsm.py",=20line=20=
2553,=20in=20disconnectStorageServer=0A=20=20=20=20conObj.disconnect()=0A=
=20=20File=20"/usr/share/vdsm/storage/storageServer.py",=20line=20258,=20=
in=20disconnect=0A=20=20=20=20self._mount.umount(True,=20True)=0A=20=20=
File=20"/usr/share/vdsm/storage/mount.py",=20line=20256,=20in=20umount=0A=
=20=20=20=20return=20self._runcmd(cmd,=20timeout)=0A=20=20File=20=
"/usr/share/vdsm/storage/mount.py",=20line=20241,=20in=20_runcmd=0A=20=20=
=20=20raise=20MountError(rc,=20";".join((out,=20err)))=0AMountError:=20=
(32,=20';umount:=20=
/rhev/data-center/mnt/glusterSD/superstore235.svc.exam.org:ovirtb001:=20=
mountpoint=20not=20found\n')=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,694::misc::750::Storage.SamplingMethod::(__call__)=20Trying=20=
to=20enter=20sampling=20method=20(storage.sdc.refreshStorage)=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,694::misc::753::Storage.SamplingMethod::(__call__)=20Got=20in=20=
to=20sampling=20method=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,694::misc::750::Storage.SamplingMethod::(__call__)=20Trying=20=
to=20enter=20sampling=20method=20(storage.iscsi.rescan)=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,694::misc::753::Storage.SamplingMethod::(__call__)=20Got=20in=20=
to=20sampling=20method=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,694::iscsi::434::Storage.ISCSI::(rescan)=20Performing=20SCSI=20=
scan,=20this=20will=20take=20up=20to=2030=20seconds=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,695::iscsiadm::97::Storage.Misc.excCmd::(_runCmd)=20=
/usr/bin/taskset=20--cpu-list=200-39=20/usr/bin/sudo=20-n=20=
/sbin/iscsiadm=20-m=20session=20-R=20(cwd=20None)=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,703::misc::760::Storage.SamplingMethod::(__call__)=20Returning=20=
last=20result=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,703::misc::750::Storage.SamplingMethod::(__call__)=20Trying=20=
to=20enter=20sampling=20method=20(storage.hba.rescan)=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,703::misc::753::Storage.SamplingMethod::(__call__)=20Got=20in=20=
to=20sampling=20method=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,703::hba::56::Storage.HBA::(rescan)=20Starting=20scan=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,751::hba::62::Storage.HBA::(rescan)=20Scan=20finished=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,751::misc::760::Storage.SamplingMethod::(__call__)=20Returning=20=
last=20result=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,751::multipath::77::Storage.Misc.excCmd::(rescan)=20=
/usr/bin/taskset=20--cpu-list=200-39=20/usr/bin/sudo=20-n=20=
/usr/sbin/multipath=20(cwd=20None)=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,784::multipath::77::Storage.Misc.excCmd::(rescan)=20SUCCESS:=20=
<err>=20=3D=20'';=20<rc>=20=3D=200=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,784::utils::671::root::(execCmd)=20/usr/bin/taskset=20=
--cpu-list=200-39=20/sbin/udevadm=20settle=20--timeout=3D5=20(cwd=20=
None)=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,789::utils::689::root::(execCmd)=20SUCCESS:=20<err>=20=3D=20'';=20=
<rc>=20=3D=200=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,789::lvm::497::Storage.OperationMutex::(_invalidateAllPvs)=20=
Operation=20'lvm=20invalidate=20operation'=20got=20the=20operation=20=
mutex=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,790::lvm::499::Storage.OperationMutex::(_invalidateAllPvs)=20=
Operation=20'lvm=20invalidate=20operation'=20released=20the=20operation=20=
mutex=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,790::lvm::508::Storage.OperationMutex::(_invalidateAllVgs)=20=
Operation=20'lvm=20invalidate=20operation'=20got=20the=20operation=20=
mutex=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,790::lvm::510::Storage.OperationMutex::(_invalidateAllVgs)=20=
Operation=20'lvm=20invalidate=20operation'=20released=20the=20operation=20=
mutex=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,790::lvm::528::Storage.OperationMutex::(_invalidateAllLvs)=20=
Operation=20'lvm=20invalidate=20operation'=20got=20the=20operation=20=
mutex=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,790::lvm::530::Storage.OperationMutex::(_invalidateAllLvs)=20=
Operation=20'lvm=20invalidate=20operation'=20released=20the=20operation=20=
mutex=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,790::misc::760::Storage.SamplingMethod::(__call__)=20Returning=20=
last=20result=0Ajsonrpc.Executor/2::INFO::2016-04-04=20=
15:07:55,790::logUtils::51::dispatcher::(wrapper)=20Run=20and=20protect:=20=
disconnectStorageServer,=20Return=20response:=20{'statuslist':=20=
[{'status':=20477,=20'id':=20u'5ea6a340-8e8b-43f5-b7a3-e9786429d968'},=20=
{'status':=20477,=20'id':=20u'154c63b8-eee1-4e6d-a801-d51bfc93b720'},=20=
{'status':=20477,=20'id':=20u'c3fb1655-0e9e-4e5c-be26-411638a3700b'},=20=
{'status':=20477,=20'id':=20u'79549c5d-2b6d-4ef7-94ff-c041170952a9'},=20=
{'status':=20477,=20'id':=20u'b2ea5cf8-4772-45c9-8ca4-e12c7bf3f6c7'}]}=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,790::task::1191::Storage.TaskManager.Task::(prepare)=20=
Task=3D`7b579463-bb63-47d8-b750-a21de9233226`::finished:=20=
{'statuslist':=20[{'status':=20477,=20'id':=20=
u'5ea6a340-8e8b-43f5-b7a3-e9786429d968'},=20{'status':=20477,=20'id':=20=
u'154c63b8-eee1-4e6d-a801-d51bfc93b720'},=20{'status':=20477,=20'id':=20=
u'c3fb1655-0e9e-4e5c-be26-411638a3700b'},=20{'status':=20477,=20'id':=20=
u'79549c5d-2b6d-4ef7-94ff-c041170952a9'},=20{'status':=20477,=20'id':=20=
u'b2ea5cf8-4772-45c9-8ca4-e12c7bf3f6c7'}]}=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,790::task::595::Storage.TaskManager.Task::(_updateState)=20=
Task=3D`7b579463-bb63-47d8-b750-a21de9233226`::moving=20from=20state=20=
preparing=20->=20state=20finished=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,790::resourceManager::943::Storage.ResourceManager.Owner::(releas=
eAll)=20Owner.releaseAll=20requests=20{}=20resources=20{}=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,790::resourceManager::980::Storage.ResourceManager.Owner::(cancel=
All)=20Owner.cancelAll=20requests=20{}=0A=
jsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,791::task::993::Storage.TaskManager.Task::(_decref)=20=
Task=3D`7b579463-bb63-47d8-b750-a21de9233226`::ref=200=20aborting=20=
False=0Ajsonrpc.Executor/2::DEBUG::2016-04-04=20=
15:07:55,791::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Return=20'StoragePool.disconnectStorageServer'=20in=20bridge=20with=20=
[{'status':=20477,=20'id':=20u'5ea6a340-8e8b-43f5-b7a3-e9786429d968'},=20=
{'status':=20477,=20'id':=20u'154c63b8-eee1-4e6d-a801-d51bfc93b720'},=20=
{'status':=20477,=20'id':=20u'c3fb1655-0e9e-4e5c-be26-411638a3700b'},=20=
{'status':=20477,=20'id':=20u'79549c5d-2b6d-4ef7-94ff-c041170952a9'},=20=
{'status':=20477,=20'id':=20u'b2ea5cf8-4772-45c9-8ca4-e12c7bf3f6c7'}]=0A=
Reactor=20thread::INFO::2016-04-04=20=
15:07:59,487::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37258=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:07:59,492::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:07:59,492::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37258=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:07:59,492::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37258=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:07:59,493::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037258)=0A=
Thread-13::INFO::2016-04-04=20=
15:07:59,493::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37258=20started=0A=
Thread-13::INFO::2016-04-04=20=
15:07:59,494::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37258=20stopped=0AReactor=20=
thread::INFO::2016-04-04=20=
15:07:59,607::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37259=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:07:59,612::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:07:59,612::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37259=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:07:59,612::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37259=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:07:59,613::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037259)=0A=
Thread-14::INFO::2016-04-04=20=
15:07:59,613::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37259=20started=0A=
Thread-14::INFO::2016-04-04=20=
15:07:59,619::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37259=20stopped=0AJsonRpc=20=
(StompReactor)::ERROR::2016-04-04=20=
15:08:01,595::betterAsyncore::124::vds.dispatcher::(recv)=20SSL=20error=20=
during=20reading=20data:=20unexpected=20eof=0AReactor=20=
thread::INFO::2016-04-04=20=
15:08:01,595::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=2010.149.133.23:57193=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:08:01,662::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:08:01,663::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20stomp=20from=2010.149.133.23:57193=0AReactor=20=
thread::INFO::2016-04-04=20=
15:08:01,663::stompreactor::101::Broker.StompAdapter::(_cmd_connect)=20=
Processing=20CONNECT=20request=0AJsonRpc=20=
(StompReactor)::INFO::2016-04-04=20=
15:08:01,664::stompreactor::128::Broker.StompAdapter::(_cmd_subscribe)=20=
Subscribe=20command=20received=0AJsonRpc=20=
(StompReactor)::INFO::2016-04-04=20=
15:08:01,664::stompreactor::128::Broker.StompAdapter::(_cmd_subscribe)=20=
Subscribe=20command=20received=0AReactor=20thread::DEBUG::2016-04-04=20=
15:08:01,664::stompreactor::470::protocoldetector.StompDetector::(handle_s=
ocket)=20Stomp=20detected=20from=20('10.149.133.23',=2057193)=0A=
jsonrpc.Executor/4::DEBUG::2016-04-04=20=
15:08:02,086::__init__::503::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Calling=20'Host.setupNetworks'=20in=20bridge=20with=20{u'bondings':=20=
{u'bond0':=20{u'nics':=20[u'eno1',=20u'eno2'],=20u'options':=20=
u'miimon=3D100=20mode=3D4'}},=20u'networks':=20{u'ovirtmgmt':=20{u'nic':=20=
u'ens1f0',=20u'custom':=20{},=20u'bridged':=20u'false',=20u'mtu':=20=
u'1500'},=20u'VLAN602':=20{u'custom':=20{},=20u'bonding':=20u'bond0',=20=
u'vlan':=20u'602',=20u'bridged':=20u'false',=20u'mtu':=20u'1500'}},=20=
u'options':=20{u'connectivityCheck':=20u'false'}}=0A=
jsonrpc.Executor/4::INFO::2016-04-04=20=
15:08:02,087::API::1489::vds::(setupNetworks)=20API=20setupNetworks=20=
with:=20networks:=20{u'ovirtmgmt':=20{u'nic':=20u'ens1f0',=20u'custom':=20=
{},=20u'bridged':=20u'false',=20u'mtu':=20u'1500'},=20u'VLAN602':=20=
{u'custom':=20{},=20u'bonding':=20u'bond0',=20u'vlan':=20u'602',=20=
u'bridged':=20u'false',=20u'mtu':=20u'1500'}},=20bondings:=20{u'bond0':=20=
{u'nics':=20[u'eno1',=20u'eno2'],=20u'options':=20u'miimon=3D100=20=
mode=3D4'}},=20options:=20{u'connectivityCheck':=20u'false'}=0A=
jsonrpc.Executor/4::DEBUG::2016-04-04=20=
15:08:10,622::__init__::533::jsonrpc.JsonRpcServer::(_serveRequest)=20=
Return=20'Host.setupNetworks'=20in=20bridge=20with=20{'message':=20=
'Done',=20'code':=200}=0AReactor=20thread::INFO::2016-04-04=20=
15:08:14,510::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37260=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:08:14,515::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:08:14,515::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37260=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:08:14,515::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037260)=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:08:14,515::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37260=0AThread-15::INFO::2016-04-04=20=
15:08:14,515::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37260=20started=0A=
Thread-15::INFO::2016-04-04=20=
15:08:14,517::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37260=20stopped=0AReactor=20=
thread::INFO::2016-04-04=20=
15:08:29,533::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37261=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:08:29,537::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:08:29,537::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37261=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:08:29,537::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037261)=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:08:29,537::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37261=0AThread-16::INFO::2016-04-04=20=
15:08:29,538::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37261=20started=0A=
Thread-16::INFO::2016-04-04=20=
15:08:29,539::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37261=20stopped=0AReactor=20=
thread::INFO::2016-04-04=20=
15:08:44,554::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37262=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:08:44,559::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:08:44,559::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37262=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:08:44,559::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037262)=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:08:44,559::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37262=0AThread-17::INFO::2016-04-04=20=
15:08:44,560::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37262=20started=0A=
Thread-17::INFO::2016-04-04=20=
15:08:44,561::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37262=20stopped=0AReactor=20=
thread::INFO::2016-04-04=20=
15:08:59,577::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37263=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:08:59,581::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:08:59,581::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37263=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:08:59,581::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037263)=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:08:59,581::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37263=0AThread-18::INFO::2016-04-04=20=
15:08:59,582::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37263=20started=0A=
Thread-18::INFO::2016-04-04=20=
15:08:59,583::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37263=20stopped=0AReactor=20=
thread::INFO::2016-04-04=20=
15:09:14,599::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37264=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:09:14,603::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:09:14,603::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37264=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:09:14,604::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037264)=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:09:14,604::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37264=0AThread-19::INFO::2016-04-04=20=
15:09:14,604::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37264=20started=0A=
Thread-19::INFO::2016-04-04=20=
15:09:14,605::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37264=20stopped=0AReactor=20=
thread::INFO::2016-04-04=20=
15:09:29,621::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37265=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:09:29,625::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:09:29,625::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37265=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:09:29,625::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037265)=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:09:29,626::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37265=0AThread-20::INFO::2016-04-04=20=
15:09:29,626::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37265=20started=0A=
Thread-20::INFO::2016-04-04=20=
15:09:29,627::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37265=20stopped=0AReactor=20=
thread::INFO::2016-04-04=20=
15:09:44,643::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37266=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:09:44,647::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:09:44,647::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37266=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:09:44,647::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037266)=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:09:44,647::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37266=0AThread-21::INFO::2016-04-04=20=
15:09:44,647::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37266=20started=0A=
Thread-21::INFO::2016-04-04=20=
15:09:44,648::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37266=20stopped=0AReactor=20=
thread::INFO::2016-04-04=20=
15:09:59,664::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37267=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:09:59,668::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:09:59,669::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37267=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:09:59,669::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037267)=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:09:59,669::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37267=0AThread-22::INFO::2016-04-04=20=
15:09:59,669::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37267=20started=0A=
Thread-22::INFO::2016-04-04=20=
15:09:59,670::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37267=20stopped=0AReactor=20=
thread::INFO::2016-04-04=20=
15:10:14,686::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37268=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:10:14,690::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:10:14,690::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37268=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:10:14,691::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037268)=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:10:14,691::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37268=0AThread-23::INFO::2016-04-04=20=
15:10:14,691::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37268=20started=0A=
Thread-23::INFO::2016-04-04=20=
15:10:14,692::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37268=20stopped=0AReactor=20=
thread::INFO::2016-04-04=20=
15:10:29,708::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37269=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:10:29,712::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:10:29,712::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37269=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:10:29,712::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037269)=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:10:29,712::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37269=0AThread-24::INFO::2016-04-04=20=
15:10:29,713::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37269=20started=0A=
Thread-24::INFO::2016-04-04=20=
15:10:29,714::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37269=20stopped=0AReactor=20=
thread::INFO::2016-04-04=20=
15:10:44,730::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37270=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:10:44,734::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:10:44,734::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37270=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:10:44,734::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037270)=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:10:44,735::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37270=0AThread-25::INFO::2016-04-04=20=
15:10:44,735::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37270=20started=0A=
Thread-25::INFO::2016-04-04=20=
15:10:44,736::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37270=20stopped=0AReactor=20=
thread::INFO::2016-04-04=20=
15:10:59,752::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handle=
_accept)=20Accepting=20connection=20from=20127.0.0.1:37271=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:10:59,756::protocoldetector::82::ProtocolDetector.Detector::(__init__)=20=
Using=20required_size=3D11=0AReactor=20thread::INFO::2016-04-04=20=
15:10:59,756::protocoldetector::118::ProtocolDetector.Detector::(handle_re=
ad)=20Detected=20protocol=20xml=20from=20127.0.0.1:37271=0AReactor=20=
thread::DEBUG::2016-04-04=20=
15:10:59,757::bindingxmlrpc::1298::XmlDetector::(handle_socket)=20xml=20=
over=20http=20detected=20from=20('127.0.0.1',=2037271)=0A=
BindingXMLRPC::INFO::2016-04-04=20=
15:10:59,757::xmlrpc::73::vds.XMLRPCServer::(handle_request)=20Starting=20=
request=20handler=20for=20127.0.0.1:37271=0AThread-26::INFO::2016-04-04=20=
15:10:59,757::xmlrpc::84::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37271=20started=0A=
Thread-26::INFO::2016-04-04=20=
15:10:59,758::xmlrpc::92::vds.XMLRPCServer::(_process_requests)=20=
Request=20handler=20for=20127.0.0.1:37271=20stopped=0A=
--Apple-Mail=_B565CEDD-E856-4748-912B-7B9679AB82CE
Content-Transfer-Encoding: quoted-printable
Content-Type: text/plain;
charset=us-ascii
->Rein.
On 24 Mar 2016, at 05:03, David LeVene
<David.LeVene(a)blackboard.com> =
wrote:
=20
Hi Rein,
=20
Not sure if you are using IPv6, but I ran into this issue it wouldn't =
configure things correctly. If I fixed it manually after a reboot it =
would fail again. There is a patch that is being released in ovirt 3.6.4 =
which resolves the issue I was having.
=20
Your issue might be related - =
http://lists.ovirt.org/pipermail/users/2016-March/038201.html which is =
fixed in
https://gerrit.ovirt.org/#/c/54237
=20
The RH guys will generally ask for your vdsm logs and maybe supervdsm =
(see the
above post for more information on where they are located). =
Looking in these logs might guide you as well.
=20
Regards
David
=20
-----Original Message-----
From: users-bounces(a)ovirt.org [mailto:users-bounces@ovirt.org] On =
Behalf Of Rein
van Weerden
Sent: Thursday, March 24, 2016 07:16
To: users(a)ovirt.org
Subject: [ovirt-users] Losing IP config on host
=20
Hi All,
=20
When creating a new host i lose the ip configuration on the host while =
creating
the interfaces.
Please advice.
=20
Using:
oVirt engine 3.6.3.4-1 on CentOS 7
oVirt engine SDK python 3.6.3.0
=20
->Rein.
=20
=20
=20
=20
_______________________________________________
Users mailing list
Users(a)ovirt.org
http://lists.ovirt.org/mailman/listinfo/users
This email and any attachments may contain confidential and =
proprietary
information of Blackboard that is for the sole use of the =
intended recipient. If you are not the intended recipient, disclosure, =
copying, re-distribution or other use of any of this information is =
strictly prohibited. Please immediately notify the sender and delete =
this transmission if you received this email in error.
--Apple-Mail=_B565CEDD-E856-4748-912B-7B9679AB82CE--