[Users] VDSM ERROR
Nathan Stratton
nathan at robotics.net
Fri Jun 22 19:57:40 UTC 2012
Thanks! That was it, now I think I have some issue with sudo or someting.
If I run vdsm as root it connects to the engine and the host comes up, but
if it is run normally I get:
MainThread::INFO::2012-06-22 15:46:50,424::vdsm::70::vds::(run) I am the
actual vdsm 4.10-1
MainThread::DEBUG::2012-06-22
15:46:50,675::resourceManager::379::ResourceManager::(registerNamespace)
Registering namespace 'Storage'
MainThread::DEBUG::2012-06-22
15:46:50,675::threadPool::45::Misc.ThreadPool::(__init__) Enter -
numThreads: 10.0, waitTimeout: 3, maxTasks: 500.0
MainThread::DEBUG::2012-06-22
15:46:50,690::__init__::1249::Storage.Misc.excCmd::(_log) '/usr/bin/sudo
-n /usr/bin/kill -9 2106' (cwd None)
MainThread::DEBUG::2012-06-22
15:46:50,696::supervdsm::103::SuperVdsmProxy::(_killSupervdsm) Could not
kill old Super Vdsm Permission denied
MainThread::DEBUG::2012-06-22
15:46:50,697::supervdsm::91::SuperVdsmProxy::(_launchSupervdsm) Launching
Super Vdsm
MainThread::DEBUG::2012-06-22
15:46:50,697::__init__::1249::Storage.Misc.excCmd::(_log) '/usr/bin/sudo
-n /usr/bin/python /usr/share/vdsm/supervdsmServer.py
5b882e55-ee35-4daa-86ab-be408d99e8b3 3032' (cwd None)
MainThread::ERROR::2012-06-22 15:46:50,702::clientIF::210::vds::(_initIRS)
Error initializing IRS
Traceback (most recent call last):
File "/usr/share/vdsm/clientIF.py", line 208, in _initIRS
self.irs = Dispatcher(HSM())
File "/usr/share/vdsm/storage/hsm.py", line 296, in __init__
if not multipath.isEnabled():
File "/usr/share/vdsm/storage/multipath.py", line 85, in isEnabled
svdsm = supervdsm.getProxy()
File "/usr/share/vdsm/supervdsm.py", line 135, in getProxy
_g_singletonSupervdsmInstance = SuperVdsmProxy()
File "/usr/share/vdsm/supervdsm.py", line 82, in __init__
self._restartSupervdsm()
File "/usr/share/vdsm/supervdsm.py", line 123, in _restartSupervdsm
self._launchSupervdsm()
File "/usr/share/vdsm/supervdsm.py", line 94, in _launchSupervdsm
misc.execCmd(superVdsmCmd, sync=False, sudo=True)
File "/usr/share/vdsm/storage/misc.py", line 199, in execCmd
p = BetterPopen(command, close_fds=True, cwd=cwd, env=env)
File "/usr/lib/python2.7/site-packages/vdsm/betterPopen/__init__.py",
line 46, in __init__
stderr=PIPE)
File "/usr/lib64/python2.7/subprocess.py", line 679, in __init__
errread, errwrite)
File "/usr/lib/python2.7/site-packages/vdsm/betterPopen/__init__.py",
line 60, in _execute_child
cwd, env)
OSError: Permission denied
MainThread::DEBUG::2012-06-22
15:46:50,712::__init__::1249::Storage.Misc.excCmd::(_log) '/usr/bin/pgrep
-xf ksmd' (cwd None)
MainThread::DEBUG::2012-06-22
15:46:50,725::__init__::1249::Storage.Misc.excCmd::(_log) SUCCESS: <err> =
''; <rc> = 0
MainThread::INFO::2012-06-22
15:46:50,726::vmChannels::139::vds::(settimeout) Setting channels' timeout
to 30 seconds.
VM Channels Listener::INFO::2012-06-22
15:46:50,728::vmChannels::127::vds::(run) Starting VM channels listener
thread.
MainThread::ERROR::2012-06-22
15:46:50,731::clientIF::151::vds::(_prepareBindings) Unable to load the
rest server module. Please make sure it is installed.
MainThread::INFO::2012-06-22 15:55:12,339::vmChannels::135::vds::(stop) VM
channels listener was stopped.
MainThread::INFO::2012-06-22 15:55:12,339::vdsm::75::vds::(run) VDSM main
thread ended. Waiting for 15 other threads...
MainThread::INFO::2012-06-22 15:55:12,340::vdsm::78::vds::(run)
<_MainThread(MainThread, started 140294687758144)>
MainThread::INFO::2012-06-22 15:55:12,340::vdsm::78::vds::(run)
<Thread(libvirtEventLoop, started daemon 140294603454208)>
MainThread::INFO::2012-06-22 15:55:12,340::vdsm::78::vds::(run)
<WorkerThread(Thread-8, started daemon 140293965870848)>
MainThread::INFO::2012-06-22 15:55:12,340::vdsm::78::vds::(run)
<WorkerThread(Thread-5, started daemon 140294469170944)>
MainThread::INFO::2012-06-22 15:55:12,340::vdsm::78::vds::(run)
<WorkerThread(Thread-4, started daemon 140294477563648)>
MainThread::INFO::2012-06-22 15:55:12,340::vdsm::78::vds::(run)
<WorkerThread(Thread-10, started daemon 140293949085440)>
MainThread::INFO::2012-06-22 15:55:12,340::vdsm::78::vds::(run)
<WorkerThread(Thread-3, started daemon 140294485956352)>
MainThread::INFO::2012-06-22 15:55:12,340::vdsm::78::vds::(run)
<Thread(Thread-11, started daemon 140293940692736)>
MainThread::INFO::2012-06-22 15:55:12,340::vdsm::78::vds::(run)
<WorkerThread(Thread-9, started daemon 140293957478144)>
MainThread::INFO::2012-06-22 15:55:12,341::vmChannels::135::vds::(stop) VM
channels listener was stopped.
MainThread::INFO::2012-06-22 15:55:12,341::vdsm::78::vds::(run)
<Listener(VM Channels Listener, started daemon 140293428999936)>
MainThread::INFO::2012-06-22 15:55:12,341::vdsm::78::vds::(run)
<WorkerThread(Thread-1, started daemon 140294502741760)>
MainThread::INFO::2012-06-22 15:55:12,341::vdsm::78::vds::(run)
<KsmMonitorThread(KsmMonitor, started daemon 140293923907328)>
MainThread::INFO::2012-06-22 15:55:12,341::vdsm::78::vds::(run)
<WorkerThread(Thread-6, started daemon 140294460778240)>
MainThread::INFO::2012-06-22 15:55:12,341::vdsm::78::vds::(run)
<WorkerThread(Thread-7, started daemon 140294452385536)>
MainThread::INFO::2012-06-22 15:55:12,341::vdsm::78::vds::(run)
<WorkerThread(Thread-2, started daemon 140294494349056)>
MainThread::INFO::2012-06-22 15:55:19,304::vdsm::70::vds::(run) I am the
actual vdsm 4.10-1
MainThread::DEBUG::2012-06-22
15:55:19,557::resourceManager::379::ResourceManager::(registerNamespace)
Registering namespace 'Storage'
MainThread::DEBUG::2012-06-22
15:55:19,557::threadPool::45::Misc.ThreadPool::(__init__) Enter -
numThreads: 10.0, waitTimeout: 3, maxTasks: 500.0
MainThread::DEBUG::2012-06-22
15:55:19,573::__init__::1249::Storage.Misc.excCmd::(_log) '/usr/bin/sudo
-n /usr/bin/kill -9 2106' (cwd None)
MainThread::DEBUG::2012-06-22
15:55:19,578::supervdsm::103::SuperVdsmProxy::(_killSupervdsm) Could not
kill old Super Vdsm Permission denied
MainThread::DEBUG::2012-06-22
15:55:19,579::supervdsm::91::SuperVdsmProxy::(_launchSupervdsm) Launching
Super Vdsm
MainThread::DEBUG::2012-06-22
15:55:19,580::__init__::1249::Storage.Misc.excCmd::(_log) '/usr/bin/sudo
-n /usr/bin/python /usr/share/vdsm/supervdsmServer.py
8fc32c0c-f502-4d3c-9de0-fc1bf2ba53cd 3485' (cwd None)
MainThread::ERROR::2012-06-22 15:55:19,584::clientIF::210::vds::(_initIRS)
Error initializing IRS
Traceback (most recent call last):
File "/usr/share/vdsm/clientIF.py", line 208, in _initIRS
self.irs = Dispatcher(HSM())
File "/usr/share/vdsm/storage/hsm.py", line 296, in __init__
if not multipath.isEnabled():
File "/usr/share/vdsm/storage/multipath.py", line 85, in isEnabled
svdsm = supervdsm.getProxy()
File "/usr/share/vdsm/supervdsm.py", line 135, in getProxy
_g_singletonSupervdsmInstance = SuperVdsmProxy()
File "/usr/share/vdsm/supervdsm.py", line 82, in __init__
self._restartSupervdsm()
File "/usr/share/vdsm/supervdsm.py", line 123, in _restartSupervdsm
self._launchSupervdsm()
File "/usr/share/vdsm/supervdsm.py", line 94, in _launchSupervdsm
misc.execCmd(superVdsmCmd, sync=False, sudo=True)
File "/usr/share/vdsm/storage/misc.py", line 199, in execCmd
p = BetterPopen(command, close_fds=True, cwd=cwd, env=env)
File "/usr/lib/python2.7/site-packages/vdsm/betterPopen/__init__.py",
line 46, in __init__
stderr=PIPE)
File "/usr/lib64/python2.7/subprocess.py", line 679, in __init__
errread, errwrite)
File "/usr/lib/python2.7/site-packages/vdsm/betterPopen/__init__.py",
line 60, in _execute_child
cwd, env)
OSError: Permission denied
MainThread::DEBUG::2012-06-22
15:55:19,594::__init__::1249::Storage.Misc.excCmd::(_log) '/usr/bin/pgrep
-xf ksmd' (cwd None)
MainThread::DEBUG::2012-06-22
15:55:19,606::__init__::1249::Storage.Misc.excCmd::(_log) SUCCESS: <err> =
''; <rc> = 0
MainThread::INFO::2012-06-22
15:55:19,607::vmChannels::139::vds::(settimeout) Setting channels' timeout
to 30 seconds.
VM Channels Listener::INFO::2012-06-22
15:55:19,608::vmChannels::127::vds::(run) Starting VM channels listener
thread.
MainThread::ERROR::2012-06-22
15:55:19,612::clientIF::151::vds::(_prepareBindings) Unable to load the
rest server module. Please make sure it is installed.
><>
Nathan Stratton
nathan at robotics.net
http://www.robotics.net
On Fri, 22 Jun 2012, Douglas Landgraf wrote:
> Hi Nathan,
>
> On 06/21/2012 01:15 PM, Nathan Stratton wrote:
>>
>> Fedora 17 RPMs, hosts complets install and reboots, but never connects back
>> to engine. I just see thousands of the following in the logs:
>>
>> ----
>>
>> MainThread::INFO::2012-06-21 13:07:26,304::vdsm::71::vds::(run) I am the
>> actual vdsm 4.9-0
>
> 4.9-0? Looks like a previous version of vdsm which we had a network error.
> Can you please try 4.10.0 ?
>
>
>> MainThread::ERROR::2012-06-21 13:07:26,656::vdsm::74::vds::(run) Traceback
>> (most recent call last):
>> File "/usr/share/vdsm/vdsm", line 72, in run
>> serve_clients(log)
>> File "/usr/share/vdsm/vdsm", line 40, in serve_clients
>> cif = clientIF.clientIF(log)
>> File "/usr/share/vdsm/clientIF.py", line 115, in __init__
>> self._createLibvirtNetworks()
>> File "/usr/share/vdsm/clientIF.py", line 152, in _createLibvirtNetworks
>> nf = netinfo.NetInfo()
>> File "/usr/share/vdsm/netinfo.py", line 268, in __init__
>> _netinfo = get()
>> File "/usr/share/vdsm/netinfo.py", line 215, in get
>> for bridge in bridges() ])
>> KeyError: 'ovirtmgmt'
>>
>> MainThread::INFO::2012-06-21 13:07:26,657::vdsm::76::vds::(run) VDSM main
>> thread ended. Waiting for 1 other threads...
>> MainThread::INFO::2012-06-21 13:07:26,657::vdsm::79::vds::(run)
>> <_MainThread(MainThread, started 140487047427904)>
>> MainThread::INFO::2012-06-21 13:07:26,657::vdsm::79::vds::(run)
>> <Thread(libvirtEventLoop, started daemon 140486974248704)>
>>
>> ----
>>
>> ovirtmgmt is up and running:
>>
>> -bash-4.2# brctl show
>> bridge name bridge id STP enabled interfaces
>> ovirtmgmt 8000.a0369f0a15f8 no bond0
>>
>>> <>
>> Nathan Stratton
>> nathan at robotics.net
>> http://www.robotics.net
>> _______________________________________________
>> Users mailing list
>> Users at ovirt.org
>> http://lists.ovirt.org/mailman/listinfo/users
>
>
> --
> Cheers
> Douglas
>
More information about the Users
mailing list