</o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-userportal-3.1.0_0001-1.8.el6.noarch</span><o:p= </o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-tools-common-3.1.0_0001-1.8.el6.noarch</span><o= :p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-setup-plugin-allinone-3.1.0_0001-1.8.el6.noarch= </span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-jbossas-1.2-2.fc16.x86_64</span><o:p></o:p></p>= <p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-log-collector-3.1.0_0001-1.8.el6.x86_64</span><= o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-setup-3.1.0_0001-1.8.el6.noarch</span><o:p></o:=

</o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-webadmin-portal-3.1.0_0001-1.8.el6.noarch</span= <o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US> </span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>[root@noc-2 vds]# rpm -qa | grep = vdsm</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>vdsm-python-4.9.6-0.223.gitb3c6b0c.el6.x86_64</span><o:p></o= :p></p><p class=3DMsoNormal><span = lang=3DEN-US>vdsm-bootstrap-4.9.6-0.223.gitb3c6b0c.el6.noarch</span><o:p>= </o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>vdsm-4.9.6-0.223.gitb3c6b0c.el6.x86_64</span><o:p></o:p></p>= <p class=3DMsoNormal><span lang=3DEN-US> </span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>Installing a new host is = successful. The host goes to reboot.</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>However, after rebooting the status = of the host:</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US style=3D'font-size:12.0pt;font-family:"Arial Unicode = MS","sans-serif";color:black;mso-fareast-language:RU'>Host 10.1.20.7 is = initializing. Message: Failed to initialize = storage</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US> </span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>In the logs:</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>Engine.log:</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>2012-05-19 17:36:45,183 INFO  = [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] = (QuartzScheduler_Worker-88) Command = org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand = return value</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US><a =

This is a multipart message in MIME format. ------=_NextPart_000_00C9_01CD368A.85F030B0 Content-Type: text/plain; charset="utf-8" Content-Transfer-Encoding: quoted-printable Host: [root@noc-3-synt ~]# rpm -qa | grep lvm2 lvm2-libs-2.02.87-6.el6.x86_64 lvm2-2.02.87-6.el6.x86_64 =20 ovirt: [root@noc-2 ~]# rpm -qa | grep lvm2 lvm2-libs-2.02.87-6.el6.x86_64 lvm2-2.02.87-6.el6.x86_64 =20 =20 =20 From: Haim Ateya [mailto:hateya@redhat.com]=20 Sent: Sunday, May 20, 2012 8:03 AM To: =D0=B7=D0=BE=D1=80=D1=80=D1=8B=D1=87 Cc: users@ovirt.org Subject: Re: [Users] Failed to initialize storage =20 Hi,=20 =20 What version of lvm2 are you using? Haim On May 20, 2012, at 1:16, =D0=B7=D0=BE=D1=80=D1=80=D1=8B=D1=87 = <zorro@megatrone.ru> wrote: Hi. I installed ovirt and vdsm version: [root@noc-2 vds]# rpm -qa | grep ovirt-engine ovirt-engine-image-uploader-3.1.0_0001-1.8.el6.x86_64 ovirt-engine-3.1.0_0001-1.8.el6.noarch ovirt-engine-restapi-3.1.0_0001-1.8.el6.noarch ovirt-engine-notification-service-3.1.0_0001-1.8.el6.noarch ovirt-engine-jboss-deps-3.1.0_0001-1.8.el6.noarch ovirt-engine-userportal-3.1.0_0001-1.8.el6.noarch ovirt-engine-tools-common-3.1.0_0001-1.8.el6.noarch ovirt-engine-setup-plugin-allinone-3.1.0_0001-1.8.el6.noarch ovirt-engine-jbossas-1.2-2.fc16.x86_64 ovirt-engine-log-collector-3.1.0_0001-1.8.el6.x86_64 ovirt-engine-setup-3.1.0_0001-1.8.el6.noarch ovirt-engine-iso-uploader-3.1.0_0001-1.8.el6.x86_64 ovirt-engine-dbscripts-3.1.0_0001-1.8.el6.noarch ovirt-engine-sdk-1.3-1.el6.noarch ovirt-engine-backend-3.1.0_0001-1.8.el6.noarch ovirt-engine-config-3.1.0_0001-1.8.el6.noarch ovirt-engine-genericapi-3.1.0_0001-1.8.el6.noarch ovirt-engine-webadmin-portal-3.1.0_0001-1.8.el6.noarch =20 [root@noc-2 vds]# rpm -qa | grep vdsm vdsm-python-4.9.6-0.223.gitb3c6b0c.el6.x86_64 vdsm-bootstrap-4.9.6-0.223.gitb3c6b0c.el6.noarch vdsm-4.9.6-0.223.gitb3c6b0c.el6.x86_64 =20 Installing a new host is successful. The host goes to reboot. However, after rebooting the status of the host: Host 10.1.20.7 is initializing. Message: Failed to initialize storage =20 In the logs: Engine.log: 2012-05-19 17:36:45,183 INFO = [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] = (QuartzScheduler_Worker-88) Command = org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand = return value org.ovirt.engine.core.vdsbroker.vdsbroker.VDSInfoReturnForXmlRpc@6082848f= 2012-05-19 17:36:45,183 INFO = [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] = (QuartzScheduler_Worker-88) Vds: 10.1.20.7 2012-05-19 17:36:45,183 ERROR = [org.ovirt.engine.core.vdsbroker.VDSCommandBase] = (QuartzScheduler_Worker-88) Command GetCapabilitiesVDS execution failed. = Error: VDSRecoveringException: Failed to initialize storage 2012-05-19 17:36:47,203 INFO = [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] = (QuartzScheduler_Worker-91) Command = org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand = return value org.ovirt.engine.core.vdsbroker.vdsbroker.VDSInfoReturnForXmlRpc@70db29ad= 2012-05-19 17:36:47,203 INFO = [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] = (QuartzScheduler_Worker-91) Vds: 10.1.20.7 2012-05-19 17:36:47,203 ERROR = [org.ovirt.engine.core.vdsbroker.VDSCommandBase] = (QuartzScheduler_Worker-91) Command GetCapabilitiesVDS execution failed. = Error: VDSRecoveringException: Failed to initialize storage =20 Vdsm.log(host): MainThread::INFO::2012-05-19 17:21:54,938::vdsm::78::vds::(run) = <_MainThread(MainThread, started 140055851738880)> MainThread::INFO::2012-05-19 17:21:54,938::vdsm::78::vds::(run) = <Thread(libvirtEventLoop, started daemon 140055763654400)> MainThread::INFO::2012-05-19 17:21:54,938::vdsm::78::vds::(run) = <WorkerThread(Thread-5, started daemon 140055620335360)> MainThread::INFO::2012-05-19 17:21:54,939::vdsm::78::vds::(run) = <WorkerThread(Thread-8, started daemon 140055249151744)> MainThread::INFO::2012-05-19 17:21:54,939::vdsm::78::vds::(run) = <WorkerThread(Thread-10, started daemon 140055228172032)> MainThread::INFO::2012-05-19 17:21:54,939::vdsm::78::vds::(run) = <KsmMonitorThread(KsmMonitor, started daemon 140054789879552)> MainThread::INFO::2012-05-19 17:21:54,939::vdsm::78::vds::(run) = <WorkerThread(Thread-3, started daemon 140055641315072)> MainThread::INFO::2012-05-19 17:21:54,939::vdsm::78::vds::(run) = <WorkerThread(Thread-6, started daemon 140055609845504)> MainThread::INFO::2012-05-19 17:21:54,940::vdsm::78::vds::(run) = <WorkerThread(Thread-2, started daemon 140055651804928)> MainThread::INFO::2012-05-19 17:21:54,940::vdsm::78::vds::(run) = <WorkerThread(Thread-1, started daemon 140055662294784)> MainThread::INFO::2012-05-19 17:21:54,940::vdsm::78::vds::(run) = <WorkerThread(Thread-7, started daemon 140055259641600)> MainThread::INFO::2012-05-19 17:21:54,940::vmChannels::135::vds::(stop) = VM channels listener was stopped. MainThread::INFO::2012-05-19 17:21:54,940::vdsm::78::vds::(run) = <Listener(VM Channels Listener, started daemon 140054768899840)> MainThread::INFO::2012-05-19 17:21:54,940::vdsm::78::vds::(run) = <WorkerThread(Thread-9, started daemon 140055238661888)> MainThread::INFO::2012-05-19 17:21:54,941::vdsm::78::vds::(run) = <WorkerThread(Thread-4, started daemon 140055630825216)> MainThread::INFO::2012-05-19 17:21:54,941::vdsm::78::vds::(run) = <Thread(Thread-11, started daemon 140055217682176)> MainThread::INFO::2012-05-19 17:30:55,476::vdsm::70::vds::(run) I am the = actual vdsm 4.9.6-0.223.gitb3c6b0c MainThread::DEBUG::2012-05-19 = 17:30:56,219::resourceManager::379::ResourceManager::(registerNamespace) = Registering namespace 'Storage' MainThread::DEBUG::2012-05-19 = 17:30:56,220::threadPool::45::Misc.ThreadPool::(__init__) Enter - = numThreads: 10.0, waitTimeout: 3, maxTasks: 500.0 MainThread::DEBUG::2012-05-19 = 17:30:56,234::sp::359::Storage.StoragePool::(cleanupMasterMount) master = `/rhev/data-center/mnt/blockSD/e5a63624-716e-4bb4-ae60-cd4d7aae9ed2/maste= r` is not mounted, skipping MainThread::DEBUG::2012-05-19 = 17:30:56,302::supervdsm::103::SuperVdsmProxy::(_killSupervdsm) Could not = kill old Super Vdsm [Errno 2] No such file or directory: = '/var/run/vdsm/svdsm.pid' MainThread::DEBUG::2012-05-19 = 17:30:56,302::supervdsm::91::SuperVdsmProxy::(_launchSupervdsm) = Launching Super Vdsm MainThread::DEBUG::2012-05-19 = 17:30:56,302::__init__::1164::Storage.Misc.excCmd::(_log) '/usr/bin/sudo = -n /usr/bin/python /usr/share/vdsm/supervdsmServer.py = 1f16883e-d8b7-45ab-b527-bcee38e5fc87 2994' (cwd None) MainThread::DEBUG::2012-05-19 = 17:30:56,529::supervdsmServer::279::SuperVdsm.Server::(main) Making sure = I'm root MainThread::DEBUG::2012-05-19 = 17:30:56,529::supervdsmServer::283::SuperVdsm.Server::(main) Parsing cmd = args MainThread::DEBUG::2012-05-19 = 17:30:56,529::supervdsmServer::286::SuperVdsm.Server::(main) Creating = PID file MainThread::DEBUG::2012-05-19 = 17:30:56,529::supervdsmServer::290::SuperVdsm.Server::(main) Cleaning = old socket MainThread::DEBUG::2012-05-19 = 17:30:56,530::supervdsmServer::294::SuperVdsm.Server::(main) Setting up = keep alive thread MainThread::DEBUG::2012-05-19 = 17:30:56,530::supervdsmServer::300::SuperVdsm.Server::(main) Creating = remote object manager MainThread::DEBUG::2012-05-19 = 17:30:56,531::supervdsmServer::311::SuperVdsm.Server::(main) Started = serving super vdsm object MainThread::DEBUG::2012-05-19 = 17:30:58,309::supervdsm::113::SuperVdsmProxy::(_connect) Trying to = connect to Super Vdsm MainThread::DEBUG::2012-05-19 = 17:30:58,314::supervdsm::84::SuperVdsmProxy::(__init__) Connected to = Super Vdsm MainThread::DEBUG::2012-05-19 = 17:30:58,315::multipath::102::Storage.Multipath::(isEnabled) Current = revision of multipath.conf detected, preserving MainThread::DEBUG::2012-05-19 = 17:30:58,315::__init__::1164::Storage.Misc.excCmd::(_log) '/usr/bin/sudo = -n /sbin/lvm dumpconfig global/locking_type' (cwd None) MainThread::DEBUG::2012-05-19 = 17:30:58,464::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: <err> = =3D ''; <rc> =3D 0 MainThread::DEBUG::2012-05-19 = 17:30:58,465::lvm::316::OperationMutex::(_reloadpvs) Operation 'lvm = reload operation' got the operation mutex MainThread::DEBUG::2012-05-19 = 17:30:58,467::__init__::1164::Storage.Misc.excCmd::(_log) '/usr/bin/sudo = -n /sbin/lvm pvs --config " devices { preferred_names =3D = [\\"^/dev/mapper/\\"] ignore_suspended_devices=3D1 write_cache_state=3D0 = disable_after_error_count=3D3 filter =3D [ \\ = <file:///\\%22a%2535000c50001770ea3%25\> "a%35000c50001770ea3%\\", \\ = <file:///\\%22r%25.*%25\> "r%.*%\\" ] } global { locking_type=3D1 = prioritise_write_locks=3D1 wait_for_locks=3D1 } backup { retain_min = =3D 50 retain_days =3D 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::DEBUG::2012-05-19 = 17:30:58,613::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: <err> = =3D " Couldn't find device with uuid = jbH4vV-SWm9-NI0q-Apmd-12qW-KBPX-Rgg2lK.\n"; <rc> =3D 0 MainThread::DEBUG::2012-05-19 = 17:30:58,615::lvm::339::OperationMutex::(_reloadpvs) Operation 'lvm = reload operation' released the operation mutex MainThread::DEBUG::2012-05-19 = 17:30:58,615::lvm::349::OperationMutex::(_reloadvgs) Operation 'lvm = reload operation' got the operation mutex MainThread::DEBUG::2012-05-19 = 17:30:58,616::__init__::1164::Storage.Misc.excCmd::(_log) '/usr/bin/sudo = -n /sbin/lvm vgs --config " devices { preferred_names =3D = [\\"^/dev/mapper/\\"] ignore_suspended_devices=3D1 write_cache_state=3D0 = disable_after_error_count=3D3 filter =3D [ \\ = <file:///\\%22a%2535000c50001770ea3%25\> "a%35000c50001770ea3%\\", \\ = <file:///\\%22r%25.*%25\> "r%.*%\\" ] } global { locking_type=3D1 = prioritise_write_locks=3D1 wait_for_locks=3D1 } backup { retain_min = =3D 50 retain_days =3D 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' (cwd None) MainThread::DEBUG::2012-05-19 = 17:30:58,764::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: <err> = =3D " Couldn't find device with uuid = jbH4vV-SWm9-NI0q-Apmd-12qW-KBPX-Rgg2lK.\n"; <rc> =3D 0 MainThread::DEBUG::2012-05-19 = 17:30:58,766::lvm::376::OperationMutex::(_reloadvgs) Operation 'lvm = reload operation' released the operation mutex MainThread::DEBUG::2012-05-19 = 17:30:58,766::__init__::1164::Storage.Misc.excCmd::(_log) '/usr/bin/sudo = -n /sbin/lvm lvs --config " devices { preferred_names =3D = [\\"^/dev/mapper/\\"] ignore_suspended_devices=3D1 write_cache_state=3D0 = disable_after_error_count=3D3 filter =3D [ \\ = <file:///\\%22a%2535000c50001770ea3%25\> "a%35000c50001770ea3%\\", \\ = <file:///\\%22r%25.*%25\> "r%.*%\\" ] } global { locking_type=3D1 = prioritise_write_locks=3D1 wait_for_locks=3D1 } backup { retain_min = =3D 50 retain_days =3D 0 } " --noheadings --units b --nosuffix = --separator | -o uuid,name,vg_name,attr,size,seg_start_pe,devices,tags' = (cwd None) MainThread::DEBUG::2012-05-19 = 17:30:58,907::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: <err> = =3D " Couldn't find device with uuid = jbH4vV-SWm9-NI0q-Apmd-12qW-KBPX-Rgg2lK.\n"; <rc> =3D 0 MainThread::ERROR::2012-05-19 = 17:30:58,909::clientIF::201::vds::(_initIRS) Error initializing IRS Traceback (most recent call last): File "/usr/share/vdsm/clientIF.py", line 199, in _initIRS self.irs =3D Dispatcher(HSM()) File "/usr/share/vdsm/storage/hsm.py", line 300, in __init__ lvm._lvminfo.bootstrap() File "/usr/share/vdsm/storage/lvm.py", line 309, in bootstrap self._reloadAllLvs() File "/usr/share/vdsm/storage/lvm.py", line 435, in _reloadAllLvs lv =3D makeLV(*fields) File "/usr/share/vdsm/storage/lvm.py", line 218, in makeLV attrs =3D _attr2NamedTuple(args[LV._fields.index("attr")], = LV_ATTR_BITS, "LV_ATTR") File "/usr/share/vdsm/storage/lvm.py", line 188, in _attr2NamedTuple attrs =3D Attrs(*values) TypeError: __new__() takes exactly 9 arguments (7 given) MainThread::DEBUG::2012-05-19 = 17:30:58,918::__init__::1164::Storage.Misc.excCmd::(_log) = '/usr/bin/pgrep -xf ksmd' (cwd None) MainThread::DEBUG::2012-05-19 = 17:30:58,945::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: <err> = =3D ''; <rc> =3D 0 MainThread::INFO::2012-05-19 = 17:30:58,946::vmChannels::139::vds::(settimeout) Setting channels' = timeout to 30 seconds. MainThread::ERROR::2012-05-19 = 17:30:58,951::clientIF::142::vds::(_prepareBindings) Unable to load the = rest server module. Please make sure it is installed. VM Channels Listener::INFO::2012-05-19 = 17:30:58,952::vmChannels::127::vds::(run) Starting VM channels listener = thread. _______________________________________________ Users mailing list Users@ovirt.org http://lists.ovirt.org/mailman/listinfo/users ------=_NextPart_000_00C9_01CD368A.85F030B0 Content-Type: text/html; charset="utf-8" Content-Transfer-Encoding: quoted-printable <html xmlns:v=3D"urn:schemas-microsoft-com:vml" = xmlns:o=3D"urn:schemas-microsoft-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=3Dutf-8"> <meta name=3DGenerator content=3D"Microsoft Word 14 (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:"Arial Unicode MS"; panose-1:2 11 6 4 2 2 2 2 2 4;} @font-face {font-family:Calibri; panose-1:2 15 5 2 2 2 4 3 2 4;} @font-face {font-family:Tahoma; panose-1:2 11 6 4 3 5 4 4 2 4;} @font-face {font-family:"\@Arial Unicode MS"; panose-1:2 11 6 4 2 2 2 2 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:blue; text-decoration:underline;} a:visited, span.MsoHyperlinkFollowed {mso-style-priority:99; color:purple; text-decoration:underline;} span.EmailStyle17 {mso-style-type:personal; font-family:"Calibri","sans-serif"; color:windowtext;} span.EmailStyle18 {mso-style-type:personal-reply; font-family:"Calibri","sans-serif"; color:#1F497D;} .MsoChpDefault {mso-style-type:export-only; font-size:10.0pt;} @page WordSection1 {size:612.0pt 792.0pt; margin:2.0cm 42.5pt 2.0cm 3.0cm;} 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 bgcolor=3Dwhite lang=3DRU = link=3Dblue vlink=3Dpurple><div class=3DWordSection1><p = class=3DMsoNormal><span lang=3DEN-US = style=3D'color:#1F497D'>Host:<o:p></o:p></span></p><p = class=3DMsoNormal><span lang=3DEN-US = style=3D'color:#1F497D'>[root@noc-3-synt ~]# rpm -qa | grep=C2=A0 = lvm2<o:p></o:p></span></p><p class=3DMsoNormal><span lang=3DEN-US = style=3D'color:#1F497D'>lvm2-libs-2.02.87-6.el6.x86_64<o:p></o:p></span><= /p><p class=3DMsoNormal><span lang=3DEN-US = style=3D'color:#1F497D'>lvm2-2.02.87-6.el6.x86_64<o:p></o:p></span></p><p= class=3DMsoNormal><span lang=3DEN-US = style=3D'color:#1F497D'><o:p> </o:p></span></p><p = class=3DMsoNormal><span lang=3DEN-US = style=3D'color:#1F497D'>ovirt:<o:p></o:p></span></p><p = class=3DMsoNormal><span lang=3DEN-US style=3D'color:#1F497D'>[root@noc-2 = ~]#=C2=A0 rpm -qa | grep=C2=A0 lvm2<o:p></o:p></span></p><p = class=3DMsoNormal><span lang=3DEN-US = style=3D'color:#1F497D'>lvm2-libs-2.02.87-6.el6.x86_64<o:p></o:p></span><= /p><p class=3DMsoNormal><span lang=3DEN-US = style=3D'color:#1F497D'>lvm2-2.02.87-6.el6.x86_64<o:p></o:p></span></p><p= class=3DMsoNormal><span lang=3DEN-US = style=3D'color:#1F497D'><o:p> </o:p></span></p><p = class=3DMsoNormal><span lang=3DEN-US = style=3D'color:#1F497D'><o:p> </o:p></span></p><p = class=3DMsoNormal><span = style=3D'color:#1F497D'><o:p> </o:p></span></p><div><div = style=3D'border:none;border-top:solid #B5C4DF 1.0pt;padding:3.0pt 0cm = 0cm 0cm'><p class=3DMsoNormal><b><span = style=3D'font-size:10.0pt;font-family:"Tahoma","sans-serif";mso-fareast-l= anguage:RU'>From:</span></b><span = style=3D'font-size:10.0pt;font-family:"Tahoma","sans-serif";mso-fareast-l= anguage:RU'> Haim Ateya [mailto:hateya@redhat.com] <br><b>Sent:</b> = Sunday, May 20, 2012 8:03 AM<br><b>To:</b> = =D0=B7=D0=BE=D1=80=D1=80=D1=8B=D1=87<br><b>Cc:</b> = users@ovirt.org<br><b>Subject:</b> Re: [Users] Failed to initialize = storage<o:p></o:p></span></p></div></div><p = class=3DMsoNormal><o:p> </o:p></p><div><p = class=3DMsoNormal>Hi, <o:p></o:p></p></div><div><p = class=3DMsoNormal><o:p> </o:p></p></div><div><p = class=3DMsoNormal>What version of lvm2 are you = using?<br><br>Haim<o:p></o:p></p></div><div><p class=3DMsoNormal = style=3D'margin-bottom:12.0pt'><br>On May 20, 2012, at 1:16, = =D0=B7=D0=BE=D1=80=D1=80=D1=8B=D1=87 <<a = href=3D"mailto:zorro@megatrone.ru">zorro@megatrone.ru</a>> = wrote:<o:p></o:p></p></div><blockquote = style=3D'margin-top:5.0pt;margin-bottom:5.0pt'><div><p = class=3DMsoNormal><span lang=3DEN-US>Hi.</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>I installed  ovirt and vdsm = version:</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>[root@noc-2 vds]# rpm -qa | grep = ovirt-engine</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-image-uploader-3.1.0_0001-1.8.el6.x86_64</span>= <o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-3.1.0_0001-1.8.el6.noarch</span><o:p></o:p></p>= <p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-restapi-3.1.0_0001-1.8.el6.noarch</span><o:p></= o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-notification-service-3.1.0_0001-1.8.el6.noarch<= /span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-jboss-deps-3.1.0_0001-1.8.el6.noarch</span><o:p= p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-iso-uploader-3.1.0_0001-1.8.el6.x86_64</span><o= :p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-dbscripts-3.1.0_0001-1.8.el6.noarch</span><o:p>= </o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-sdk-1.3-1.el6.noarch</span><o:p></o:p></p><p = class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-backend-3.1.0_0001-1.8.el6.noarch</span><o:p></= o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-config-3.1.0_0001-1.8.el6.noarch</span><o:p></o= :p></p><p class=3DMsoNormal><span = lang=3DEN-US>ovirt-engine-genericapi-3.1.0_0001-1.8.el6.noarch</span><o:p= href=3D"mailto:org.ovirt.engine.core.vdsbroker.vdsbroker.VDSInfoReturnFor= XmlRpc@6082848f">org.ovirt.engine.core.vdsbroker.vdsbroker.VDSInfoReturnF= orXmlRpc@6082848f</a></span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>2012-05-19 17:36:45,183 INFO  = [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] = (QuartzScheduler_Worker-88) Vds: 10.1.20.7</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>2012-05-19 17:36:45,183 ERROR = [org.ovirt.engine.core.vdsbroker.VDSCommandBase] = (QuartzScheduler_Worker-88) Command GetCapabilitiesVDS execution failed. = Error: VDSRecoveringException: Failed to initialize = storage</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>2012-05-19 17:36:47,203 INFO  = [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] = (QuartzScheduler_Worker-91) Command = org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand = return value</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US><a = href=3D"mailto:org.ovirt.engine.core.vdsbroker.vdsbroker.VDSInfoReturnFor= XmlRpc@70db29ad">org.ovirt.engine.core.vdsbroker.vdsbroker.VDSInfoReturnF= orXmlRpc@70db29ad</a></span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>2012-05-19 17:36:47,203 INFO  = [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] = (QuartzScheduler_Worker-91) Vds: 10.1.20.7</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>2012-05-19 17:36:47,203 ERROR = [org.ovirt.engine.core.vdsbroker.VDSCommandBase] = (QuartzScheduler_Worker-91) Command GetCapabilitiesVDS execution failed. = </span>Error: VDSRecoveringException: Failed to initialize = storage<o:p></o:p></p><p class=3DMsoNormal> <o:p></o:p></p><p = class=3DMsoNormal><span = lang=3DEN-US>Vdsm.log(host):</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,938::vdsm::78::vds::(run) <_MainThread(MainThread, started = 140055851738880)></span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,938::vdsm::78::vds::(run) <Thread(libvirtEventLoop, started = daemon 140055763654400)></span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,938::vdsm::78::vds::(run) <WorkerThread(Thread-5, started = daemon 140055620335360)></span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,939::vdsm::78::vds::(run) <WorkerThread(Thread-8, started = daemon 140055249151744)></span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,939::vdsm::78::vds::(run) <WorkerThread(Thread-10, started = daemon 140055228172032)></span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,939::vdsm::78::vds::(run) <KsmMonitorThread(KsmMonitor, = started daemon 140054789879552)></span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,939::vdsm::78::vds::(run) <WorkerThread(Thread-3, started = daemon 140055641315072)></span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,939::vdsm::78::vds::(run) <WorkerThread(Thread-6, started = daemon 140055609845504)></span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,940::vdsm::78::vds::(run) <WorkerThread(Thread-2, started = daemon 140055651804928)></span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,940::vdsm::78::vds::(run) <WorkerThread(Thread-1, started = daemon 140055662294784)></span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,940::vdsm::78::vds::(run) <WorkerThread(Thread-7, started = daemon 140055259641600)></span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,940::vmChannels::135::vds::(stop) VM channels listener was = stopped.</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,940::vdsm::78::vds::(run) <Listener(VM Channels Listener, = started daemon 140054768899840)></span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,940::vdsm::78::vds::(run) <WorkerThread(Thread-9, started = daemon 140055238661888)></span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,941::vdsm::78::vds::(run) <WorkerThread(Thread-4, started = daemon 140055630825216)></span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:21:54,941::vdsm::78::vds::(run) <Thread(Thread-11, started daemon = 140055217682176)></span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:30:55,476::vdsm::70::vds::(run) I am the actual vdsm = 4.9.6-0.223.gitb3c6b0c</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:56,219::resourceManager::379::ResourceManager::(registerNamespace) = Registering namespace 'Storage'</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:56,220::threadPool::45::Misc.ThreadPool::(__init__) Enter - = numThreads: 10.0, waitTimeout: 3, maxTasks: = 500.0</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:56,234::sp::359::Storage.StoragePool::(cleanupMasterMount) master = `/rhev/data-center/mnt/blockSD/e5a63624-716e-4bb4-ae60-cd4d7aae9ed2/maste= r` is not mounted, skipping</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:56,302::supervdsm::103::SuperVdsmProxy::(_killSupervdsm) Could not = kill old Super Vdsm [Errno 2] No such file or directory: = '/var/run/vdsm/svdsm.pid'</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:56,302::supervdsm::91::SuperVdsmProxy::(_launchSupervdsm) = Launching Super Vdsm</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:56,302::__init__::1164::Storage.Misc.excCmd::(_log) '/usr/bin/sudo = -n /usr/bin/python /usr/share/vdsm/supervdsmServer.py = 1f16883e-d8b7-45ab-b527-bcee38e5fc87 2994' (cwd = None)</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:56,529::supervdsmServer::279::SuperVdsm.Server::(main) Making sure = I'm root</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:56,529::supervdsmServer::283::SuperVdsm.Server::(main) Parsing cmd = args</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:56,529::supervdsmServer::286::SuperVdsm.Server::(main) Creating = PID file</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:56,529::supervdsmServer::290::SuperVdsm.Server::(main) Cleaning = old socket</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:56,530::supervdsmServer::294::SuperVdsm.Server::(main) Setting up = keep alive thread</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:56,530::supervdsmServer::300::SuperVdsm.Server::(main) Creating = remote object manager</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:56,531::supervdsmServer::311::SuperVdsm.Server::(main) Started = serving super vdsm object</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,309::supervdsm::113::SuperVdsmProxy::(_connect) Trying to = connect to Super Vdsm</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,314::supervdsm::84::SuperVdsmProxy::(__init__) Connected to = Super Vdsm</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,315::multipath::102::Storage.Multipath::(isEnabled) Current = revision of multipath.conf detected, preserving</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,315::__init__::1164::Storage.Misc.excCmd::(_log) '/usr/bin/sudo = -n /sbin/lvm dumpconfig global/locking_type' (cwd = None)</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,464::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: = <err> =3D ''; <rc> =3D 0</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,465::lvm::316::OperationMutex::(_reloadpvs) Operation 'lvm = reload operation' got the operation mutex</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,467::__init__::1164::Storage.Misc.excCmd::(_log) '/usr/bin/sudo = -n /sbin/lvm pvs --config " devices { preferred_names =3D = [\\"^/dev/mapper/\\"] ignore_suspended_devices=3D1 = write_cache_state=3D0 disable_after_error_count=3D3 filter =3D [ <a = href=3D"file:///\\%22a%2535000c50001770ea3%25\">\\"a%35000c50001770e= a3%\\</a>", <a = href=3D"file:///\\%22r%25.*%25\">\\"r%.*%\\</a>" ] }  = global {  locking_type=3D1  prioritise_write_locks=3D1  = wait_for_locks=3D1 }  backup {  retain_min =3D 50  = retain_days =3D 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)</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,613::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: = <err> =3D "  Couldn't find device with uuid = jbH4vV-SWm9-NI0q-Apmd-12qW-KBPX-Rgg2lK.\n"; <rc> =3D = 0</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,615::lvm::339::OperationMutex::(_reloadpvs) Operation 'lvm = reload operation' released the operation mutex</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,615::lvm::349::OperationMutex::(_reloadvgs) Operation 'lvm = reload operation' got the operation mutex</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,616::__init__::1164::Storage.Misc.excCmd::(_log) '/usr/bin/sudo = -n /sbin/lvm vgs --config " devices { preferred_names =3D = [\\"^/dev/mapper/\\"] ignore_suspended_devices=3D1 = write_cache_state=3D0 disable_after_error_count=3D3 filter =3D [ <a = href=3D"file:///\\%22a%2535000c50001770ea3%25\">\\"a%35000c50001770e= a3%\\</a>", <a = href=3D"file:///\\%22r%25.*%25\">\\"r%.*%\\</a>" ] }  = global {  locking_type=3D1  prioritise_write_locks=3D1  = wait_for_locks=3D1 }  backup {  retain_min =3D 50  = retain_days =3D 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' (cwd None)</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,764::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: = <err> =3D "  Couldn't find device with uuid = jbH4vV-SWm9-NI0q-Apmd-12qW-KBPX-Rgg2lK.\n"; <rc> =3D = 0</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,766::lvm::376::OperationMutex::(_reloadvgs) Operation 'lvm = reload operation' released the operation mutex</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,766::__init__::1164::Storage.Misc.excCmd::(_log) '/usr/bin/sudo = -n /sbin/lvm lvs --config " devices { preferred_names =3D = [\\"^/dev/mapper/\\"] ignore_suspended_devices=3D1 = write_cache_state=3D0 disable_after_error_count=3D3 filter =3D [ <a = href=3D"file:///\\%22a%2535000c50001770ea3%25\">\\"a%35000c50001770e= a3%\\</a>", <a = href=3D"file:///\\%22r%25.*%25\">\\"r%.*%\\</a>" ] }  = global {  locking_type=3D1  prioritise_write_locks=3D1  = wait_for_locks=3D1 }  backup {  retain_min =3D 50  = retain_days =3D 0 } " --noheadings --units b --nosuffix --separator = | -o uuid,name,vg_name,attr,size,seg_start_pe,devices,tags' (cwd = None)</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,907::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: = <err> =3D "  Couldn't find device with uuid = jbH4vV-SWm9-NI0q-Apmd-12qW-KBPX-Rgg2lK.\n"; <rc> =3D = 0</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::ERROR::2012-05-19 = 17:30:58,909::clientIF::201::vds::(_initIRS) Error initializing = IRS</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>Traceback (most recent call last):</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>  File = "/usr/share/vdsm/clientIF.py", line 199, in = _initIRS</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>    self.irs =3D = Dispatcher(HSM())</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>  File "/usr/share/vdsm/storage/hsm.py", = line 300, in __init__</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>    = lvm._lvminfo.bootstrap()</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>  File "/usr/share/vdsm/storage/lvm.py", = line 309, in bootstrap</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>    = self._reloadAllLvs()</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>  File "/usr/share/vdsm/storage/lvm.py", = line 435, in _reloadAllLvs</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>    lv =3D = makeLV(*fields)</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>  File "/usr/share/vdsm/storage/lvm.py", = line 218, in makeLV</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>    attrs =3D = _attr2NamedTuple(args[LV._fields.index("attr")], LV_ATTR_BITS, = "LV_ATTR")</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>  File "/usr/share/vdsm/storage/lvm.py", = line 188, in _attr2NamedTuple</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>    attrs =3D = Attrs(*values)</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>TypeError: __new__() takes exactly 9 arguments (7 = given)</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,918::__init__::1164::Storage.Misc.excCmd::(_log) = '/usr/bin/pgrep -xf ksmd' (cwd None)</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::DEBUG::2012-05-19 = 17:30:58,945::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: = <err> =3D ''; <rc> =3D 0</span><o:p></o:p></p><p = class=3DMsoNormal><span lang=3DEN-US>MainThread::INFO::2012-05-19 = 17:30:58,946::vmChannels::139::vds::(settimeout) Setting channels' = timeout to 30 seconds.</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>MainThread::ERROR::2012-05-19 = 17:30:58,951::clientIF::142::vds::(_prepareBindings) Unable to load the = rest server module. Please make sure it is = installed.</span><o:p></o:p></p><p class=3DMsoNormal><span = lang=3DEN-US>VM Channels Listener::INFO::2012-05-19 = 17:30:58,952::vmChannels::127::vds::(run) Starting VM channels listener = thread.</span><o:p></o:p></p></div></blockquote><blockquote = style=3D'margin-top:5.0pt;margin-bottom:5.0pt'><div><p = class=3DMsoNormal><span style=3D'font-size:12.0pt;font-family:"Times New = Roman","serif";mso-fareast-language:RU'>_________________________________= ______________<br>Users mailing list<br><a = href=3D"mailto:Users@ovirt.org">Users@ovirt.org</a><br><a = href=3D"http://lists.ovirt.org/mailman/listinfo/users">http://lists.ovirt= .org/mailman/listinfo/users</a><o:p></o:p></span></p></div></blockquote><= /div></body></html> ------=_NextPart_000_00C9_01CD368A.85F030B0--

Thanks -----Original Message----- From: Haim Ateya [mailto:hateya@redhat.com] Sent: Sunday, May 20, 2012 1:29 PM To: зоррыч Cc: users@ovirt.org Subject: Re: [Users] Failed to initialize storage vdsm now requires higher version of lvm: Requires: lvm2 >= 2.02.95 please use correct version and try again. we introduced this requirement in commit aa709c48778de1aadfe8331160280e51e2a83587 Thanks, Haim ----- Original Message -----

From: "зоррыч" <zorro@megatrone.ru> To: "Haim Ateya" <hateya@redhat.com> Cc: users@ovirt.org Sent: Sunday, May 20, 2012 12:14:43 PM Subject: RE: [Users] Failed to initialize storage

Host:

[root@noc-3-synt ~]# rpm -qa | grep lvm2

lvm2-libs-2.02.87-6.el6.x86_64

lvm2-2.02.87-6.el6.x86_64

ovirt:

[root@noc-2 ~]# rpm -qa | grep lvm2

lvm2-libs-2.02.87-6.el6.x86_64

lvm2-2.02.87-6.el6.x86_64

From: Haim Ateya [mailto:hateya@redhat.com] Sent: Sunday, May 20, 2012 8:03 AM To: зоррыч Cc: users@ovirt.org Subject: Re: [Users] Failed to initialize storage

Hi,

What version of lvm2 are you using?

Haim

On May 20, 2012, at 1:16, зоррыч < zorro@megatrone.ru > wrote:

Hi.

I installed ovirt and vdsm version:

[root@noc-2 vds]# rpm -qa | grep ovirt-engine

ovirt-engine-image-uploader-3.1.0_0001-1.8.el6.x86_64

ovirt-engine-3.1.0_0001-1.8.el6.noarch

ovirt-engine-restapi-3.1.0_0001-1.8.el6.noarch

ovirt-engine-notification-service-3.1.0_0001-1.8.el6.noarch

ovirt-engine-jboss-deps-3.1.0_0001-1.8.el6.noarch

ovirt-engine-userportal-3.1.0_0001-1.8.el6.noarch

ovirt-engine-tools-common-3.1.0_0001-1.8.el6.noarch

ovirt-engine-setup-plugin-allinone-3.1.0_0001-1.8.el6.noarch

ovirt-engine-jbossas-1.2-2.fc16.x86_64

ovirt-engine-log-collector-3.1.0_0001-1.8.el6.x86_64

ovirt-engine-setup-3.1.0_0001-1.8.el6.noarch

ovirt-engine-iso-uploader-3.1.0_0001-1.8.el6.x86_64

ovirt-engine-dbscripts-3.1.0_0001-1.8.el6.noarch

ovirt-engine-sdk-1.3-1.el6.noarch

ovirt-engine-backend-3.1.0_0001-1.8.el6.noarch

ovirt-engine-config-3.1.0_0001-1.8.el6.noarch

ovirt-engine-genericapi-3.1.0_0001-1.8.el6.noarch

ovirt-engine-webadmin-portal-3.1.0_0001-1.8.el6.noarch

[root@noc-2 vds]# rpm -qa | grep vdsm

vdsm-python-4.9.6-0.223.gitb3c6b0c.el6.x86_64

vdsm-bootstrap-4.9.6-0.223.gitb3c6b0c.el6.noarch

vdsm-4.9.6-0.223.gitb3c6b0c.el6.x86_64

Installing a new host is successful. The host goes to reboot.

However, after rebooting the status of the host:

Host 10.1.20.7 is initializing. Message: Failed to initialize storage

In the logs:

Engine.log:

2012-05-19 17:36:45,183 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] (QuartzScheduler_Worker-88) Command org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand return value

org.ovirt.engine.core.vdsbroker.vdsbroker.VDSInfoReturnForXmlRpc@60828 48f

2012-05-19 17:36:45,183 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] (QuartzScheduler_Worker-88) Vds: 10.1.20.7

2012-05-19 17:36:45,183 ERROR [org.ovirt.engine.core.vdsbroker.VDSCommandBase] (QuartzScheduler_Worker-88) Command GetCapabilitiesVDS execution failed. Error: VDSRecoveringException: Failed to initialize storage

2012-05-19 17:36:47,203 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] (QuartzScheduler_Worker-91) Command org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand return value

org.ovirt.engine.core.vdsbroker.vdsbroker.VDSInfoReturnForXmlRpc@70db2 9ad

2012-05-19 17:36:47,203 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] (QuartzScheduler_Worker-91) Vds: 10.1.20.7

2012-05-19 17:36:47,203 ERROR [org.ovirt.engine.core.vdsbroker.VDSCommandBase] (QuartzScheduler_Worker-91) Command GetCapabilitiesVDS execution failed. Error: VDSRecoveringException: Failed to initialize storage

Vdsm.log(host):

MainThread::INFO::2012-05-19 17:21:54,938::vdsm::78::vds::(run) <_MainThread(MainThread, started 140055851738880)>

MainThread::INFO::2012-05-19 17:21:54,938::vdsm::78::vds::(run) <Thread(libvirtEventLoop, started daemon 140055763654400)>

MainThread::INFO::2012-05-19 17:21:54,938::vdsm::78::vds::(run) <WorkerThread(Thread-5, started daemon 140055620335360)>

MainThread::INFO::2012-05-19 17:21:54,939::vdsm::78::vds::(run) <WorkerThread(Thread-8, started daemon 140055249151744)>

MainThread::INFO::2012-05-19 17:21:54,939::vdsm::78::vds::(run) <WorkerThread(Thread-10, started daemon 140055228172032)>

MainThread::INFO::2012-05-19 17:21:54,939::vdsm::78::vds::(run) <KsmMonitorThread(KsmMonitor, started daemon 140054789879552)>

MainThread::INFO::2012-05-19 17:21:54,939::vdsm::78::vds::(run) <WorkerThread(Thread-3, started daemon 140055641315072)>

MainThread::INFO::2012-05-19 17:21:54,939::vdsm::78::vds::(run) <WorkerThread(Thread-6, started daemon 140055609845504)>

MainThread::INFO::2012-05-19 17:21:54,940::vdsm::78::vds::(run) <WorkerThread(Thread-2, started daemon 140055651804928)>

MainThread::INFO::2012-05-19 17:21:54,940::vdsm::78::vds::(run) <WorkerThread(Thread-1, started daemon 140055662294784)>

MainThread::INFO::2012-05-19 17:21:54,940::vdsm::78::vds::(run) <WorkerThread(Thread-7, started daemon 140055259641600)>

MainThread::INFO::2012-05-19 17:21:54,940::vmChannels::135::vds::(stop) VM channels listener was stopped.

MainThread::INFO::2012-05-19 17:21:54,940::vdsm::78::vds::(run) <Listener(VM Channels Listener, started daemon 140054768899840)>

MainThread::INFO::2012-05-19 17:21:54,940::vdsm::78::vds::(run) <WorkerThread(Thread-9, started daemon 140055238661888)>

MainThread::INFO::2012-05-19 17:21:54,941::vdsm::78::vds::(run) <WorkerThread(Thread-4, started daemon 140055630825216)>

MainThread::INFO::2012-05-19 17:21:54,941::vdsm::78::vds::(run) <Thread(Thread-11, started daemon 140055217682176)>

MainThread::INFO::2012-05-19 17:30:55,476::vdsm::70::vds::(run) I am the actual vdsm 4.9.6-0.223.gitb3c6b0c

MainThread::DEBUG::2012-05-19 17:30:56,219::resourceManager::379::ResourceManager::(registerNamespac e) Registering namespace 'Storage'

MainThread::DEBUG::2012-05-19 17:30:56,220::threadPool::45::Misc.ThreadPool::(__init__) Enter - numThreads: 10.0, waitTimeout: 3, maxTasks: 500.0

MainThread::DEBUG::2012-05-19 17:30:56,234::sp::359::Storage.StoragePool::(cleanupMasterMount) master `/rhev/data-center/mnt/blockSD/e5a63624-716e-4bb4-ae60-cd4d7aae9ed2/ma ster` is not mounted, skipping

MainThread::DEBUG::2012-05-19 17:30:56,302::supervdsm::103::SuperVdsmProxy::(_killSupervdsm) Could not kill old Super Vdsm [Errno 2] No such file or directory: '/var/run/vdsm/svdsm.pid'

MainThread::DEBUG::2012-05-19 17:30:56,302::supervdsm::91::SuperVdsmProxy::(_launchSupervdsm) Launching Super Vdsm

MainThread::DEBUG::2012-05-19 17:30:56,302::__init__::1164::Storage.Misc.excCmd::(_log) '/usr/bin/sudo -n /usr/bin/python /usr/share/vdsm/supervdsmServer.py 1f16883e-d8b7-45ab-b527-bcee38e5fc87 2994' (cwd None)

MainThread::DEBUG::2012-05-19 17:30:56,529::supervdsmServer::279::SuperVdsm.Server::(main) Making sure I'm root

MainThread::DEBUG::2012-05-19 17:30:56,529::supervdsmServer::283::SuperVdsm.Server::(main) Parsing cmd args

MainThread::DEBUG::2012-05-19 17:30:56,529::supervdsmServer::286::SuperVdsm.Server::(main) Creating PID file

MainThread::DEBUG::2012-05-19 17:30:56,529::supervdsmServer::290::SuperVdsm.Server::(main) Cleaning old socket

MainThread::DEBUG::2012-05-19 17:30:56,530::supervdsmServer::294::SuperVdsm.Server::(main) Setting up keep alive thread

MainThread::DEBUG::2012-05-19 17:30:56,530::supervdsmServer::300::SuperVdsm.Server::(main) Creating remote object manager

MainThread::DEBUG::2012-05-19 17:30:56,531::supervdsmServer::311::SuperVdsm.Server::(main) Started serving super vdsm object

MainThread::DEBUG::2012-05-19 17:30:58,309::supervdsm::113::SuperVdsmProxy::(_connect) Trying to connect to Super Vdsm

MainThread::DEBUG::2012-05-19 17:30:58,314::supervdsm::84::SuperVdsmProxy::(__init__) Connected to Super Vdsm

MainThread::DEBUG::2012-05-19 17:30:58,315::multipath::102::Storage.Multipath::(isEnabled) Current revision of multipath.conf detected, preserving

MainThread::DEBUG::2012-05-19 17:30:58,315::__init__::1164::Storage.Misc.excCmd::(_log) '/usr/bin/sudo -n /sbin/lvm dumpconfig global/locking_type' (cwd None)

MainThread::DEBUG::2012-05-19 17:30:58,464::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: <err> = ''; <rc> = 0

MainThread::DEBUG::2012-05-19 17:30:58,465::lvm::316::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' got the operation mutex

MainThread::DEBUG::2012-05-19 17:30:58,467::__init__::1164::Storage.Misc.excCmd::(_log) '/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 filter = [ \\"a%35000c50001770ea3%\\ ", \\"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::DEBUG::2012-05-19 17:30:58,613::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: <err> = " Couldn't find device with uuid jbH4vV-SWm9-NI0q-Apmd-12qW-KBPX-Rgg2lK.\n"; <rc> = 0

MainThread::DEBUG::2012-05-19 17:30:58,615::lvm::339::OperationMutex::(_reloadpvs) Operation 'lvm reload operation' released the operation mutex

MainThread::DEBUG::2012-05-19 17:30:58,615::lvm::349::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' got the operation mutex

MainThread::DEBUG::2012-05-19 17:30:58,616::__init__::1164::Storage.Misc.excCmd::(_log) '/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 filter = [ \\"a%35000c50001770ea3%\\ ", \\"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' (cwd None)

MainThread::DEBUG::2012-05-19 17:30:58,764::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: <err> = " Couldn't find device with uuid jbH4vV-SWm9-NI0q-Apmd-12qW-KBPX-Rgg2lK.\n"; <rc> = 0

MainThread::DEBUG::2012-05-19 17:30:58,766::lvm::376::OperationMutex::(_reloadvgs) Operation 'lvm reload operation' released the operation mutex

MainThread::DEBUG::2012-05-19 17:30:58,766::__init__::1164::Storage.Misc.excCmd::(_log) '/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 filter = [ \\"a%35000c50001770ea3%\\ ", \\"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)

MainThread::DEBUG::2012-05-19 17:30:58,907::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: <err> = " Couldn't find device with uuid jbH4vV-SWm9-NI0q-Apmd-12qW-KBPX-Rgg2lK.\n"; <rc> = 0

MainThread::ERROR::2012-05-19 17:30:58,909::clientIF::201::vds::(_initIRS) Error initializing IRS

Traceback (most recent call last):

File "/usr/share/vdsm/clientIF.py", line 199, in _initIRS

self.irs = Dispatcher(HSM())

File "/usr/share/vdsm/storage/hsm.py", line 300, in __init__

lvm._lvminfo.bootstrap()

File "/usr/share/vdsm/storage/lvm.py", line 309, in bootstrap

self._reloadAllLvs()

File "/usr/share/vdsm/storage/lvm.py", line 435, in _reloadAllLvs

lv = makeLV(*fields)

File "/usr/share/vdsm/storage/lvm.py", line 218, in makeLV

attrs = _attr2NamedTuple(args[LV._fields.index("attr")], LV_ATTR_BITS, "LV_ATTR")

File "/usr/share/vdsm/storage/lvm.py", line 188, in _attr2NamedTuple

attrs = Attrs(*values)

TypeError: __new__() takes exactly 9 arguments (7 given)

MainThread::DEBUG::2012-05-19 17:30:58,918::__init__::1164::Storage.Misc.excCmd::(_log) '/usr/bin/pgrep -xf ksmd' (cwd None)

MainThread::DEBUG::2012-05-19 17:30:58,945::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: <err> = ''; <rc> = 0

MainThread::INFO::2012-05-19 17:30:58,946::vmChannels::139::vds::(settimeout) Setting channels' timeout to 30 seconds.

MainThread::ERROR::2012-05-19 17:30:58,951::clientIF::142::vds::(_prepareBindings) Unable to load the rest server module. Please make sure it is installed.

VM Channels Listener::INFO::2012-05-19 17:30:58,952::vmChannels::127::vds::(run) Starting VM channels listener thread.

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