[Users] does anyone know if there is an ovirt weekly status meeting today?
by Einav Cohen
it has been removed from the calendar (at least mine...)
Thanks,
Einav
10 years, 8 months
- 1
- 0
[Users] Call for Papers Deadline in One Month: LinuxCon/CloudOpen North America
by Brian Proffitt
Conference: LinuxCon North America
Information: LinuxCon is the only event covering all matters Linux - offering collaboration and education for everyone in the ecosystem from developers and maintainers to sys admins and architects to business executives and community members.
Date: August 20-22, 2014
Location: Chicago, Illinois
Website: http://events.linuxfoundation.org/events/linuxcon-north-america
Call for Papers Deadline: May 2, 2014
Call for Papers URL: http://events.linuxfoundation.org/events/linuxcon-north-america/program/cfp
Conference: CloudOpen North America
Information: CloudOpen is the only conference offering collaboration and education for all matters of open source cloud, from CloudStack to KVM to Xen, Hadoop, Gluster, OpenStack and more.
Date: August 20-22, 2014
Location: Chicago, Illinois
Website: http://events.linuxfoundation.org/events/cloudopen-north-america
Call for Papers Deadline: May 2, 2014
Call for Papers URL: http://events.linuxfoundation.org/events/cloudopen-north-america/program/cfp
--
Brian Proffitt - oVirt Community Manager
Open Source and Standards, Red Hat - http://community.redhat.com
Phone: +1 574 383 9BKP
IRC: bkp @ OFTC
10 years, 8 months
- 1
- 0
[Users] Host's Cluster Compatibility Version doesn't match the Cluster's Compatibility Version.
by Jim＠Ovirt
Hi,
I've just installed OVirt 3.4 AllInOne on a clean install of Fedora19 on
a multihomed box.
I had some issues getting networking working, but that seems to be up now.
I've got two Alerts that are in the way now:
Host's Cluster Compatibility Version doesn't match the Cluster's
Compatibility Version.
According to "yum list installed" every package that begins "ovirt" is
version 3.4.something and every package that begins "vdsm" is version
4.14.6, but "vdsClient -s 0 getVdsCaps" reports clusterLevels = ['3.0',
'3.1', '3.2', '3.3' ].
So it looks like ovirt 3.4 isn't compatible with ovirt 3.4, which seems
a bit odd.
What have I done wrong here?
The other Alert is "Power Management is not configured for this Host.".
I don't have any kind of power management for this box, is it possible
to stop this message?
Thanks
Jim
10 years, 8 months
- 3
- 3
[Users] el7 based node? el7 as a supported platform for ovirt?
by Paul Jansen
--1060583355-1358189179-1396420276=:80659
Content-Type: text/plain; charset=iso-8859-1
Content-Transfer-Encoding: quoted-printable
Hi.=0AThere's been a bit of chatter about what is required for Fedora 20 su=
pport for ovirt.=0AI can't seem to find newer fedora19 based node isos anym=
ore.=A0 Has there been a conscious decision to standardize on the el6 based=
node iso?=0AIs an F20 based node iso something that is being worked on?=0A=
=0AI hear that el7 might be announced this month.=A0 Presumably Centos 7.0 =
won't be far away after that.=0AI've done some test installs of RHEL 7 beta=
to get a look at what packages are in use.=0AOf particular interest to me =
is the qemu-kvm package - the version of which seem to be important for liv=
e snapshots and live migrations (something we don't seem to do well right n=
ow).=0AEL beta7 has this version - qemu-kvm-1.5.3-19.el7.x86_64.rpm=0A=0AGi=
ven the issues with needing newer versions of certain packages than what is=
in EL 6.5, is this situation likely to be improved greatly when Centos 7 i=
s available?=0AI don't recall seeing much discussion about ovirt running un=
der el7.=A0 Is this being looked at at this stage, or given the fact there =
is only a beta of rhel7=A0 to work with right now are we just waiting for t=
he release before deciding too much?=0A=0AThanks.=0A
--1060583355-1358189179-1396420276=:80659
Content-Type: text/html; charset=iso-8859-1
Content-Transfer-Encoding: quoted-printable
<html><body><div style=3D"color:#000; background-color:#fff; font-family:He=
lveticaNeue, Helvetica Neue, Helvetica, Arial, Lucida Grande, Sans-Serif;fo=
nt-size:12pt"><div>Hi.</div><div><span>There's been a bit of chatter about =
what is required for Fedora 20 support for ovirt.</span></div><div style=3D=
"color: rgb(0, 0, 0); font-size: 16px; font-family: HelveticaNeue,Helvetica=
Neue,Helvetica,Arial,Lucida Grande,Sans-Serif; background-color: transpare=
nt; font-style: normal;"><span>I can't seem to find newer fedora19 based no=
de isos anymore. Has there been a conscious decision to standardize o=
n the el6 based node iso?</span></div><div style=3D"color: rgb(0, 0, 0); fo=
nt-size: 16px; font-family: HelveticaNeue,Helvetica Neue,Helvetica,Arial,Lu=
cida Grande,Sans-Serif; background-color: transparent; font-style: normal;"=
><span>Is an F20 based node iso something that is being worked on?</span></=
div><div style=3D"color: rgb(0, 0, 0); font-size: 16px; font-family:
HelveticaNeue,Helvetica Neue,Helvetica,Arial,Lucida Grande,Sans-Serif; bac=
kground-color: transparent; font-style: normal;"><br><span></span></div><di=
v style=3D"color: rgb(0, 0, 0); font-size: 16px; font-family: HelveticaNeue=
,Helvetica Neue,Helvetica,Arial,Lucida Grande,Sans-Serif; background-color:=
transparent; font-style: normal;"><span>I hear that el7 might be announced=
this month. Presumably Centos 7.0 won't be far away after that.</spa=
n></div><div style=3D"color: rgb(0, 0, 0); font-size: 16px; font-family: He=
lveticaNeue,Helvetica Neue,Helvetica,Arial,Lucida Grande,Sans-Serif; backgr=
ound-color: transparent; font-style: normal;"><span>I've done some test ins=
talls of RHEL 7 beta to get a look at what packages are in use.</span></div=
><div style=3D"color: rgb(0, 0, 0); font-size: 16px; font-family: Helvetica=
Neue,Helvetica Neue,Helvetica,Arial,Lucida Grande,Sans-Serif; background-co=
lor: transparent; font-style: normal;"><span>Of particular interest to me
is the qemu-kvm package - the version of which seem to be important for li=
ve snapshots and live migrations (something we don't seem to do well right =
now).</span></div><div style=3D"color: rgb(0, 0, 0); font-size: 16px; font-=
family: HelveticaNeue,Helvetica Neue,Helvetica,Arial,Lucida Grande,Sans-Ser=
if; background-color: transparent; font-style: normal;"><span>EL beta7 has =
this version - </span><a href=3D"http://easi.adl.quantum.com/install/rhel/7=
.0/x86_64/dvd/Packages/qemu-kvm-1.5.3-19.el7.x86_64.rpm">qemu-kvm-1.5.3-19.=
el7.x86_64.rpm</a></div><div style=3D"color: rgb(0, 0, 0); font-size: 16px;=
font-family: HelveticaNeue,Helvetica Neue,Helvetica,Arial,Lucida Grande,Sa=
ns-Serif; background-color: transparent; font-style: normal;"><br></div><di=
v style=3D"color: rgb(0, 0, 0); font-size: 16px; font-family: HelveticaNeue=
,Helvetica Neue,Helvetica,Arial,Lucida Grande,Sans-Serif; background-color:=
transparent; font-style: normal;">Given the issues with needing newer
versions of certain packages than what is in EL 6.5, is this situation lik=
ely to be improved greatly when Centos 7 is available?</div><div style=3D"c=
olor: rgb(0, 0, 0); font-size: 16px; font-family: HelveticaNeue,Helvetica N=
eue,Helvetica,Arial,Lucida Grande,Sans-Serif; background-color: transparent=
; font-style: normal;">I don't recall seeing much discussion about ovirt ru=
nning under el7. Is this being looked at at this stage, or given the =
fact there is only a beta of rhel7 to work with right now are we just=
waiting for the release before deciding too much?</div><div style=3D"color=
: rgb(0, 0, 0); font-size: 16px; font-family: HelveticaNeue,Helvetica Neue,=
Helvetica,Arial,Lucida Grande,Sans-Serif; background-color: transparent; fo=
nt-style: normal;"><br></div><div style=3D"color: rgb(0, 0, 0); font-size: =
16px; font-family: HelveticaNeue,Helvetica Neue,Helvetica,Arial,Lucida Gran=
de,Sans-Serif; background-color: transparent; font-style:
normal;">Thanks.<br></div></div></body></html>
--1060583355-1358189179-1396420276=:80659--
10 years, 8 months
- 3
- 2
[Users] Logical Network VLAN Tagging and DataCenters
by Simon Barrett
--_000_D86C48DF8800164BBE50B87623F7AC95481F3217ln2wio001devtra_
Content-Type: text/plain; charset="us-ascii"
Content-Transfer-Encoding: quoted-printable
Is it possible/supported to have the same VLAN ID defined across multiple d=
atacenters logical networks?
I am seeing a situation where if I have two Datacenters, both with a logica=
l network that have the same vlan tag. E.G.
DC =3D London, Logical network =3D prod, VLAN =3D 123
DC =3D Paris, Logical network =3D prod, VLAN =3D 123
If I edit one of the VM's running in the "London" datacenter, the VM NIC sh=
ows up as empty even though if I click on the VM and go to the "Network Int=
erfaces" tab at the bottom of the screen it lists up the "prod" network und=
er "Network Name".
All works OK for VM's that are assigned a logical network that is only defi=
ned once (i.e. has not been added to both datacenters).
This configuration is on oVirt Engine 3.3.2-1.el6. I am planning on moving =
to 3.4 very soon so will test out again on that version.
Thanks,
Simon
--_000_D86C48DF8800164BBE50B87623F7AC95481F3217ln2wio001devtra_
Content-Type: text/html; charset="us-ascii"
Content-Transfer-Encoding: quoted-printable
<html xmlns:v=3D"urn:schemas-microsoft-com:vml" xmlns:o=3D"urn:schemas-micr=
osoft-com:office:office" xmlns:w=3D"urn:schemas-microsoft-com:office:word" =
xmlns:m=3D"http://schemas.microsoft.com/office/2004/12/omml" xmlns=3D"http:=
//www.w3.org/TR/REC-html40">
<head>
<meta http-equiv=3D"Content-Type" content=3D"text/html; charset=3Dus-ascii"=
>
<meta name=3D"Generator" content=3D"Microsoft Word 15 (filtered medium)">
<style><!--
/* Font Definitions */
@font-face
{font-family:"Cambria Math";
panose-1:2 4 5 3 5 4 6 3 2 4;}
@font-face
{font-family:Calibri;
panose-1:2 15 5 2 2 2 4 3 2 4;}
/* Style Definitions */
p.MsoNormal, li.MsoNormal, div.MsoNormal
{margin:0cm;
margin-bottom:.0001pt;
font-size:11.0pt;
font-family:"Calibri","sans-serif";
mso-fareast-language:EN-US;}
a:link, span.MsoHyperlink
{mso-style-priority:99;
color:#0563C1;
text-decoration:underline;}
a:visited, span.MsoHyperlinkFollowed
{mso-style-priority:99;
color:#954F72;
text-decoration:underline;}
span.EmailStyle17
{mso-style-type:personal-compose;
font-family:"Calibri","sans-serif";
color:windowtext;}
.MsoChpDefault
{mso-style-type:export-only;
font-family:"Calibri","sans-serif";
mso-fareast-language:EN-US;}
@page WordSection1
{size:612.0pt 792.0pt;
margin:72.0pt 72.0pt 72.0pt 72.0pt;}
div.WordSection1
{page:WordSection1;}
--></style><!--[if gte mso 9]><xml>
<o:shapedefaults v:ext=3D"edit" spidmax=3D"1026" />
</xml><![endif]--><!--[if gte mso 9]><xml>
<o:shapelayout v:ext=3D"edit">
<o:idmap v:ext=3D"edit" data=3D"1" />
</o:shapelayout></xml><![endif]-->
</head>
<body lang=3D"EN-GB" link=3D"#0563C1" vlink=3D"#954F72">
<div class=3D"WordSection1">
<p class=3D"MsoNormal">Is it possible/supported to have the same VLAN ID de=
fined across multiple datacenters logical networks?<o:p></o:p></p>
<p class=3D"MsoNormal"><o:p> </o:p></p>
<p class=3D"MsoNormal">I am seeing a situation where if I have two Datacent=
ers, both with a logical network that have the same vlan tag. E.G.<o:p></o:=
p></p>
<p class=3D"MsoNormal"><o:p> </o:p></p>
<p class=3D"MsoNormal">DC =3D London, Logical network =3D prod, VLAN =3D 12=
3<o:p></o:p></p>
<p class=3D"MsoNormal">DC =3D Paris, Logical network =3D prod, VLAN =3D 123=
<o:p></o:p></p>
<p class=3D"MsoNormal"><o:p> </o:p></p>
<p class=3D"MsoNormal">If I edit one of the VM’s running in the ̶=
0;London” datacenter, the VM NIC shows up as empty even though if I c=
lick on the VM and go to the “Network Interfaces” tab at the bo=
ttom of the screen it lists up the “prod” network under “=
Network
Name”.<o:p></o:p></p>
<p class=3D"MsoNormal"><o:p> </o:p></p>
<p class=3D"MsoNormal">All works OK for VM’s that are assigned a logi=
cal network that is only defined once (i.e. has not been added to both data=
centers).<o:p></o:p></p>
<p class=3D"MsoNormal"><o:p> </o:p></p>
<p class=3D"MsoNormal">This configuration is on oVirt Engine 3.3.2-1.el6. I=
am planning on moving to 3.4 very soon so will test out again on that vers=
ion.
<o:p></o:p></p>
<p class=3D"MsoNormal"><o:p> </o:p></p>
<p class=3D"MsoNormal">Thanks,<o:p></o:p></p>
<p class=3D"MsoNormal"><o:p> </o:p></p>
<p class=3D"MsoNormal">Simon<o:p></o:p></p>
<p class=3D"MsoNormal"><o:p> </o:p></p>
</div>
</body>
</html>
--_000_D86C48DF8800164BBE50B87623F7AC95481F3217ln2wio001devtra_--
10 years, 8 months
- 3
- 3
[Users] Where is the hosted engine storage?
by Jimmy Dorff
This is a cryptographically signed message in MIME format.
--------------ms010202000106020805010209
Content-Type: text/plain; charset=ISO-8859-1; format=flowed
Content-Transfer-Encoding: quoted-printable
I installed a test system with 3.4 and hosted-engine. Everything worked!
Post-install I didn't have a Storage Domain and the Data Center wasn't=20
initialized. I added a second NFS path (everything on a NFS appliance)=20
and setup a Storage Domain and such.
My question is where is the storage for the engine vm? Clearly it's on=20
the NFS path I provided during the setup, but that isn't visible in the=20
oVirt GUI at all. The "HostedEngine" Disks tab is blank.
Just checking that this is the design intent.
Thanks,
Jimmy
--------------ms010202000106020805010209
Content-Type: application/pkcs7-signature; name="smime.p7s"
Content-Transfer-Encoding: base64
Content-Disposition: attachment; filename="smime.p7s"
Content-Description: S/MIME Cryptographic Signature
MIAGCSqGSIb3DQEHAqCAMIACAQExCzAJBgUrDgMCGgUAMIAGCSqGSIb3DQEHAQAAoIIKYDCC
BOowggPSoAMCAQICECeaPwnGr8aRr9rqNxvvpm8wDQYJKoZIhvcNAQEFBQAwga4xCzAJBgNV
BAYTAlVTMQswCQYDVQQIEwJVVDEXMBUGA1UEBxMOU2FsdCBMYWtlIENpdHkxHjAcBgNVBAoT
FVRoZSBVU0VSVFJVU1QgTmV0d29yazEhMB8GA1UECxMYaHR0cDovL3d3dy51c2VydHJ1c3Qu
Y29tMTYwNAYDVQQDEy1VVE4tVVNFUkZpcnN0LUNsaWVudCBBdXRoZW50aWNhdGlvbiBhbmQg
RW1haWwwHhcNMTEwMjExMDAwMDAwWhcNMjAwNTMwMTA0ODM4WjBkMQswCQYDVQQGEwJVUzES
MBAGA1UEChMJSW50ZXJuZXQyMREwDwYDVQQLEwhJbkNvbW1vbjEuMCwGA1UEAxMlSW5Db21t
b24gU3RhbmRhcmQgQXNzdXJhbmNlIENsaWVudCBDQTCCASIwDQYJKoZIhvcNAQEBBQADggEP
ADCCAQoCggEBANPgFQJ7+XaC6f6RlvPwHiFotQ1hML4Jl2bdHSOn+x+GeDrml2rHwaR/iU2z
nlmzOAsfOSJrAigSvymW0TX0lSpsBpgcGWRcpn5FbiBrkbh0DzxTyIMZaxGjxyyFBR6H1Mug
CAUGLmaJPXing5NUt9gX6tPufWbUNN6Jyhn9N8rQg95RaNha9XTr3YICWvogzqrPQCvTyJ6F
6YEzm9bxT5FF2Y0zKRxdB5qF6f/JErJMDEIq7TD019yZtc8LgOp53qcjYp+16Zai1rIaRdDY
Ex2SefSEgT22FY/ubywaxuxdrJOPC0dNOjsJ1d4GIjoRlZBvTnsfci4nkTM+iFfCvwkCAwEA
AaOCAUswggFHMB8GA1UdIwQYMBaAFImCZ33EnSZwAEu0UEh83j2uBG59MB0GA1UdDgQWBBTo
172Wqt3QCO+hM55eWZg8ErebkTAOBgNVHQ8BAf8EBAMCAQYwEgYDVR0TAQH/BAgwBgEB/wIB
ADARBgNVHSAECjAIMAYGBFUdIAAwWAYDVR0fBFEwTzBNoEugSYZHaHR0cDovL2NybC51c2Vy
dHJ1c3QuY29tL1VUTi1VU0VSRmlyc3QtQ2xpZW50QXV0aGVudGljYXRpb25hbmRFbWFpbC5j
cmwwdAYIKwYBBQUHAQEEaDBmMD0GCCsGAQUFBzAChjFodHRwOi8vY3J0LnVzZXJ0cnVzdC5j
b20vVVROQWRkVHJ1c3RDbGllbnRfQ0EuY3J0MCUGCCsGAQUFBzABhhlodHRwOi8vb2NzcC51
c2VydHJ1c3QuY29tMA0GCSqGSIb3DQEBBQUAA4IBAQAO7bbgOJ86aKIBwfCE5Sbu/IHS14zJ
GyRDoMmxheaf5OAq0UTe8qBwrYgYKEiWExJHSfnKOaNX181ThU239y8f2atTemkHTshCv+Ls
Xjt79D6ypEmWkRZ7+U9qXkJyMdHTQ6E5BYk+y7XR6T4RxoR1zjW/9S3ooqv1pAFOcBwmZasW
w70y5ikQL2tqskjWcAYG9SjoVH7MEMVprhHpBes7OMFiWtAeGOlcTVP49Srh3ZI1hPoljx/H
I1ka+KIlpVZi4t44rNTfM1diATgqUSo7TLlHsHHpySHBYY7SY626SSsiAKw2NRBIDl7B7B2x
22JekwPq5VBI71GrIYr7YMXCMIIFbjCCBFagAwIBAgIRAJii4SGmG4xeMs7zeGP14o4wDQYJ
KoZIhvcNAQEFBQAwZDELMAkGA1UEBhMCVVMxEjAQBgNVBAoTCUludGVybmV0MjERMA8GA1UE
CxMISW5Db21tb24xLjAsBgNVBAMTJUluQ29tbW9uIFN0YW5kYXJkIEFzc3VyYW5jZSBDbGll
bnQgQ0EwHhcNMTMxMDMxMDAwMDAwWhcNMTgxMDMxMjM1OTU5WjCBnDEOMAwGA1UEERMFMjc3
MDExJTAjBgNVBAoTHER1a2UgVW5pdmVyc2l0eSAtIEVuY3J5cHRpb24xCzAJBgNVBAgTAk5D
MQ8wDQYDVQQHEwZEdXJoYW0xCzAJBgNVBAYTAlVTMRQwEgYDVQQDEwtKaW1teSBEb3JmZjEi
MCAGCSqGSIb3DQEJARYTamRvcmZmQHBoeS5kdWtlLmVkdTCCASIwDQYJKoZIhvcNAQEBBQAD
ggEPADCCAQoCggEBALHXuvlDP6Pjn3MAVN2+FB2Yu+Bjl8VzAxBmqrrflkFWvpOv/xpI0/QI
A1NhPOER1zKev2GK35R44eM4P7jyz3rbvM2SBH4OVpk6l5aTJnM5shneFyxMr9TmlHi6gMeA
MuCwGZvTeP+nfUgf0Gdrf3dPMlwxMeoPDjb0nApn8f5ZtuNRB46yuHwsXmSi6MNrufOgclkm
AtjirEydxysjl/Ck1AOzI6dUyFFmGR63lddOWIPFR+K1Seh7t1auVx4Z8VuW2wCSzurcBOJV
j0RnsduOxIzHZgQcoy5QaNi6h0/61fUvKB4S1K8mGY18rdtTz5DWCgf0lq276E2Wy6JidkMC
AwEAAaOCAeAwggHcMB8GA1UdIwQYMBaAFOjXvZaq3dAI76Eznl5ZmDwSt5uRMB0GA1UdDgQW
BBT3kO8ynA7nwzcRrZ/97bI0/CQ9iDAOBgNVHQ8BAf8EBAMCBaAwDAYDVR0TAQH/BAIwADAd
BgNVHSUEFjAUBggrBgEFBQcDAgYIKwYBBQUHAwQwagYDVR0gBGMwYTBfBg0rBgEEAa4jAQQD
AwABME4wTAYIKwYBBQUHAgEWQGh0dHBzOi8vd3d3LmluY29tbW9uLm9yZy9jZXJ0L3JlcG9z
aXRvcnkvY3BzX3N0YW5kYXJkX2NsaWVudC5wZGYwTgYDVR0fBEcwRTBDoEGgP4Y9aHR0cDov
L2NybC5pbmNvbW1vbi5vcmcvSW5Db21tb25TdGFuZGFyZEFzc3VyYW5jZUNsaWVudENBLmNy
bDCBgAYIKwYBBQUHAQEEdDByMEoGCCsGAQUFBzAChj5odHRwOi8vY2VydC5pbmNvbW1vbi5v
cmcvSW5Db21tb25TdGFuZGFyZEFzc3VyYW5jZUNsaWVudENBLmNydDAkBggrBgEFBQcwAYYY
aHR0cDovL29jc3AuaW5jb21tb24ub3JnMB4GA1UdEQQXMBWBE2pkb3JmZkBwaHkuZHVrZS5l
ZHUwDQYJKoZIhvcNAQEFBQADggEBAISQv2tq3fwqcnd7y7gjlPcxAvJgiXrgKoeED2KFYrbB
fg8JeBEi1fqRZnk38LDobfgFFbCaBmVZ37sSW0XPxeQIwQdbY5FpcjMpb2dG1SIPEzV5nuos
Bsh+SAGDia86e4SxMpagT39aKcc/5TfR9iBquKEgvriUNJW8VAJzOd9/VmMzsjBz0mEGpEYJ
6cV+7D2uITp4nbpU34YOVENvLUlV44Lyw52DJ6ZeKP+hmNrJx1sz93LD841B9Q494/wC6H4Q
G/OjWB7TEA1EqVNvr9/WiXt5WJDLCT+WSuFwIfq1sY5252u8PCOB8kdBMEvWT23YJ9UdoZPK
K9bYrCXTEn4xggOHMIIDgwIBATB5MGQxCzAJBgNVBAYTAlVTMRIwEAYDVQQKEwlJbnRlcm5l
dDIxETAPBgNVBAsTCEluQ29tbW9uMS4wLAYDVQQDEyVJbkNvbW1vbiBTdGFuZGFyZCBBc3N1
cmFuY2UgQ2xpZW50IENBAhEAmKLhIaYbjF4yzvN4Y/XijjAJBgUrDgMCGgUAoIIB4zAYBgkq
hkiG9w0BCQMxCwYJKoZIhvcNAQcBMBwGCSqGSIb3DQEJBTEPFw0xNDA0MDExODUxNTVaMCMG
CSqGSIb3DQEJBDEWBBSsqibTB91/Qyqg7dmPk+T/uRbz/jBsBgkqhkiG9w0BCQ8xXzBdMAsG
CWCGSAFlAwQBKjALBglghkgBZQMEAQIwCgYIKoZIhvcNAwcwDgYIKoZIhvcNAwICAgCAMA0G
CCqGSIb3DQMCAgFAMAcGBSsOAwIHMA0GCCqGSIb3DQMCAgEoMIGIBgkrBgEEAYI3EAQxezB5
MGQxCzAJBgNVBAYTAlVTMRIwEAYDVQQKEwlJbnRlcm5ldDIxETAPBgNVBAsTCEluQ29tbW9u
MS4wLAYDVQQDEyVJbkNvbW1vbiBTdGFuZGFyZCBBc3N1cmFuY2UgQ2xpZW50IENBAhEAmKLh
IaYbjF4yzvN4Y/XijjCBigYLKoZIhvcNAQkQAgsxe6B5MGQxCzAJBgNVBAYTAlVTMRIwEAYD
VQQKEwlJbnRlcm5ldDIxETAPBgNVBAsTCEluQ29tbW9uMS4wLAYDVQQDEyVJbkNvbW1vbiBT
dGFuZGFyZCBBc3N1cmFuY2UgQ2xpZW50IENBAhEAmKLhIaYbjF4yzvN4Y/XijjANBgkqhkiG
9w0BAQEFAASCAQBENeOvjbra1fRISNeBQK0yyXjmdrheZxSvA8Hs4mL6U/xXkLFRq5l7pt5K
f1P67bHLN2FR1AHpIfWJ+LYgWPpMwAEu8CW1sAgHLpz/BdyJjJ2lBlWJZw+KEfGmFNnRGmmL
EvcjS5w4ZsvoY8eD6Jm7f3orT8ces+KCz7uD7VU/JUhAeS+/PkrCr0BrE8OaZ13rNtl930cd
ZTcMyPCFgoThSinBKaLkYs5hvgok43l8f/jSP09oMicY03xfGewAzXCY9BzVIGEjzfgsBgVc
8sAT+gp7DV0QGtYfnLaZqvUENsvvLAyMWkU3TNAIPZ1whp9uHXBbshkK466HoiVPQ7O3AAAA
AAAA
--------------ms010202000106020805010209--
10 years, 8 months
- 2
- 1
[Users] Clome thin provision to thin provision??
by Federico Alberto Sayd
Hello:
Is it possible to clone a vm with thin provisioned disks to another vm
with thin provisioned disks too?
Currently when I clone a VM from a snapshot, although I choose "thin
provision" in "resource allocation"->"Storage Allocation" from the
"Clone VM from Snapshot dialog", the VM is created with preallocated disk(s)
Is this the default or there is a problem with my engine/nodes installation?
Engine: Centos 6.5, ovirt-engine 3.4.0-1.el6
Nodes: Centos 6.5, vdsm-4.13.3-2.el6
10 years, 8 months
- 2
- 3
[Users] How-to NAT / host-only virtual machine network
by Alexander von Gluck
Found a way to get easy NAT / host only virtual networks in oVirt 3.4. I
didn't see this documented, so posting it here:
1. Create a fake ethernet card
- ip link set name vmnet0dummy dev dummy0
Now you can create a new network (bridge) named vmnet0, and attach it to
vmnet0dummy.
The issue is that as posted on
http://www.ovirt.org/Features/Nicless_Network#Benefit_to_oVirt:
"
I am told that implementing this in Engine is quite a pain, as network
external interfaces are currently used as keys. A network without nics is
currently unsearchable.
"
You'll need to figure out your own dhcp / NAT using libvirt or something
running on your server, but a *lot* easier and less hacky than
http://lists.ovirt.org/pipermail/users/2012-April/001751.html :-)
-- Alex
10 years, 8 months
- 1
- 0
Re: [Users] upgrade from 3.3 to 3.4 on fedora 19 failed
by Alastair Neil
Thanks Alon, that did the trick and my upgrade completed successfully.
On 31 March 2014 23:18, Alastair Neil <ajneil.tech(a)gmail.com> wrote:
> Thanks Alon
>
>
> On 31 March 2014 19:22, Alon Bar-Lev <alonbl(a)redhat.com> wrote:
>
>>
>>
>> ----- Original Message -----
>> > From: "Alastair Neil" <ajneil.tech(a)gmail.com>
>> > To: "Alon Bar-Lev" <alonbl(a)redhat.com>
>> > Sent: Tuesday, April 1, 2014 2:10:03 AM
>> > Subject: Re: [Users] upgrade from 3.3 to 3.4 on fedora 19 failed
>> >
>> > So are there any specific actions I need to do or just try tomorrow?
>>
>> You can edit:
>> /usr/share/ovirt-engine/setup/ovirt_engine_setup/constants.py
>>
>> Replace:
>> UPGRADE_YUM_GROUP = 'ovirt-engine-3.4'
>> With:
>> UPGRADE_YUM_GROUP = 'ovirt-engine-XXX'
>>
>> This will make setup ignore the bad group and upgrade based on package
>> name.
>>
>> >
>> > -Alastair
>> >
>> >
>> >
>> > On 31 March 2014 19:07, Alon Bar-Lev <alonbl(a)redhat.com> wrote:
>> >
>> > >
>> > > The group within repository[1] is invalid.
>> > >
>> > > Sandro, kiril, please modify ovirt->ovirt-enigne and check that all
>> > > packages are OK.
>> > >
>> > > I also do not know what this file[2] is at that location.
>> > >
>> > > Alastair, all the issues are caused by this, as product is not
>> upgraded to
>> > > 3.4, so setup package of 3.4 is trying to setup 3.3 product.
>> > >
>> > > Thank you for the report!
>> > >
>> > > Alon
>> > >
>> > > [1]
>> > >
>> http://resources.ovirt.org/pub/ovirt-3.4/rpm/fc19/repodata/6cf75ccf11a0c2...
>> > > [2] http://resources.ovirt.org/pub/ovirt-3.4/ovirt34.xml
>> > >
>> > > ----- Original Message -----
>> > > > From: "Alastair Neil" <ajneil.tech(a)gmail.com>
>> > > > To: "Alon Bar-Lev" <alonbl(a)redhat.com>
>> > > > Cc: users(a)ovirt.org
>> > > > Sent: Tuesday, April 1, 2014 1:59:16 AM
>> > > > Subject: Re: [Users] upgrade from 3.3 to 3.4 on fedora 19 failed
>> > > >
>> > > > I tried manually copying the directory /etc/ovirt-engine/sysprep to
>> > > > /usr/share/ovirt-engine/conf, and then running engine-setup
>> > > >
>> > > > I now get a different failure:
>> > > >
>> > > > [ ERROR ] Failed to execute stage 'Misc configuration': function
>> > > > inst_add_glance_provider(unknown, unknown, unknown, unknown,
>> unknown)
>> > > does
>> > > > not exist LINE 2: select inst_add_glance_provider(
>> > > > ^ HINT: No function matches the given name
>> and
>> > > > argument types. You might need to add explicit type casts.
>> > > >
>> > > > I am attaching the logs from both in case this was a bogus thing to
>> try
>> > > >
>> > > > -20140331175537.log has the original failure and the second in in
>> the
>> > > > other file.
>> > > >
>> > > > Thanks
>> > > >
>> > > > -Alastair
>> > > >
>> > > >
>> > > >
>> > > > On 31 March 2014 18:24, Alon Bar-Lev <alonbl(a)redhat.com> wrote:
>> > > >
>> > > > >
>> > > > >
>> > > > > ----- Original Message -----
>> > > > > > From: "Alastair Neil" <ajneil.tech(a)gmail.com>
>> > > > > > To: users(a)ovirt.org
>> > > > > > Sent: Tuesday, April 1, 2014 1:18:37 AM
>> > > > > > Subject: [Users] upgrade from 3.3 to 3.4 on fedora 19 failed
>> > > > > >
>> > > > > > Any suggestions what to look for?
>> > > > >
>> > > > > Please attach:
>> > > > > /var/log/ovirt-engine/setup/ovirt-engine-setup-20140331175537.log
>> > > > >
>> > > > > > Thanks
>> > > > > > Alastair
>> > > > > >
>> > > > > >
>> > > > > >
>> > > > > > [root@ovirt-admin ~]# engine-setup
>> > > > > > [ INFO ] Stage: Initializing
>> > > > > > [ INFO ] Stage: Environment setup
>> > > > > > Configuration files:
>> > > ['/etc/ovirt-engine-setup.conf.d/10-packaging.conf',
>> > > > > > '/etc/ovirt-engine-setup.conf.d/20-setup-ovirt-post.conf']
>> > > > > > Log file:
>> > > > > /var/log/ovirt-engine/setup/ovirt-engine-setup-20140331175537.log
>> > > > > > Version: otopi-1.2.0 (otopi-1.2.0-1.fc19)
>> > > > > > [ INFO ] Stage: Environment packages setup
>> > > > > > [ INFO ] Stage: Programs detection
>> > > > > > [ INFO ] Stage: Environment setup
>> > > > > > [ INFO ] Stage: Environment customization
>> > > > > >
>> > > > > > --== PRODUCT OPTIONS ==--
>> > > > > >
>> > > > > >
>> > > > > > --== PACKAGES ==--
>> > > > > >
>> > > > > > [ INFO ] Checking for product updates...
>> > > > > > [ INFO ] No product updates found
>> > > > > >
>> > > > > > --== NETWORK CONFIGURATION ==--
>> > > > > >
>> > > > > > Setup can automatically configure the firewall on this system.
>> > > > > > Note: automatic configuration of the firewall may overwrite
>> current
>> > > > > settings.
>> > > > > > Do you want Setup to configure the firewall? (Yes, No) [Yes]:
>> > > > > > [ INFO ] firewalld will be configured as firewall manager.
>> > > > > >
>> > > > > > --== DATABASE CONFIGURATION ==--
>> > > > > >
>> > > > > > --== OVIRT ENGINE CONFIGURATION ==--
>> > > > > >
>> > > > > > Skipping storing options as database already prepared
>> > > > > >
>> > > > > > --== PKI CONFIGURATION ==--
>> > > > > >
>> > > > > > PKI is already configured
>> > > > > > --== APACHE CONFIGURATION ==--
>> > > > > >
>> > > > > > --== SYSTEM CONFIGURATION ==--
>> > > > > >
>> > > > > > --== MISC CONFIGURATION ==--
>> > > > > >
>> > > > > > --== END OF CONFIGURATION ==--
>> > > > > >
>> > > > > > [ INFO ] Stage: Setup validation
>> > > > > > [WARNING] Less than 16384MB of memory is available
>> > > > > > [ INFO ] Cleaning stale zombie tasks
>> > > > > >
>> > > > > > --== CONFIGURATION PREVIEW ==--
>> > > > > >
>> > > > > > Engine database name : engine
>> > > > > > Engine database secured connection : False
>> > > > > > Engine database host : localhost
>> > > > > > Engine database user name : engine
>> > > > > > Engine database host name validation : False
>> > > > > > Engine database port : 5432
>> > > > > > NFS setup : True
>> > > > > > Firewall manager : firewalld
>> > > > > > Update Firewall : True
>> > > > > > Configure WebSocket Proxy : True
>> > > > > > Host FQDN : ovirt-admin.xxxxx.xxx.xxx
>> > > > > > NFS mount point : /var/lib/exports/iso
>> > > > > > Set application as default page : True
>> > > > > > Configure Apache SSL : True
>> > > > > >
>> > > > > > Please confirm installation settings (OK, Cancel) [OK]:
>> > > > > > [ INFO ] Cleaning async tasks and compensations
>> > > > > > [ INFO ] Checking the Engine database consistency
>> > > > > > [ INFO ] Stage: Transaction setup
>> > > > > > [ INFO ] Stopping engine service
>> > > > > > [ INFO ] Stage: Misc configuration
>> > > > > > [ INFO ] Stage: Package installation
>> > > > > > [ INFO ] Stage: Misc configuration
>> > > > > > [ INFO ] Backing up database localhost:engine to
>> > > > > >
>> '/var/lib/ovirt-engine/backups/engine-20140331175747.lV9QoZ.sql'.
>> > > > > > [ INFO ] Updating Engine database schema
>> > > > > > [ ERROR ] Failed to execute stage 'Misc configuration': [Errno
>> 2] No
>> > > such
>> > > > > > file or directory:
>> '/usr/share/ovirt-engine/conf/sysprep/sysprep.2k3'
>> > > > > > [ INFO ] Yum Performing yum transaction rollback
>> > > > > > [ INFO ] Rolling back database schema
>> > > > > > [ INFO ] Clearing Engine database engine
>> > > > > > [ INFO ] Restoring Engine database engine
>> > > > > > [ INFO ] Stage: Clean up
>> > > > > > Log file is located at
>> > > > > >
>> /var/log/ovirt-engine/setup/ovirt-engine-setup-20140331175537.log
>> > > > > > [ INFO ] Stage: Pre-termination
>> > > > > > [ INFO ] Stage: Termination
>> > > > > > [ ERROR ] Execution of setup failed
>> > > > > >
>> > > > > >
>> > > > > > _______________________________________________
>> > > > > > Users mailing list
>> > > > > > Users(a)ovirt.org
>> > > > > > http://lists.ovirt.org/mailman/listinfo/users
>> > > > > >
>> > > > >
>> > > >
>> > >
>> >
>>
>
>
10 years, 8 months
- 1
- 0
Re: [Users] Error installing self hosted engine
by ovirt-test＠arcor.de
------=_Part_594693_2003216810.1396362976018
Content-Type: multipart/alternative;
boundary="----=_Part_594692_1360520117.1396362976018"
------=_Part_594692_1360520117.1396362976018
Content-Type: text/plain; charset=ISO-8859-1
Content-Transfer-Encoding: 7bit
> Can you please attach also vdsm logs?
Thank you. I have attached the logfiles (mom.log, supervdsm.log, vdsm.log).
metadata.log is empty
------=_Part_594692_1360520117.1396362976018--
------=_Part_594693_2003216810.1396362976018
Content-Type: text/x-log
Content-Transfer-Encoding: 7bit
Content-Disposition: attachment; filename=vdsm.log
MainThread::INFO::2014-04-01 12:50:15,497::vdsm::119::vds::(run) (PID: 5366) I am the actual vdsm 4.14.6-0.el6 ovirt01.mydomain (2.6.32-431.11.2.el6.x86_64)
MainThread::DEBUG::2014-04-01 12:50:15,498::resourceManager::421::ResourceManager::(registerNamespace) Registering namespace 'Storage'
MainThread::DEBUG::2014-04-01 12:50:15,499::threadPool::35::Misc.ThreadPool::(__init__) Enter - numThreads: 10.0, waitTimeout: 3, maxTasks: 500.0
MainThread::WARNING::2014-04-01 12:50:15,504::fileUtils::167::Storage.fileUtils::(createdir) Dir /rhev/data-center/mnt already exists
MainThread::DEBUG::2014-04-01 12:50:15,994::supervdsm::77::SuperVdsmProxy::(_connect) Trying to connect to Super Vdsm
MainThread::DEBUG::2014-04-01 12:50:16,020::multipath::142::Storage.Multipath::(isEnabled) Current revision of multipath.conf detected, preserving
MainThread::DEBUG::2014-04-01 12:50:16,020::hsm::423::Storage.Misc.excCmd::(__validateLvmLockingType) '/usr/bin/sudo -n /sbin/lvm dumpconfig global/locking_type' (cwd None)
MainThread::DEBUG::2014-04-01 12:50:16,211::hsm::423::Storage.Misc.excCmd::(__validateLvmLockingType) SUCCESS: <err> = ''; <rc> = 0
MainThread::DEBUG::2014-04-01 12:50:16,212::hsm::447::Storage.HSM::(__cleanStorageRepository) Started cleaning storage repository at '/rhev/data-center'
MainThread::DEBUG::2014-04-01 12:50:16,216::hsm::479::Storage.HSM::(__cleanStorageRepository) White list: ['/rhev/data-center/hsm-tasks', '/rhev/data-center/hsm-tasks/*', '/rhev/data-center/mnt']
MainThread::DEBUG::2014-04-01 12:50:16,217::hsm::480::Storage.HSM::(__cleanStorageRepository) Mount list: []
MainThread::DEBUG::2014-04-01 12:50:16,217::hsm::482::Storage.HSM::(__cleanStorageRepository) Cleaning leftovers
MainThread::DEBUG::2014-04-01 12:50:16,218::hsm::525::Storage.HSM::(__cleanStorageRepository) Finished cleaning storage repository at '/rhev/data-center'
storageRefresh::DEBUG::2014-04-01 12:50:16,218::misc::762::SamplingMethod::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage)
MainThread::INFO::2014-04-01 12:50:16,220::dispatcher::97::Storage.Dispatcher::(__init__) Starting StorageDispatcher...
storageRefresh::DEBUG::2014-04-01 12:50:16,235::misc::764::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2014-04-01 12:50:16,240::misc::762::SamplingMethod::(__call__) Trying to enter sampling method (storage.iscsi.rescan)
storageRefresh::DEBUG::2014-04-01 12:50:16,254::misc::764::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2014-04-01 12:50:16,255::iscsi::393::Storage.ISCSI::(rescan) Performing SCSI scan, this will take up to 30 seconds
storageRefresh::DEBUG::2014-04-01 12:50:16,257::iscsiadm::92::Storage.Misc.excCmd::(_runCmd) '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None)
storageRefresh::DEBUG::2014-04-01 12:50:16,273::misc::772::SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2014-04-01 12:50:16,274::multipath::110::Storage.Misc.excCmd::(rescan) '/usr/bin/sudo -n /sbin/multipath -r' (cwd None)
MainThread::DEBUG::2014-04-01 12:50:16,302::task::595::TaskManager.Task::(_updateState) Task=`e024f2c2-4487-4115-869a-954a2d3eb26f`::moving from state init -> state preparing
MainThread::INFO::2014-04-01 12:50:16,302::logUtils::44::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback(callbackFunc=<bound method clientIF.contEIOVms of <clientIF.clientIF instance at 0x2d27fc8>>)
MainThread::INFO::2014-04-01 12:50:16,303::logUtils::47::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback, Return response: None
MainThread::DEBUG::2014-04-01 12:50:16,303::task::1185::TaskManager.Task::(prepare) Task=`e024f2c2-4487-4115-869a-954a2d3eb26f`::finished: None
MainThread::DEBUG::2014-04-01 12:50:16,303::task::595::TaskManager.Task::(_updateState) Task=`e024f2c2-4487-4115-869a-954a2d3eb26f`::moving from state preparing -> state finished
MainThread::DEBUG::2014-04-01 12:50:16,303::resourceManager::940::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2014-04-01 12:50:16,303::resourceManager::977::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2014-04-01 12:50:16,303::task::990::TaskManager.Task::(_decref) Task=`e024f2c2-4487-4115-869a-954a2d3eb26f`::ref 0 aborting False
MainThread::INFO::2014-04-01 12:50:16,312::momIF::47::MOM::(__init__) Starting up MOM
MainThread::INFO::2014-04-01 12:50:16,318::vmChannels::187::vds::(settimeout) Setting channels' timeout to 30 seconds.
VM Channels Listener::INFO::2014-04-01 12:50:16,349::vmChannels::170::vds::(run) Starting VM channels listener thread.
clientIFinit::DEBUG::2014-04-01 12:50:16,350::libvirtconnection::145::root::(get) trying to connect libvirt
MainThread::WARNING::2014-04-01 12:50:16,363::clientIF::181::vds::(_prepareBindings) Unable to load the json rpc server module. Please make sure it is installed.
storageRefresh::DEBUG::2014-04-01 12:50:16,379::multipath::110::Storage.Misc.excCmd::(rescan) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2014-04-01 12:50:16,381::lvm::496::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 12:50:16,381::lvm::498::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 12:50:16,382::lvm::507::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 12:50:16,382::lvm::509::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 12:50:16,382::lvm::527::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 12:50:16,383::lvm::529::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 12:50:16,383::misc::772::SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2014-04-01 12:50:16,383::lvm::324::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 12:50:16,387::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm pvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,size,vg_name,vg_uuid,pe_start,pe_count,pe_alloc_count,mda_count,dev_size' (cwd None)
storageRefresh::DEBUG::2014-04-01 12:50:16,564::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2014-04-01 12:50:16,567::lvm::349::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 12:50:16,570::lvm::372::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 12:50:16,581::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name' (cwd None)
storageRefresh::DEBUG::2014-04-01 12:50:16,729::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 12:50:16,729::lvm::414::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 12:50:16,730::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm lvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,vg_name,attr,size,seg_start_pe,devices,tags' (cwd None)
storageRefresh::DEBUG::2014-04-01 12:50:16,873::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 12:50:16,873::lvm::372::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 12:50:16,874::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name' (cwd None)
storageRefresh::DEBUG::2014-04-01 12:50:17,016::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 12:50:17,017::lvm::414::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::WARNING::2014-04-01 12:50:17,017::fileUtils::167::Storage.fileUtils::(createdir) Dir /rhev/data-center/hsm-tasks already exists
storageRefresh::DEBUG::2014-04-01 12:50:17,018::hsm::391::Storage.HSM::(storageRefresh) HSM is ready
MainThread::DEBUG::2014-04-01 12:50:31,127::vdsm::55::vds::(sigtermHandler) Received signal 15
MainThread::INFO::2014-04-01 12:50:31,387::vmChannels::183::vds::(stop) VM channels listener was stopped.
MainThread::INFO::2014-04-01 12:50:31,387::momIF::84::MOM::(stop) Shutting down MOM
MainThread::DEBUG::2014-04-01 12:50:31,388::task::595::TaskManager.Task::(_updateState) Task=`a07b1802-4b0c-4e13-ba61-7a95b67c2c00`::moving from state init -> state preparing
MainThread::INFO::2014-04-01 12:50:31,389::logUtils::44::dispatcher::(wrapper) Run and protect: prepareForShutdown(options=None)
Thread-11::DEBUG::2014-04-01 12:50:31,389::storageServer::698::ConnectionMonitor::(_monitorConnections) Monitoring stopped
MainThread::INFO::2014-04-01 12:50:31,882::domainMonitor::125::Storage.DomainMonitor::(close) Stopping domain monitors
MainThread::DEBUG::2014-04-01 12:50:31,882::taskManager::80::TaskManager::(prepareForShutdown) Request to stop all tasks
MainThread::INFO::2014-04-01 12:50:31,907::logUtils::47::dispatcher::(wrapper) Run and protect: prepareForShutdown, Return response: None
MainThread::DEBUG::2014-04-01 12:50:31,907::task::1185::TaskManager.Task::(prepare) Task=`a07b1802-4b0c-4e13-ba61-7a95b67c2c00`::finished: None
MainThread::DEBUG::2014-04-01 12:50:31,907::task::595::TaskManager.Task::(_updateState) Task=`a07b1802-4b0c-4e13-ba61-7a95b67c2c00`::moving from state preparing -> state finished
MainThread::DEBUG::2014-04-01 12:50:31,907::resourceManager::940::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2014-04-01 12:50:31,908::resourceManager::977::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2014-04-01 12:50:31,908::task::990::TaskManager.Task::(_decref) Task=`a07b1802-4b0c-4e13-ba61-7a95b67c2c00`::ref 0 aborting False
MainThread::INFO::2014-04-01 12:50:31,908::vdsm::125::vds::(run) VDSM main thread ended. Waiting for 14 other threads...
MainThread::INFO::2014-04-01 12:50:31,908::vdsm::129::vds::(run) <_MainThread(MainThread, started 140606334629632)>
MainThread::INFO::2014-04-01 12:50:31,908::vdsm::129::vds::(run) <Thread(libvirtEventLoop, started daemon 140606066681600)>
MainThread::INFO::2014-04-01 12:50:31,908::vdsm::129::vds::(run) <WorkerThread(Thread-4, started daemon 140605820761856)>
MainThread::INFO::2014-04-01 12:50:31,908::vdsm::129::vds::(run) <PolicyEngine(PolicyEngine, started daemon 140605298550528)>
MainThread::INFO::2014-04-01 12:50:31,909::momIF::84::MOM::(stop) Shutting down MOM
MainThread::INFO::2014-04-01 12:50:31,909::vdsm::129::vds::(run) <MomThread(MOM, started 140605309040384)>
MainThread::INFO::2014-04-01 12:50:31,909::vdsm::129::vds::(run) <WorkerThread(Thread-7, started daemon 140605789292288)>
MainThread::INFO::2014-04-01 12:50:31,909::vmChannels::183::vds::(stop) VM channels listener was stopped.
MainThread::INFO::2014-04-01 12:50:31,909::vdsm::129::vds::(run) <Listener(VM Channels Listener, started daemon 140604881237760)>
MainThread::INFO::2014-04-01 12:50:31,909::vdsm::129::vds::(run) <WorkerThread(Thread-10, started daemon 140605350999808)>
MainThread::INFO::2014-04-01 12:50:31,909::vdsm::129::vds::(run) <WorkerThread(Thread-3, started daemon 140606035212032)>
MainThread::INFO::2014-04-01 12:50:31,910::vdsm::129::vds::(run) <WorkerThread(Thread-2, started daemon 140606045701888)>
MainThread::INFO::2014-04-01 12:50:31,910::vdsm::129::vds::(run) <WorkerThread(Thread-1, started daemon 140606056191744)>
MainThread::INFO::2014-04-01 12:50:31,910::vdsm::129::vds::(run) <WorkerThread(Thread-6, started daemon 140605799782144)>
MainThread::INFO::2014-04-01 12:50:31,910::vdsm::129::vds::(run) <WorkerThread(Thread-8, started daemon 140605778802432)>
MainThread::INFO::2014-04-01 12:50:31,910::vdsm::129::vds::(run) <WorkerThread(Thread-9, started daemon 140605768312576)>
MainThread::INFO::2014-04-01 12:50:31,910::vdsm::129::vds::(run) <WorkerThread(Thread-5, started daemon 140605810272000)>
VM Channels Listener::INFO::2014-04-01 12:50:32,368::vmChannels::178::vds::(run) VM channels listener thread has ended.
MainThread::INFO::2014-04-01 12:52:42,089::vdsm::119::vds::(run) (PID: 1954) I am the actual vdsm 4.14.6-0.el6 ovirt01.mydomain (2.6.32-431.11.2.el6.x86_64)
MainThread::DEBUG::2014-04-01 12:52:42,093::resourceManager::421::ResourceManager::(registerNamespace) Registering namespace 'Storage'
MainThread::DEBUG::2014-04-01 12:52:42,093::threadPool::35::Misc.ThreadPool::(__init__) Enter - numThreads: 10.0, waitTimeout: 3, maxTasks: 500.0
MainThread::WARNING::2014-04-01 12:52:42,105::fileUtils::167::Storage.fileUtils::(createdir) Dir /rhev/data-center/mnt already exists
MainThread::DEBUG::2014-04-01 12:52:42,618::supervdsm::77::SuperVdsmProxy::(_connect) Trying to connect to Super Vdsm
MainThread::DEBUG::2014-04-01 12:52:42,650::multipath::142::Storage.Multipath::(isEnabled) Current revision of multipath.conf detected, preserving
MainThread::DEBUG::2014-04-01 12:52:42,650::hsm::423::Storage.Misc.excCmd::(__validateLvmLockingType) '/usr/bin/sudo -n /sbin/lvm dumpconfig global/locking_type' (cwd None)
MainThread::DEBUG::2014-04-01 12:52:42,844::hsm::423::Storage.Misc.excCmd::(__validateLvmLockingType) SUCCESS: <err> = ''; <rc> = 0
MainThread::DEBUG::2014-04-01 12:52:42,844::hsm::447::Storage.HSM::(__cleanStorageRepository) Started cleaning storage repository at '/rhev/data-center'
MainThread::DEBUG::2014-04-01 12:52:42,848::hsm::479::Storage.HSM::(__cleanStorageRepository) White list: ['/rhev/data-center/hsm-tasks', '/rhev/data-center/hsm-tasks/*', '/rhev/data-center/mnt']
MainThread::DEBUG::2014-04-01 12:52:42,849::hsm::480::Storage.HSM::(__cleanStorageRepository) Mount list: []
MainThread::DEBUG::2014-04-01 12:52:42,849::hsm::482::Storage.HSM::(__cleanStorageRepository) Cleaning leftovers
MainThread::DEBUG::2014-04-01 12:52:42,850::hsm::525::Storage.HSM::(__cleanStorageRepository) Finished cleaning storage repository at '/rhev/data-center'
storageRefresh::DEBUG::2014-04-01 12:52:42,850::misc::762::SamplingMethod::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage)
MainThread::INFO::2014-04-01 12:52:42,852::dispatcher::97::Storage.Dispatcher::(__init__) Starting StorageDispatcher...
storageRefresh::DEBUG::2014-04-01 12:52:43,018::misc::764::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2014-04-01 12:52:43,021::misc::762::SamplingMethod::(__call__) Trying to enter sampling method (storage.iscsi.rescan)
storageRefresh::DEBUG::2014-04-01 12:52:43,088::misc::764::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2014-04-01 12:52:43,088::iscsi::393::Storage.ISCSI::(rescan) Performing SCSI scan, this will take up to 30 seconds
storageRefresh::DEBUG::2014-04-01 12:52:43,089::iscsiadm::92::Storage.Misc.excCmd::(_runCmd) '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None)
storageRefresh::DEBUG::2014-04-01 12:52:43,157::misc::772::SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2014-04-01 12:52:43,158::multipath::110::Storage.Misc.excCmd::(rescan) '/usr/bin/sudo -n /sbin/multipath -r' (cwd None)
MainThread::DEBUG::2014-04-01 12:52:43,225::task::595::TaskManager.Task::(_updateState) Task=`7c021db9-d327-4ca2-8f58-5ab2bd8dcf2f`::moving from state init -> state preparing
MainThread::INFO::2014-04-01 12:52:43,225::logUtils::44::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback(callbackFunc=<bound method clientIF.contEIOVms of <clientIF.clientIF instance at 0x11dc098>>)
MainThread::INFO::2014-04-01 12:52:43,225::logUtils::47::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback, Return response: None
MainThread::DEBUG::2014-04-01 12:52:43,226::task::1185::TaskManager.Task::(prepare) Task=`7c021db9-d327-4ca2-8f58-5ab2bd8dcf2f`::finished: None
MainThread::DEBUG::2014-04-01 12:52:43,226::task::595::TaskManager.Task::(_updateState) Task=`7c021db9-d327-4ca2-8f58-5ab2bd8dcf2f`::moving from state preparing -> state finished
MainThread::DEBUG::2014-04-01 12:52:43,226::resourceManager::940::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2014-04-01 12:52:43,226::resourceManager::977::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2014-04-01 12:52:43,227::task::990::TaskManager.Task::(_decref) Task=`7c021db9-d327-4ca2-8f58-5ab2bd8dcf2f`::ref 0 aborting False
storageRefresh::DEBUG::2014-04-01 12:52:43,228::multipath::110::Storage.Misc.excCmd::(rescan) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2014-04-01 12:52:43,229::lvm::496::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 12:52:43,229::lvm::498::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 12:52:43,229::lvm::507::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 12:52:43,229::lvm::509::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 12:52:43,230::lvm::527::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 12:52:43,230::lvm::529::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 12:52:43,230::misc::772::SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2014-04-01 12:52:43,230::lvm::324::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 12:52:43,233::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm pvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,size,vg_name,vg_uuid,pe_start,pe_count,pe_alloc_count,mda_count,dev_size' (cwd None)
MainThread::INFO::2014-04-01 12:52:43,244::momIF::47::MOM::(__init__) Starting up MOM
MainThread::INFO::2014-04-01 12:52:43,253::vmChannels::187::vds::(settimeout) Setting channels' timeout to 30 seconds.
VM Channels Listener::INFO::2014-04-01 12:52:43,255::vmChannels::170::vds::(run) Starting VM channels listener thread.
MainThread::WARNING::2014-04-01 12:52:43,396::clientIF::181::vds::(_prepareBindings) Unable to load the json rpc server module. Please make sure it is installed.
clientIFinit::DEBUG::2014-04-01 12:52:43,399::libvirtconnection::145::root::(get) trying to connect libvirt
storageRefresh::DEBUG::2014-04-01 12:52:43,417::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2014-04-01 12:52:43,418::lvm::349::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 12:52:43,418::lvm::372::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 12:52:43,419::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name' (cwd None)
storageRefresh::DEBUG::2014-04-01 12:52:43,575::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 12:52:43,578::lvm::414::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 12:52:43,606::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm lvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,vg_name,attr,size,seg_start_pe,devices,tags' (cwd None)
storageRefresh::DEBUG::2014-04-01 12:52:43,767::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 12:52:43,767::lvm::372::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 12:52:43,768::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name' (cwd None)
storageRefresh::DEBUG::2014-04-01 12:52:43,930::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 12:52:43,930::lvm::414::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::WARNING::2014-04-01 12:52:43,931::fileUtils::167::Storage.fileUtils::(createdir) Dir /rhev/data-center/hsm-tasks already exists
storageRefresh::DEBUG::2014-04-01 12:52:43,939::hsm::391::Storage.HSM::(storageRefresh) HSM is ready
Thread-13::DEBUG::2014-04-01 12:55:50,786::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-13::DEBUG::2014-04-01 12:55:50,929::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-14::DEBUG::2014-04-01 13:02:22,261::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-14::DEBUG::2014-04-01 13:02:22,285::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-15::DEBUG::2014-04-01 13:04:41,953::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-15::DEBUG::2014-04-01 13:04:41,955::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-16::DEBUG::2014-04-01 13:04:49,768::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-16::DEBUG::2014-04-01 13:04:49,777::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-17::DEBUG::2014-04-01 13:06:19,190::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-17::DEBUG::2014-04-01 13:06:19,192::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
MainThread::DEBUG::2014-04-01 13:11:01,685::vdsm::55::vds::(sigtermHandler) Received signal 15
MainThread::INFO::2014-04-01 13:11:02,459::vmChannels::183::vds::(stop) VM channels listener was stopped.
MainThread::INFO::2014-04-01 13:11:02,460::momIF::84::MOM::(stop) Shutting down MOM
MainThread::DEBUG::2014-04-01 13:11:02,460::task::595::TaskManager.Task::(_updateState) Task=`45e391ef-1ad3-4a09-a344-988a3172b11e`::moving from state init -> state preparing
MainThread::INFO::2014-04-01 13:11:02,461::logUtils::44::dispatcher::(wrapper) Run and protect: prepareForShutdown(options=None)
Thread-11::DEBUG::2014-04-01 13:11:02,462::storageServer::698::ConnectionMonitor::(_monitorConnections) Monitoring stopped
VM Channels Listener::INFO::2014-04-01 13:11:02,601::vmChannels::178::vds::(run) VM channels listener thread has ended.
MainThread::INFO::2014-04-01 13:11:02,971::domainMonitor::125::Storage.DomainMonitor::(close) Stopping domain monitors
MainThread::DEBUG::2014-04-01 13:11:02,971::taskManager::80::TaskManager::(prepareForShutdown) Request to stop all tasks
MainThread::INFO::2014-04-01 13:11:02,971::logUtils::47::dispatcher::(wrapper) Run and protect: prepareForShutdown, Return response: None
MainThread::DEBUG::2014-04-01 13:11:02,971::task::1185::TaskManager.Task::(prepare) Task=`45e391ef-1ad3-4a09-a344-988a3172b11e`::finished: None
MainThread::DEBUG::2014-04-01 13:11:02,971::task::595::TaskManager.Task::(_updateState) Task=`45e391ef-1ad3-4a09-a344-988a3172b11e`::moving from state preparing -> state finished
MainThread::DEBUG::2014-04-01 13:11:02,971::resourceManager::940::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2014-04-01 13:11:02,972::resourceManager::977::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2014-04-01 13:11:02,972::task::990::TaskManager.Task::(_decref) Task=`45e391ef-1ad3-4a09-a344-988a3172b11e`::ref 0 aborting False
MainThread::INFO::2014-04-01 13:11:02,972::vdsm::125::vds::(run) VDSM main thread ended. Waiting for 15 other threads...
MainThread::INFO::2014-04-01 13:11:02,972::vdsm::129::vds::(run) <_MainThread(MainThread, started 139901802637056)>
MainThread::INFO::2014-04-01 13:11:02,972::vdsm::129::vds::(run) <Thread(libvirtEventLoop, started daemon 139901535491840)>
MainThread::INFO::2014-04-01 13:11:02,972::vdsm::129::vds::(run) <GuestManager(GuestManager, started daemon 139900036839168)>
MainThread::INFO::2014-04-01 13:11:02,973::vdsm::129::vds::(run) <WorkerThread(Thread-2, started daemon 139901446125312)>
MainThread::INFO::2014-04-01 13:11:02,973::vdsm::129::vds::(run) <WorkerThread(Thread-1, started daemon 139901525001984)>
MainThread::INFO::2014-04-01 13:11:02,973::vdsm::129::vds::(run) <WorkerThread(Thread-6, started daemon 139901404165888)>
MainThread::INFO::2014-04-01 13:11:02,973::vdsm::129::vds::(run) <WorkerThread(Thread-9, started daemon 139900965873408)>
MainThread::INFO::2014-04-01 13:11:02,973::vdsm::129::vds::(run) <WorkerThread(Thread-5, started daemon 139901414655744)>
MainThread::INFO::2014-04-01 13:11:02,973::vdsm::129::vds::(run) <WorkerThread(Thread-4, started daemon 139901425145600)>
MainThread::INFO::2014-04-01 13:11:02,973::vdsm::129::vds::(run) <PolicyEngine(PolicyEngine, started daemon 139900496111360)>
MainThread::INFO::2014-04-01 13:11:02,973::vdsm::129::vds::(run) <WorkerThread(Thread-8, started daemon 139900976363264)>
MainThread::INFO::2014-04-01 13:11:02,974::vdsm::129::vds::(run) <WorkerThread(Thread-10, started daemon 139900955383552)>
MainThread::INFO::2014-04-01 13:11:02,974::vdsm::129::vds::(run) <WorkerThread(Thread-7, started daemon 139901393676032)>
MainThread::INFO::2014-04-01 13:11:02,974::vdsm::129::vds::(run) <WorkerThread(Thread-3, started daemon 139901435635456)>
MainThread::INFO::2014-04-01 13:11:02,974::vdsm::129::vds::(run) <HostMonitor(HostMonitor, started daemon 139900453762816)>
MainThread::INFO::2014-04-01 13:11:02,974::momIF::84::MOM::(stop) Shutting down MOM
MainThread::INFO::2014-04-01 13:11:02,974::vdsm::129::vds::(run) <MomThread(MOM, started 139900506601216)>
MainThread::INFO::2014-04-01 13:11:10,078::vdsm::119::vds::(run) (PID: 3343) I am the actual vdsm 4.14.6-0.el6 ovirt01.mydomain (2.6.32-431.11.2.el6.x86_64)
MainThread::DEBUG::2014-04-01 13:11:10,080::resourceManager::421::ResourceManager::(registerNamespace) Registering namespace 'Storage'
MainThread::DEBUG::2014-04-01 13:11:10,080::threadPool::35::Misc.ThreadPool::(__init__) Enter - numThreads: 10.0, waitTimeout: 3, maxTasks: 500.0
MainThread::WARNING::2014-04-01 13:11:10,086::fileUtils::167::Storage.fileUtils::(createdir) Dir /rhev/data-center/mnt already exists
MainThread::DEBUG::2014-04-01 13:11:10,586::supervdsm::77::SuperVdsmProxy::(_connect) Trying to connect to Super Vdsm
MainThread::DEBUG::2014-04-01 13:11:10,616::multipath::142::Storage.Multipath::(isEnabled) Current revision of multipath.conf detected, preserving
MainThread::DEBUG::2014-04-01 13:11:10,616::hsm::423::Storage.Misc.excCmd::(__validateLvmLockingType) '/usr/bin/sudo -n /sbin/lvm dumpconfig global/locking_type' (cwd None)
MainThread::DEBUG::2014-04-01 13:11:10,809::hsm::423::Storage.Misc.excCmd::(__validateLvmLockingType) SUCCESS: <err> = ''; <rc> = 0
MainThread::DEBUG::2014-04-01 13:11:10,809::hsm::447::Storage.HSM::(__cleanStorageRepository) Started cleaning storage repository at '/rhev/data-center'
MainThread::DEBUG::2014-04-01 13:11:10,814::hsm::479::Storage.HSM::(__cleanStorageRepository) White list: ['/rhev/data-center/hsm-tasks', '/rhev/data-center/hsm-tasks/*', '/rhev/data-center/mnt']
MainThread::DEBUG::2014-04-01 13:11:10,814::hsm::480::Storage.HSM::(__cleanStorageRepository) Mount list: []
MainThread::DEBUG::2014-04-01 13:11:10,814::hsm::482::Storage.HSM::(__cleanStorageRepository) Cleaning leftovers
MainThread::DEBUG::2014-04-01 13:11:10,815::hsm::525::Storage.HSM::(__cleanStorageRepository) Finished cleaning storage repository at '/rhev/data-center'
storageRefresh::DEBUG::2014-04-01 13:11:10,816::misc::762::SamplingMethod::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage)
MainThread::INFO::2014-04-01 13:11:10,817::dispatcher::97::Storage.Dispatcher::(__init__) Starting StorageDispatcher...
storageRefresh::DEBUG::2014-04-01 13:11:10,818::misc::764::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2014-04-01 13:11:10,838::misc::762::SamplingMethod::(__call__) Trying to enter sampling method (storage.iscsi.rescan)
storageRefresh::DEBUG::2014-04-01 13:11:10,841::misc::764::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2014-04-01 13:11:10,848::iscsi::393::Storage.ISCSI::(rescan) Performing SCSI scan, this will take up to 30 seconds
storageRefresh::DEBUG::2014-04-01 13:11:10,855::iscsiadm::92::Storage.Misc.excCmd::(_runCmd) '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:11:10,871::misc::772::SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2014-04-01 13:11:10,872::multipath::110::Storage.Misc.excCmd::(rescan) '/usr/bin/sudo -n /sbin/multipath -r' (cwd None)
MainThread::DEBUG::2014-04-01 13:11:10,906::task::595::TaskManager.Task::(_updateState) Task=`1bb370e2-557f-4392-93f8-2120ebe30369`::moving from state init -> state preparing
MainThread::INFO::2014-04-01 13:11:10,907::logUtils::44::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback(callbackFunc=<bound method clientIF.contEIOVms of <clientIF.clientIF instance at 0x2c8bfc8>>)
MainThread::INFO::2014-04-01 13:11:10,907::logUtils::47::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback, Return response: None
MainThread::DEBUG::2014-04-01 13:11:10,907::task::1185::TaskManager.Task::(prepare) Task=`1bb370e2-557f-4392-93f8-2120ebe30369`::finished: None
MainThread::DEBUG::2014-04-01 13:11:10,907::task::595::TaskManager.Task::(_updateState) Task=`1bb370e2-557f-4392-93f8-2120ebe30369`::moving from state preparing -> state finished
MainThread::DEBUG::2014-04-01 13:11:10,908::resourceManager::940::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2014-04-01 13:11:10,908::resourceManager::977::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2014-04-01 13:11:10,908::task::990::TaskManager.Task::(_decref) Task=`1bb370e2-557f-4392-93f8-2120ebe30369`::ref 0 aborting False
MainThread::INFO::2014-04-01 13:11:10,917::momIF::47::MOM::(__init__) Starting up MOM
MainThread::INFO::2014-04-01 13:11:10,927::vmChannels::187::vds::(settimeout) Setting channels' timeout to 30 seconds.
VM Channels Listener::INFO::2014-04-01 13:11:10,936::vmChannels::170::vds::(run) Starting VM channels listener thread.
clientIFinit::DEBUG::2014-04-01 13:11:10,959::libvirtconnection::145::root::(get) trying to connect libvirt
MainThread::WARNING::2014-04-01 13:11:10,979::clientIF::181::vds::(_prepareBindings) Unable to load the json rpc server module. Please make sure it is installed.
storageRefresh::DEBUG::2014-04-01 13:11:10,993::multipath::110::Storage.Misc.excCmd::(rescan) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:11:10,994::lvm::496::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:11:10,994::lvm::498::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:11:10,994::lvm::507::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:11:10,995::lvm::509::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:11:10,995::lvm::527::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:11:10,995::lvm::529::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:11:10,996::misc::772::SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2014-04-01 13:11:10,996::lvm::324::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:11:10,999::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm pvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,size,vg_name,vg_uuid,pe_start,pe_count,pe_alloc_count,mda_count,dev_size' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:11:11,209::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:11:11,212::lvm::349::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:11:11,215::lvm::372::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:11:11,249::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:11:11,396::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:11:11,396::lvm::414::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:11:11,397::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm lvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,vg_name,attr,size,seg_start_pe,devices,tags' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:11:11,539::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:11:11,540::lvm::372::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:11:11,540::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:11:11,682::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:11:11,683::lvm::414::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::WARNING::2014-04-01 13:11:11,684::fileUtils::167::Storage.fileUtils::(createdir) Dir /rhev/data-center/hsm-tasks already exists
storageRefresh::DEBUG::2014-04-01 13:11:11,685::hsm::391::Storage.HSM::(storageRefresh) HSM is ready
Thread-13::DEBUG::2014-04-01 13:11:22,955::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-13::DEBUG::2014-04-01 13:11:23,031::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
MainThread::DEBUG::2014-04-01 13:13:29,535::vdsm::55::vds::(sigtermHandler) Received signal 15
MainThread::INFO::2014-04-01 13:13:30,050::vmChannels::183::vds::(stop) VM channels listener was stopped.
MainThread::INFO::2014-04-01 13:13:30,050::momIF::84::MOM::(stop) Shutting down MOM
MainThread::DEBUG::2014-04-01 13:13:30,051::task::595::TaskManager.Task::(_updateState) Task=`94e511a0-85eb-48d4-beae-cdd00fac1cbe`::moving from state init -> state preparing
MainThread::INFO::2014-04-01 13:13:30,051::logUtils::44::dispatcher::(wrapper) Run and protect: prepareForShutdown(options=None)
Thread-11::DEBUG::2014-04-01 13:13:30,052::storageServer::698::ConnectionMonitor::(_monitorConnections) Monitoring stopped
VM Channels Listener::INFO::2014-04-01 13:13:30,105::vmChannels::178::vds::(run) VM channels listener thread has ended.
MainThread::INFO::2014-04-01 13:13:30,540::domainMonitor::125::Storage.DomainMonitor::(close) Stopping domain monitors
MainThread::DEBUG::2014-04-01 13:13:30,540::taskManager::80::TaskManager::(prepareForShutdown) Request to stop all tasks
MainThread::INFO::2014-04-01 13:13:30,540::logUtils::47::dispatcher::(wrapper) Run and protect: prepareForShutdown, Return response: None
MainThread::DEBUG::2014-04-01 13:13:30,540::task::1185::TaskManager.Task::(prepare) Task=`94e511a0-85eb-48d4-beae-cdd00fac1cbe`::finished: None
MainThread::DEBUG::2014-04-01 13:13:30,541::task::595::TaskManager.Task::(_updateState) Task=`94e511a0-85eb-48d4-beae-cdd00fac1cbe`::moving from state preparing -> state finished
MainThread::DEBUG::2014-04-01 13:13:30,541::resourceManager::940::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2014-04-01 13:13:30,541::resourceManager::977::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2014-04-01 13:13:30,541::task::990::TaskManager.Task::(_decref) Task=`94e511a0-85eb-48d4-beae-cdd00fac1cbe`::ref 0 aborting False
MainThread::INFO::2014-04-01 13:13:30,541::vdsm::125::vds::(run) VDSM main thread ended. Waiting for 15 other threads...
MainThread::INFO::2014-04-01 13:13:30,542::vdsm::129::vds::(run) <_MainThread(MainThread, started 140616788940544)>
MainThread::INFO::2014-04-01 13:13:30,542::vdsm::129::vds::(run) <Thread(libvirtEventLoop, started daemon 140616522061568)>
MainThread::INFO::2014-04-01 13:13:30,542::vdsm::129::vds::(run) <WorkerThread(Thread-2, started daemon 140616423962368)>
MainThread::INFO::2014-04-01 13:13:30,542::vdsm::129::vds::(run) <GuestManager(GuestManager, started daemon 140615429867264)>
MainThread::INFO::2014-04-01 13:13:30,542::vdsm::129::vds::(run) <HostMonitor(HostMonitor, started daemon 140615440357120)>
MainThread::INFO::2014-04-01 13:13:30,542::momIF::84::MOM::(stop) Shutting down MOM
MainThread::INFO::2014-04-01 13:13:30,542::vdsm::129::vds::(run) <MomThread(MOM, started 140615484438272)>
MainThread::INFO::2014-04-01 13:13:30,542::vdsm::129::vds::(run) <WorkerThread(Thread-7, started daemon 140616371513088)>
MainThread::INFO::2014-04-01 13:13:30,543::vdsm::129::vds::(run) <WorkerThread(Thread-6, started daemon 140616382002944)>
MainThread::INFO::2014-04-01 13:13:30,543::vdsm::129::vds::(run) <WorkerThread(Thread-9, started daemon 140615943710464)>
MainThread::INFO::2014-04-01 13:13:30,543::vdsm::129::vds::(run) <WorkerThread(Thread-5, started daemon 140616392492800)>
MainThread::INFO::2014-04-01 13:13:30,543::vdsm::129::vds::(run) <PolicyEngine(PolicyEngine, started daemon 140615473948416)>
MainThread::INFO::2014-04-01 13:13:30,543::vdsm::129::vds::(run) <WorkerThread(Thread-8, started daemon 140615954200320)>
MainThread::INFO::2014-04-01 13:13:30,543::vdsm::129::vds::(run) <WorkerThread(Thread-4, started daemon 140616402982656)>
MainThread::INFO::2014-04-01 13:13:30,543::vdsm::129::vds::(run) <WorkerThread(Thread-3, started daemon 140616413472512)>
MainThread::INFO::2014-04-01 13:13:30,544::vdsm::129::vds::(run) <WorkerThread(Thread-1, started daemon 140616511571712)>
MainThread::INFO::2014-04-01 13:13:30,544::vdsm::129::vds::(run) <WorkerThread(Thread-10, started daemon 140615933220608)>
MainThread::INFO::2014-04-01 13:16:43,521::vdsm::119::vds::(run) (PID: 4430) I am the actual vdsm 4.14.6-0.el6 ovirt01.mydomain (2.6.32-431.11.2.el6.x86_64)
MainThread::DEBUG::2014-04-01 13:16:43,522::resourceManager::421::ResourceManager::(registerNamespace) Registering namespace 'Storage'
MainThread::DEBUG::2014-04-01 13:16:43,523::threadPool::35::Misc.ThreadPool::(__init__) Enter - numThreads: 10.0, waitTimeout: 3, maxTasks: 500.0
MainThread::DEBUG::2014-04-01 13:16:44,023::supervdsm::77::SuperVdsmProxy::(_connect) Trying to connect to Super Vdsm
MainThread::DEBUG::2014-04-01 13:16:44,054::multipath::142::Storage.Multipath::(isEnabled) Current revision of multipath.conf detected, preserving
MainThread::DEBUG::2014-04-01 13:16:44,054::hsm::423::Storage.Misc.excCmd::(__validateLvmLockingType) '/usr/bin/sudo -n /sbin/lvm dumpconfig global/locking_type' (cwd None)
MainThread::DEBUG::2014-04-01 13:16:44,258::hsm::423::Storage.Misc.excCmd::(__validateLvmLockingType) SUCCESS: <err> = ''; <rc> = 0
MainThread::DEBUG::2014-04-01 13:16:44,259::hsm::447::Storage.HSM::(__cleanStorageRepository) Started cleaning storage repository at '/rhev/data-center'
MainThread::DEBUG::2014-04-01 13:16:44,264::hsm::479::Storage.HSM::(__cleanStorageRepository) White list: ['/rhev/data-center/hsm-tasks', '/rhev/data-center/hsm-tasks/*', '/rhev/data-center/mnt']
MainThread::DEBUG::2014-04-01 13:16:44,264::hsm::480::Storage.HSM::(__cleanStorageRepository) Mount list: []
MainThread::DEBUG::2014-04-01 13:16:44,265::hsm::482::Storage.HSM::(__cleanStorageRepository) Cleaning leftovers
MainThread::DEBUG::2014-04-01 13:16:44,266::hsm::525::Storage.HSM::(__cleanStorageRepository) Finished cleaning storage repository at '/rhev/data-center'
storageRefresh::DEBUG::2014-04-01 13:16:44,267::misc::762::SamplingMethod::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage)
MainThread::INFO::2014-04-01 13:16:44,269::dispatcher::97::Storage.Dispatcher::(__init__) Starting StorageDispatcher...
storageRefresh::DEBUG::2014-04-01 13:16:44,269::misc::764::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2014-04-01 13:16:44,292::misc::762::SamplingMethod::(__call__) Trying to enter sampling method (storage.iscsi.rescan)
storageRefresh::DEBUG::2014-04-01 13:16:44,300::misc::764::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2014-04-01 13:16:44,306::iscsi::393::Storage.ISCSI::(rescan) Performing SCSI scan, this will take up to 30 seconds
storageRefresh::DEBUG::2014-04-01 13:16:44,307::iscsiadm::92::Storage.Misc.excCmd::(_runCmd) '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:16:44,325::misc::772::SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2014-04-01 13:16:44,326::multipath::110::Storage.Misc.excCmd::(rescan) '/usr/bin/sudo -n /sbin/multipath -r' (cwd None)
MainThread::DEBUG::2014-04-01 13:16:44,354::task::595::TaskManager.Task::(_updateState) Task=`a3b79013-b275-4de1-b015-9e11f01a74a5`::moving from state init -> state preparing
MainThread::INFO::2014-04-01 13:16:44,354::logUtils::44::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback(callbackFunc=<bound method clientIF.contEIOVms of <clientIF.clientIF instance at 0x20ee9e0>>)
MainThread::INFO::2014-04-01 13:16:44,354::logUtils::47::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback, Return response: None
MainThread::DEBUG::2014-04-01 13:16:44,354::task::1185::TaskManager.Task::(prepare) Task=`a3b79013-b275-4de1-b015-9e11f01a74a5`::finished: None
MainThread::DEBUG::2014-04-01 13:16:44,355::task::595::TaskManager.Task::(_updateState) Task=`a3b79013-b275-4de1-b015-9e11f01a74a5`::moving from state preparing -> state finished
MainThread::DEBUG::2014-04-01 13:16:44,355::resourceManager::940::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2014-04-01 13:16:44,355::resourceManager::977::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2014-04-01 13:16:44,355::task::990::TaskManager.Task::(_decref) Task=`a3b79013-b275-4de1-b015-9e11f01a74a5`::ref 0 aborting False
MainThread::INFO::2014-04-01 13:16:44,367::momIF::47::MOM::(__init__) Starting up MOM
MainThread::INFO::2014-04-01 13:16:44,377::vmChannels::187::vds::(settimeout) Setting channels' timeout to 30 seconds.
VM Channels Listener::INFO::2014-04-01 13:16:44,381::vmChannels::170::vds::(run) Starting VM channels listener thread.
clientIFinit::DEBUG::2014-04-01 13:16:44,399::libvirtconnection::145::root::(get) trying to connect libvirt
MainThread::WARNING::2014-04-01 13:16:44,417::clientIF::181::vds::(_prepareBindings) Unable to load the json rpc server module. Please make sure it is installed.
storageRefresh::DEBUG::2014-04-01 13:16:44,448::multipath::110::Storage.Misc.excCmd::(rescan) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:16:44,451::lvm::496::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:16:44,454::lvm::498::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:16:44,457::lvm::507::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:16:44,463::lvm::509::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:16:44,470::lvm::527::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:16:44,476::lvm::529::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:16:44,481::misc::772::SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2014-04-01 13:16:44,488::lvm::324::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:16:44,524::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm pvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,size,vg_name,vg_uuid,pe_start,pe_count,pe_alloc_count,mda_count,dev_size' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:16:44,705::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:16:44,709::lvm::349::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:16:44,712::lvm::372::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:16:44,720::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:16:44,863::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:16:44,863::lvm::414::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:16:44,864::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm lvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,vg_name,attr,size,seg_start_pe,devices,tags' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:16:45,006::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:16:45,007::lvm::372::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:16:45,008::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:16:45,149::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:16:45,150::lvm::414::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:16:45,151::hsm::391::Storage.HSM::(storageRefresh) HSM is ready
Thread-13::DEBUG::2014-04-01 13:16:45,271::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-13::DEBUG::2014-04-01 13:16:45,344::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-14::DEBUG::2014-04-01 13:20:39,283::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-14::DEBUG::2014-04-01 13:20:39,297::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-15::DEBUG::2014-04-01 13:21:11,414::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-15::DEBUG::2014-04-01 13:21:11,423::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
MainThread::DEBUG::2014-04-01 13:22:10,217::vdsm::55::vds::(sigtermHandler) Received signal 15
MainThread::INFO::2014-04-01 13:22:10,439::vmChannels::183::vds::(stop) VM channels listener was stopped.
MainThread::INFO::2014-04-01 13:22:10,439::momIF::84::MOM::(stop) Shutting down MOM
MainThread::DEBUG::2014-04-01 13:22:10,440::task::595::TaskManager.Task::(_updateState) Task=`d46a208f-52dd-4136-9bcf-faa8cc47c55f`::moving from state init -> state preparing
MainThread::INFO::2014-04-01 13:22:10,440::logUtils::44::dispatcher::(wrapper) Run and protect: prepareForShutdown(options=None)
Thread-11::DEBUG::2014-04-01 13:22:10,441::storageServer::698::ConnectionMonitor::(_monitorConnections) Monitoring stopped
VM Channels Listener::INFO::2014-04-01 13:22:10,785::vmChannels::178::vds::(run) VM channels listener thread has ended.
MainThread::INFO::2014-04-01 13:22:10,889::domainMonitor::125::Storage.DomainMonitor::(close) Stopping domain monitors
MainThread::DEBUG::2014-04-01 13:22:10,889::taskManager::80::TaskManager::(prepareForShutdown) Request to stop all tasks
MainThread::INFO::2014-04-01 13:22:10,889::logUtils::47::dispatcher::(wrapper) Run and protect: prepareForShutdown, Return response: None
MainThread::DEBUG::2014-04-01 13:22:10,889::task::1185::TaskManager.Task::(prepare) Task=`d46a208f-52dd-4136-9bcf-faa8cc47c55f`::finished: None
MainThread::DEBUG::2014-04-01 13:22:10,889::task::595::TaskManager.Task::(_updateState) Task=`d46a208f-52dd-4136-9bcf-faa8cc47c55f`::moving from state preparing -> state finished
MainThread::DEBUG::2014-04-01 13:22:10,890::resourceManager::940::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2014-04-01 13:22:10,890::resourceManager::977::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2014-04-01 13:22:10,890::task::990::TaskManager.Task::(_decref) Task=`d46a208f-52dd-4136-9bcf-faa8cc47c55f`::ref 0 aborting False
MainThread::INFO::2014-04-01 13:22:10,890::vdsm::125::vds::(run) VDSM main thread ended. Waiting for 15 other threads...
MainThread::INFO::2014-04-01 13:22:10,890::vdsm::129::vds::(run) <_MainThread(MainThread, started 140406153848576)>
MainThread::INFO::2014-04-01 13:22:10,890::vdsm::129::vds::(run) <Thread(libvirtEventLoop, started daemon 140405886969600)>
MainThread::INFO::2014-04-01 13:22:10,891::vdsm::129::vds::(run) <WorkerThread(Thread-10, started daemon 140405165258496)>
MainThread::INFO::2014-04-01 13:22:10,891::vdsm::129::vds::(run) <WorkerThread(Thread-5, started daemon 140405624530688)>
MainThread::INFO::2014-04-01 13:22:10,891::vdsm::129::vds::(run) <WorkerThread(Thread-9, started daemon 140405582571264)>
MainThread::INFO::2014-04-01 13:22:10,891::vdsm::129::vds::(run) <WorkerThread(Thread-8, started daemon 140405593061120)>
MainThread::INFO::2014-04-01 13:22:10,891::vdsm::129::vds::(run) <WorkerThread(Thread-7, started daemon 140405603550976)>
MainThread::INFO::2014-04-01 13:22:10,891::vdsm::129::vds::(run) <WorkerThread(Thread-6, started daemon 140405614040832)>
MainThread::INFO::2014-04-01 13:22:10,891::vdsm::129::vds::(run) <WorkerThread(Thread-3, started daemon 140405855500032)>
MainThread::INFO::2014-04-01 13:22:10,892::vdsm::129::vds::(run) <WorkerThread(Thread-2, started daemon 140405865989888)>
MainThread::INFO::2014-04-01 13:22:10,892::vdsm::129::vds::(run) <WorkerThread(Thread-1, started daemon 140405876479744)>
MainThread::INFO::2014-04-01 13:22:10,892::vdsm::129::vds::(run) <WorkerThread(Thread-4, started daemon 140405635020544)>
MainThread::INFO::2014-04-01 13:22:10,892::momIF::84::MOM::(stop) Shutting down MOM
MainThread::INFO::2014-04-01 13:22:10,892::vdsm::129::vds::(run) <MomThread(MOM, started 140405123299072)>
MainThread::INFO::2014-04-01 13:22:10,892::vdsm::129::vds::(run) <PolicyEngine(PolicyEngine, started daemon 140405112809216)>
MainThread::INFO::2014-04-01 13:22:10,892::vdsm::129::vds::(run) <GuestManager(GuestManager, started daemon 140404659783424)>
MainThread::INFO::2014-04-01 13:22:10,892::vdsm::129::vds::(run) <HostMonitor(HostMonitor, started daemon 140404670273280)>
MainThread::INFO::2014-04-01 13:22:28,275::vdsm::119::vds::(run) (PID: 5891) I am the actual vdsm 4.14.6-0.el6 ovirt01.mydomain (2.6.32-431.11.2.el6.x86_64)
MainThread::DEBUG::2014-04-01 13:22:28,283::resourceManager::421::ResourceManager::(registerNamespace) Registering namespace 'Storage'
MainThread::DEBUG::2014-04-01 13:22:28,283::threadPool::35::Misc.ThreadPool::(__init__) Enter - numThreads: 10.0, waitTimeout: 3, maxTasks: 500.0
MainThread::WARNING::2014-04-01 13:22:28,289::fileUtils::167::Storage.fileUtils::(createdir) Dir /rhev/data-center/mnt already exists
MainThread::DEBUG::2014-04-01 13:22:28,786::supervdsm::77::SuperVdsmProxy::(_connect) Trying to connect to Super Vdsm
MainThread::DEBUG::2014-04-01 13:22:28,809::multipath::142::Storage.Multipath::(isEnabled) Current revision of multipath.conf detected, preserving
MainThread::DEBUG::2014-04-01 13:22:28,809::hsm::423::Storage.Misc.excCmd::(__validateLvmLockingType) '/usr/bin/sudo -n /sbin/lvm dumpconfig global/locking_type' (cwd None)
MainThread::DEBUG::2014-04-01 13:22:29,015::hsm::423::Storage.Misc.excCmd::(__validateLvmLockingType) SUCCESS: <err> = ''; <rc> = 0
MainThread::DEBUG::2014-04-01 13:22:29,016::hsm::447::Storage.HSM::(__cleanStorageRepository) Started cleaning storage repository at '/rhev/data-center'
MainThread::DEBUG::2014-04-01 13:22:29,020::hsm::479::Storage.HSM::(__cleanStorageRepository) White list: ['/rhev/data-center/hsm-tasks', '/rhev/data-center/hsm-tasks/*', '/rhev/data-center/mnt']
MainThread::DEBUG::2014-04-01 13:22:29,021::hsm::480::Storage.HSM::(__cleanStorageRepository) Mount list: []
MainThread::DEBUG::2014-04-01 13:22:29,021::hsm::482::Storage.HSM::(__cleanStorageRepository) Cleaning leftovers
MainThread::DEBUG::2014-04-01 13:22:29,022::hsm::525::Storage.HSM::(__cleanStorageRepository) Finished cleaning storage repository at '/rhev/data-center'
MainThread::INFO::2014-04-01 13:22:29,024::dispatcher::97::Storage.Dispatcher::(__init__) Starting StorageDispatcher...
storageRefresh::DEBUG::2014-04-01 13:22:29,024::misc::762::SamplingMethod::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage)
storageRefresh::DEBUG::2014-04-01 13:22:29,044::misc::764::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2014-04-01 13:22:29,048::misc::762::SamplingMethod::(__call__) Trying to enter sampling method (storage.iscsi.rescan)
storageRefresh::DEBUG::2014-04-01 13:22:29,055::misc::764::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2014-04-01 13:22:29,062::iscsi::393::Storage.ISCSI::(rescan) Performing SCSI scan, this will take up to 30 seconds
storageRefresh::DEBUG::2014-04-01 13:22:29,063::iscsiadm::92::Storage.Misc.excCmd::(_runCmd) '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:22:29,080::misc::772::SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2014-04-01 13:22:29,081::multipath::110::Storage.Misc.excCmd::(rescan) '/usr/bin/sudo -n /sbin/multipath -r' (cwd None)
MainThread::DEBUG::2014-04-01 13:22:29,114::task::595::TaskManager.Task::(_updateState) Task=`c687f922-eb71-4870-89f2-79997db11eb2`::moving from state init -> state preparing
MainThread::INFO::2014-04-01 13:22:29,115::logUtils::44::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback(callbackFunc=<bound method clientIF.contEIOVms of <clientIF.clientIF instance at 0x1b73fc8>>)
MainThread::INFO::2014-04-01 13:22:29,115::logUtils::47::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback, Return response: None
MainThread::DEBUG::2014-04-01 13:22:29,115::task::1185::TaskManager.Task::(prepare) Task=`c687f922-eb71-4870-89f2-79997db11eb2`::finished: None
MainThread::DEBUG::2014-04-01 13:22:29,115::task::595::TaskManager.Task::(_updateState) Task=`c687f922-eb71-4870-89f2-79997db11eb2`::moving from state preparing -> state finished
MainThread::DEBUG::2014-04-01 13:22:29,115::resourceManager::940::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2014-04-01 13:22:29,116::resourceManager::977::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2014-04-01 13:22:29,116::task::990::TaskManager.Task::(_decref) Task=`c687f922-eb71-4870-89f2-79997db11eb2`::ref 0 aborting False
MainThread::INFO::2014-04-01 13:22:29,127::momIF::47::MOM::(__init__) Starting up MOM
MainThread::INFO::2014-04-01 13:22:29,130::vmChannels::187::vds::(settimeout) Setting channels' timeout to 30 seconds.
clientIFinit::DEBUG::2014-04-01 13:22:29,147::libvirtconnection::145::root::(get) trying to connect libvirt
VM Channels Listener::INFO::2014-04-01 13:22:29,189::vmChannels::170::vds::(run) Starting VM channels listener thread.
storageRefresh::DEBUG::2014-04-01 13:22:29,229::multipath::110::Storage.Misc.excCmd::(rescan) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:22:29,256::lvm::496::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:22:29,262::lvm::498::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:22:29,275::lvm::507::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:22:29,283::lvm::509::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:22:29,293::lvm::527::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:22:29,311::lvm::529::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:22:29,313::misc::772::SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2014-04-01 13:22:29,322::lvm::324::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:22:29,411::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm pvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,size,vg_name,vg_uuid,pe_start,pe_count,pe_alloc_count,mda_count,dev_size' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:22:29,637::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:22:29,638::lvm::349::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:22:29,638::lvm::372::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:22:29,639::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:22:29,789::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:22:29,789::lvm::414::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:22:29,790::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm lvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,vg_name,attr,size,seg_start_pe,devices,tags' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:22:29,933::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:22:29,934::lvm::372::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:22:29,935::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name' (cwd None)
Thread-13::DEBUG::2014-04-01 13:22:30,032::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-13::DEBUG::2014-04-01 13:22:30,032::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Recovering from crash or Initializing', 'code': 99}}
storageRefresh::DEBUG::2014-04-01 13:22:30,078::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:22:30,079::lvm::414::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::WARNING::2014-04-01 13:22:30,079::fileUtils::167::Storage.fileUtils::(createdir) Dir /rhev/data-center/hsm-tasks already exists
storageRefresh::DEBUG::2014-04-01 13:22:30,079::hsm::391::Storage.HSM::(storageRefresh) HSM is ready
Thread-14::DEBUG::2014-04-01 13:22:31,092::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-14::DEBUG::2014-04-01 13:22:31,166::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
MainThread::DEBUG::2014-04-01 13:43:11,588::vdsm::55::vds::(sigtermHandler) Received signal 15
MainThread::INFO::2014-04-01 13:43:12,407::vmChannels::183::vds::(stop) VM channels listener was stopped.
MainThread::INFO::2014-04-01 13:43:12,407::momIF::84::MOM::(stop) Shutting down MOM
MainThread::DEBUG::2014-04-01 13:43:12,408::task::595::TaskManager.Task::(_updateState) Task=`d71c704e-bf1f-4d6d-97c2-41a9f97087d3`::moving from state init -> state preparing
MainThread::INFO::2014-04-01 13:43:12,408::logUtils::44::dispatcher::(wrapper) Run and protect: prepareForShutdown(options=None)
Thread-11::DEBUG::2014-04-01 13:43:12,410::storageServer::698::ConnectionMonitor::(_monitorConnections) Monitoring stopped
VM Channels Listener::INFO::2014-04-01 13:43:12,529::vmChannels::178::vds::(run) VM channels listener thread has ended.
MainThread::INFO::2014-04-01 13:43:12,872::domainMonitor::125::Storage.DomainMonitor::(close) Stopping domain monitors
MainThread::DEBUG::2014-04-01 13:43:12,872::taskManager::80::TaskManager::(prepareForShutdown) Request to stop all tasks
MainThread::INFO::2014-04-01 13:43:12,872::logUtils::47::dispatcher::(wrapper) Run and protect: prepareForShutdown, Return response: None
MainThread::DEBUG::2014-04-01 13:43:12,873::task::1185::TaskManager.Task::(prepare) Task=`d71c704e-bf1f-4d6d-97c2-41a9f97087d3`::finished: None
MainThread::DEBUG::2014-04-01 13:43:12,873::task::595::TaskManager.Task::(_updateState) Task=`d71c704e-bf1f-4d6d-97c2-41a9f97087d3`::moving from state preparing -> state finished
MainThread::DEBUG::2014-04-01 13:43:12,873::resourceManager::940::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2014-04-01 13:43:12,873::resourceManager::977::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2014-04-01 13:43:12,873::task::990::TaskManager.Task::(_decref) Task=`d71c704e-bf1f-4d6d-97c2-41a9f97087d3`::ref 0 aborting False
MainThread::INFO::2014-04-01 13:43:12,873::vdsm::125::vds::(run) VDSM main thread ended. Waiting for 15 other threads...
MainThread::INFO::2014-04-01 13:43:12,874::vdsm::129::vds::(run) <_MainThread(MainThread, started 140370161301248)>
MainThread::INFO::2014-04-01 13:43:12,874::vdsm::129::vds::(run) <Thread(libvirtEventLoop, started daemon 140369894422272)>
MainThread::INFO::2014-04-01 13:43:12,874::vdsm::129::vds::(run) <WorkerThread(Thread-8, started daemon 140369329125120)>
MainThread::INFO::2014-04-01 13:43:12,874::vdsm::129::vds::(run) <WorkerThread(Thread-6, started daemon 140369756927744)>
MainThread::INFO::2014-04-01 13:43:12,874::vdsm::129::vds::(run) <WorkerThread(Thread-1, started daemon 140369883932416)>
MainThread::INFO::2014-04-01 13:43:12,874::vdsm::129::vds::(run) <WorkerThread(Thread-9, started daemon 140369318635264)>
MainThread::INFO::2014-04-01 13:43:12,874::vdsm::129::vds::(run) <WorkerThread(Thread-3, started daemon 140369788397312)>
MainThread::INFO::2014-04-01 13:43:12,874::vdsm::129::vds::(run) <WorkerThread(Thread-5, started daemon 140369767417600)>
MainThread::INFO::2014-04-01 13:43:12,875::vdsm::129::vds::(run) <GuestManager(GuestManager, started daemon 140368848873216)>
MainThread::INFO::2014-04-01 13:43:12,875::vdsm::129::vds::(run) <WorkerThread(Thread-10, started daemon 140369308145408)>
MainThread::INFO::2014-04-01 13:43:12,875::momIF::84::MOM::(stop) Shutting down MOM
MainThread::INFO::2014-04-01 13:43:12,875::vdsm::129::vds::(run) <MomThread(MOM, started 140368859363072)>
MainThread::INFO::2014-04-01 13:43:12,875::vdsm::129::vds::(run) <PolicyEngine(PolicyEngine, started daemon 140368368621312)>
MainThread::INFO::2014-04-01 13:43:12,875::vdsm::129::vds::(run) <HostMonitor(HostMonitor, started daemon 140368827893504)>
MainThread::INFO::2014-04-01 13:43:12,875::vdsm::129::vds::(run) <WorkerThread(Thread-2, started daemon 140369798887168)>
MainThread::INFO::2014-04-01 13:43:12,876::vdsm::129::vds::(run) <WorkerThread(Thread-4, started daemon 140369777907456)>
MainThread::INFO::2014-04-01 13:43:12,876::vdsm::129::vds::(run) <WorkerThread(Thread-7, started daemon 140369746437888)>
MainThread::INFO::2014-04-01 13:45:23,951::vdsm::119::vds::(run) (PID: 1960) I am the actual vdsm 4.14.6-0.el6 ovirt01.mydomain (2.6.32-431.11.2.el6.x86_64)
MainThread::DEBUG::2014-04-01 13:45:23,962::resourceManager::421::ResourceManager::(registerNamespace) Registering namespace 'Storage'
MainThread::DEBUG::2014-04-01 13:45:23,962::threadPool::35::Misc.ThreadPool::(__init__) Enter - numThreads: 10.0, waitTimeout: 3, maxTasks: 500.0
MainThread::WARNING::2014-04-01 13:45:23,976::fileUtils::167::Storage.fileUtils::(createdir) Dir /rhev/data-center/mnt already exists
MainThread::DEBUG::2014-04-01 13:45:24,512::supervdsm::77::SuperVdsmProxy::(_connect) Trying to connect to Super Vdsm
MainThread::DEBUG::2014-04-01 13:45:24,567::multipath::142::Storage.Multipath::(isEnabled) Current revision of multipath.conf detected, preserving
MainThread::DEBUG::2014-04-01 13:45:24,567::hsm::423::Storage.Misc.excCmd::(__validateLvmLockingType) '/usr/bin/sudo -n /sbin/lvm dumpconfig global/locking_type' (cwd None)
MainThread::DEBUG::2014-04-01 13:45:24,765::hsm::423::Storage.Misc.excCmd::(__validateLvmLockingType) SUCCESS: <err> = ''; <rc> = 0
MainThread::DEBUG::2014-04-01 13:45:24,766::hsm::447::Storage.HSM::(__cleanStorageRepository) Started cleaning storage repository at '/rhev/data-center'
MainThread::DEBUG::2014-04-01 13:45:24,770::hsm::479::Storage.HSM::(__cleanStorageRepository) White list: ['/rhev/data-center/hsm-tasks', '/rhev/data-center/hsm-tasks/*', '/rhev/data-center/mnt']
MainThread::DEBUG::2014-04-01 13:45:24,771::hsm::480::Storage.HSM::(__cleanStorageRepository) Mount list: []
MainThread::DEBUG::2014-04-01 13:45:24,771::hsm::482::Storage.HSM::(__cleanStorageRepository) Cleaning leftovers
MainThread::DEBUG::2014-04-01 13:45:24,772::hsm::525::Storage.HSM::(__cleanStorageRepository) Finished cleaning storage repository at '/rhev/data-center'
storageRefresh::DEBUG::2014-04-01 13:45:24,772::misc::762::SamplingMethod::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage)
MainThread::INFO::2014-04-01 13:45:24,774::dispatcher::97::Storage.Dispatcher::(__init__) Starting StorageDispatcher...
storageRefresh::DEBUG::2014-04-01 13:45:24,775::misc::764::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2014-04-01 13:45:24,946::misc::762::SamplingMethod::(__call__) Trying to enter sampling method (storage.iscsi.rescan)
storageRefresh::DEBUG::2014-04-01 13:45:24,950::misc::764::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2014-04-01 13:45:24,982::iscsi::393::Storage.ISCSI::(rescan) Performing SCSI scan, this will take up to 30 seconds
storageRefresh::DEBUG::2014-04-01 13:45:25,011::iscsiadm::92::Storage.Misc.excCmd::(_runCmd) '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:45:25,071::misc::772::SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2014-04-01 13:45:25,072::multipath::110::Storage.Misc.excCmd::(rescan) '/usr/bin/sudo -n /sbin/multipath -r' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:45:25,153::multipath::110::Storage.Misc.excCmd::(rescan) SUCCESS: <err> = ''; <rc> = 0
MainThread::DEBUG::2014-04-01 13:45:25,153::task::595::TaskManager.Task::(_updateState) Task=`ce193c89-44a5-4e88-a22a-85954714c93f`::moving from state init -> state preparing
storageRefresh::DEBUG::2014-04-01 13:45:25,154::lvm::496::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operation mutex
MainThread::INFO::2014-04-01 13:45:25,161::logUtils::44::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback(callbackFunc=<bound method clientIF.contEIOVms of <clientIF.clientIF instance at 0x2918098>>)
storageRefresh::DEBUG::2014-04-01 13:45:25,162::lvm::498::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the operation mutex
MainThread::INFO::2014-04-01 13:45:25,162::logUtils::47::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback, Return response: None
storageRefresh::DEBUG::2014-04-01 13:45:25,162::lvm::507::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operation mutex
MainThread::DEBUG::2014-04-01 13:45:25,163::task::1185::TaskManager.Task::(prepare) Task=`ce193c89-44a5-4e88-a22a-85954714c93f`::finished: None
storageRefresh::DEBUG::2014-04-01 13:45:25,163::lvm::509::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the operation mutex
MainThread::DEBUG::2014-04-01 13:45:25,163::task::595::TaskManager.Task::(_updateState) Task=`ce193c89-44a5-4e88-a22a-85954714c93f`::moving from state preparing -> state finished
storageRefresh::DEBUG::2014-04-01 13:45:25,164::lvm::527::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operation mutex
MainThread::DEBUG::2014-04-01 13:45:25,164::resourceManager::940::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
storageRefresh::DEBUG::2014-04-01 13:45:25,164::lvm::529::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the operation mutex
MainThread::DEBUG::2014-04-01 13:45:25,165::resourceManager::977::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
storageRefresh::DEBUG::2014-04-01 13:45:25,165::misc::772::SamplingMethod::(__call__) Returning last result
MainThread::DEBUG::2014-04-01 13:45:25,166::task::990::TaskManager.Task::(_decref) Task=`ce193c89-44a5-4e88-a22a-85954714c93f`::ref 0 aborting False
storageRefresh::DEBUG::2014-04-01 13:45:25,166::lvm::324::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:45:25,170::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm pvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,size,vg_name,vg_uuid,pe_start,pe_count,pe_alloc_count,mda_count,dev_size' (cwd None)
MainThread::INFO::2014-04-01 13:45:25,181::momIF::47::MOM::(__init__) Starting up MOM
MainThread::INFO::2014-04-01 13:45:25,191::vmChannels::187::vds::(settimeout) Setting channels' timeout to 30 seconds.
VM Channels Listener::INFO::2014-04-01 13:45:25,194::vmChannels::170::vds::(run) Starting VM channels listener thread.
clientIFinit::DEBUG::2014-04-01 13:45:25,305::libvirtconnection::145::root::(get) trying to connect libvirt
storageRefresh::DEBUG::2014-04-01 13:45:25,372::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:45:25,406::lvm::349::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:45:25,422::lvm::372::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:45:25,431::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:45:25,619::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:45:25,622::lvm::414::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 13:45:25,629::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm lvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,vg_name,attr,size,seg_start_pe,devices,tags' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:45:25,803::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:45:25,804::lvm::372::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 13:45:25,804::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name' (cwd None)
storageRefresh::DEBUG::2014-04-01 13:45:25,968::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 13:45:25,969::lvm::414::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::WARNING::2014-04-01 13:45:25,970::fileUtils::167::Storage.fileUtils::(createdir) Dir /rhev/data-center/hsm-tasks already exists
storageRefresh::DEBUG::2014-04-01 13:45:25,978::hsm::391::Storage.HSM::(storageRefresh) HSM is ready
Thread-13::DEBUG::2014-04-01 13:47:59,432::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-13::DEBUG::2014-04-01 13:47:59,569::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-14::DEBUG::2014-04-01 13:49:32,208::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-14::DEBUG::2014-04-01 13:49:32,240::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-15::DEBUG::2014-04-01 13:51:17,857::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-15::DEBUG::2014-04-01 13:51:17,888::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-16::DEBUG::2014-04-01 13:57:54,486::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-16::DEBUG::2014-04-01 13:57:54,510::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-17::DEBUG::2014-04-01 14:02:37,349::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-17::DEBUG::2014-04-01 14:02:37,360::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-18::DEBUG::2014-04-01 14:24:48,882::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-18::DEBUG::2014-04-01 14:24:48,931::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-19::DEBUG::2014-04-01 14:26:09,043::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-19::DEBUG::2014-04-01 14:26:09,067::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
MainThread::DEBUG::2014-04-01 14:26:18,534::vdsm::55::vds::(sigtermHandler) Received signal 15
MainThread::INFO::2014-04-01 14:26:19,015::vmChannels::183::vds::(stop) VM channels listener was stopped.
MainThread::INFO::2014-04-01 14:26:19,015::momIF::84::MOM::(stop) Shutting down MOM
MainThread::DEBUG::2014-04-01 14:26:19,016::task::595::TaskManager.Task::(_updateState) Task=`bba14d83-2a49-4970-8f76-2be58762768a`::moving from state init -> state preparing
MainThread::INFO::2014-04-01 14:26:19,016::logUtils::44::dispatcher::(wrapper) Run and protect: prepareForShutdown(options=None)
Thread-11::DEBUG::2014-04-01 14:26:19,051::storageServer::698::ConnectionMonitor::(_monitorConnections) Monitoring stopped
VM Channels Listener::INFO::2014-04-01 14:26:19,075::vmChannels::178::vds::(run) VM channels listener thread has ended.
MainThread::INFO::2014-04-01 14:26:19,527::domainMonitor::125::Storage.DomainMonitor::(close) Stopping domain monitors
MainThread::DEBUG::2014-04-01 14:26:19,528::taskManager::80::TaskManager::(prepareForShutdown) Request to stop all tasks
MainThread::INFO::2014-04-01 14:26:19,528::logUtils::47::dispatcher::(wrapper) Run and protect: prepareForShutdown, Return response: None
MainThread::DEBUG::2014-04-01 14:26:19,528::task::1185::TaskManager.Task::(prepare) Task=`bba14d83-2a49-4970-8f76-2be58762768a`::finished: None
MainThread::DEBUG::2014-04-01 14:26:19,528::task::595::TaskManager.Task::(_updateState) Task=`bba14d83-2a49-4970-8f76-2be58762768a`::moving from state preparing -> state finished
MainThread::DEBUG::2014-04-01 14:26:19,528::resourceManager::940::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2014-04-01 14:26:19,528::resourceManager::977::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2014-04-01 14:26:19,529::task::990::TaskManager.Task::(_decref) Task=`bba14d83-2a49-4970-8f76-2be58762768a`::ref 0 aborting False
MainThread::INFO::2014-04-01 14:26:19,529::vdsm::125::vds::(run) VDSM main thread ended. Waiting for 15 other threads...
MainThread::INFO::2014-04-01 14:26:19,529::vdsm::129::vds::(run) <_MainThread(MainThread, started 139946453554944)>
MainThread::INFO::2014-04-01 14:26:19,529::vdsm::129::vds::(run) <Thread(libvirtEventLoop, started daemon 139946186409728)>
MainThread::INFO::2014-04-01 14:26:19,529::vdsm::129::vds::(run) <WorkerThread(Thread-4, started daemon 139945939302144)>
MainThread::INFO::2014-04-01 14:26:19,529::vdsm::129::vds::(run) <PolicyEngine(PolicyEngine, started daemon 139944530016000)>
MainThread::INFO::2014-04-01 14:26:19,529::vdsm::129::vds::(run) <WorkerThread(Thread-9, started daemon 139945886852864)>
MainThread::INFO::2014-04-01 14:26:19,530::vdsm::129::vds::(run) <WorkerThread(Thread-8, started daemon 139945897342720)>
MainThread::INFO::2014-04-01 14:26:19,530::vdsm::129::vds::(run) <WorkerThread(Thread-7, started daemon 139945907832576)>
MainThread::INFO::2014-04-01 14:26:19,530::vdsm::129::vds::(run) <WorkerThread(Thread-5, started daemon 139945928812288)>
MainThread::INFO::2014-04-01 14:26:19,530::vdsm::129::vds::(run) <WorkerThread(Thread-10, started daemon 139945469540096)>
MainThread::INFO::2014-04-01 14:26:19,530::vdsm::129::vds::(run) <GuestManager(GuestManager, started daemon 139944980776704)>
MainThread::INFO::2014-04-01 14:26:19,530::vdsm::129::vds::(run) <WorkerThread(Thread-3, started daemon 139946154940160)>
MainThread::INFO::2014-04-01 14:26:19,530::vdsm::129::vds::(run) <WorkerThread(Thread-2, started daemon 139946165430016)>
MainThread::INFO::2014-04-01 14:26:19,531::vdsm::129::vds::(run) <WorkerThread(Thread-1, started daemon 139946175919872)>
MainThread::INFO::2014-04-01 14:26:19,531::momIF::84::MOM::(stop) Shutting down MOM
MainThread::INFO::2014-04-01 14:26:19,531::vdsm::129::vds::(run) <MomThread(MOM, started 139945427580672)>
MainThread::INFO::2014-04-01 14:26:19,531::vdsm::129::vds::(run) <HostMonitor(HostMonitor, started daemon 139945417090816)>
MainThread::INFO::2014-04-01 14:26:19,531::vdsm::129::vds::(run) <WorkerThread(Thread-6, started daemon 139945918322432)>
MainThread::INFO::2014-04-01 14:26:38,227::vdsm::119::vds::(run) (PID: 5104) I am the actual vdsm 4.14.6-0.el6 ovirt01.mydomain (2.6.32-431.11.2.el6.x86_64)
MainThread::DEBUG::2014-04-01 14:26:38,228::resourceManager::421::ResourceManager::(registerNamespace) Registering namespace 'Storage'
MainThread::DEBUG::2014-04-01 14:26:38,228::threadPool::35::Misc.ThreadPool::(__init__) Enter - numThreads: 10.0, waitTimeout: 3, maxTasks: 500.0
MainThread::WARNING::2014-04-01 14:26:38,233::fileUtils::167::Storage.fileUtils::(createdir) Dir /rhev/data-center/mnt already exists
MainThread::DEBUG::2014-04-01 14:26:38,781::supervdsm::77::SuperVdsmProxy::(_connect) Trying to connect to Super Vdsm
MainThread::DEBUG::2014-04-01 14:26:38,817::multipath::142::Storage.Multipath::(isEnabled) Current revision of multipath.conf detected, preserving
MainThread::DEBUG::2014-04-01 14:26:38,817::hsm::423::Storage.Misc.excCmd::(__validateLvmLockingType) '/usr/bin/sudo -n /sbin/lvm dumpconfig global/locking_type' (cwd None)
MainThread::DEBUG::2014-04-01 14:26:38,999::hsm::423::Storage.Misc.excCmd::(__validateLvmLockingType) SUCCESS: <err> = ''; <rc> = 0
MainThread::DEBUG::2014-04-01 14:26:38,999::hsm::447::Storage.HSM::(__cleanStorageRepository) Started cleaning storage repository at '/rhev/data-center'
MainThread::DEBUG::2014-04-01 14:26:39,003::hsm::479::Storage.HSM::(__cleanStorageRepository) White list: ['/rhev/data-center/hsm-tasks', '/rhev/data-center/hsm-tasks/*', '/rhev/data-center/mnt']
MainThread::DEBUG::2014-04-01 14:26:39,003::hsm::480::Storage.HSM::(__cleanStorageRepository) Mount list: []
MainThread::DEBUG::2014-04-01 14:26:39,003::hsm::482::Storage.HSM::(__cleanStorageRepository) Cleaning leftovers
MainThread::DEBUG::2014-04-01 14:26:39,005::hsm::525::Storage.HSM::(__cleanStorageRepository) Finished cleaning storage repository at '/rhev/data-center'
MainThread::INFO::2014-04-01 14:26:39,007::dispatcher::97::Storage.Dispatcher::(__init__) Starting StorageDispatcher...
storageRefresh::DEBUG::2014-04-01 14:26:39,007::misc::762::SamplingMethod::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage)
storageRefresh::DEBUG::2014-04-01 14:26:39,060::misc::764::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2014-04-01 14:26:39,075::misc::762::SamplingMethod::(__call__) Trying to enter sampling method (storage.iscsi.rescan)
storageRefresh::DEBUG::2014-04-01 14:26:39,075::misc::764::SamplingMethod::(__call__) Got in to sampling method
storageRefresh::DEBUG::2014-04-01 14:26:39,078::iscsi::393::Storage.ISCSI::(rescan) Performing SCSI scan, this will take up to 30 seconds
storageRefresh::DEBUG::2014-04-01 14:26:39,078::iscsiadm::92::Storage.Misc.excCmd::(_runCmd) '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None)
storageRefresh::DEBUG::2014-04-01 14:26:39,118::misc::772::SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2014-04-01 14:26:39,119::multipath::110::Storage.Misc.excCmd::(rescan) '/usr/bin/sudo -n /sbin/multipath -r' (cwd None)
MainThread::DEBUG::2014-04-01 14:26:39,159::task::595::TaskManager.Task::(_updateState) Task=`87e43e15-0963-43c4-be68-68466249fab0`::moving from state init -> state preparing
MainThread::INFO::2014-04-01 14:26:39,161::logUtils::44::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback(callbackFunc=<bound method clientIF.contEIOVms of <clientIF.clientIF instance at 0x18c53f8>>)
MainThread::INFO::2014-04-01 14:26:39,161::logUtils::47::dispatcher::(wrapper) Run and protect: registerDomainStateChangeCallback, Return response: None
MainThread::DEBUG::2014-04-01 14:26:39,161::task::1185::TaskManager.Task::(prepare) Task=`87e43e15-0963-43c4-be68-68466249fab0`::finished: None
MainThread::DEBUG::2014-04-01 14:26:39,161::task::595::TaskManager.Task::(_updateState) Task=`87e43e15-0963-43c4-be68-68466249fab0`::moving from state preparing -> state finished
MainThread::DEBUG::2014-04-01 14:26:39,161::resourceManager::940::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {}
MainThread::DEBUG::2014-04-01 14:26:39,162::resourceManager::977::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
MainThread::DEBUG::2014-04-01 14:26:39,162::task::990::TaskManager.Task::(_decref) Task=`87e43e15-0963-43c4-be68-68466249fab0`::ref 0 aborting False
MainThread::INFO::2014-04-01 14:26:39,172::momIF::47::MOM::(__init__) Starting up MOM
MainThread::INFO::2014-04-01 14:26:39,188::vmChannels::187::vds::(settimeout) Setting channels' timeout to 30 seconds.
VM Channels Listener::INFO::2014-04-01 14:26:39,190::vmChannels::170::vds::(run) Starting VM channels listener thread.
clientIFinit::DEBUG::2014-04-01 14:26:39,233::libvirtconnection::145::root::(get) trying to connect libvirt
storageRefresh::DEBUG::2014-04-01 14:26:39,235::multipath::110::Storage.Misc.excCmd::(rescan) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2014-04-01 14:26:39,236::lvm::496::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 14:26:39,241::lvm::498::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 14:26:39,241::lvm::507::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 14:26:39,242::lvm::509::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 14:26:39,242::lvm::527::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 14:26:39,242::lvm::529::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 14:26:39,243::misc::772::SamplingMethod::(__call__) Returning last result
storageRefresh::DEBUG::2014-04-01 14:26:39,243::lvm::324::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 14:26:39,329::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm pvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,size,vg_name,vg_uuid,pe_start,pe_count,pe_alloc_count,mda_count,dev_size' (cwd None)
storageRefresh::DEBUG::2014-04-01 14:26:39,547::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ''; <rc> = 0
storageRefresh::DEBUG::2014-04-01 14:26:39,550::lvm::349::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 14:26:39,579::lvm::372::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 14:26:39,588::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name' (cwd None)
storageRefresh::DEBUG::2014-04-01 14:26:39,751::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 14:26:39,751::lvm::414::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::DEBUG::2014-04-01 14:26:39,752::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm lvs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,vg_name,attr,size,seg_start_pe,devices,tags' (cwd None)
Thread-13::DEBUG::2014-04-01 14:26:39,863::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-13::DEBUG::2014-04-01 14:26:39,863::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Recovering from crash or Initializing', 'code': 99}}
storageRefresh::DEBUG::2014-04-01 14:26:39,913::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 14:26:39,914::lvm::372::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
storageRefresh::DEBUG::2014-04-01 14:26:39,915::lvm::295::Storage.Misc.excCmd::(cmd) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [ \'r|.*|\' ] } global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup { retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free,lv_count,pv_count,pv_name' (cwd None)
storageRefresh::DEBUG::2014-04-01 14:26:40,055::lvm::295::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = ' No volume groups found\n'; <rc> = 0
storageRefresh::DEBUG::2014-04-01 14:26:40,056::lvm::414::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex
storageRefresh::WARNING::2014-04-01 14:26:40,057::fileUtils::167::Storage.fileUtils::(createdir) Dir /rhev/data-center/hsm-tasks already exists
storageRefresh::DEBUG::2014-04-01 14:26:40,062::hsm::391::Storage.HSM::(storageRefresh) HSM is ready
Thread-14::DEBUG::2014-04-01 14:26:40,924::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-14::DEBUG::2014-04-01 14:26:41,026::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-15::DEBUG::2014-04-01 14:48:06,601::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-15::DEBUG::2014-04-01 14:48:06,623::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-16::DEBUG::2014-04-01 14:51:28,992::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-16::DEBUG::2014-04-01 14:51:29,020::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-17::DEBUG::2014-04-01 15:04:55,803::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-17::DEBUG::2014-04-01 15:04:55,813::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-18::DEBUG::2014-04-01 15:07:59,091::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-18::DEBUG::2014-04-01 15:07:59,107::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-19::DEBUG::2014-04-01 15:10:26,674::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-19::DEBUG::2014-04-01 15:10:26,682::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-20::DEBUG::2014-04-01 15:22:09,047::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-20::DEBUG::2014-04-01 15:22:09,056::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-21::DEBUG::2014-04-01 15:22:32,925::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-21::DEBUG::2014-04-01 15:22:32,928::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
Thread-22::DEBUG::2014-04-01 15:30:32,100::BindingXMLRPC::1067::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {}
Thread-22::DEBUG::2014-04-01 15:30:32,110::BindingXMLRPC::1074::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Done', 'code': 0}, 'info': {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}}
------=_Part_594693_2003216810.1396362976018
Content-Type: text/x-log
Content-Transfer-Encoding: 7bit
Content-Disposition: attachment; filename=supervdsm.log
MainThread::DEBUG::2014-04-01 12:50:10,809::supervdsmServer::424::SuperVdsm.Server::(main) Terminated normally
MainThread::DEBUG::2014-04-01 12:50:12,851::netconfpersistence::134::root::(_getConfigs) Non-existing config set.
MainThread::DEBUG::2014-04-01 12:50:12,851::netconfpersistence::134::root::(_getConfigs) Non-existing config set.
MainThread::DEBUG::2014-04-01 12:50:12,873::supervdsmServer::384::SuperVdsm.Server::(main) Making sure I'm root - SuperVdsm
MainThread::DEBUG::2014-04-01 12:50:12,873::supervdsmServer::393::SuperVdsm.Server::(main) Parsing cmd args
MainThread::DEBUG::2014-04-01 12:50:12,873::supervdsmServer::396::SuperVdsm.Server::(main) Cleaning old socket /var/run/vdsm/svdsm.sock
MainThread::DEBUG::2014-04-01 12:50:12,874::supervdsmServer::400::SuperVdsm.Server::(main) Setting up keep alive thread
MainThread::DEBUG::2014-04-01 12:50:12,874::supervdsmServer::406::SuperVdsm.Server::(main) Creating remote object manager
MainThread::DEBUG::2014-04-01 12:50:12,880::supervdsmServer::417::SuperVdsm.Server::(main) Started serving super vdsm object
sourceRoute::DEBUG::2014-04-01 12:50:12,880::sourceRouteThread::56::root::(_subscribeToInotifyLoop) sourceRouteThread.subscribeToInotifyLoop started
MainProcess::DEBUG::2014-04-01 12:50:16,019::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call readMultipathConf with () {}
MainProcess::DEBUG::2014-04-01 12:50:16,020::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return readMultipathConf with ['# RHEV REVISION 1.0', '', 'defaults {', ' polling_interval 5', ' getuid_callout "/sbin/scsi_id --whitelisted --replace-whitespace --device=/dev/%n"', ' no_path_retry fail', ' user_friendly_names no', ' flush_on_last_del yes', ' fast_io_fail_tmo 5', ' dev_loss_tmo 30', ' max_fds 4096', '}', '', 'devices {', 'device {', ' vendor "HITACHI"', ' product "DF.*"', ' getuid_callout "/sbin/scsi_id --whitelisted --replace-whitespace --device=/dev/%n"', '}', 'device {', ' vendor "COMPELNT"', ' product "Compellent Vol"', ' no_path_retry fail', '}', '}']
MainProcess|PolicyEngine::DEBUG::2014-04-01 12:50:26,756::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call ksmTune with ({'run': 0},) {}
MainProcess|PolicyEngine::DEBUG::2014-04-01 12:50:26,761::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return ksmTune with None
MainThread::DEBUG::2014-04-01 12:50:40,269::supervdsmServer::424::SuperVdsm.Server::(main) Terminated normally
MainThread::DEBUG::2014-04-01 12:52:17,924::netconfpersistence::134::root::(_getConfigs) Non-existing config set.
MainThread::DEBUG::2014-04-01 12:52:17,933::netconfpersistence::134::root::(_getConfigs) Non-existing config set.
MainThread::DEBUG::2014-04-01 12:52:18,005::supervdsmServer::384::SuperVdsm.Server::(main) Making sure I'm root - SuperVdsm
MainThread::DEBUG::2014-04-01 12:52:18,005::supervdsmServer::393::SuperVdsm.Server::(main) Parsing cmd args
MainThread::DEBUG::2014-04-01 12:52:18,006::supervdsmServer::396::SuperVdsm.Server::(main) Cleaning old socket /var/run/vdsm/svdsm.sock
MainThread::DEBUG::2014-04-01 12:52:18,006::supervdsmServer::400::SuperVdsm.Server::(main) Setting up keep alive thread
MainThread::DEBUG::2014-04-01 12:52:18,006::supervdsmServer::406::SuperVdsm.Server::(main) Creating remote object manager
MainThread::DEBUG::2014-04-01 12:52:18,008::supervdsmServer::417::SuperVdsm.Server::(main) Started serving super vdsm object
sourceRoute::DEBUG::2014-04-01 12:52:18,008::sourceRouteThread::56::root::(_subscribeToInotifyLoop) sourceRouteThread.subscribeToInotifyLoop started
MainProcess::DEBUG::2014-04-01 12:52:42,649::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call readMultipathConf with () {}
MainProcess::DEBUG::2014-04-01 12:52:42,650::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return readMultipathConf with ['# RHEV REVISION 1.0', '', 'defaults {', ' polling_interval 5', ' getuid_callout "/sbin/scsi_id --whitelisted --replace-whitespace --device=/dev/%n"', ' no_path_retry fail', ' user_friendly_names no', ' flush_on_last_del yes', ' fast_io_fail_tmo 5', ' dev_loss_tmo 30', ' max_fds 4096', '}', '', 'devices {', 'device {', ' vendor "HITACHI"', ' product "DF.*"', ' getuid_callout "/sbin/scsi_id --whitelisted --replace-whitespace --device=/dev/%n"', '}', 'device {', ' vendor "COMPELNT"', ' product "Compellent Vol"', ' no_path_retry fail', '}', '}']
MainProcess|PolicyEngine::DEBUG::2014-04-01 12:52:53,805::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call ksmTune with ({'run': 0},) {}
MainProcess|PolicyEngine::DEBUG::2014-04-01 12:52:53,806::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return ksmTune with None
MainProcess|Thread-13::DEBUG::2014-04-01 12:55:50,816::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-13::DEBUG::2014-04-01 12:55:50,928::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-14::DEBUG::2014-04-01 13:02:22,284::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-14::DEBUG::2014-04-01 13:02:22,285::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-15::DEBUG::2014-04-01 13:04:41,955::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-15::DEBUG::2014-04-01 13:04:41,955::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-16::DEBUG::2014-04-01 13:04:49,776::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-16::DEBUG::2014-04-01 13:04:49,777::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-17::DEBUG::2014-04-01 13:06:19,192::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-17::DEBUG::2014-04-01 13:06:19,192::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainThread::DEBUG::2014-04-01 13:11:01,435::supervdsmServer::424::SuperVdsm.Server::(main) Terminated normally
MainThread::DEBUG::2014-04-01 13:11:07,331::netconfpersistence::134::root::(_getConfigs) Non-existing config set.
MainThread::DEBUG::2014-04-01 13:11:07,332::netconfpersistence::134::root::(_getConfigs) Non-existing config set.
MainThread::DEBUG::2014-04-01 13:11:07,352::supervdsmServer::384::SuperVdsm.Server::(main) Making sure I'm root - SuperVdsm
MainThread::DEBUG::2014-04-01 13:11:07,353::supervdsmServer::393::SuperVdsm.Server::(main) Parsing cmd args
MainThread::DEBUG::2014-04-01 13:11:07,353::supervdsmServer::396::SuperVdsm.Server::(main) Cleaning old socket /var/run/vdsm/svdsm.sock
MainThread::DEBUG::2014-04-01 13:11:07,353::supervdsmServer::400::SuperVdsm.Server::(main) Setting up keep alive thread
MainThread::DEBUG::2014-04-01 13:11:07,353::supervdsmServer::406::SuperVdsm.Server::(main) Creating remote object manager
MainThread::DEBUG::2014-04-01 13:11:07,357::supervdsmServer::417::SuperVdsm.Server::(main) Started serving super vdsm object
sourceRoute::DEBUG::2014-04-01 13:11:07,358::sourceRouteThread::56::root::(_subscribeToInotifyLoop) sourceRouteThread.subscribeToInotifyLoop started
MainProcess::DEBUG::2014-04-01 13:11:10,614::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call readMultipathConf with () {}
MainProcess::DEBUG::2014-04-01 13:11:10,615::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return readMultipathConf with ['# RHEV REVISION 1.0', '', 'defaults {', ' polling_interval 5', ' getuid_callout "/sbin/scsi_id --whitelisted --replace-whitespace --device=/dev/%n"', ' no_path_retry fail', ' user_friendly_names no', ' flush_on_last_del yes', ' fast_io_fail_tmo 5', ' dev_loss_tmo 30', ' max_fds 4096', '}', '', 'devices {', 'device {', ' vendor "HITACHI"', ' product "DF.*"', ' getuid_callout "/sbin/scsi_id --whitelisted --replace-whitespace --device=/dev/%n"', '}', 'device {', ' vendor "COMPELNT"', ' product "Compellent Vol"', ' no_path_retry fail', '}', '}']
MainProcess|PolicyEngine::DEBUG::2014-04-01 13:11:21,387::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call ksmTune with ({'run': 0},) {}
MainProcess|PolicyEngine::DEBUG::2014-04-01 13:11:21,388::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return ksmTune with None
MainProcess|Thread-13::DEBUG::2014-04-01 13:11:22,959::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-13::DEBUG::2014-04-01 13:11:23,031::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainThread::DEBUG::2014-04-01 13:13:31,965::supervdsmServer::424::SuperVdsm.Server::(main) Terminated normally
MainThread::DEBUG::2014-04-01 13:16:40,783::netconfpersistence::134::root::(_getConfigs) Non-existing config set.
MainThread::DEBUG::2014-04-01 13:16:40,783::netconfpersistence::134::root::(_getConfigs) Non-existing config set.
MainThread::DEBUG::2014-04-01 13:16:40,806::supervdsmServer::384::SuperVdsm.Server::(main) Making sure I'm root - SuperVdsm
MainThread::DEBUG::2014-04-01 13:16:40,807::supervdsmServer::393::SuperVdsm.Server::(main) Parsing cmd args
MainThread::DEBUG::2014-04-01 13:16:40,807::supervdsmServer::396::SuperVdsm.Server::(main) Cleaning old socket /var/run/vdsm/svdsm.sock
MainThread::DEBUG::2014-04-01 13:16:40,807::supervdsmServer::400::SuperVdsm.Server::(main) Setting up keep alive thread
MainThread::DEBUG::2014-04-01 13:16:40,807::supervdsmServer::406::SuperVdsm.Server::(main) Creating remote object manager
MainThread::DEBUG::2014-04-01 13:16:40,809::supervdsmServer::417::SuperVdsm.Server::(main) Started serving super vdsm object
sourceRoute::DEBUG::2014-04-01 13:16:40,809::sourceRouteThread::56::root::(_subscribeToInotifyLoop) sourceRouteThread.subscribeToInotifyLoop started
MainProcess::DEBUG::2014-04-01 13:16:44,053::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call readMultipathConf with () {}
MainProcess::DEBUG::2014-04-01 13:16:44,053::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return readMultipathConf with ['# RHEV REVISION 1.0', '', 'defaults {', ' polling_interval 5', ' getuid_callout "/sbin/scsi_id --whitelisted --replace-whitespace --device=/dev/%n"', ' no_path_retry fail', ' user_friendly_names no', ' flush_on_last_del yes', ' fast_io_fail_tmo 5', ' dev_loss_tmo 30', ' max_fds 4096', '}', '', 'devices {', 'device {', ' vendor "HITACHI"', ' product "DF.*"', ' getuid_callout "/sbin/scsi_id --whitelisted --replace-whitespace --device=/dev/%n"', '}', 'device {', ' vendor "COMPELNT"', ' product "Compellent Vol"', ' no_path_retry fail', '}', '}']
MainProcess|Thread-13::DEBUG::2014-04-01 13:16:45,279::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-13::DEBUG::2014-04-01 13:16:45,343::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|PolicyEngine::DEBUG::2014-04-01 13:16:54,860::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call ksmTune with ({'run': 0},) {}
MainProcess|PolicyEngine::DEBUG::2014-04-01 13:16:54,860::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return ksmTune with None
MainProcess|Thread-14::DEBUG::2014-04-01 13:20:39,297::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-14::DEBUG::2014-04-01 13:20:39,297::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-15::DEBUG::2014-04-01 13:21:11,423::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-15::DEBUG::2014-04-01 13:21:11,423::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainThread::DEBUG::2014-04-01 13:22:22,074::supervdsmServer::424::SuperVdsm.Server::(main) Terminated normally
MainThread::DEBUG::2014-04-01 13:22:25,111::netconfpersistence::134::root::(_getConfigs) Non-existing config set.
MainThread::DEBUG::2014-04-01 13:22:25,111::netconfpersistence::134::root::(_getConfigs) Non-existing config set.
MainThread::DEBUG::2014-04-01 13:22:25,132::supervdsmServer::384::SuperVdsm.Server::(main) Making sure I'm root - SuperVdsm
MainThread::DEBUG::2014-04-01 13:22:25,132::supervdsmServer::393::SuperVdsm.Server::(main) Parsing cmd args
MainThread::DEBUG::2014-04-01 13:22:25,132::supervdsmServer::396::SuperVdsm.Server::(main) Cleaning old socket /var/run/vdsm/svdsm.sock
MainThread::DEBUG::2014-04-01 13:22:25,133::supervdsmServer::400::SuperVdsm.Server::(main) Setting up keep alive thread
MainThread::DEBUG::2014-04-01 13:22:25,133::supervdsmServer::406::SuperVdsm.Server::(main) Creating remote object manager
MainThread::DEBUG::2014-04-01 13:22:25,200::supervdsmServer::417::SuperVdsm.Server::(main) Started serving super vdsm object
sourceRoute::DEBUG::2014-04-01 13:22:25,201::sourceRouteThread::56::root::(_subscribeToInotifyLoop) sourceRouteThread.subscribeToInotifyLoop started
MainProcess::DEBUG::2014-04-01 13:22:28,808::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call readMultipathConf with () {}
MainProcess::DEBUG::2014-04-01 13:22:28,808::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return readMultipathConf with ['# RHEV REVISION 1.0', '', 'defaults {', ' polling_interval 5', ' getuid_callout "/sbin/scsi_id --whitelisted --replace-whitespace --device=/dev/%n"', ' no_path_retry fail', ' user_friendly_names no', ' flush_on_last_del yes', ' fast_io_fail_tmo 5', ' dev_loss_tmo 30', ' max_fds 4096', '}', '', 'devices {', 'device {', ' vendor "HITACHI"', ' product "DF.*"', ' getuid_callout "/sbin/scsi_id --whitelisted --replace-whitespace --device=/dev/%n"', '}', 'device {', ' vendor "COMPELNT"', ' product "Compellent Vol"', ' no_path_retry fail', '}', '}']
MainProcess|Thread-14::DEBUG::2014-04-01 13:22:31,095::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-14::DEBUG::2014-04-01 13:22:31,165::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|PolicyEngine::DEBUG::2014-04-01 13:22:39,576::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call ksmTune with ({'run': 0},) {}
MainProcess|PolicyEngine::DEBUG::2014-04-01 13:22:39,577::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return ksmTune with None
MainThread::DEBUG::2014-04-01 13:44:59,743::netconfpersistence::134::root::(_getConfigs) Non-existing config set.
MainThread::DEBUG::2014-04-01 13:44:59,759::netconfpersistence::134::root::(_getConfigs) Non-existing config set.
MainThread::DEBUG::2014-04-01 13:44:59,839::supervdsmServer::384::SuperVdsm.Server::(main) Making sure I'm root - SuperVdsm
MainThread::DEBUG::2014-04-01 13:44:59,839::supervdsmServer::393::SuperVdsm.Server::(main) Parsing cmd args
MainThread::DEBUG::2014-04-01 13:44:59,839::supervdsmServer::396::SuperVdsm.Server::(main) Cleaning old socket /var/run/vdsm/svdsm.sock
MainThread::DEBUG::2014-04-01 13:44:59,840::supervdsmServer::400::SuperVdsm.Server::(main) Setting up keep alive thread
MainThread::DEBUG::2014-04-01 13:44:59,840::supervdsmServer::406::SuperVdsm.Server::(main) Creating remote object manager
MainThread::DEBUG::2014-04-01 13:44:59,841::supervdsmServer::417::SuperVdsm.Server::(main) Started serving super vdsm object
sourceRoute::DEBUG::2014-04-01 13:44:59,842::sourceRouteThread::56::root::(_subscribeToInotifyLoop) sourceRouteThread.subscribeToInotifyLoop started
MainProcess::DEBUG::2014-04-01 13:45:24,565::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call readMultipathConf with () {}
MainProcess::DEBUG::2014-04-01 13:45:24,566::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return readMultipathConf with ['# RHEV REVISION 1.0', '', 'defaults {', ' polling_interval 5', ' getuid_callout "/sbin/scsi_id --whitelisted --replace-whitespace --device=/dev/%n"', ' no_path_retry fail', ' user_friendly_names no', ' flush_on_last_del yes', ' fast_io_fail_tmo 5', ' dev_loss_tmo 30', ' max_fds 4096', '}', '', 'devices {', 'device {', ' vendor "HITACHI"', ' product "DF.*"', ' getuid_callout "/sbin/scsi_id --whitelisted --replace-whitespace --device=/dev/%n"', '}', 'device {', ' vendor "COMPELNT"', ' product "Compellent Vol"', ' no_path_retry fail', '}', '}']
MainProcess|PolicyEngine::DEBUG::2014-04-01 13:45:35,830::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call ksmTune with ({'run': 0},) {}
MainProcess|PolicyEngine::DEBUG::2014-04-01 13:45:35,837::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return ksmTune with None
MainProcess|Thread-13::DEBUG::2014-04-01 13:47:59,454::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-13::DEBUG::2014-04-01 13:47:59,568::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-14::DEBUG::2014-04-01 13:49:32,238::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-14::DEBUG::2014-04-01 13:49:32,240::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-15::DEBUG::2014-04-01 13:51:17,886::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-15::DEBUG::2014-04-01 13:51:17,888::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-16::DEBUG::2014-04-01 13:57:54,508::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-16::DEBUG::2014-04-01 13:57:54,510::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-17::DEBUG::2014-04-01 14:02:37,358::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-17::DEBUG::2014-04-01 14:02:37,359::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-18::DEBUG::2014-04-01 14:24:48,924::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-18::DEBUG::2014-04-01 14:24:48,931::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-19::DEBUG::2014-04-01 14:26:09,065::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-19::DEBUG::2014-04-01 14:26:09,066::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainThread::DEBUG::2014-04-01 14:26:29,970::supervdsmServer::424::SuperVdsm.Server::(main) Terminated normally
MainThread::DEBUG::2014-04-01 14:26:34,549::netconfpersistence::134::root::(_getConfigs) Non-existing config set.
MainThread::DEBUG::2014-04-01 14:26:34,550::netconfpersistence::134::root::(_getConfigs) Non-existing config set.
MainThread::DEBUG::2014-04-01 14:26:34,633::supervdsmServer::384::SuperVdsm.Server::(main) Making sure I'm root - SuperVdsm
MainThread::DEBUG::2014-04-01 14:26:34,635::supervdsmServer::393::SuperVdsm.Server::(main) Parsing cmd args
MainThread::DEBUG::2014-04-01 14:26:34,635::supervdsmServer::396::SuperVdsm.Server::(main) Cleaning old socket /var/run/vdsm/svdsm.sock
MainThread::DEBUG::2014-04-01 14:26:34,636::supervdsmServer::400::SuperVdsm.Server::(main) Setting up keep alive thread
MainThread::DEBUG::2014-04-01 14:26:34,636::supervdsmServer::406::SuperVdsm.Server::(main) Creating remote object manager
MainThread::DEBUG::2014-04-01 14:26:34,637::supervdsmServer::417::SuperVdsm.Server::(main) Started serving super vdsm object
sourceRoute::DEBUG::2014-04-01 14:26:34,648::sourceRouteThread::56::root::(_subscribeToInotifyLoop) sourceRouteThread.subscribeToInotifyLoop started
MainProcess::DEBUG::2014-04-01 14:26:38,816::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call readMultipathConf with () {}
MainProcess::DEBUG::2014-04-01 14:26:38,816::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return readMultipathConf with ['# RHEV REVISION 1.0', '', 'defaults {', ' polling_interval 5', ' getuid_callout "/sbin/scsi_id --whitelisted --replace-whitespace --device=/dev/%n"', ' no_path_retry fail', ' user_friendly_names no', ' flush_on_last_del yes', ' fast_io_fail_tmo 5', ' dev_loss_tmo 30', ' max_fds 4096', '}', '', 'devices {', 'device {', ' vendor "HITACHI"', ' product "DF.*"', ' getuid_callout "/sbin/scsi_id --whitelisted --replace-whitespace --device=/dev/%n"', '}', 'device {', ' vendor "COMPELNT"', ' product "Compellent Vol"', ' no_path_retry fail', '}', '}']
MainProcess|Thread-14::DEBUG::2014-04-01 14:26:40,926::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-14::DEBUG::2014-04-01 14:26:41,025::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|PolicyEngine::DEBUG::2014-04-01 14:26:49,745::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call ksmTune with ({'run': 0},) {}
MainProcess|PolicyEngine::DEBUG::2014-04-01 14:26:49,745::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return ksmTune with None
MainProcess|Thread-15::DEBUG::2014-04-01 14:48:06,622::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-15::DEBUG::2014-04-01 14:48:06,622::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-16::DEBUG::2014-04-01 14:51:29,018::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-16::DEBUG::2014-04-01 14:51:29,019::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-17::DEBUG::2014-04-01 15:04:55,811::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-17::DEBUG::2014-04-01 15:04:55,812::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-18::DEBUG::2014-04-01 15:07:59,106::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-18::DEBUG::2014-04-01 15:07:59,106::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-19::DEBUG::2014-04-01 15:10:26,681::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-19::DEBUG::2014-04-01 15:10:26,682::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-20::DEBUG::2014-04-01 15:22:09,055::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-20::DEBUG::2014-04-01 15:22:09,055::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-21::DEBUG::2014-04-01 15:22:32,928::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-21::DEBUG::2014-04-01 15:22:32,928::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
MainProcess|Thread-22::DEBUG::2014-04-01 15:30:32,109::supervdsmServer::96::SuperVdsm.ServerCallback::(wrapper) call getHardwareInfo with () {}
MainProcess|Thread-22::DEBUG::2014-04-01 15:30:32,109::supervdsmServer::103::SuperVdsm.ServerCallback::(wrapper) return getHardwareInfo with {'systemProductName': 'ProLiant DL380 G5', 'systemSerialNumber': 'CZC6451JFR', 'systemFamily': None, 'systemVersion': 'Not Specified', 'systemUUID': '435a4336-3435-435a-4336-3435314a4652', 'systemManufacturer': 'HP'}
------=_Part_594693_2003216810.1396362976018
Content-Type: text/x-log
Content-Transfer-Encoding: 7bit
Content-Disposition: attachment; filename=mom.log
2014-04-01 12:50:16,314 - mom - INFO - MOM starting
2014-04-01 12:50:16,401 - mom - INFO - hypervisor interface vdsm
2014-04-01 12:50:16,401 - mom.HostMonitor - INFO - Host Monitor starting
2014-04-01 12:50:16,409 - mom.GuestManager - INFO - Guest Manager starting
2014-04-01 12:50:16,488 - mom.Policy - INFO - Loaded policy '00-defines'
2014-04-01 12:50:16,577 - mom.HostMonitor - INFO - HostMonitor is ready
2014-04-01 12:50:16,598 - mom.Policy - INFO - Loaded policy '02-balloon'
2014-04-01 12:50:16,691 - mom.Policy - INFO - Loaded policy '03-ksm'
2014-04-01 12:50:16,693 - mom.PolicyEngine - INFO - Policy Engine starting
2014-04-01 12:50:16,696 - mom.RPCServer - INFO - RPC Server is disabled
2014-04-01 12:50:26,748 - mom.Controllers.KSM - INFO - Updating KSM configuration: pages_to_scan:0 run:0 sleep_millisecs:0
2014-04-01 12:50:31,434 - mom.GuestManager - INFO - Guest Manager ending
2014-04-01 12:50:31,635 - mom.HostMonitor - INFO - Host Monitor ending
2014-04-01 12:50:31,712 - mom - ERROR - Thread 'HostMonitor' has exited
2014-04-01 12:52:43,250 - mom - INFO - MOM starting
2014-04-01 12:52:43,434 - mom - INFO - hypervisor interface vdsm
2014-04-01 12:52:43,444 - mom.HostMonitor - INFO - Host Monitor starting
2014-04-01 12:52:43,464 - mom.GuestManager - INFO - Guest Manager starting
2014-04-01 12:52:43,528 - mom.Policy - INFO - Loaded policy '00-defines'
2014-04-01 12:52:43,551 - mom.HostMonitor - INFO - HostMonitor is ready
2014-04-01 12:52:43,644 - mom.Policy - INFO - Loaded policy '02-balloon'
2014-04-01 12:52:43,742 - mom.Policy - INFO - Loaded policy '03-ksm'
2014-04-01 12:52:43,742 - mom.PolicyEngine - INFO - Policy Engine starting
2014-04-01 12:52:43,750 - mom.RPCServer - INFO - RPC Server is disabled
2014-04-01 12:52:53,802 - mom.Controllers.KSM - INFO - Updating KSM configuration: pages_to_scan:0 run:0 sleep_millisecs:0
2014-04-01 13:11:10,919 - mom - INFO - MOM starting
2014-04-01 13:11:11,019 - mom.HostMonitor - INFO - Host Monitor starting
2014-04-01 13:11:11,020 - mom - INFO - hypervisor interface vdsm
2014-04-01 13:11:11,028 - mom.GuestManager - INFO - Guest Manager starting
2014-04-01 13:11:11,080 - mom.HostMonitor - INFO - HostMonitor is ready
2014-04-01 13:11:11,112 - mom.Policy - INFO - Loaded policy '00-defines'
2014-04-01 13:11:11,186 - mom.Policy - INFO - Loaded policy '02-balloon'
2014-04-01 13:11:11,309 - mom.Policy - INFO - Loaded policy '03-ksm'
2014-04-01 13:11:11,310 - mom.PolicyEngine - INFO - Policy Engine starting
2014-04-01 13:11:11,314 - mom.RPCServer - INFO - RPC Server is disabled
2014-04-01 13:11:21,366 - mom.Controllers.KSM - INFO - Updating KSM configuration: pages_to_scan:0 run:0 sleep_millisecs:0
2014-04-01 13:13:31,180 - mom.GuestManager - INFO - Guest Manager ending
2014-04-01 13:13:31,458 - mom - ERROR - Thread 'GuestManager' has exited
2014-04-01 13:16:44,369 - mom - INFO - MOM starting
2014-04-01 13:16:44,431 - mom - INFO - hypervisor interface vdsm
2014-04-01 13:16:44,431 - mom.HostMonitor - INFO - Host Monitor starting
2014-04-01 13:16:44,435 - mom.GuestManager - INFO - Guest Manager starting
2014-04-01 13:16:44,621 - mom.HostMonitor - INFO - HostMonitor is ready
2014-04-01 13:16:44,629 - mom.Policy - INFO - Loaded policy '00-defines'
2014-04-01 13:16:44,692 - mom.Policy - INFO - Loaded policy '02-balloon'
2014-04-01 13:16:44,802 - mom.Policy - INFO - Loaded policy '03-ksm'
2014-04-01 13:16:44,803 - mom.PolicyEngine - INFO - Policy Engine starting
2014-04-01 13:16:44,806 - mom.RPCServer - INFO - RPC Server is disabled
2014-04-01 13:16:54,858 - mom.Controllers.KSM - INFO - Updating KSM configuration: pages_to_scan:0 run:0 sleep_millisecs:0
2014-04-01 13:22:11,271 - mom.HostMonitor - INFO - Host Monitor ending
2014-04-01 13:22:29,129 - mom - INFO - MOM starting
2014-04-01 13:22:29,211 - mom.HostMonitor - INFO - Host Monitor starting
2014-04-01 13:22:29,211 - mom - INFO - hypervisor interface vdsm
2014-04-01 13:22:29,323 - mom.GuestManager - INFO - Guest Manager starting
2014-04-01 13:22:29,340 - mom.Policy - INFO - Loaded policy '00-defines'
2014-04-01 13:22:29,370 - mom.HostMonitor - INFO - HostMonitor is ready
2014-04-01 13:22:29,401 - mom.Policy - INFO - Loaded policy '02-balloon'
2014-04-01 13:22:29,525 - mom.Policy - INFO - Loaded policy '03-ksm'
2014-04-01 13:22:29,525 - mom.PolicyEngine - INFO - Policy Engine starting
2014-04-01 13:22:29,527 - mom.RPCServer - INFO - RPC Server is disabled
2014-04-01 13:22:39,575 - mom.Controllers.KSM - INFO - Updating KSM configuration: pages_to_scan:0 run:0 sleep_millisecs:0
2014-04-01 13:43:13,362 - mom.PolicyEngine - INFO - Policy Engine ending
2014-04-01 13:45:25,188 - mom - INFO - MOM starting
2014-04-01 13:45:25,436 - mom.HostMonitor - INFO - Host Monitor starting
2014-04-01 13:45:25,437 - mom - INFO - hypervisor interface vdsm
2014-04-01 13:45:25,507 - mom.GuestManager - INFO - Guest Manager starting
2014-04-01 13:45:25,533 - mom.Policy - INFO - Loaded policy '00-defines'
2014-04-01 13:45:25,558 - mom.HostMonitor - INFO - HostMonitor is ready
2014-04-01 13:45:25,596 - mom.Policy - INFO - Loaded policy '02-balloon'
2014-04-01 13:45:25,752 - mom.Policy - INFO - Loaded policy '03-ksm'
2014-04-01 13:45:25,754 - mom.PolicyEngine - INFO - Policy Engine starting
2014-04-01 13:45:25,762 - mom.RPCServer - INFO - RPC Server is disabled
2014-04-01 13:45:35,814 - mom.Controllers.KSM - INFO - Updating KSM configuration: pages_to_scan:0 run:0 sleep_millisecs:0
2014-04-01 14:26:39,180 - mom - INFO - MOM starting
2014-04-01 14:26:39,307 - mom - INFO - hypervisor interface vdsm
2014-04-01 14:26:39,307 - mom.HostMonitor - INFO - Host Monitor starting
2014-04-01 14:26:39,395 - mom.HostMonitor - INFO - HostMonitor is ready
2014-04-01 14:26:39,463 - mom.GuestManager - INFO - Guest Manager starting
2014-04-01 14:26:39,482 - mom.Policy - INFO - Loaded policy '00-defines'
2014-04-01 14:26:39,527 - mom.Policy - INFO - Loaded policy '02-balloon'
2014-04-01 14:26:39,676 - mom.Policy - INFO - Loaded policy '03-ksm'
2014-04-01 14:26:39,677 - mom.PolicyEngine - INFO - Policy Engine starting
2014-04-01 14:26:39,690 - mom.RPCServer - INFO - RPC Server is disabled
2014-04-01 14:26:49,743 - mom.Controllers.KSM - INFO - Updating KSM configuration: pages_to_scan:0 run:0 sleep_millisecs:0
------=_Part_594693_2003216810.1396362976018--
10 years, 8 months
- 1
- 0