<html>
<head>
<meta content="text/html; charset=UTF-8" http-equiv="Content-Type">
</head>
<body bgcolor="#FFFFFF" text="#000000">
<font color="#000000"><span style="color: rgb(31, 73, 125);"
lang="EN-US">All commands in this both logs you've attached (see
example line below) indicate that the sdUUID is still </span><span
style="color:#1F497D" lang="EN-US">e3e565d6-8104-11e1-afd2-001cc43ceea0
which is the same as the spUUID</span>. Are you sure your
metadata file contains the
"SDUUID=b23c7ab6-b1d4-4888-8d4a-adc78e61db38" line and not </font><font
color="#000000">the wrong "SDUUID=</font><font color="#000000"><span
style="color:#1F497D" lang="EN-US">3e565d6-8104-11e1-afd2-001cc43ceea0"</span></font><font
color="#000000"> line?<br>
<span style="color:#1F497D" lang="EN-US"><br>
Thread-79075::INFO::2012-04-09
06:28:05,328::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: attachStorageDomain, args: (
sdUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0)</span></font><br>
<br>
On 04/09/2012 01:37 PM, зоррыч wrote:
<blockquote cite="mid:012901cd163c$b633a860$229af920$@ru"
type="cite">
<meta http-equiv="Content-Type" content="text/html; charset=UTF-8">
<meta name="Generator" content="Microsoft Word 12 (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;}
@font-face
{font-family:Tahoma;
panose-1:2 11 6 4 3 5 4 4 2 4;}
@font-face
{font-family:Consolas;
panose-1:2 11 6 9 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";
color:black;}
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;}
pre
{mso-style-priority:99;
mso-style-link:"Стандартный HTML Знак";
margin:0cm;
margin-bottom:.0001pt;
font-size:10.0pt;
font-family:"Courier New";
color:black;}
p.MsoAcetate, li.MsoAcetate, div.MsoAcetate
{mso-style-priority:99;
mso-style-link:"Текст выноски Знак";
margin:0cm;
margin-bottom:.0001pt;
font-size:8.0pt;
font-family:"Tahoma","sans-serif";
color:black;}
span.HTML
{mso-style-name:"Стандартный HTML Знак";
mso-style-priority:99;
mso-style-link:"Стандартный HTML";
font-family:Consolas;
color:black;}
span.a
{mso-style-name:"Текст выноски Знак";
mso-style-priority:99;
mso-style-link:"Текст выноски";
font-family:"Tahoma","sans-serif";
color:black;}
span.EmailStyle21
{mso-style-type:personal;
font-family:"Calibri","sans-serif";
color:windowtext;}
span.EmailStyle22
{mso-style-type:personal;
font-family:"Calibri","sans-serif";
color:#1F497D;}
span.EmailStyle23
{mso-style-type:personal;
font-family:"Calibri","sans-serif";
color:#1F497D;}
span.EmailStyle24
{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="edit" spidmax="1026" />
</xml><![endif]--><!--[if gte mso 9]><xml>
<o:shapelayout v:ext="edit">
<o:idmap v:ext="edit" data="1" />
</o:shapelayout></xml><![endif]-->
<div class="WordSection1">
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Vdsm
log (spm):<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"><o:p> </o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"><o:p> </o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::DEBUG::2012-04-09
06:28:05,189::clientIF::239::Storage.Dispatcher.Protect::(wrapper)
[10.1.20.2]<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::INFO::2012-04-09
06:28:05,190::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: validateStorageServerConnection, args:
(domType=1, spUUID=00000000-0000-0000-0000-000000000000,
conList=[{'connection': '10.1.20.2:/home/nfs4', 'iqn': '',
'portal': '', 'user': '', 'password': '******', 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f', 'port': ''}])<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::DEBUG::2012-04-09
06:28:05,190::task::495::TaskManager.Task::(_debug) Task
3634fc46-5104-4ebd-8ed6-1d4428beed92: moving from state init
-> state preparing<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::INFO::2012-04-09
06:28:05,190::storage_connection::127::Storage.ServerConnection::(validate)
Request to validate NFS storage server<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::INFO::2012-04-09
06:28:05,191::storage_connection::53::Storage.ServerConnection::(__validateConnectionParams)
conList=[{'connection': '10.1.20.2:/home/nfs4', 'iqn': '',
'portal': '', 'user': '', 'password': '******', 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f', 'port': ''}]<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::DEBUG::2012-04-09
06:28:05,192::fileUtils::83::Storage.Misc.excCmd::(mount)
'/usr/bin/sudo -n /bin/mount -o
soft,timeo=600,retrans=6,nosharecache,vers=3 -t nfs
10.1.20.2:/home/nfs4 /tmp/tmp2rKh29' (cwd None)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::DEBUG::2012-04-09
06:28:05,228::fileUtils::83::Storage.Misc.excCmd::(mount)
SUCCESS: <err> = ''; <rc> = 0<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::DEBUG::2012-04-09
06:28:05,235::fileUtils::112::Storage.Misc.excCmd::(umount)
'/usr/bin/sudo -n /bin/umount -t nfs -f /tmp/tmp2rKh29' (cwd
None)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::DEBUG::2012-04-09
06:28:05,270::fileUtils::112::Storage.Misc.excCmd::(umount)
SUCCESS: <err> = ''; <rc> = 0<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::DEBUG::2012-04-09
06:28:05,271::task::495::TaskManager.Task::(_debug) Task
3634fc46-5104-4ebd-8ed6-1d4428beed92: finished:
{'statuslist': [{'status': 0, 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f'}]}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::DEBUG::2012-04-09
06:28:05,272::task::495::TaskManager.Task::(_debug) Task
3634fc46-5104-4ebd-8ed6-1d4428beed92: moving from state
preparing -> state finished<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::DEBUG::2012-04-09
06:28:05,272::resourceManager::786::ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::DEBUG::2012-04-09
06:28:05,272::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::DEBUG::2012-04-09
06:28:05,273::task::495::TaskManager.Task::(_debug) Task
3634fc46-5104-4ebd-8ed6-1d4428beed92: ref 0 aborting False<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79073::INFO::2012-04-09
06:28:05,273::dispatcher::100::Storage.Dispatcher.Protect::(run)
Run and protect: validateStorageServerConnection, Return
response: {'status': {'message': 'OK', 'code': 0},
'statuslist': [{'status': 0, 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f'}]}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::DEBUG::2012-04-09
06:28:05,297::clientIF::239::Storage.Dispatcher.Protect::(wrapper)
[10.1.20.2]<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::INFO::2012-04-09
06:28:05,298::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: connectStorageServer, args: (domType=1,
spUUID=00000000-0000-0000-0000-000000000000,
conList=[{'connection': '10.1.20.2:/home/nfs4', 'iqn': '',
'portal': '', 'user': '', 'password': '******', 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f', 'port': ''}])<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::DEBUG::2012-04-09
06:28:05,298::task::495::TaskManager.Task::(_debug) Task
4cf78074-142b-418d-ae9d-aa1a3afbd0b8: moving from state init
-> state preparing<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::INFO::2012-04-09
06:28:05,298::storage_connection::95::Storage.ServerConnection::(connect)
Request to connect NFS storage server<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::INFO::2012-04-09
06:28:05,298::storage_connection::53::Storage.ServerConnection::(__validateConnectionParams)
conList=[{'connection': '10.1.20.2:/home/nfs4', 'iqn': '',
'portal': '', 'user': '', 'password': '******', 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f', 'port': ''}]<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::DEBUG::2012-04-09
06:28:05,308::lvm::547::OperationMutex::(_invalidateAllPvs)
Operation 'lvm invalidate operation' got the operation mutex<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::DEBUG::2012-04-09
06:28:05,308::lvm::549::OperationMutex::(_invalidateAllPvs)
Operation 'lvm invalidate operation' released the operation
mutex<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::DEBUG::2012-04-09
06:28:05,309::lvm::559::OperationMutex::(_invalidateAllVgs)
Operation 'lvm invalidate operation' got the operation mutex<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::DEBUG::2012-04-09
06:28:05,309::lvm::561::OperationMutex::(_invalidateAllVgs)
Operation 'lvm invalidate operation' released the operation
mutex<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::DEBUG::2012-04-09
06:28:05,310::lvm::580::OperationMutex::(_invalidateAllLvs)
Operation 'lvm invalidate operation' got the operation mutex<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::DEBUG::2012-04-09
06:28:05,310::lvm::582::OperationMutex::(_invalidateAllLvs)
Operation 'lvm invalidate operation' released the operation
mutex<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::DEBUG::2012-04-09
06:28:05,310::task::495::TaskManager.Task::(_debug) Task
4cf78074-142b-418d-ae9d-aa1a3afbd0b8: finished:
{'statuslist': [{'status': 0, 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f'}]}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::DEBUG::2012-04-09
06:28:05,311::task::495::TaskManager.Task::(_debug) Task
4cf78074-142b-418d-ae9d-aa1a3afbd0b8: moving from state
preparing -> state finished<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::DEBUG::2012-04-09
06:28:05,311::resourceManager::786::ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::DEBUG::2012-04-09
06:28:05,311::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::DEBUG::2012-04-09
06:28:05,311::task::495::TaskManager.Task::(_debug) Task
4cf78074-142b-418d-ae9d-aa1a3afbd0b8: ref 0 aborting False<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79074::INFO::2012-04-09
06:28:05,312::dispatcher::100::Storage.Dispatcher.Protect::(run)
Run and protect: connectStorageServer, Return response:
{'status': {'message': 'OK', 'code': 0}, 'statuslist':
[{'status': 0, 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f'}]}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,328::clientIF::239::Storage.Dispatcher.Protect::(wrapper)
[10.1.20.2]<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::INFO::2012-04-09
06:28:05,328::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: attachStorageDomain, args: (
sdUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,329::task::495::TaskManager.Task::(_debug) Task
b0ef8b95-fabe-43e0-944c-eb959cf9930a: moving from state init
-> state preparing<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,329::resourceManager::155::ResourceManager.Request::(__init__)
ResName=`Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0`ReqID=`af876ee5-24f4-43f1-a161-d495903c82b5`::Request
was made in '/usr/share/vdsm/storage/spm.py' line '1072' at
'public_attachStorageDomain'<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,330::resourceManager::463::ResourceManager::(registerResource)
Trying to register resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' for lock type
'exclusive'<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,330::resourceManager::505::ResourceManager::(registerResource)
Resource 'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' is
free. Now locking as 'exclusive' (1 active user)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,330::resourceManager::192::ResourceManager.Request::(grant)
ResName=`Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0`ReqID=`af876ee5-24f4-43f1-a161-d495903c82b5`::Granted
request<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,331::task::495::TaskManager.Task::(_debug) Task
b0ef8b95-fabe-43e0-944c-eb959cf9930a: _resourcesAcquired:
Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0 (exclusive)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,331::task::495::TaskManager.Task::(_debug) Task
b0ef8b95-fabe-43e0-944c-eb959cf9930a: ref 1 aborting False<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::ERROR::2012-04-09
06:28:05,331::task::868::TaskManager.Task::(_setError)
Unexpected error<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Traceback
(most recent call last):<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
File "/usr/share/vdsm/storage/task.py", line 876, in _run<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
return fn(*args, **kargs)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
File "/usr/share/vdsm/storage/spm.py", line 115, in run<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
return self.func(*args, **kwargs)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
File "/usr/share/vdsm/storage/spm.py", line 1073, in
public_attachStorageDomain<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
vars.task.getExclusiveLock(STORAGE, sdUUID)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
File "/usr/share/vdsm/storage/task.py", line 1311, in
getExclusiveLock<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
self.resOwner.acquire(namespace, resName,
resourceManager.LockType.exclusive, timeout)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
File "/usr/share/vdsm/storage/resourceManager.py", line 673,
in acquire<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
raise ValueError("Owner %s: acquire: resource %s is already
acquired" % (str(self), fullName))<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">ValueError:
Owner b0ef8b95-fabe-43e0-944c-eb959cf9930a: acquire:
resource Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0 is
already acquired<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,332::task::495::TaskManager.Task::(_debug) Task
b0ef8b95-fabe-43e0-944c-eb959cf9930a: Task._run:
b0ef8b95-fabe-43e0-944c-eb959cf9930a
('e3e565d6-8104-11e1-afd2-001cc43ceea0',
'e3e565d6-8104-11e1-afd2-001cc43ceea0') {} failed - stopping
task<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,332::task::495::TaskManager.Task::(_debug) Task
b0ef8b95-fabe-43e0-944c-eb959cf9930a: stopping in state
preparing (force False)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,333::task::495::TaskManager.Task::(_debug) Task
b0ef8b95-fabe-43e0-944c-eb959cf9930a: ref 1 aborting True<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::INFO::2012-04-09
06:28:05,333::task::1171::TaskManager.Task::(prepare)
aborting: Task is aborted: 'Owner
b0ef8b95-fabe-43e0-944c-eb959cf9930a: acquire: resource
Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0 is already
acquired' - code 100<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,333::task::495::TaskManager.Task::(_debug) Task
b0ef8b95-fabe-43e0-944c-eb959cf9930a: Prepare: aborted:
Owner b0ef8b95-fabe-43e0-944c-eb959cf9930a: acquire:
resource Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0 is
already acquired<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,333::task::495::TaskManager.Task::(_debug) Task
b0ef8b95-fabe-43e0-944c-eb959cf9930a: ref 0 aborting True<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,334::task::495::TaskManager.Task::(_debug) Task
b0ef8b95-fabe-43e0-944c-eb959cf9930a: Task._doAbort: force
False<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,334::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,334::task::495::TaskManager.Task::(_debug) Task
b0ef8b95-fabe-43e0-944c-eb959cf9930a: moving from state
preparing -> state aborting<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,335::task::495::TaskManager.Task::(_debug) Task
b0ef8b95-fabe-43e0-944c-eb959cf9930a: _aborting: recover
policy none<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,335::task::495::TaskManager.Task::(_debug) Task
b0ef8b95-fabe-43e0-944c-eb959cf9930a: moving from state
aborting -> state failed<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,335::resourceManager::786::ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources
{'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0': <
ResourceRef 'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0',
isValid: 'True' obj: 'None'>}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,335::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,336::resourceManager::515::ResourceManager::(releaseResource)
Trying to release resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0'<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,336::resourceManager::530::ResourceManager::(releaseResource)
Released resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' (0 active
users)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,336::resourceManager::535::ResourceManager::(releaseResource)
Resource 'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' is
free, finding out if anyone is waiting for it.<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::DEBUG::2012-04-09
06:28:05,337::resourceManager::542::ResourceManager::(releaseResource)
No one is waiting for resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0', Clearing
records.<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::ERROR::2012-04-09
06:28:05,337::dispatcher::106::Storage.Dispatcher.Protect::(run)
Owner b0ef8b95-fabe-43e0-944c-eb959cf9930a: acquire:
resource Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0 is
already acquired<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79075::ERROR::2012-04-09
06:28:05,337::dispatcher::107::Storage.Dispatcher.Protect::(run)
Traceback (most recent call last):<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
File "/usr/share/vdsm/storage/dispatcher.py", line 96, in
run<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
result = ctask.prepare(self.func, *args, **kwargs)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
File "/usr/share/vdsm/storage/task.py", line 1178, in
prepare<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
raise self.error<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">ValueError:
Owner b0ef8b95-fabe-43e0-944c-eb959cf9930a: acquire:
resource Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0 is
already acquired<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"><o:p> </o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79076::DEBUG::2012-04-09
06:28:05,349::clientIF::239::Storage.Dispatcher.Protect::(wrapper)
[10.1.20.2]<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79076::INFO::2012-04-09
06:28:05,349::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: getSpmStatus, args: (
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79076::DEBUG::2012-04-09
06:28:05,350::task::495::TaskManager.Task::(_debug) Task
13ba6f56-88a9-4bab-a677-11b84d1170dd: moving from state init
-> state preparing<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79076::DEBUG::2012-04-09
06:28:05,350::spm::688::Storage.SPM::(public_getSpmStatus)
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0: spmStatus=SPM
spmLver=18 spmId=2<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79076::DEBUG::2012-04-09
06:28:05,350::task::495::TaskManager.Task::(_debug) Task
13ba6f56-88a9-4bab-a677-11b84d1170dd: finished: {'spm_st':
{'spmId': 2, 'spmStatus': 'SPM', 'spmLver': 18}}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79076::DEBUG::2012-04-09
06:28:05,350::task::495::TaskManager.Task::(_debug) Task
13ba6f56-88a9-4bab-a677-11b84d1170dd: moving from state
preparing -> state finished<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79076::DEBUG::2012-04-09
06:28:05,351::resourceManager::786::ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79076::DEBUG::2012-04-09
06:28:05,351::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79076::DEBUG::2012-04-09
06:28:05,351::task::495::TaskManager.Task::(_debug) Task
13ba6f56-88a9-4bab-a677-11b84d1170dd: ref 0 aborting False<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79076::INFO::2012-04-09
06:28:05,352::dispatcher::100::Storage.Dispatcher.Protect::(run)
Run and protect: getSpmStatus, Return response: {'status':
{'message': 'OK', 'code': 0}, 'spm_st': {'spmId': 2,
'spmStatus': 'SPM', 'spmLver': 18}}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79077::DEBUG::2012-04-09
06:28:05,362::clientIF::239::Storage.Dispatcher.Protect::(wrapper)
[10.1.20.2]<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79077::INFO::2012-04-09
06:28:05,363::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: getAllTasksStatuses, args: ()<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79077::DEBUG::2012-04-09
06:28:05,363::task::495::TaskManager.Task::(_debug) Task
d87eafd3-24e9-4aaf-ba81-9c52dbfb5a1c: moving from state init
-> state preparing<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79077::DEBUG::2012-04-09
06:28:05,363::taskManager::92::TaskManager::(getAllTasksStatuses)
Entry.<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79077::DEBUG::2012-04-09
06:28:05,363::taskManager::97::TaskManager::(getAllTasksStatuses)
Return: {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79077::DEBUG::2012-04-09
06:28:05,364::task::495::TaskManager.Task::(_debug) Task
d87eafd3-24e9-4aaf-ba81-9c52dbfb5a1c: finished:
{'allTasksStatus': {}}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79077::DEBUG::2012-04-09
06:28:05,364::task::495::TaskManager.Task::(_debug) Task
d87eafd3-24e9-4aaf-ba81-9c52dbfb5a1c: moving from state
preparing -> state finished<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79077::DEBUG::2012-04-09
06:28:05,364::resourceManager::786::ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79077::DEBUG::2012-04-09
06:28:05,365::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79077::DEBUG::2012-04-09
06:28:05,365::task::495::TaskManager.Task::(_debug) Task
d87eafd3-24e9-4aaf-ba81-9c52dbfb5a1c: ref 0 aborting False<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79077::INFO::2012-04-09
06:28:05,365::dispatcher::100::Storage.Dispatcher.Protect::(run)
Run and protect: getAllTasksStatuses, Return response:
{'status': {'message': 'OK', 'code': 0}, 'allTasksStatus':
{}}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,373::clientIF::239::Storage.Dispatcher.Protect::(wrapper)
[10.1.20.2]<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::INFO::2012-04-09
06:28:05,373::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: spmStop, args: (
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,374::task::495::TaskManager.Task::(_debug) Task
0b1d8a06-7441-4614-ab6a-e5ae6b7f1891: moving from state init
-> state preparing<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,374::spm::547::Storage.SPM::(public_spmStop)
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,374::taskManager::105::TaskManager::(getAllTasks)
Entry.<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,375::taskManager::110::TaskManager::(getAllTasks)
Return: {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,375::resourceManager::155::ResourceManager.Request::(__init__)
ResName=`Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0`ReqID=`0f0e6998-87a6-40e8-8ded-9f600cb0ca2d`::Request
was made in '/usr/share/vdsm/storage/spm.py' line '573' at
'public_spmStop'<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,375::resourceManager::463::ResourceManager::(registerResource)
Trying to register resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' for lock type
'exclusive'<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,376::resourceManager::505::ResourceManager::(registerResource)
Resource 'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' is
free. Now locking as 'exclusive' (1 active user)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,376::resourceManager::192::ResourceManager.Request::(grant)
ResName=`Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0`ReqID=`0f0e6998-87a6-40e8-8ded-9f600cb0ca2d`::Granted
request<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,376::task::495::TaskManager.Task::(_debug) Task
0b1d8a06-7441-4614-ab6a-e5ae6b7f1891: _resourcesAcquired:
Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0 (exclusive)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,377::task::495::TaskManager.Task::(_debug) Task
0b1d8a06-7441-4614-ab6a-e5ae6b7f1891: ref 1 aborting False<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,377::resourceManager::155::ResourceManager.Request::(__init__)
ResName=`Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0`ReqID=`eb290e92-2fbb-4e12-bde2-83292aade8e4`::Request
was made in '/usr/share/vdsm/storage/spm.py' line '584' at
'_stop'<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,378::resourceManager::463::ResourceManager::(registerResource)
Trying to register resource
'Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0' for
lock type 'exclusive'<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,378::resourceManager::505::ResourceManager::(registerResource)
Resource
'Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0' is
free. Now locking as 'exclusive' (1 active user)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,378::resourceManager::192::ResourceManager.Request::(grant)
ResName=`Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0`ReqID=`eb290e92-2fbb-4e12-bde2-83292aade8e4`::Granted
request<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,379::resourceManager::515::ResourceManager::(releaseResource)
Trying to release resource
'Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0'<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,379::resourceManager::530::ResourceManager::(releaseResource)
Released resource
'Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0' (0
active users)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,379::resourceManager::535::ResourceManager::(releaseResource)
Resource
'Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0' is
free, finding out if anyone is waiting for it.<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,380::resourceManager::542::ResourceManager::(releaseResource)
No one is waiting for resource
'Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0',
Clearing records.<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,380::taskManager::118::TaskManager::(unloadTasks)
Entry.<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,380::taskManager::122::TaskManager::(unloadTasks)
Return<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,381::spm::201::Storage.SPM::(__cleanupMasterMount)
master
`/rhev/data-center/mnt/blockSD/e5a63624-716e-4bb4-ae60-cd4d7aae9ed2/master`
is not mounted, skipping<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,381::spm::290::Storage.SPM::(__cleanupSPM) cleaning
up SPM: e3e565d6-8104-11e1-afd2-001cc43ceea0<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,381::persistentDict::140::Storage.PersistentDict::(transaction)
Starting transaction<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,382::persistentDict::146::Storage.PersistentDict::(transaction)
Flushing changes<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,382::persistentDict::265::Storage.PersistentDict::(flush)
about to write lines (FileMetadataRW)=['CLASS=Data',
'DESCRIPTION=main', 'IOOPTIMEOUTSEC=10', 'LEASERETRIES=3',
'LEASETIMESEC=60', 'LOCKPOLICY=',
'LOCKRENEWALINTERVALSEC=5', 'MASTER_VERSION=1',
'POOL_DESCRIPTION=Default',
'POOL_DOMAINS=4f1199ec-9cdb-4efe-91eb-587faeec2099:Active',
'POOL_SPM_ID=-1', 'POOL_SPM_LVER=18',
'POOL_UUID=e3e565d6-8104-11e1-afd2-001cc43ceea0',
'REMOTE_PATH=nfs.corp:/share', 'ROLE=Master',
'SDUUID=4f1199ec-9cdb-4efe-91eb-587faeec2099', 'TYPE=NFS',
'VERSION=0',
'_SHA_CKSUM=5a3d228ad230c9d61a754c22abaa6b5f11b6c721']<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,397::persistentDict::148::Storage.PersistentDict::(transaction)
Finished transaction<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::INFO::2012-04-09
06:28:05,398::safelease::83::ClusterLock::(release)
Releasing cluster lock for domain
4f1199ec-9cdb-4efe-91eb-587faeec2099<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:05,398::safelease::84::Storage.Misc.excCmd::(release)
'/usr/libexec/vdsm/spmstop.sh
4f1199ec-9cdb-4efe-91eb-587faeec2099' (cwd
/usr/libexec/vdsm/)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:06,433::safelease::84::Storage.Misc.excCmd::(release)
SUCCESS: <err> = ''; <rc> = 0<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:06,434::safelease::87::ClusterLock::(release) Cluster
lock released successfully<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:06,434::task::495::TaskManager.Task::(_debug) Task
0b1d8a06-7441-4614-ab6a-e5ae6b7f1891: finished: None<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:06,434::task::495::TaskManager.Task::(_debug) Task
0b1d8a06-7441-4614-ab6a-e5ae6b7f1891: moving from state
preparing -> state finished<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:06,435::resourceManager::786::ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources
{'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0': <
ResourceRef 'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0',
isValid: 'True' obj: 'None'>}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:06,435::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:06,435::resourceManager::515::ResourceManager::(releaseResource)
Trying to release resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0'<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:06,436::resourceManager::530::ResourceManager::(releaseResource)
Released resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' (0 active
users)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:06,436::resourceManager::535::ResourceManager::(releaseResource)
Resource 'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' is
free, finding out if anyone is waiting for it.<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:06,436::resourceManager::542::ResourceManager::(releaseResource)
No one is waiting for resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0', Clearing
records.<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::DEBUG::2012-04-09
06:28:06,437::task::495::TaskManager.Task::(_debug) Task
0b1d8a06-7441-4614-ab6a-e5ae6b7f1891: ref 0 aborting False<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79078::INFO::2012-04-09
06:28:06,437::dispatcher::100::Storage.Dispatcher.Protect::(run)
Run and protect: spmStop, Return response: {'status':
{'message': 'OK', 'code': 0}}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79080::INFO::2012-04-09
06:28:08,375::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: repoStats, args: ()<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79080::DEBUG::2012-04-09
06:28:08,375::task::495::TaskManager.Task::(_debug) Task
6ef7ea52-d656-4f05-a80d-10026a9cf6a7: moving from state init
-> state preparing<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79080::DEBUG::2012-04-09
06:28:08,376::task::495::TaskManager.Task::(_debug) Task
6ef7ea52-d656-4f05-a80d-10026a9cf6a7: finished:
{'4f1199ec-9cdb-4efe-91eb-587faeec2099': {'delay':
'0.00202488899231', 'lastCheck': 1333967286.1603661,
'valid': True, 'code': 0}}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79080::DEBUG::2012-04-09
06:28:08,376::task::495::TaskManager.Task::(_debug) Task
6ef7ea52-d656-4f05-a80d-10026a9cf6a7: moving from state
preparing -> state finished<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79080::DEBUG::2012-04-09
06:28:08,376::resourceManager::786::ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79080::DEBUG::2012-04-09
06:28:08,377::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79080::DEBUG::2012-04-09
06:28:08,377::task::495::TaskManager.Task::(_debug) Task
6ef7ea52-d656-4f05-a80d-10026a9cf6a7: ref 0 aborting False<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-79080::INFO::2012-04-09
06:28:08,377::dispatcher::100::Storage.Dispatcher.Protect::(run)
Run and protect: repoStats, Return response: {'status':
{'message': 'OK', 'code': 0},
'4f1199ec-9cdb-4efe-91eb-587faeec2099': {'delay':
'0.00202488899231', 'lastCheck': 1333967286.1603661,
'valid': True, 'code': 0}}<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">^C<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D"><o:p> </o:p></span></p>
<div>
<div style="border:none;border-top:solid #B5C4DF
1.0pt;padding:3.0pt 0cm 0cm 0cm">
<p class="MsoNormal"><b><span
style="font-size:10.0pt;font-family:"Tahoma","sans-serif";color:windowtext">From:</span></b><span
style="font-size:10.0pt;font-family:"Tahoma","sans-serif";color:windowtext">
<a class="moz-txt-link-abbreviated" href="mailto:users-bounces@ovirt.org">users-bounces@ovirt.org</a> [<a class="moz-txt-link-freetext" href="mailto:users-bounces@ovirt.org">mailto:users-bounces@ovirt.org</a>]
<b>On Behalf Of </b>зоррыч<br>
<b>Sent:</b> Monday, April 09, 2012 2:20 PM<br>
<b>To:</b> <a class="moz-txt-link-abbreviated" href="mailto:rvaknin@redhat.com">rvaknin@redhat.com</a><br>
<b>Cc:</b> <a class="moz-txt-link-abbreviated" href="mailto:users@ovirt.org">users@ovirt.org</a><br>
<b>Subject:</b> Re: [Users] Failed to attach Storage
Domain export to Data Center<o:p></o:p></span></p>
</div>
</div>
<p class="MsoNormal"><o:p> </o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">In
an attempt to connect ovirt storage domain fail<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">[root@noc-2-synt
nfs4]# cat
b23c7ab6-b1d4-4888-8d4a-adc78e61db38/dom_md/metadata<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">CLASS=Backup<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">DESCRIPTION=export<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">IOOPTIMEOUTSEC=1<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">LEASERETRIES=3<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">LEASETIMESEC=5<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">LOCKPOLICY=<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">LOCKRENEWALINTERVALSEC=5<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">MASTER_VERSION=0<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">POOL_UUID=e3e565d6-8104-11e1-afd2-001cc43ceea0<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">REMOTE_PATH=10.1.20.2:/home/nfs4<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">ROLE=Regular<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">SDUUID=b23c7ab6-b1d4-4888-8d4a-adc78e61db38<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">TYPE=NFS<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">VERSION=0<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">_SHA_CKSUM=d91770b5a0f1956cbfb79a6a59b5291dc5bd2b59<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"><o:p> </o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"><o:p> </o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D">logs:</span><span
style="color:#1F497D" lang="EN-US"><o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"><o:p> </o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,628 INFO
[org.ovirt.engine.core.bll.storage.AttachStorageDomainToPoolCommand]
(pool-5-thread-50) Running command:
AttachStorageDomainToPoolCommand internal: false. Entities
affected : ID: e3e565d6-8104-11e1-afd2-001cc43ceea0 Type:
Storage<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,658 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-49) START,
ValidateStorageServerConnectionVDSCommand(vdsId =
270e3720-8105-11e1-a3ed-001cc43ceea0, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS,
connectionList = [{ id:
aef7de23-f271-45f3-853b-9e7b7be6607f, connection:
10.1.20.2:/home/nfs4 };]), log id: 651832d2<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,658 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-48) START,
ValidateStorageServerConnectionVDSCommand(vdsId =
1bb3653a-8105-11e1-9eda-001cc43ceea0, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS,
connectionList = [{ id:
aef7de23-f271-45f3-853b-9e7b7be6607f, connection:
10.1.20.2:/home/nfs4 };]), log id: 69324bf2<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,747 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-48) FINISH,
ValidateStorageServerConnectionVDSCommand, return:
{aef7de23-f271-45f3-853b-9e7b7be6607f=0}, log id: 69324bf2<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,748 INFO
[org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand]
(pool-5-thread-48) Running command:
ConnectStorageToVdsCommand internal: true. Entities affected
: ID: aaa00000-0000-0000-0000-123456789aaa Type: System<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,750 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-48) START,
ConnectStorageServerVDSCommand(vdsId =
1bb3653a-8105-11e1-9eda-001cc43ceea0, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS,
connectionList = [{ id:
aef7de23-f271-45f3-853b-9e7b7be6607f, connection:
10.1.20.2:/home/nfs4 };]), log id: 1b5bf8d2<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,762 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-49) FINISH,
ValidateStorageServerConnectionVDSCommand, return:
{aef7de23-f271-45f3-853b-9e7b7be6607f=0}, log id: 651832d2<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,763 INFO
[org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand]
(pool-5-thread-49) Running command:
ConnectStorageToVdsCommand internal: true. Entities affected
: ID: aaa00000-0000-0000-0000-123456789aaa Type: System<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,765 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-49) START,
ConnectStorageServerVDSCommand(vdsId =
270e3720-8105-11e1-a3ed-001cc43ceea0, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS,
connectionList = [{ id:
aef7de23-f271-45f3-853b-9e7b7be6607f, connection:
10.1.20.2:/home/nfs4 };]), log id: 59f6a186<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,775 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-48) FINISH, ConnectStorageServerVDSCommand,
return: {aef7de23-f271-45f3-853b-9e7b7be6607f=0}, log id:
1b5bf8d2<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,791 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-49) FINISH, ConnectStorageServerVDSCommand,
return: {aef7de23-f271-45f3-853b-9e7b7be6607f=0}, log id:
59f6a186<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,792 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.AttachStorageDomainVDSCommand]
(pool-5-thread-50) START,
AttachStorageDomainVDSCommand(storagePoolId =
e3e565d6-8104-11e1-afd2-001cc43ceea0, ignoreFailoverLimit =
false, compatabilityVersion = null, storageDomainId =
e3e565d6-8104-11e1-afd2-001cc43ceea0), log id: 58a14aa<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,816 ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase]
(pool-5-thread-50) Failed in AttachStorageDomainVDS method<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,817 ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase]
(pool-5-thread-50) Error code StorageDomainActionError and
error message IRSGenericException: IRSErrorException: Failed
to AttachStorageDomainVDS, error = Error in storage domain
action: ('sdUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0,
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0',)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,817 ERROR
[org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(pool-5-thread-50) IrsBroker::Failed::AttachStorageDomainVDS
due to: IRSErrorException: IRSGenericException:
IRSErrorException: Failed to AttachStorageDomainVDS, error =
Error in storage domain action:
('sdUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0,
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0',)<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,836 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand]
(pool-5-thread-50) START, SpmStopVDSCommand(vdsId =
270e3720-8105-11e1-a3ed-001cc43ceea0, storagePoolId =
e3e565d6-8104-11e1-afd2-001cc43ceea0), log id: fbb0af9<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:38,848 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand]
(pool-5-thread-50) SpmStopVDSCommand::Stopping SPM on vds
10.2.20.8, pool id e3e565d6-8104-11e1-afd2-001cc43ceea0<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:39,915 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand]
(pool-5-thread-50) FINISH, SpmStopVDSCommand, log id:
fbb0af9<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:39,915 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(pool-5-thread-50) Irs placed on server null failed. Proceed
Failover<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:39,923 INFO
[org.ovirt.engine.core.bll.storage.SetStoragePoolStatusCommand]
(pool-5-thread-50) Running command:
SetStoragePoolStatusCommand internal: true. Entities
affected : ID: e3e565d6-8104-11e1-afd2-001cc43ceea0 Type:
StoragePool<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:39,948 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(pool-5-thread-50) hostFromVds::selectedVds - 10.1.20.7,
spmStatus Free, storage pool Default<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:39,953 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(pool-5-thread-50) starting spm on vds 10.1.20.7, storage
pool Default, prevId -1, LVER 13<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:39,955 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand]
(pool-5-thread-50) START, SpmStartVDSCommand(vdsId =
1bb3653a-8105-11e1-9eda-001cc43ceea0, storagePoolId =
e3e565d6-8104-11e1-afd2-001cc43ceea0, prevId=-1,
prevLVER=13, storagePoolFormatType=V1, recoveryMode=Manual,
SCSIFencing=false), log id: 3eff326c<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-09
06:11:39,971 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand]
(pool-5-thread-50) spmStart polling started: taskId =
e6db13d3-1c55-4d11-9fbc-8abf50c635ae<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">^C<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D"><o:p> </o:p></span></p>
<div>
<div style="border:none;border-top:solid #B5C4DF
1.0pt;padding:3.0pt 0cm 0cm 0cm">
<p class="MsoNormal"><b><span
style="font-size:10.0pt;font-family:"Tahoma","sans-serif";color:windowtext">From:</span></b><span
style="font-size:10.0pt;font-family:"Tahoma","sans-serif";color:windowtext">
Rami Vaknin [<a moz-do-not-send="true"
href="mailto:rvaknin@redhat.com">mailto:rvaknin@redhat.com</a>]
<br>
<b>Sent:</b> Monday, April 09, 2012 1:27 PM<br>
<b>To:</b> зоррыч<br>
<b>Cc:</b> <a moz-do-not-send="true"
href="mailto:users@ovirt.org">users@ovirt.org</a><br>
<b>Subject:</b> Re: [Users] Failed to attach Storage
Domain export to Data Center<o:p></o:p></span></p>
</div>
</div>
<p class="MsoNormal"><o:p> </o:p></p>
<p class="MsoNormal">On 04/08/2012 07:05 PM, зоррыч wrote: <o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">I
found the metadata in the file ./dom_md/metadata</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Changed
“b23c7ab6-b1d4-4888-8d4a-adc78e61db38” to
“e3e565d6-8104-11e1-afd2-001cc43ceea0” (SDUUID)</span><o:p></o:p></p>
<p class="MsoNormal" style="margin-bottom:12.0pt"><span
style="font-size:12.0pt;font-family:"Times New
Roman","serif""><br>
It's wrong, you should change that in POOL_UUID and not in
SDUUID (my fault, by spuuid I meant to the POOL_UUID).<br>
<br>
<o:p></o:p></span></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">The
data I gave the command: </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">[root@noc-3-synt
~]# vdsClient -s 0 getConnectedStoragePoolsList</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">e3e565d6-8104-11e1-afd2-001cc43ceea0</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Found
in </span><span lang="EN-US">checksum</span><span
style="color:#1F497D" lang="EN-US"> vdsm.log:</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-36836::WARNING::2012-04-08
11:19:47,945::persistentDict::242::Storage.PersistentDict::(refresh)
data seal is broken metadata declares
`4df87518878fd0d74932917b83aba9672f92dff2` should be
`d91770b5a0f1956cbfb79a6a59b5291dc5bd2b59`
(lines={'VERSION': '0', 'LEASETIMESEC': '5', 'DESCRIPTION':
'export', 'LOCKPOLICY': '', 'LEASERETRIES': '3', 'SDUUID':
'e3e565d6-8104-11e1-afd2-001cc43ceea0', 'REMOTE_PATH':
'10.1.20.2:/home/nfs4', 'MASTER_VERSION': '0',
'IOOPTIMEOUTSEC': '1', 'ROLE': 'Regular',
'LOCKRENEWALINTERVALSEC': '5', 'POOL_UUID':
'801e35d4-7405-11e1-b152-001cc43ceea0', 'TYPE': 'NFS',
'CLASS': 'Backup'})</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">MetaDataSealIsBroken:
Meta Data seal is broken (checksum mismatch): 'cksum =
4df87518878fd0d74932917b83aba9672f92dff2, computed_cksum =
d91770b5a0f1956cbfb79a6a59b5291dc5bd2b59'</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Changed
it.</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">As
a result, the metadata file:</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">[root@noc-2-synt
dom_md]# cat metadata</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">CLASS=Backup</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">DESCRIPTION=export</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">IOOPTIMEOUTSEC=1</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">LEASERETRIES=3</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">LEASETIMESEC=5</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">LOCKPOLICY=</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">LOCKRENEWALINTERVALSEC=5</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">MASTER_VERSION=0</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">POOL_UUID=801e35d4-7405-11e1-b152-001cc43ceea0</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">REMOTE_PATH=10.1.20.2:/home/nfs4</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">ROLE=Regular</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">SDUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">TYPE=NFS</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">VERSION=0</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">_SHA_CKSUM=d91770b5a0f1956cbfb79a6a59b5291dc5bd2b59</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">attachment
to the ovirt fails:</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-35311::INFO::2012-04-08
11:25:54,668::fileSD::244::Storage.StorageDomain::(getStats)
sdUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0 [Errno 2] No
such file or directory:
'/rhev/data-center/mnt/10.1.20.2:_home_nfs4/e3e565d6-8104-11e1-afd2-001cc43ceea0'</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-35311::ERROR::2012-04-08
11:25:54,669::task::868::TaskManager.Task::(_setError)
Unexpected error</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">I
renamed the folder that contains the data to
e3e565d6-8104-11e1-afd2-001cc43ceea0 for
b23c7ab6-b1d4-4888-8d4a-adc78e61db38 (SDUUID)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">attachment
to the ovirt fails =(</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">messages:</span><o:p></o:p></p>
<p class="MsoNormal"><span style="font-size:12.0pt" lang="EN-US">Error
while executing action AttachStorageDomainToPool: Error in
storage domain action</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">engine.log:</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,557 INFO
[org.ovirt.engine.core.bll.storage.AttachStorageDomainToPoolCommand]
(pool-5-thread-49) Running command:
AttachStorageDomainToPoolCommand internal: false. Entities
affected : ID: e3e565d6-8104-11e1-afd2-001cc43ceea0 Type:
Storage</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,583 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-46) START,
ValidateStorageServerConnectionVDSCommand(vdsId =
1bb3653a-8105-11e1-9eda-001cc43ceea0, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS,
connectionList = [{ id:
aef7de23-f271-45f3-853b-9e7b7be6607f, connection:
10.1.20.2:/home/nfs4 };]), log id: 3dbf104d</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,583 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-50) START,
ValidateStorageServerConnectionVDSCommand(vdsId =
270e3720-8105-11e1-a3ed-001cc43ceea0, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS,
connectionList = [{ id:
aef7de23-f271-45f3-853b-9e7b7be6607f, connection:
10.1.20.2:/home/nfs4 };]), log id: 4ac74ee6</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,685 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-50) FINISH,
ValidateStorageServerConnectionVDSCommand, return:
{aef7de23-f271-45f3-853b-9e7b7be6607f=0}, log id: 4ac74ee6</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,686 INFO
[org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand]
(pool-5-thread-50) Running command:
ConnectStorageToVdsCommand internal: true. Entities affected
: ID: aaa00000-0000-0000-0000-123456789aaa Type: System</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,689 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-50) START,
ConnectStorageServerVDSCommand(vdsId =
270e3720-8105-11e1-a3ed-001cc43ceea0, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS,
connectionList = [{ id:
aef7de23-f271-45f3-853b-9e7b7be6607f, connection:
10.1.20.2:/home/nfs4 };]), log id: 53bd874a</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,690 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-46) FINISH,
ValidateStorageServerConnectionVDSCommand, return:
{aef7de23-f271-45f3-853b-9e7b7be6607f=0}, log id: 3dbf104d</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,691 INFO
[org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand]
(pool-5-thread-46) Running command:
ConnectStorageToVdsCommand internal: true. Entities affected
: ID: aaa00000-0000-0000-0000-123456789aaa Type: System</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,693 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-46) START,
ConnectStorageServerVDSCommand(vdsId =
1bb3653a-8105-11e1-9eda-001cc43ceea0, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS,
connectionList = [{ id:
aef7de23-f271-45f3-853b-9e7b7be6607f, connection:
10.1.20.2:/home/nfs4 };]), log id: 3129fd68</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,714 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-50) FINISH, ConnectStorageServerVDSCommand,
return: {aef7de23-f271-45f3-853b-9e7b7be6607f=0}, log id:
53bd874a</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,716 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-46) FINISH, ConnectStorageServerVDSCommand,
return: {aef7de23-f271-45f3-853b-9e7b7be6607f=0}, log id:
3129fd68</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,718 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.AttachStorageDomainVDSCommand]
(pool-5-thread-49) START,
AttachStorageDomainVDSCommand(storagePoolId =
e3e565d6-8104-11e1-afd2-001cc43ceea0, ignoreFailoverLimit =
false, compatabilityVersion = null, storageDomainId =
e3e565d6-8104-11e1-afd2-001cc43ceea0), log id: 2b559a22</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,737 ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase]
(pool-5-thread-49) Failed in AttachStorageDomainVDS method</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,737 ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase]
(pool-5-thread-49) Error code StorageDomainActionError and
error message IRSGenericException: IRSErrorException: Failed
to AttachStorageDomainVDS, error = Error in storage domain
action: ('sdUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0,
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0',)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,738 ERROR
[org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(pool-5-thread-49) IrsBroker::Failed::AttachStorageDomainVDS
due to: IRSErrorException: IRSGenericException:
IRSErrorException: Failed to AttachStorageDomainVDS, error =
Error in storage domain action:
('sdUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0,
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0',)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,752 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand]
(pool-5-thread-49) START, SpmStopVDSCommand(vdsId =
1bb3653a-8105-11e1-9eda-001cc43ceea0, storagePoolId =
e3e565d6-8104-11e1-afd2-001cc43ceea0), log id: 6b2f2dd2</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:10,764 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand]
(pool-5-thread-49) SpmStopVDSCommand::Stopping SPM on vds
10.1.20.7, pool id e3e565d6-8104-11e1-afd2-001cc43ceea0</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:11,843 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand]
(pool-5-thread-49) FINISH, SpmStopVDSCommand, log id:
6b2f2dd2</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:11,843 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(pool-5-thread-49) Irs placed on server null failed. Proceed
Failover</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:11,850 INFO
[org.ovirt.engine.core.bll.storage.SetStoragePoolStatusCommand]
(pool-5-thread-49) Running command:
SetStoragePoolStatusCommand internal: true. Entities
affected : ID: e3e565d6-8104-11e1-afd2-001cc43ceea0 Type:
StoragePool</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:11,881 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(pool-5-thread-49) hostFromVds::selectedVds - 10.2.20.8,
spmStatus Free, storage pool Default</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:11,886 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(pool-5-thread-49) starting spm on vds 10.2.20.8, storage
pool Default, prevId -1, LVER 8</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:11,888 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand]
(pool-5-thread-49) START, SpmStartVDSCommand(vdsId =
270e3720-8105-11e1-a3ed-001cc43ceea0, storagePoolId =
e3e565d6-8104-11e1-afd2-001cc43ceea0, prevId=-1, prevLVER=8,
storagePoolFormatType=V1, recoveryMode=Manual,
SCSIFencing=false), log id: 382e702</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">2012-04-08
11:53:11,905 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand]
(pool-5-thread-49) spmStart polling started: taskId =
f65c40e4-956f-4c01-ab3f-5c43f2853806</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Vdsm.log:</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38311::INFO::2012-04-08
11:54:32,427::dispatcher::100::Storage.Dispatcher.Protect::(run)
Run and protect: getStoragePoolInfo, Return response:
{'status': {'message': 'OK', 'code': 0}, 'info': {'spm_id':
2, 'master_uuid': '4f1199ec-9cdb-4efe-91eb-587faeec2099',
'name': 'Default', 'version': '0', 'domains':
'4f1199ec-9cdb-4efe-91eb-587faeec2099:Active',
'pool_status': 'connected', 'isoprefix': '', 'type': 'NFS',
'master_ver': 1, 'lver': 10}, 'dominfo':
{'4f1199ec-9cdb-4efe-91eb-587faeec2099': {'status':
'Active', 'diskfree': '490079256576', 'alerts': [],
'disktotal': '516524343296'}}}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::DEBUG::2012-04-08
11:54:32,952::clientIF::239::Storage.Dispatcher.Protect::(wrapper)
[10.1.20.2]</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::INFO::2012-04-08
11:54:32,952::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: validateStorageServerConnection, args:
(domType=1, spUUID=00000000-0000-0000-0000-000000000000,
conList=[{'connection': '10.1.20.2:/home/nfs4', 'iqn': '',
'portal': '', 'user': '', 'password': '******', 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f', 'port': ''}])</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::DEBUG::2012-04-08
11:54:32,953::task::495::TaskManager.Task::(_debug) Task
7899228e-1fc3-4fe0-bbcd-84cb4aa1ef11: moving from state init
-> state preparing</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::INFO::2012-04-08
11:54:32,953::storage_connection::127::Storage.ServerConnection::(validate)
Request to validate NFS storage server</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::INFO::2012-04-08
11:54:32,953::storage_connection::53::Storage.ServerConnection::(__validateConnectionParams)
conList=[{'connection': '10.1.20.2:/home/nfs4', 'iqn': '',
'portal': '', 'user': '', 'password': '******', 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f', 'port': ''}]</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::DEBUG::2012-04-08
11:54:32,955::fileUtils::83::Storage.Misc.excCmd::(mount)
'/usr/bin/sudo -n /bin/mount -o
soft,timeo=600,retrans=6,nosharecache,vers=3 -t nfs
10.1.20.2:/home/nfs4 /tmp/tmplHltd0' (cwd None)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::DEBUG::2012-04-08
11:54:32,987::fileUtils::83::Storage.Misc.excCmd::(mount)
SUCCESS: <err> = ''; <rc> = 0</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::DEBUG::2012-04-08
11:54:32,994::fileUtils::112::Storage.Misc.excCmd::(umount)
'/usr/bin/sudo -n /bin/umount -t nfs -f /tmp/tmplHltd0' (cwd
None)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::DEBUG::2012-04-08
11:54:33,021::fileUtils::112::Storage.Misc.excCmd::(umount)
SUCCESS: <err> = ''; <rc> = 0</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::DEBUG::2012-04-08
11:54:33,022::task::495::TaskManager.Task::(_debug) Task
7899228e-1fc3-4fe0-bbcd-84cb4aa1ef11: finished:
{'statuslist': [{'status': 0, 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f'}]}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::DEBUG::2012-04-08
11:54:33,023::task::495::TaskManager.Task::(_debug) Task
7899228e-1fc3-4fe0-bbcd-84cb4aa1ef11: moving from state
preparing -> state finished</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::DEBUG::2012-04-08
11:54:33,023::resourceManager::786::ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::DEBUG::2012-04-08
11:54:33,024::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::DEBUG::2012-04-08
11:54:33,024::task::495::TaskManager.Task::(_debug) Task
7899228e-1fc3-4fe0-bbcd-84cb4aa1ef11: ref 0 aborting False</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38312::INFO::2012-04-08
11:54:33,024::dispatcher::100::Storage.Dispatcher.Protect::(run)
Run and protect: validateStorageServerConnection, Return
response: {'status': {'message': 'OK', 'code': 0},
'statuslist': [{'status': 0, 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f'}]}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::DEBUG::2012-04-08
11:54:33,037::clientIF::239::Storage.Dispatcher.Protect::(wrapper)
[10.1.20.2]</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::INFO::2012-04-08
11:54:33,037::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: connectStorageServer, args: (domType=1,
spUUID=00000000-0000-0000-0000-000000000000,
conList=[{'connection': '10.1.20.2:/home/nfs4', 'iqn': '',
'portal': '', 'user': '', 'password': '******', 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f', 'port': ''}])</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::DEBUG::2012-04-08
11:54:33,038::task::495::TaskManager.Task::(_debug) Task
83b36131-7378-4f69-841d-b82637362295: moving from state init
-> state preparing</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::INFO::2012-04-08
11:54:33,038::storage_connection::95::Storage.ServerConnection::(connect)
Request to connect NFS storage server</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::INFO::2012-04-08
11:54:33,038::storage_connection::53::Storage.ServerConnection::(__validateConnectionParams)
conList=[{'connection': '10.1.20.2:/home/nfs4', 'iqn': '',
'portal': '', 'user': '', 'password': '******', 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f', 'port': ''}]</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::DEBUG::2012-04-08
11:54:33,048::lvm::547::OperationMutex::(_invalidateAllPvs)
Operation 'lvm invalidate operation' got the operation mutex</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::DEBUG::2012-04-08
11:54:33,048::lvm::549::OperationMutex::(_invalidateAllPvs)
Operation 'lvm invalidate operation' released the operation
mutex</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::DEBUG::2012-04-08
11:54:33,049::lvm::559::OperationMutex::(_invalidateAllVgs)
Operation 'lvm invalidate operation' got the operation mutex</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::DEBUG::2012-04-08
11:54:33,049::lvm::561::OperationMutex::(_invalidateAllVgs)
Operation 'lvm invalidate operation' released the operation
mutex</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::DEBUG::2012-04-08
11:54:33,049::lvm::580::OperationMutex::(_invalidateAllLvs)
Operation 'lvm invalidate operation' got the operation mutex</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::DEBUG::2012-04-08
11:54:33,050::lvm::582::OperationMutex::(_invalidateAllLvs)
Operation 'lvm invalidate operation' released the operation
mutex</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::DEBUG::2012-04-08
11:54:33,050::task::495::TaskManager.Task::(_debug) Task
83b36131-7378-4f69-841d-b82637362295: finished:
{'statuslist': [{'status': 0, 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f'}]}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::DEBUG::2012-04-08
11:54:33,050::task::495::TaskManager.Task::(_debug) Task
83b36131-7378-4f69-841d-b82637362295: moving from state
preparing -> state finished</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::DEBUG::2012-04-08
11:54:33,051::resourceManager::786::ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::DEBUG::2012-04-08
11:54:33,051::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::DEBUG::2012-04-08
11:54:33,051::task::495::TaskManager.Task::(_debug) Task
83b36131-7378-4f69-841d-b82637362295: ref 0 aborting False</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38313::INFO::2012-04-08
11:54:33,051::dispatcher::100::Storage.Dispatcher.Protect::(run)
Run and protect: connectStorageServer, Return response:
{'status': {'message': 'OK', 'code': 0}, 'statuslist':
[{'status': 0, 'id':
'aef7de23-f271-45f3-853b-9e7b7be6607f'}]}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,062::clientIF::239::Storage.Dispatcher.Protect::(wrapper)
[10.1.20.2]</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::INFO::2012-04-08
11:54:33,062::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: attachStorageDomain, args: (
sdUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,063::task::495::TaskManager.Task::(_debug) Task
2b306544-6fcc-443b-9ea6-23ae4b71d422: moving from state init
-> state preparing</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,063::resourceManager::155::ResourceManager.Request::(__init__)
ResName=`Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0`ReqID=`a97b6096-7b1a-4f93-b0c0-322399c2ac3a`::Request
was made in '/usr/share/vdsm/storage/spm.py' line '1072' at
'public_attachStorageDomain'</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,064::resourceManager::463::ResourceManager::(registerResource)
Trying to register resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' for lock type
'exclusive'</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,064::resourceManager::505::ResourceManager::(registerResource)
Resource 'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' is
free. Now locking as 'exclusive' (1 active user)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,064::resourceManager::192::ResourceManager.Request::(grant)
ResName=`Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0`ReqID=`a97b6096-7b1a-4f93-b0c0-322399c2ac3a`::Granted
request</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,065::task::495::TaskManager.Task::(_debug) Task
2b306544-6fcc-443b-9ea6-23ae4b71d422: _resourcesAcquired:
Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0 (exclusive)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,065::task::495::TaskManager.Task::(_debug) Task
2b306544-6fcc-443b-9ea6-23ae4b71d422: ref 1 aborting False</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::ERROR::2012-04-08
11:54:33,065::task::868::TaskManager.Task::(_setError)
Unexpected error</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Traceback
(most recent call last):</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
File "/usr/share/vdsm/storage/task.py", line 876, in _run</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
return fn(*args, **kargs)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
File "/usr/share/vdsm/storage/spm.py", line 115, in run</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
return self.func(*args, **kwargs)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
File "/usr/share/vdsm/storage/spm.py", line 1073, in
public_attachStorageDomain</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
vars.task.getExclusiveLock(STORAGE, sdUUID)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
File "/usr/share/vdsm/storage/task.py", line 1311, in
getExclusiveLock</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
self.resOwner.acquire(namespace, resName,
resourceManager.LockType.exclusive, timeout)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
File "/usr/share/vdsm/storage/resourceManager.py", line 673,
in acquire</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
raise ValueError("Owner %s: acquire: resource %s is already
acquired" % (str(self), fullName))</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">ValueError:
Owner 2b306544-6fcc-443b-9ea6-23ae4b71d422: acquire:
resource Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0 is
already acquired</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,066::task::495::TaskManager.Task::(_debug) Task
2b306544-6fcc-443b-9ea6-23ae4b71d422: Task._run:
2b306544-6fcc-443b-9ea6-23ae4b71d422
('e3e565d6-8104-11e1-afd2-001cc43ceea0',
'e3e565d6-8104-11e1-afd2-001cc43ceea0') {} failed - stopping
task</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,066::task::495::TaskManager.Task::(_debug) Task
2b306544-6fcc-443b-9ea6-23ae4b71d422: stopping in state
preparing (force False)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,067::task::495::TaskManager.Task::(_debug) Task
2b306544-6fcc-443b-9ea6-23ae4b71d422: ref 1 aborting True</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::INFO::2012-04-08
11:54:33,067::task::1171::TaskManager.Task::(prepare)
aborting: Task is aborted: 'Owner
2b306544-6fcc-443b-9ea6-23ae4b71d422: acquire: resource
Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0 is already
acquired' - code 100</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,067::task::495::TaskManager.Task::(_debug) Task
2b306544-6fcc-443b-9ea6-23ae4b71d422: Prepare: aborted:
Owner 2b306544-6fcc-443b-9ea6-23ae4b71d422: acquire:
resource Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0 is
already acquired</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,067::task::495::TaskManager.Task::(_debug) Task
2b306544-6fcc-443b-9ea6-23ae4b71d422: ref 0 aborting True</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,068::task::495::TaskManager.Task::(_debug) Task
2b306544-6fcc-443b-9ea6-23ae4b71d422: Task._doAbort: force
False</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,068::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,068::task::495::TaskManager.Task::(_debug) Task
2b306544-6fcc-443b-9ea6-23ae4b71d422: moving from state
preparing -> state aborting</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,069::task::495::TaskManager.Task::(_debug) Task
2b306544-6fcc-443b-9ea6-23ae4b71d422: _aborting: recover
policy none</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,069::task::495::TaskManager.Task::(_debug) Task
2b306544-6fcc-443b-9ea6-23ae4b71d422: moving from state
aborting -> state failed</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,069::resourceManager::786::ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources
{'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0': <
ResourceRef 'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0',
isValid: 'True' obj: 'None'>}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,069::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,070::resourceManager::515::ResourceManager::(releaseResource)
Trying to release resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0'</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,070::resourceManager::530::ResourceManager::(releaseResource)
Released resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' (0 active
users)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,070::resourceManager::535::ResourceManager::(releaseResource)
Resource 'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' is
free, finding out if anyone is waiting for it.</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::DEBUG::2012-04-08
11:54:33,071::resourceManager::542::ResourceManager::(releaseResource)
No one is waiting for resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0', Clearing
records.</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::ERROR::2012-04-08
11:54:33,071::dispatcher::106::Storage.Dispatcher.Protect::(run)
Owner 2b306544-6fcc-443b-9ea6-23ae4b71d422: acquire:
resource Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0 is
already acquired</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38314::ERROR::2012-04-08
11:54:33,071::dispatcher::107::Storage.Dispatcher.Protect::(run)
Traceback (most recent call last):</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
File "/usr/share/vdsm/storage/dispatcher.py", line 96, in
run</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
result = ctask.prepare(self.func, *args, **kwargs)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
File "/usr/share/vdsm/storage/task.py", line 1178, in
prepare</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">
raise self.error</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">ValueError:
Owner 2b306544-6fcc-443b-9ea6-23ae4b71d422: acquire:
resource Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0 is
already acquired</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38315::DEBUG::2012-04-08
11:54:33,086::clientIF::239::Storage.Dispatcher.Protect::(wrapper)
[10.1.20.2]</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38315::INFO::2012-04-08
11:54:33,086::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: getSpmStatus, args: (
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38315::DEBUG::2012-04-08
11:54:33,086::task::495::TaskManager.Task::(_debug) Task
04c6f0a0-6010-4c40-a888-8c59b1e69de3: moving from state init
-> state preparing</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38315::DEBUG::2012-04-08
11:54:33,087::spm::688::Storage.SPM::(public_getSpmStatus)
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0: spmStatus=SPM
spmLver=10 spmId=2</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38315::DEBUG::2012-04-08
11:54:33,087::task::495::TaskManager.Task::(_debug) Task
04c6f0a0-6010-4c40-a888-8c59b1e69de3: finished: {'spm_st':
{'spmId': 2, 'spmStatus': 'SPM', 'spmLver': 10}}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38315::DEBUG::2012-04-08
11:54:33,087::task::495::TaskManager.Task::(_debug) Task
04c6f0a0-6010-4c40-a888-8c59b1e69de3: moving from state
preparing -> state finished</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38315::DEBUG::2012-04-08
11:54:33,088::resourceManager::786::ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38315::DEBUG::2012-04-08
11:54:33,088::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38315::DEBUG::2012-04-08
11:54:33,088::task::495::TaskManager.Task::(_debug) Task
04c6f0a0-6010-4c40-a888-8c59b1e69de3: ref 0 aborting False</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38315::INFO::2012-04-08
11:54:33,089::dispatcher::100::Storage.Dispatcher.Protect::(run)
Run and protect: getSpmStatus, Return response: {'status':
{'message': 'OK', 'code': 0}, 'spm_st': {'spmId': 2,
'spmStatus': 'SPM', 'spmLver': 10}}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38316::DEBUG::2012-04-08
11:54:33,101::clientIF::239::Storage.Dispatcher.Protect::(wrapper)
[10.1.20.2]</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38316::INFO::2012-04-08
11:54:33,102::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: getAllTasksStatuses, args: ()</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38316::DEBUG::2012-04-08
11:54:33,102::task::495::TaskManager.Task::(_debug) Task
6714a525-c7c6-4132-90a3-da21b312d7fd: moving from state init
-> state preparing</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38316::DEBUG::2012-04-08
11:54:33,102::taskManager::92::TaskManager::(getAllTasksStatuses)
Entry.</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38316::DEBUG::2012-04-08
11:54:33,102::taskManager::97::TaskManager::(getAllTasksStatuses)
Return: {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38316::DEBUG::2012-04-08
11:54:33,103::task::495::TaskManager.Task::(_debug) Task
6714a525-c7c6-4132-90a3-da21b312d7fd: finished:
{'allTasksStatus': {}}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38316::DEBUG::2012-04-08
11:54:33,103::task::495::TaskManager.Task::(_debug) Task
6714a525-c7c6-4132-90a3-da21b312d7fd: moving from state
preparing -> state finished</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38316::DEBUG::2012-04-08
11:54:33,103::resourceManager::786::ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38316::DEBUG::2012-04-08
11:54:33,104::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38316::DEBUG::2012-04-08
11:54:33,104::task::495::TaskManager.Task::(_debug) Task
6714a525-c7c6-4132-90a3-da21b312d7fd: ref 0 aborting False</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38316::INFO::2012-04-08
11:54:33,104::dispatcher::100::Storage.Dispatcher.Protect::(run)
Run and protect: getAllTasksStatuses, Return response:
{'status': {'message': 'OK', 'code': 0}, 'allTasksStatus':
{}}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,113::clientIF::239::Storage.Dispatcher.Protect::(wrapper)
[10.1.20.2]</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::INFO::2012-04-08
11:54:33,113::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: spmStop, args: (
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,114::task::495::TaskManager.Task::(_debug) Task
6bec12b5-5e5b-49d8-a6d3-e8f2a5ef06bf: moving from state init
-> state preparing</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,114::spm::547::Storage.SPM::(public_spmStop)
spUUID=e3e565d6-8104-11e1-afd2-001cc43ceea0</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,114::taskManager::105::TaskManager::(getAllTasks)
Entry.</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,114::taskManager::110::TaskManager::(getAllTasks)
Return: {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,115::resourceManager::155::ResourceManager.Request::(__init__)
ResName=`Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0`ReqID=`417fa7c5-958c-4001-8944-d64df2b44f43`::Request
was made in '/usr/share/vdsm/storage/spm.py' line '573' at
'public_spmStop'</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,115::resourceManager::463::ResourceManager::(registerResource)
Trying to register resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' for lock type
'exclusive'</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,116::resourceManager::505::ResourceManager::(registerResource)
Resource 'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' is
free. Now locking as 'exclusive' (1 active user)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,116::resourceManager::192::ResourceManager.Request::(grant)
ResName=`Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0`ReqID=`417fa7c5-958c-4001-8944-d64df2b44f43`::Granted
request</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,116::task::495::TaskManager.Task::(_debug) Task
6bec12b5-5e5b-49d8-a6d3-e8f2a5ef06bf: _resourcesAcquired:
Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0 (exclusive)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,117::task::495::TaskManager.Task::(_debug) Task
6bec12b5-5e5b-49d8-a6d3-e8f2a5ef06bf: ref 1 aborting False</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,117::resourceManager::155::ResourceManager.Request::(__init__)
ResName=`Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0`ReqID=`b1954479-bdb7-47d3-a42c-b672fe788ca4`::Request
was made in '/usr/share/vdsm/storage/spm.py' line '584' at
'_stop'</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,117::resourceManager::463::ResourceManager::(registerResource)
Trying to register resource
'Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0' for
lock type 'exclusive'</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,118::resourceManager::505::ResourceManager::(registerResource)
Resource
'Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0' is
free. Now locking as 'exclusive' (1 active user)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,118::resourceManager::192::ResourceManager.Request::(grant)
ResName=`Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0`ReqID=`b1954479-bdb7-47d3-a42c-b672fe788ca4`::Granted
request</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,119::resourceManager::515::ResourceManager::(releaseResource)
Trying to release resource
'Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0'</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,119::resourceManager::530::ResourceManager::(releaseResource)
Released resource
'Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0' (0
active users)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,119::resourceManager::535::ResourceManager::(releaseResource)
Resource
'Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0' is
free, finding out if anyone is waiting for it.</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,119::resourceManager::542::ResourceManager::(releaseResource)
No one is waiting for resource
'Storage.upgrade_e3e565d6-8104-11e1-afd2-001cc43ceea0',
Clearing records.</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,120::taskManager::118::TaskManager::(unloadTasks)
Entry.</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,120::taskManager::122::TaskManager::(unloadTasks)
Return</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,121::spm::201::Storage.SPM::(__cleanupMasterMount)
master
`/rhev/data-center/mnt/blockSD/e5a63624-716e-4bb4-ae60-cd4d7aae9ed2/master`
is not mounted, skipping</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,121::spm::290::Storage.SPM::(__cleanupSPM) cleaning
up SPM: e3e565d6-8104-11e1-afd2-001cc43ceea0</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,121::persistentDict::140::Storage.PersistentDict::(transaction)
Starting transaction</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,122::persistentDict::146::Storage.PersistentDict::(transaction)
Flushing changes</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,122::persistentDict::265::Storage.PersistentDict::(flush)
about to write lines (FileMetadataRW)=['CLASS=Data',
'DESCRIPTION=main', 'IOOPTIMEOUTSEC=10', 'LEASERETRIES=3',
'LEASETIMESEC=60', 'LOCKPOLICY=',
'LOCKRENEWALINTERVALSEC=5', 'MASTER_VERSION=1',
'POOL_DESCRIPTION=Default',
'POOL_DOMAINS=4f1199ec-9cdb-4efe-91eb-587faeec2099:Active',
'POOL_SPM_ID=-1', 'POOL_SPM_LVER=10',
'POOL_UUID=e3e565d6-8104-11e1-afd2-001cc43ceea0',
'REMOTE_PATH=nfs.corp:/share', 'ROLE=Master',
'SDUUID=4f1199ec-9cdb-4efe-91eb-587faeec2099', 'TYPE=NFS',
'VERSION=0',
'_SHA_CKSUM=1d1cd722cad65ebb2edfa75641c30a5b97302f84']</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,128::persistentDict::148::Storage.PersistentDict::(transaction)
Finished transaction</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::INFO::2012-04-08
11:54:33,129::safelease::83::ClusterLock::(release)
Releasing cluster lock for domain
4f1199ec-9cdb-4efe-91eb-587faeec2099</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:33,129::safelease::84::Storage.Misc.excCmd::(release)
'/usr/libexec/vdsm/spmstop.sh
4f1199ec-9cdb-4efe-91eb-587faeec2099' (cwd
/usr/libexec/vdsm/)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:34,164::safelease::84::Storage.Misc.excCmd::(release)
SUCCESS: <err> = ''; <rc> = 0</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:34,165::safelease::87::ClusterLock::(release) Cluster
lock released successfully</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:34,165::task::495::TaskManager.Task::(_debug) Task
6bec12b5-5e5b-49d8-a6d3-e8f2a5ef06bf: finished: None</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:34,165::task::495::TaskManager.Task::(_debug) Task
6bec12b5-5e5b-49d8-a6d3-e8f2a5ef06bf: moving from state
preparing -> state finished</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:34,166::resourceManager::786::ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources
{'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0': <
ResourceRef 'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0',
isValid: 'True' obj: 'None'>}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:34,166::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:34,166::resourceManager::515::ResourceManager::(releaseResource)
Trying to release resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0'</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:34,167::resourceManager::530::ResourceManager::(releaseResource)
Released resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' (0 active
users)</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:34,167::resourceManager::535::ResourceManager::(releaseResource)
Resource 'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0' is
free, finding out if anyone is waiting for it.</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:34,167::resourceManager::542::ResourceManager::(releaseResource)
No one is waiting for resource
'Storage.e3e565d6-8104-11e1-afd2-001cc43ceea0', Clearing
records.</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::DEBUG::2012-04-08
11:54:34,168::task::495::TaskManager.Task::(_debug) Task
6bec12b5-5e5b-49d8-a6d3-e8f2a5ef06bf: ref 0 aborting False</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38317::INFO::2012-04-08
11:54:34,168::dispatcher::100::Storage.Dispatcher.Protect::(run)
Run and protect: spmStop, Return response: {'status':
{'message': 'OK', 'code': 0}}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38318::INFO::2012-04-08
11:54:34,395::dispatcher::94::Storage.Dispatcher.Protect::(run)
Run and protect: repoStats, args: ()</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38318::DEBUG::2012-04-08
11:54:34,395::task::495::TaskManager.Task::(_debug) Task
612d6da8-5aa1-4f72-89b4-14c3101b0cec: moving from state init
-> state preparing</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38318::DEBUG::2012-04-08
11:54:34,395::task::495::TaskManager.Task::(_debug) Task
612d6da8-5aa1-4f72-89b4-14c3101b0cec: finished:
{'4f1199ec-9cdb-4efe-91eb-587faeec2099': {'delay':
'0.00149178504944', 'lastCheck': 1333900465.46615, 'valid':
True, 'code': 0}}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38318::DEBUG::2012-04-08
11:54:34,396::task::495::TaskManager.Task::(_debug) Task
612d6da8-5aa1-4f72-89b4-14c3101b0cec: moving from state
preparing -> state finished</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38318::DEBUG::2012-04-08
11:54:34,396::resourceManager::786::ResourceManager.Owner::(releaseAll)
Owner.releaseAll requests {} resources {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38318::DEBUG::2012-04-08
11:54:34,396::resourceManager::821::ResourceManager.Owner::(cancelAll)
Owner.cancelAll requests {}</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US">Thread-38318::DEBUG::2012-04-08
11:54:34,397::task::495::TaskManager.Task::(_debug) Task
612d6da8-5aa1-4f72-89b4-14c3101b0cec: ref 0 aborting False</span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span style="color:#1F497D" lang="EN-US"> </span><o:p></o:p></p>
<div>
<div style="border:none;border-top:solid #B5C4DF
1.0pt;padding:3.0pt 0cm 0cm 0cm">
<p class="MsoNormal"><b><span
style="font-size:10.0pt;font-family:"Tahoma","sans-serif";color:windowtext"
lang="EN-US">From:</span></b><span
style="font-size:10.0pt;font-family:"Tahoma","sans-serif";color:windowtext"
lang="EN-US"> Rami Vaknin [<a moz-do-not-send="true"
href="mailto:rvaknin@redhat.com">mailto:rvaknin@redhat.com</a>]
<br>
<b>Sent:</b> Sunday, April 08, 2012 7:02 PM<br>
<b>To:</b> </span><span
style="font-size:10.0pt;font-family:"Tahoma","sans-serif";color:windowtext">зоррыч</span><span
style="font-size:10.0pt;font-family:"Tahoma","sans-serif";color:windowtext"
lang="EN-US"><br>
<b>Subject:</b> Re: [Users] Failed to attach Storage
Domain export to Data Center</span><o:p></o:p></p>
</div>
</div>
<p class="MsoNormal"><span lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal" style="margin-bottom:12.0pt">On 04/08/2012
03:48 PM, зоррыч wrote:<br>
<br>
1. Change the spuuid in the domain's metadata file to be the
spuuid of the new datacenter (the metadata can be found in
dom_md/ dir somewhere inside the stoarge domain's directories
tree), you can take the new spuuid from any host running on
the new data center by running:<br>
vdsClient -s 0 getConnectedStoragePoolsList<br>
<br>
2. Try to attach the storage domain again, this time it will
fail due to broken checksum on the metadata file, go to
vdsm.log of the spm and look for "checksum", it will tell you
what the right checksum should be like, copy it to the
metadata file.<br>
This time the attachment should work.<br>
<br>
<o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">Hi. </span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">Thank you for the help
you provided me in the mailing list.</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">I dropped the settings
using the ovirt - engine-cleanup</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">Ovirt reinstalled and
tried to restore the virtual machine from the export of
storage domain.</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">If you try an attachment
domain ovirt error:</span><o:p></o:p></p>
<p class="MsoNormal"><span style="font-size:12.0pt" lang="EN-US">Error
while executing action AttachStorageDomainToPool: The Domain
is already used by another Data Center.<br/>In order
to use it, detach it from the Data Center it is currently
attached to.</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">In the logs:</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:49,898
INFO
[org.ovirt.engine.core.bll.storage.AttachStorageDomainToPoolCommand]
(pool-5-thread-50) Running command:
AttachStorageDomainToPoolCommand internal: false. Entities
affected : ID: b23c7ab6-b1d4-4888-8d4a-adc78e61db38 Type:
Storage</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:49,925
INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-48) START,
ValidateStorageServerConnectionVDSCommand(vdsId =
1bb3653a-8105-11e1-9eda-001cc43ceea0, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS,
connectionList = [{ id:
aef7de23-f271-45f3-853b-9e7b7be6607f, connection:
10.1.20.2:/home/nfs4 };]), log id: 1985db9c</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:49,925
INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-47) START,
ValidateStorageServerConnectionVDSCommand(vdsId =
270e3720-8105-11e1-a3ed-001cc43ceea0, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS,
connectionList = [{ id:
aef7de23-f271-45f3-853b-9e7b7be6607f, connection:
10.1.20.2:/home/nfs4 };]), log id: 17f02ea3</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:50,004
INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-47) FINISH,
ValidateStorageServerConnectionVDSCommand, return:
{aef7de23-f271-45f3-853b-9e7b7be6607f=0}, log id: 17f02ea3</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:50,005
INFO
[org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand]
(pool-5-thread-47) Running command:
ConnectStorageToVdsCommand internal: true. Entities affected
: ID: aaa00000-0000-0000-0000-123456789aaa Type: System</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:50,008
INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-47) START,
ConnectStorageServerVDSCommand(vdsId =
270e3720-8105-11e1-a3ed-001cc43ceea0, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS,
connectionList = [{ id:
aef7de23-f271-45f3-853b-9e7b7be6607f, connection:
10.1.20.2:/home/nfs4 };]), log id: 6f4db784</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:50,009
INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-48) FINISH,
ValidateStorageServerConnectionVDSCommand, return:
{aef7de23-f271-45f3-853b-9e7b7be6607f=0}, log id: 1985db9c</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:50,010
INFO
[org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand]
(pool-5-thread-48) Running command:
ConnectStorageToVdsCommand internal: true. Entities affected
: ID: aaa00000-0000-0000-0000-123456789aaa Type: System</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:50,013
INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-48) START,
ConnectStorageServerVDSCommand(vdsId =
1bb3653a-8105-11e1-9eda-001cc43ceea0, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS,
connectionList = [{ id:
aef7de23-f271-45f3-853b-9e7b7be6607f, connection:
10.1.20.2:/home/nfs4 };]), log id: 42baf149</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:50,031
INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-47) FINISH, ConnectStorageServerVDSCommand,
return: {aef7de23-f271-45f3-853b-9e7b7be6607f=0}, log id:
6f4db784</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:50,035
INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-48) FINISH, ConnectStorageServerVDSCommand,
return: {aef7de23-f271-45f3-853b-9e7b7be6607f=0}, log id:
42baf149</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:50,037
INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.AttachStorageDomainVDSCommand]
(pool-5-thread-50) START,
AttachStorageDomainVDSCommand(storagePoolId =
e3e565d6-8104-11e1-afd2-001cc43ceea0, ignoreFailoverLimit =
false, compatabilityVersion = null, storageDomainId =
b23c7ab6-b1d4-4888-8d4a-adc78e61db38), log id: 6f22bcac</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:53,186
ERROR
[org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(pool-5-thread-50) IrsBroker::Failed::AttachStorageDomainVDS
due to: IrsOperationFailedNoFailoverException:
IRSGenericException: IRSErrorException: Storage domain
already attached to pool:
'domain=b23c7ab6-b1d4-4888-8d4a-adc78e61db38,
pool=801e35d4-7405-11e1-b152-001cc43ceea0'</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:53,186
INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.AttachStorageDomainVDSCommand]
(pool-5-thread-50) FINISH, AttachStorageDomainVDSCommand,
log id: 6f22bcac</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:53,186
ERROR
[org.ovirt.engine.core.bll.storage.AttachStorageDomainToPoolCommand]
(pool-5-thread-50) Command
org.ovirt.engine.core.bll.storage.AttachStorageDomainToPoolCommand
throw Vdc Bll exception. With error message VdcBLLException:
org.ovirt.engine.core.vdsbroker.irsbroker.IrsOperationFailedNoFailoverException:
IRSGenericException: IRSErrorException: Storage domain
already attached to pool:
'domain=b23c7ab6-b1d4-4888-8d4a-adc78e61db38,
pool=801e35d4-7405-11e1-b152-001cc43ceea0'</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">2012-04-08 08:39:53,190
INFO
[org.ovirt.engine.core.bll.storage.AttachStorageDomainToPoolCommand]
(pool-5-thread-50) Command
[id=b717db6a-a582-49ba-92c1-6bb09340789a]: Compensating
NEW_ENTITY_ID of
org.ovirt.engine.core.common.businessentities.storage_pool_iso_map;
snapshot: storagePoolId =
e3e565d6-8104-11e1-afd2-001cc43ceea0, storageId =
b23c7ab6-b1d4-4888-8d4a-adc78e61db38.</span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US"> </span><o:p></o:p></p>
<p class="MsoNormal"><span lang="EN-US">I did not deactivate the
export domain before clearing the configuration. How can I
be in this case? I can manually remove the flag of the
domain?</span><o:p></o:p></p>
<p class="MsoNormal" style="margin-bottom:12.0pt"><span
style="font-size:12.0pt"><br>
<br>
<br>
</span><o:p></o:p></p>
<pre>_______________________________________________<o:p></o:p></pre>
<pre>Users mailing list<o:p></o:p></pre>
<pre><a moz-do-not-send="true" href="mailto:Users@ovirt.org">Users@ovirt.org</a><o:p></o:p></pre>
<pre><a moz-do-not-send="true" href="http://lists.ovirt.org/mailman/listinfo/users">http://lists.ovirt.org/mailman/listinfo/users</a><o:p></o:p></pre>
<p class="MsoNormal" style="margin-bottom:12.0pt"><span
style="font-size:12.0pt"><br>
<br>
<br>
</span><o:p></o:p></p>
<pre>-- <o:p></o:p></pre>
<pre> <o:p></o:p></pre>
<pre>Thanks,<o:p></o:p></pre>
<pre> <o:p></o:p></pre>
<pre>Rami Vaknin, QE @ Red Hat, TLV, IL.<o:p></o:p></pre>
<p class="MsoNormal" style="margin-bottom:12.0pt"><span
style="font-size:12.0pt;font-family:"Times New
Roman","serif""><br>
<br>
<o:p></o:p></span></p>
<pre>-- <o:p></o:p></pre>
<pre><o:p> </o:p></pre>
<pre>Thanks,<o:p></o:p></pre>
<pre><o:p> </o:p></pre>
<pre>Rami Vaknin, QE @ Red Hat, TLV, IL.<o:p></o:p></pre>
</div>
</blockquote>
<br>
<br>
<pre class="moz-signature" cols="72">--
Thanks,
Rami Vaknin, QE @ Red Hat, TLV, IL.
</pre>
</body>
</html>