New subject: Don't start vm

11 Dec 2014

      ----- Original Message -----
...
From: "Roman Nikolayevich Drovalev" <drovalev@kaluga-gov.ru>
To: "Nir Soffer" <nsoffer@redhat.com>
Sent: Thursday, December 11, 2014 8:29:44 AM
Subject: Re: [ovirt-users]  Don't start vm
Hi,
I attach the file. Below log in the vdsm.log.62.xz
The given nonexistent disk has probably appeared after template removal
from which it has been created.
BUT it was independent and before problems was not, after template
removal!
The disk exists, but at it has changed ID!
I don't understand this description.

Can you describe to steps to reproduce this issue?

Guessing from your description:
1. Create vm with x disks
2. Create template
3. Create vm from template
4. Remove template
?
...
Nir Soffer <nsoffer@redhat.com> написано 09.12.2014 15:07:51:
...
...
Hi,
My config: vdsm host - CentOS 7, oVirt 3.5
...
Could you please share from hypervisor the /var/log/vdsm/vdsm.log
too?
...
my /var/log/vdsm/vdsm.log
We need the full log - please attach here or open a bug and
attach the full log.
...
Thread-283375::DEBUG::2014-12-06
21:20:40,219::stompReactor::163::yajsonrpc.StompServer::(send) Sending
response
You are using jsonrpc - please check if switching to xmlrpc solve
your issue.
...
Thread-283376::DEBUG::2014-12-06
21:20:40,252::lvm::288::Storage.Misc.excCmd::(cmd) SUCCESS: <err> = '
WARNING: lvmetad is running but disabled. Restart lvmetad before
enabling
it!\n'; <rc> = 0
Thread-283376::DEBUG::2014-12-06
21:20:40,253::lvm::454::Storage.LVM::(_reloadlvs) lvs reloaded
Thread-283376::DEBUG::2014-12-06
21:20:40,254::lvm::454::Storage.OperationMutex::(_reloadlvs) Operation
'lvm
reload operation' released the operation mutex
Thread-283376::WARNING::2014-12-06
21:20:40,254::lvm::600::Storage.LVM::(getLv) lv:
fb8466c9-0867-4e73-8362-2c95eea89a83 not found in lvs vg:
9d53ecef-8bfc-470b-8867-836bfa7df137 response
Thread-283376::ERROR::2014-12-06
21:20:40,254::task::866::Storage.TaskManager.Task::(_setError)
Task=`cb86d3c3-77f7-46c8-aec0-4c848f1eb2cd`::Unexpected error
Traceback (most recent call last):
File "/usr/share/vdsm/storage/task.py", line 873, in _run
return fn(*args, **kargs)
File "/usr/share/vdsm/logUtils.py", line 45, in wrapper
res = f(*args, **kwargs)
File "/usr/share/vdsm/storage/hsm.py", line 3099, in getVolumeSize
apparentsize = str(dom.getVSize(imgUUID, volUUID))
File "/usr/share/vdsm/storage/blockSD.py", line 622, in getVSize
size = lvm.getLV(self.sdUUID, volUUID).size
File "/usr/share/vdsm/storage/lvm.py", line 893, in getLV
raise se.LogicalVolumeDoesNotExistError("%s/%s" % (vgName, lvName))
LogicalVolumeDoesNotExistError: Logical volume does not exist:
(u'9d53ecef-8bfc-470b-8867-836bfa7df137/
fb8466c9-0867-4e73-8362-2c95eea89a83',)
Thread-283376::DEBUG::2014-12-06
21:20:40,255::task::885::Storage.TaskManager.Task::(_run)
Task=`cb86d3c3-77f7-46c8-aec0-4c848f1eb2cd`::Task._run:
cb86d3c3-77f7-46c8-aec0-4c848f1eb2cd
(u'9d53ecef-8bfc-470b-8867-836bfa7df137',
u'00000002-0002-0002-0002-00000000010b',
u'7deace0a-0c83-41c8-9122-84079ad949c2',
u'fb8466c9-0867-4e73-8362-2c95eea89a83') {} failed - stopping task
Thread-283376::DEBUG::2014-12-06
21:20:40,255::task::1217::Storage.TaskManager.Task::(stop)
Task=`cb86d3c3-77f7-46c8-aec0-4c848f1eb2cd`::stopping in state
preparing
(force False)
Thread-283376::DEBUG::2014-12-06
21:20:40,255::task::993::Storage.TaskManager.Task::(_decref)
Task=`cb86d3c3-77f7-46c8-aec0-4c848f1eb2cd`::ref 1 aborting True
Thread-283376::INFO::2014-12-06
21:20:40,255::task::1171::Storage.TaskManager.Task::(prepare)
Task=`cb86d3c3-77f7-46c8-aec0-4c848f1eb2cd`::aborting: Task is
aborted:
'Logical volume does not exist' - code 610
Thread-283376::DEBUG::2014-12-06
21:20:40,255::task::1176::Storage.TaskManager.Task::(prepare)
Task=`cb86d3c3-77f7-46c8-aec0-4c848f1eb2cd`::Prepare: aborted: Logical
volume does not exist
Thread-283376::DEBUG::2014-12-06
21:20:40,256::task::993::Storage.TaskManager.Task::(_decref)
Task=`cb86d3c3-77f7-46c8-aec0-4c848f1eb2cd`::ref 0 aborting True
Thread-283376::DEBUG::2014-12-06
21:20:40,256::task::928::Storage.TaskManager.Task::(_doAbort)
Task=`cb86d3c3-77f7-46c8-aec0-4c848f1eb2cd`::Task._doAbort: force
False
Thread-283376::DEBUG::2014-12-06
21:20:40,256::resourceManager::
977::Storage.ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}
Thread-283376::DEBUG::2014-12-06
21:20:40,256::task::595::Storage.TaskManager.Task::(_updateState)
Task=`cb86d3c3-77f7-46c8-aec0-4c848f1eb2cd`::moving from state
preparing ->
state aborting
Thread-283376::DEBUG::2014-12-06
21:20:40,256::task::550::Storage.TaskManager.Task::(__state_aborting)
Task=`cb86d3c3-77f7-46c8-aec0-4c848f1eb2cd`::_aborting: recover policy
none
Thread-283376::DEBUG::2014-12-06
21:20:40,256::task::595::Storage.TaskManager.Task::(_updateState)
Task=`cb86d3c3-77f7-46c8-aec0-4c848f1eb2cd`::moving from state
aborting ->
state failed
Thread-283376::DEBUG::2014-12-06
21:20:40,257::resourceManager::
940::Storage.ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources {}
Thread-283376::DEBUG::2014-12-06
21:20:40,257::resourceManager::
977::Storage.ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}
Thread-283376::ERROR::2014-12-06
21:20:40,257::dispatcher::76::Storage.Dispatcher::(wrapper) {'status':
{'message': "Logical volume does not exist:
(u'9d53ecef-8bfc-470b-8867-836bfa7df137/
fb8466c9-0867-4e73-8362-2c95eea89a83',)",
'code': 610}}
# My comment:" Realy, this is volume is present! I mount it in thevdsm
host!
But, mount /dev/block/253:20 , no present in
/dev/9d53ecef-8bfc-470b-8867-836bfa7df137/"
Please share with us the output of:
lsblk
multipath -ll
pvscan --cache
pvs
vgs
lvs
When a host is up.
Thanks,
Nir

Re: [ovirt-users] Don't start vm

Nir Soffer

Roman Nikolayevich Drovalev

Nir Soffer

tags

participants (2)