[Users] Error importing export storage

зоррыч zorro at megatrone.ru
Wed Aug 29 12:18:48 UTC 2012


Sorry, I was wrong.
The problem affects only one export domain.

Most of all, I do not unmount it before clearing the configuration ovirt.
I like that I can return the data stored on it?




-----Original Message-----
From: Haim Ateya [mailto:hateya at redhat.com] 
Sent: Tuesday, August 28, 2012 11:42 PM
To: зоррыч
Cc: users at ovirt.org
Subject: Re: [Users] Error importing export storage


On Aug 28, 2012, at 21:34, зоррыч <zorro at megatrone.ru> wrote:

> Again reproduce this problem.
> algorithm:
> 1. Create export storage, using ovirt (successfully) 2. Mounting it in 
> a data center ovirt (successfully)
Manually or using oVirt?
> 3. umount export storage in ovirt (without deleting the files)
Same question.
> 4. Attempting to import a previously created back in storage ovirt 
> (error)
> Error:
> Thread-114745 :: DEBUG :: 2012-08-28 14:14:05,781 :: __init__ :: 1164 
> :: Storage.Misc.excCmd :: (_log) SUCCESS: <err> = "Couldn't find 
> device with uuid sySrjj-b79L-jZ9D-8ZUe-UAwz-r08M-l7YWxe. \ n "; <rc> = 
> 0
You have to detach the storage domain using oVirt in order to be able to import it again.
>From the log below, it appears that vdsm doesn't find any existing domain under this path, which might indicate a permission problem or storage domain was not detached properly using our system, or storage domain was indeed detached but also removed and formatted.
p.s - the above failure (4) not related to the import failure, engine executed getExistingStorageDomainsList query and revived an empty list.
> 
> -----Original Message-----
> From: users-bounces at ovirt.org [mailto:users-bounces at ovirt.org] On 
> Behalf Of зоррыч
> Sent: Tuesday, August 28, 2012 7:10 PM
> To: 'Haim'
> Cc: users at ovirt.org
> Subject: Re: [Users] Error importing export storage
> 
> Engine.log:
> 2012-08-28 10:48:59,857 INFO  
> [org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnec
> tionVDSCommand] (ajp--0.0.0.0-8009-36) [173db25f] START, 
> ValidateStorageServerConnectionVDSCommand(vdsId = 
> 098ee856-ef8d-11e1-b08d-001cc43ceea0, storagePoolId = 
> 00000000-0000-0000-0000-000000000000, storageType = NFS, 
> connectionList = [{ id: null, connection: 10.1.20.7:/home/nfs4 };]), 
> log id: 56625f10
> 2012-08-28 10:48:59,871 INFO  
> [org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnec
> tionVDSCommand] (ajp--0.0.0.0-8009-36) [173db25f] FINISH, 
> ValidateStorageServerConnectionVDSCommand, return: 
> {00000000-0000-0000-0000-000000000000=0}, log id: 56625f10
> 2012-08-28 10:48:59,879 INFO  
> [org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand] 
> (ajp--0.0.0.0-8009-36) [173db25f] Running command: 
> ConnectStorageToVdsCommand internal: false. Entities affected :  ID: 
> aaa00000-0000-0000-0000-123456789aaa Type: System
> 2012-08-28 10:48:59,882 INFO  
> [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSComm
> and] (ajp--0.0.0.0-8009-36) [173db25f] START, 
> ConnectStorageServerVDSCommand(vdsId = 
> 098ee856-ef8d-11e1-b08d-001cc43ceea0, storagePoolId = 
> 00000000-0000-0000-0000-000000000000, storageType = NFS, 
> connectionList = [{ id: null, connection: 10.1.20.7:/home/nfs4 };]), 
> log id: 7820a07e
> 2012-08-28 10:49:37,318 INFO  
> [org.ovirt.engine.core.bll.storage.RemoveStorageServerConnectionComman
> d] (ajp--0.0.0.0-8009-72) [7d5acac5] Running command: 
> RemoveStorageServerConnectionCommand internal: false. Entities 
> affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type: System
> 2012-08-28 10:49:37,321 INFO  
> [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSC
> ommand] (ajp--0.0.0.0-8009-72) [7d5acac5] START, 
> DisconnectStorageServerVDSCommand(vdsId = 
> 098ee856-ef8d-11e1-b08d-001cc43ceea0, storagePoolId = 
> 00000000-0000-0000-0000-000000000000, storageType = NFS, 
> connectionList = [{ id: null, connection: 10.1.20.7:/home/nfs4 };]), 
> log id: 20c475a6
> 2012-08-28 10:49:37,619 INFO  
> [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSC
> ommand] (ajp--0.0.0.0-8009-72) [7d5acac5] FINISH, 
> DisconnectStorageServerVDSCommand, return: 
> {00000000-0000-0000-0000-000000000000=477}, log id: 20c475a6
> 2012-08-28 10:49:37,716 INFO  
> [org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnec
> tionVDSCommand] (ajp--0.0.0.0-8009-62) [d90d0ce] START, 
> ValidateStorageServerConnectionVDSCommand(vdsId = 
> 098ee856-ef8d-11e1-b08d-001cc43ceea0, storagePoolId = 
> 00000000-0000-0000-0000-000000000000, storageType = NFS, 
> connectionList = [{ id: null, connection: 10.1.20.2:/home/nfs4 };]), 
> log id: 58d63f5b
> 2012-08-28 10:49:37,728 INFO  
> [org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnec
> tionVDSCommand] (ajp--0.0.0.0-8009-62) [d90d0ce] FINISH, 
> ValidateStorageServerConnectionVDSCommand, return: 
> {00000000-0000-0000-0000-000000000000=0}, log id: 58d63f5b
> 2012-08-28 10:49:37,738 INFO  
> [org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand] 
> (ajp--0.0.0.0-8009-62) [d90d0ce] Running command: 
> ConnectStorageToVdsCommand internal: false. Entities affected :  ID: 
> aaa00000-0000-0000-0000-123456789aaa Type: System
> 2012-08-28 10:49:37,741 INFO  
> [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSComm
> and] (ajp--0.0.0.0-8009-62) [d90d0ce] START, 
> ConnectStorageServerVDSCommand(vdsId = 
> 098ee856-ef8d-11e1-b08d-001cc43ceea0, storagePoolId = 
> 00000000-0000-0000-0000-000000000000, storageType = NFS, 
> connectionList = [{ id: null, connection: 10.1.20.2:/home/nfs4 };]), 
> log id: 3248aad6
> 2012-08-28 10:49:37,810 INFO  
> [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSComm
> and] (ajp--0.0.0.0-8009-62) [d90d0ce] FINISH, 
> ConnectStorageServerVDSCommand, return: 
> {00000000-0000-0000-0000-000000000000=0}, log id: 3248aad6
> 2012-08-28 10:49:37,843 INFO  
> [org.ovirt.engine.core.bll.storage.GetExistingStorageDomainListQuery] 
> (ajp--0.0.0.0-8009-41) START, 
> GetExistingStorageDomainListQuery(org.ovirt.engine.core.common.queries
> .GetExistingStorageDomainListParameters at 7cde8097), log id: 2f278e3
> 2012-08-28 10:49:37,846 INFO  
> [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetStorageDomainsListVDS
> Command] (ajp--0.0.0.0-8009-41) START, 
> HSMGetStorageDomainsListVDSCommand(vdsId = 
> 098ee856-ef8d-11e1-b08d-001cc43ceea0, 
> storagePoolId=00000000-0000-0000-0000-000000000000, storageType=NFS, 
> storageDomainType=ImportExport, path=10.1.20.2:/home/nfs4), log id: 
> 44909d8a
> 2012-08-28 10:49:38,281 INFO  
> [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetStorageDomainsListVDS
> Command] (ajp--0.0.0.0-8009-41) FINISH, 
> HSMGetStorageDomainsListVDSCommand, return: [], log id: 44909d8a
> 2012-08-28 10:49:38,282 INFO  
> [org.ovirt.engine.core.bll.storage.GetExistingStorageDomainListQuery] 
> (ajp--0.0.0.0-8009-41) FINISH, GetExistingStorageDomainListQuery, log 
> id: 2f278e3
> 2012-08-28 10:49:38,339 INFO  
> [org.ovirt.engine.core.bll.storage.RemoveStorageServerConnectionComman
> d] (ajp--0.0.0.0-8009-26) [32374c6d] Running command: 
> RemoveStorageServerConnectionCommand internal: false. Entities 
> affected :  ID: aaa00000-0000-0000-0000-123456789aaa Type: System
> 2012-08-28 10:49:38,342 INFO  
> [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSC
> ommand] (ajp--0.0.0.0-8009-26) [32374c6d] START, 
> DisconnectStorageServerVDSCommand(vdsId = 
> 098ee856-ef8d-11e1-b08d-001cc43ceea0, storagePoolId = 
> 00000000-0000-0000-0000-000000000000, storageType = NFS, 
> connectionList = [{ id: null, connection: 10.1.20.2:/home/nfs4 };]), 
> log id: 307c0926
> 2012-08-28 10:49:38,625 INFO  
> [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSC
> ommand] (ajp--0.0.0.0-8009-26) [32374c6d] FINISH, 
> DisconnectStorageServerVDSCommand, return: 
> {00000000-0000-0000-0000-000000000000=0}, log id: 307c0926
> 
> 
> 
> 
> Vdsm.log:
> 
> 
> Thread-104470::DEBUG::2012-08-28 
> 10:51:24,934::BindingXMLRPC::160::vds::(wrapper) [10.1.20.2]
> Thread-104470::DEBUG::2012-08-28 
> 10:51:24,935::task::568::TaskManager.Task::(_updateState) 
> Task=`66d3e9f1-dbff-491b-8d05-e32bc46d3bbe`::moving from state init -> 
> state preparing
> Thread-104470::INFO::2012-08-28 
> 10:51:24,935::logUtils::37::dispatcher::(wrapper) Run and protect: 
> validateStorageServerConnection(domType=1, 
> spUUID='00000000-0000-0000-0000-000000000000', conList=[{'connection': 
> '10.1.20.2:/home/nfs4', 'iqn': '', 'portal': '', 'user': '', 
> 'password': '******', 'id': '00000000-0000-0000-0000-000000000000', 
> 'port': ''}], options=None)
> Thread-104470::INFO::2012-08-28 
> 10:51:24,936::logUtils::39::dispatcher::(wrapper) Run and protect: 
> validateStorageServerConnection, Return response: {'statuslist': 
> [{'status': 0, 'id': '00000000-0000-0000-0000-000000000000'}]}
> Thread-104470::DEBUG::2012-08-28 
> 10:51:24,936::task::1151::TaskManager.Task::(prepare) 
> Task=`66d3e9f1-dbff-491b-8d05-e32bc46d3bbe`::finished: {'statuslist': 
> [{'status': 0, 'id': '00000000-0000-0000-0000-000000000000'}]}
> Thread-104470::DEBUG::2012-08-28 
> 10:51:24,936::task::568::TaskManager.Task::(_updateState) 
> Task=`66d3e9f1-dbff-491b-8d05-e32bc46d3bbe`::moving from state 
> preparing -> state finished
> Thread-104470::DEBUG::2012-08-28 
> 10:51:24,936::resourceManager::809::ResourceManager.Owner::(releaseAll
> ) Owner.releaseAll requests {} resources {}
> Thread-104470::DEBUG::2012-08-28 
> 10:51:24,936::resourceManager::844::ResourceManager.Owner::(cancelAll) 
> Owner.cancelAll requests {}
> Thread-104470::DEBUG::2012-08-28 
> 10:51:24,936::task::957::TaskManager.Task::(_decref) 
> Task=`66d3e9f1-dbff-491b-8d05-e32bc46d3bbe`::ref 0 aborting False
> Thread-104471::DEBUG::2012-08-28 
> 10:51:24,958::BindingXMLRPC::160::vds::(wrapper) [10.1.20.2]
> Thread-104471::DEBUG::2012-08-28 
> 10:51:24,958::task::568::TaskManager.Task::(_updateState) 
> Task=`c8b2efab-c3ea-4c45-80f3-91b0702d5caa`::moving from state init -> 
> state preparing
> Thread-104471::INFO::2012-08-28 
> 10:51:24,959::logUtils::37::dispatcher::(wrapper) Run and protect: 
> connectStorageServer(domType=1, 
> spUUID='00000000-0000-0000-0000-000000000000', conList=[{'connection': 
> '10.1.20.2:/home/nfs4', 'iqn': '', 'portal': '', 'user': '', 
> 'password': '******', 'id': '00000000-0000-0000-0000-000000000000', 
> 'port': ''}], options=None)
> Thread-104471::DEBUG::2012-08-28 
> 10:51:24,962::__init__::1164::Storage.Misc.excCmd::(_log) 
> '/usr/bin/sudo -n /bin/mount -t nfs -o 
> soft,nosharecache,timeo=600,retrans=6 10.1.20.2:/home/nfs4 
> /rhev/data-center/mnt/10.1.20.2:_home_nfs4' (cwd None)
> Thread-104471::DEBUG::2012-08-28 
> 10:51:25,023::lvm::477::OperationMutex::(_invalidateAllPvs) Operation 
> 'lvm invalidate operation' got the operation mutex
> Thread-104471::DEBUG::2012-08-28 
> 10:51:25,023::lvm::479::OperationMutex::(_invalidateAllPvs) Operation 
> 'lvm invalidate operation' released the operation mutex
> Thread-104471::DEBUG::2012-08-28 
> 10:51:25,023::lvm::488::OperationMutex::(_invalidateAllVgs) Operation 
> 'lvm invalidate operation' got the operation mutex
> Thread-104471::DEBUG::2012-08-28 
> 10:51:25,024::lvm::490::OperationMutex::(_invalidateAllVgs) Operation 
> 'lvm invalidate operation' released the operation mutex
> Thread-104471::DEBUG::2012-08-28 
> 10:51:25,024::lvm::508::OperationMutex::(_invalidateAllLvs) Operation 
> 'lvm invalidate operation' got the operation mutex
> Thread-104471::DEBUG::2012-08-28 
> 10:51:25,024::lvm::510::OperationMutex::(_invalidateAllLvs) Operation 
> 'lvm invalidate operation' released the operation mutex
> Thread-104471::INFO::2012-08-28 
> 10:51:25,024::logUtils::39::dispatcher::(wrapper) Run and protect: 
> connectStorageServer, Return response: {'statuslist': [{'status': 0, 
> 'id': '00000000-0000-0000-0000-000000000000'}]}
> Thread-104471::DEBUG::2012-08-28 
> 10:51:25,025::task::1151::TaskManager.Task::(prepare) 
> Task=`c8b2efab-c3ea-4c45-80f3-91b0702d5caa`::finished: {'statuslist': 
> [{'status': 0, 'id': '00000000-0000-0000-0000-000000000000'}]}
> Thread-104471::DEBUG::2012-08-28 
> 10:51:25,025::task::568::TaskManager.Task::(_updateState) 
> Task=`c8b2efab-c3ea-4c45-80f3-91b0702d5caa`::moving from state 
> preparing -> state finished
> Thread-104471::DEBUG::2012-08-28 
> 10:51:25,025::resourceManager::809::ResourceManager.Owner::(releaseAll
> ) Owner.releaseAll requests {} resources {}
> Thread-104471::DEBUG::2012-08-28 
> 10:51:25,025::resourceManager::844::ResourceManager.Owner::(cancelAll) 
> Owner.cancelAll requests {}
> Thread-104471::DEBUG::2012-08-28 
> 10:51:25,025::task::957::TaskManager.Task::(_decref) 
> Task=`c8b2efab-c3ea-4c45-80f3-91b0702d5caa`::ref 0 aborting False
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,063::BindingXMLRPC::160::vds::(wrapper) [10.1.20.2]
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,063::task::568::TaskManager.Task::(_updateState) 
> Task=`38840ddf-7948-40b3-ae71-8d9ee71205b7`::moving from state init -> 
> state preparing
> Thread-104472::INFO::2012-08-28 
> 10:51:25,064::logUtils::37::dispatcher::(wrapper) Run and protect: 
> getStorageDomainsList(spUUID='00000000-0000-0000-0000-000000000000', 
> domainClass=3, storageType=1, remotePath='10.1.20.2:/home/nfs4', 
> options=None)
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,064::misc::1061::SamplingMethod::(__call__) Trying to enter 
> sampling method (storage.sdc.refreshStorage)
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,064::misc::1063::SamplingMethod::(__call__) Got in to 
> sampling method
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,064::misc::1061::SamplingMethod::(__call__) Trying to enter 
> sampling method (storage.iscsi.rescan)
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,064::misc::1063::SamplingMethod::(__call__) Got in to 
> sampling method
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,065::__init__::1164::Storage.Misc.excCmd::(_log) 
> '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None)
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,082::__init__::1164::Storage.Misc.excCmd::(_log) FAILED: 
> <err> = 'iscsiadm: No session found.\n'; <rc> = 21
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,082::misc::1071::SamplingMethod::(__call__) Returning last 
> result
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,247::__init__::1164::Storage.Misc.excCmd::(_log) 
> '/usr/bin/sudo -n /sbin/multipath' (cwd None)
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,304::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: 
> <err> = ''; <rc> = 0
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,305::lvm::477::OperationMutex::(_invalidateAllPvs) Operation 
> 'lvm invalidate operation' got the operation mutex
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,305::lvm::479::OperationMutex::(_invalidateAllPvs) Operation 
> 'lvm invalidate operation' released the operation mutex
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,305::lvm::488::OperationMutex::(_invalidateAllVgs) Operation 
> 'lvm invalidate operation' got the operation mutex
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,306::lvm::490::OperationMutex::(_invalidateAllVgs) Operation 
> 'lvm invalidate operation' released the operation mutex
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,306::lvm::508::OperationMutex::(_invalidateAllLvs) Operation 
> 'lvm invalidate operation' got the operation mutex
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,306::lvm::510::OperationMutex::(_invalidateAllLvs) Operation 
> 'lvm invalidate operation' released the operation mutex
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,306::misc::1071::SamplingMethod::(__call__) Returning last 
> result
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,307::lvm::368::OperationMutex::(_reloadvgs) Operation 'lvm 
> reload operation' got the operation mutex
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,308::__init__::1164::Storage.Misc.excCmd::(_log) 
> '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names = 
> [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0 
> disable_after_error_count=3 filter = [ \\"a%35000c50001770ea3%\\", 
> \\"r%.*%\\" ] }  global {  locking_type=1  prioritise_write_locks=1  
> wait_for_locks=1 }  backup {  retain_min = 50  retain_days = 0 } " 
> --noheadings --units b --nosuffix --separator | -o 
> uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_m
> da_size,vg_mda_free' (cwd None)
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,492::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: 
> <err> = "  Couldn't find device with uuid 
> sySrjj-b79L-jZ9D-8ZUe-UAwz-r08M-l7YWxe.\n"; <rc> = 0
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,494::lvm::397::OperationMutex::(_reloadvgs) Operation 'lvm 
> reload operation' released the operation mutex
> Thread-104472::INFO::2012-08-28 
> 10:51:25,507::logUtils::39::dispatcher::(wrapper) Run and protect: 
> getStorageDomainsList, Return response: {'domlist': []}
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,507::task::1151::TaskManager.Task::(prepare) 
> Task=`38840ddf-7948-40b3-ae71-8d9ee71205b7`::finished: {'domlist': []}
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,507::task::568::TaskManager.Task::(_updateState) 
> Task=`38840ddf-7948-40b3-ae71-8d9ee71205b7`::moving from state 
> preparing -> state finished
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,507::resourceManager::809::ResourceManager.Owner::(releaseAll
> ) Owner.releaseAll requests {} resources {}
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,507::resourceManager::844::ResourceManager.Owner::(cancelAll) 
> Owner.cancelAll requests {}
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,508::task::957::TaskManager.Task::(_decref) 
> Task=`38840ddf-7948-40b3-ae71-8d9ee71205b7`::ref 0 aborting False
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,566::BindingXMLRPC::160::vds::(wrapper) [10.1.20.2]
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,566::task::568::TaskManager.Task::(_updateState) 
> Task=`646a0221-f17b-4d13-8f3d-69985bb5f185`::moving from state init -> 
> state preparing
> Thread-104482::INFO::2012-08-28 
> 10:51:25,567::logUtils::37::dispatcher::(wrapper) Run and protect: 
> disconnectStorageServer(domType=1, 
> spUUID='00000000-0000-0000-0000-000000000000', conList=[{'connection': 
> '10.1.20.2:/home/nfs4', 'iqn': '', 'portal': '', 'user': '', 
> 'password': '******', 'id': '00000000-0000-0000-0000-000000000000', 
> 'port': ''}], options=None)
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,567::__init__::1164::Storage.Misc.excCmd::(_log) 
> '/usr/bin/sudo -n /bin/umount -f -l 
> /rhev/data-center/mnt/10.1.20.2:_home_nfs4' (cwd None)
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,597::misc::1061::SamplingMethod::(__call__) Trying to enter 
> sampling method (storage.sdc.refreshStorage)
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,597::misc::1063::SamplingMethod::(__call__) Got in to 
> sampling method
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,597::misc::1061::SamplingMethod::(__call__) Trying to enter 
> sampling method (storage.iscsi.rescan)
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,597::misc::1063::SamplingMethod::(__call__) Got in to 
> sampling method
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,598::__init__::1164::Storage.Misc.excCmd::(_log) 
> '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None)
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,615::__init__::1164::Storage.Misc.excCmd::(_log) FAILED: 
> <err> = 'iscsiadm: No session found.\n'; <rc> = 21
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,616::misc::1071::SamplingMethod::(__call__) Returning last 
> result
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,780::__init__::1164::Storage.Misc.excCmd::(_log) 
> '/usr/bin/sudo -n /sbin/multipath' (cwd None)
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,853::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: 
> <err> = ''; <rc> = 0
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,854::lvm::477::OperationMutex::(_invalidateAllPvs) Operation 
> 'lvm invalidate operation' got the operation mutex
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,854::lvm::479::OperationMutex::(_invalidateAllPvs) Operation 
> 'lvm invalidate operation' released the operation mutex
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,854::lvm::488::OperationMutex::(_invalidateAllVgs) Operation 
> 'lvm invalidate operation' got the operation mutex
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,855::lvm::490::OperationMutex::(_invalidateAllVgs) Operation 
> 'lvm invalidate operation' released the operation mutex
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,855::lvm::508::OperationMutex::(_invalidateAllLvs) Operation 
> 'lvm invalidate operation' got the operation mutex
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,855::lvm::510::OperationMutex::(_invalidateAllLvs) Operation 
> 'lvm invalidate operation' released the operation mutex
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,855::misc::1071::SamplingMethod::(__call__) Returning last 
> result
> Thread-104482::INFO::2012-08-28 
> 10:51:25,855::logUtils::39::dispatcher::(wrapper) Run and protect: 
> disconnectStorageServer, Return response: {'statuslist': [{'status': 
> 0, 'id': '00000000-0000-0000-0000-000000000000'}]}
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,856::task::1151::TaskManager.Task::(prepare) 
> Task=`646a0221-f17b-4d13-8f3d-69985bb5f185`::finished: {'statuslist': 
> [{'status': 0, 'id': '00000000-0000-0000-0000-000000000000'}]}
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,856::task::568::TaskManager.Task::(_updateState) 
> Task=`646a0221-f17b-4d13-8f3d-69985bb5f185`::moving from state 
> preparing -> state finished
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,856::resourceManager::809::ResourceManager.Owner::(releaseAll
> ) Owner.releaseAll requests {} resources {}
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,856::resourceManager::844::ResourceManager.Owner::(cancelAll) 
> Owner.cancelAll requests {}
> Thread-104482::DEBUG::2012-08-28 
> 10:51:25,856::task::957::TaskManager.Task::(_decref) 
> Task=`646a0221-f17b-4d13-8f3d-69985bb5f185`::ref 0 aborting False
> Thread-104483::DEBUG::2012-08-28 
> 10:51:26,240::BindingXMLRPC::160::vds::(wrapper) [10.1.20.2]
> Thread-104483::DEBUG::2012-08-28 
> 10:51:26,241::task::568::TaskManager.Task::(_updateState) 
> Task=`841cf3ff-174b-4821-b0d4-5b690138ada7`::moving from state init -> 
> state preparing
> Thread-104483::INFO::2012-08-28 
> 10:51:26,241::logUtils::37::dispatcher::(wrapper) Run and protect: 
> getSpmStatus(spUUID='dd424005-9444-4c73-8653-3b5192ec39ae', 
> options=None)
> Thread-104483::INFO::2012-08-28 
> 10:51:26,242::logUtils::39::dispatcher::(wrapper) Run and protect: 
> getSpmStatus, Return response: {'spm_st': {'spmId': 1, 'spmStatus': 
> 'SPM', 'spmLver': 1}}
> Thread-104483::DEBUG::2012-08-28 
> 10:51:26,242::task::1151::TaskManager.Task::(prepare) 
> Task=`841cf3ff-174b-4821-b0d4-5b690138ada7`::finished: {'spm_st': 
> {'spmId': 1, 'spmStatus': 'SPM', 'spmLver': 1}}
> Thread-104483::DEBUG::2012-08-28 
> 10:51:26,242::task::568::TaskManager.Task::(_updateState) 
> Task=`841cf3ff-174b-4821-b0d4-5b690138ada7`::moving from state 
> preparing -> state finished
> Thread-104483::DEBUG::2012-08-28 
> 10:51:26,242::resourceManager::809::ResourceManager.Owner::(releaseAll
> ) Owner.releaseAll requests {} resources {}
> Thread-104483::DEBUG::2012-08-28 
> 10:51:26,243::resourceManager::844::ResourceManager.Owner::(cancelAll) 
> Owner.cancelAll requests {}
> Thread-104483::DEBUG::2012-08-28 
> 10:51:26,243::task::957::TaskManager.Task::(_decref) 
> Task=`841cf3ff-174b-4821-b0d4-5b690138ada7`::ref 0 aborting False
> Thread-104484::DEBUG::2012-08-28 
> 10:51:26,250::BindingXMLRPC::160::vds::(wrapper) [10.1.20.2]
> Thread-104484::DEBUG::2012-08-28 
> 10:51:26,251::task::568::TaskManager.Task::(_updateState) 
> Task=`723785f0-9574-4ad1-b1e2-673b193d9860`::moving from state init -> 
> state preparing
> Thread-104484::INFO::2012-08-28 
> 10:51:26,251::logUtils::37::dispatcher::(wrapper) Run and protect: 
> getStoragePoolInfo(spUUID='dd424005-9444-4c73-8653-3b5192ec39ae', 
> options=None)
> Thread-104484::DEBUG::2012-08-28 10:51:26,251::resourceManager::175::ResourceManager.Request::(__init__) ResName=`Storage.dd424005-9444-4c73-8653-3b5192ec39ae`ReqID=`76f206f7-7359-4ee2-9f5a-2d90704fb28a`::Request was made in '/usr/share/vdsm/storage/resourceManager.py' line '485' at 'registerResource'
> Thread-104484::DEBUG::2012-08-28 10:51:26,251::resourceManager::486::ResourceManager::(registerResource) Trying to register resource 'Storage.dd424005-9444-4c73-8653-3b5192ec39ae' for lock type 'shared'
> Thread-104484::DEBUG::2012-08-28 
> 10:51:26,252::resourceManager::528::ResourceManager::(registerResource
> ) Resource 'Storage.dd424005-9444-4c73-8653-3b5192ec39ae' is free. Now 
> locking as 'shared' (1 active user)
> Thread-104484::DEBUG::2012-08-28 
> 10:51:26,252::resourceManager::212::ResourceManager.Request::(grant) 
> ResName=`Storage.dd424005-9444-4c73-8653-3b5192ec39ae`ReqID=`76f206f7-
> 7359-4ee2-9f5a-2d90704fb28a`::Granted request
> Thread-104484::DEBUG::2012-08-28 
> 10:51:26,252::task::794::TaskManager.Task::(resourceAcquired) 
> Task=`723785f0-9574-4ad1-b1e2-673b193d9860`::_resourcesAcquired: 
> Storage.dd424005-9444-4c73-8653-3b5192ec39ae (shared)
> Thread-104484::DEBUG::2012-08-28 
> 10:51:26,252::task::957::TaskManager.Task::(_decref) 
> Task=`723785f0-9574-4ad1-b1e2-673b193d9860`::ref 1 aborting False
> Thread-104484::INFO::2012-08-28 
> 10:51:26,256::logUtils::39::dispatcher::(wrapper) Run and protect: 
> getStoragePoolInfo, Return response: {'info': {'spm_id': 1, 
> 'master_uuid': 'b0a0e76b-f983-405b-a0af-d0314a1c381a', 'name': 'cv', 
> 'version': '0', 'domains': 
> 'b0a0e76b-f983-405b-a0af-d0314a1c381a:Active', 'pool_status': 
> 'connected', 'isoprefix': '', 'type': 'POSIXFS', 'master_ver': 1, 
> 'lver': 1}, 'dominfo': {'b0a0e76b-f983-405b-a0af-d0314a1c381a': 
> {'status': 'Active', 'diskfree': '489236856832', 'alerts': [], 
> 'disktotal': '526951907328'}}}
> Thread-104484::DEBUG::2012-08-28 
> 10:51:26,256::task::1151::TaskManager.Task::(prepare) 
> Task=`723785f0-9574-4ad1-b1e2-673b193d9860`::finished: {'info': 
> {'spm_id': 1, 'master_uuid': 'b0a0e76b-f983-405b-a0af-d0314a1c381a', 
> 'name': 'cv', 'version': '0', 'domains': 
> 'b0a0e76b-f983-405b-a0af-d0314a1c381a:Active', 'pool_status': 
> 'connected', 'isoprefix': '', 'type': 'POSIXFS', 'master_ver': 1, 
> 'lver': 1}, 'dominfo': {'b0a0e76b-f983-405b-a0af-d0314a1c381a': 
> {'status': 'Active', 'diskfree': '489236856832', 'alerts': [], 
> 'disktotal': '526951907328'}}}
> Thread-104484::DEBUG::2012-08-28 
> 10:51:26,256::task::568::TaskManager.Task::(_updateState) 
> Task=`723785f0-9574-4ad1-b1e2-673b193d9860`::moving from state 
> preparing -> state finished
> Thread-104484::DEBUG::2012-08-28 
> 10:51:26,256::resourceManager::809::ResourceManager.Owner::(releaseAll
> ) Owner.releaseAll requests {} resources 
> {'Storage.dd424005-9444-4c73-8653-3b5192ec39ae': < ResourceRef 
> 'Storage.dd424005-9444-4c73-8653-3b5192ec39ae', isValid: 'True' obj: 
> 'None'>}
> Thread-104484::DEBUG::2012-08-28 
> 10:51:26,256::resourceManager::844::ResourceManager.Owner::(cancelAll) 
> Owner.cancelAll requests {}
> Thread-104484::DEBUG::2012-08-28 10:51:26,257::resourceManager::538::ResourceManager::(releaseResource) Trying to release resource 'Storage.dd424005-9444-4c73-8653-3b5192ec39ae'
> Thread-104484::DEBUG::2012-08-28 
> 10:51:26,257::resourceManager::553::ResourceManager::(releaseResource) 
> Released resource 'Storage.dd424005-9444-4c73-8653-3b5192ec39ae' (0 
> active users)
> Thread-104484::DEBUG::2012-08-28 10:51:26,257::resourceManager::558::ResourceManager::(releaseResource) Resource 'Storage.dd424005-9444-4c73-8653-3b5192ec39ae' is free, finding out if anyone is waiting for it.
> Thread-104484::DEBUG::2012-08-28 10:51:26,257::resourceManager::565::ResourceManager::(releaseResource) No one is waiting for resource 'Storage.dd424005-9444-4c73-8653-3b5192ec39ae', Clearing records.
> Thread-104484::DEBUG::2012-08-28 
> 10:51:26,258::task::957::TaskManager.Task::(_decref) 
> Task=`723785f0-9574-4ad1-b1e2-673b193d9860`::ref 0 aborting False
> Thread-104487::DEBUG::2012-08-28 
> 10:51:30,541::task::568::TaskManager.Task::(_updateState) 
> Task=`2cedb6be-6152-47ce-9f00-7ce3a38256e0`::moving from state init -> 
> state preparing
> Thread-104487::INFO::2012-08-28 
> 10:51:30,542::logUtils::37::dispatcher::(wrapper) Run and protect: 
> repoStats(options=None)
> Thread-104487::INFO::2012-08-28 
> 10:51:30,542::logUtils::39::dispatcher::(wrapper) Run and protect: 
> repoStats, Return response: {'b0a0e76b-f983-405b-a0af-d0314a1c381a': 
> {'delay': '0.00299310684204', 'lastCheck': 1346165490.092454, 'code': 
> 0, 'valid': True}}
> Thread-104487::DEBUG::2012-08-28 
> 10:51:30,542::task::1151::TaskManager.Task::(prepare) 
> Task=`2cedb6be-6152-47ce-9f00-7ce3a38256e0`::finished: 
> {'b0a0e76b-f983-405b-a0af-d0314a1c381a': {'delay': '0.00299310684204', 
> 'lastCheck': 1346165490.092454, 'code': 0, 'valid': True}}
> Thread-104487::DEBUG::2012-08-28 
> 10:51:30,542::task::568::TaskManager.Task::(_updateState) 
> Task=`2cedb6be-6152-47ce-9f00-7ce3a38256e0`::moving from state 
> preparing -> state finished
> Thread-104487::DEBUG::2012-08-28 
> 10:51:30,543::resourceManager::809::ResourceManager.Owner::(releaseAll
> ) Owner.releaseAll requests {} resources {}
> Thread-104487::DEBUG::2012-08-28 
> 10:51:30,543::resourceManager::844::ResourceManager.Owner::(cancelAll) 
> Owner.cancelAll requests {}
> Thread-104487::DEBUG::2012-08-28 
> 10:51:30,543::task::957::TaskManager.Task::(_decref) 
> Task=`2cedb6be-6152-47ce-9f00-7ce3a38256e0`::ref 0 aborting False
> 
> Please pay attention to is the:
> Thread-104472::DEBUG::2012-08-28 
> 10:51:25,492::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: 
> <err> = "  Couldn't find device with uuid 
> sySrjj-b79L-jZ9D-8ZUe-UAwz-r08M-l7YWxe.\n"; <rc> = 0
> 
> Command:
> Node:
> [root at noc-3-synt ~]# /usr/bin/sudo -n /bin/mount -t nfs -o 
> soft,nosharecache,timeo=600,retrans=6 10.1.20.2:/home/nfs4 
> /rhev/data-center/mnt/10.1.20.2:_home_nfs4
> mount.nfs: mount point /rhev/data-center/mnt/10.1.20.2:_home_nfs4 does 
> not exist [root at noc-3-synt ~]# mkdir 
> /rhev/data-center/mnt/10.1.20.2:_home_nfs4
> [root at noc-3-synt ~]# /usr/bin/sudo -n /bin/mount -t nfs -o 
> soft,nosharecache,timeo=600,retrans=6 10.1.20.2:/home/nfs4 
> /rhev/data-center/mnt/10.1.20.2:_home_nfs4
> [root at noc-3-synt ~]# mount
> /dev/mapper/vg_noc3synt-lv_root on / type ext4 (rw) proc on /proc type 
> proc (rw) sysfs on /sys type sysfs (rw) devpts on /dev/pts type devpts 
> (rw,gid=5,mode=620) tmpfs on /dev/shm type tmpfs 
> (rw,rootcontext="system_u:object_r:tmpfs_t:s0")
> /dev/sda1 on /boot type ext4 (rw)
> /dev/mapper/vg_noc3synt-lv_home on /mht type ext4 (rw) none on 
> /proc/sys/fs/binfmt_misc type binfmt_misc (rw) sunrpc on 
> /var/lib/nfs/rpc_pipefs type rpc_pipefs (rw) 127.0.0.1:/gluster on 
> /rhev/data-center/mnt/127.0.0.1:_gluster type fuse.glusterfs 
> (rw,default_permissions,allow_other,max_read=131072)
> 10.1.20.2:/home/nfs4 on /tmp/foo type nfs 
> (rw,soft,nosharecache,timeo=600,retrans=6,addr=10.1.20.2)
> 10.1.20.2:/home/nfs4 on /rhev/data-center/mnt/10.1.20.2:_home_nfs4 
> type nfs (rw,soft,nosharecache,timeo=600,retrans=6,addr=10.1.20.2)
> [root at noc-3-synt ~]# vdsClient -s 0 getStorageDomainsList
> c1a00353-e7e0-4ff6-822a-faa0e7243137
> b0a0e76b-f983-405b-a0af-d0314a1c381a
> 
> [root at noc-3-synt ~]# vdsClient -s 0 getStorageDomainInfo 
> b23c7ab6-b1d4-4888-8d4a-adc78e61db38
> Storage domain does not exist: 
> ('b23c7ab6-b1d4-4888-8d4a-adc78e61db38',)
> [root at noc-3-synt ~]#
> 
> 
> 
> -----Original Message-----
> From: Haim [mailto:hateya at redhat.com]
> Sent: Tuesday, August 28, 2012 6:44 PM
> To: зоррыч
> Cc: users at ovirt.org
> Subject: Re: [Users] Error importing export storage
> 
> On 08/28/2012 04:34 PM, зоррыч wrote:
>> 
>> Hi
>> 
>> Trying to import export stotage created earlier.
>> 
>> But get this error:
>> 
> hi,
> 
> please provide full vdsm and engine logs (compressed).
> also, run the following commands on host (vds):
> 
> - /usr/bin/sudo -n /bin/mount -t nfs -o
> soft,nosharecache,timeo=600,retrans=6 10.1.20.2:/home/nfs4
> /rhev/data-center/mnt/10.1.20.2:_home_nfs4
> - mount
> - vdsClient -s 0 getStorageDomainsList (if you are working in a non-secure mode, don't use the -s).
> - vdsClient -s 0 getStorageDomainInfo 
> b23c7ab6-b1d4-4888-8d4a-adc78e61db38
> - check permission on storage server (NFS) - ls -l /home/nfs4 (should be vdsm:kvm).
> 
> another thing - it appears that domain is already attached to storage pool (as I understand from domain metadata), is it possible that you haven't detach this domain from its previous domain ?
> 
>> There is no storage domain under the specified path. Please check path.
>> 
>> Vdsm.logs:
>> 
>> Thread-99790::DEBUG::2012-08-28
>> 09:17:26,010::task::568::TaskManager.Task::(_updateState)
>> Task=`ac99ba99-f55d-4562-822e-0286ab30566e`::moving from state init 
>> -> state preparing
>> 
>> Thread-99790::INFO::2012-08-28
>> 09:17:26,010::logUtils::37::dispatcher::(wrapper) Run and protect: 
>> repoStats(options=None)
>> 
>> Thread-99790::INFO::2012-08-28
>> 09:17:26,010::logUtils::39::dispatcher::(wrapper) Run and protect: 
>> repoStats, Return response: {'b0a0e76b-f983-405b-a0af-d0314a1c381a': 
>> {'delay': '0.00292301177979', 'lastCheck': 1346159839.788852, 'code': 
>> 0, 'valid': True}}
>> 
>> Thread-99790::DEBUG::2012-08-28
>> 09:17:26,011::task::1151::TaskManager.Task::(prepare)
>> Task=`ac99ba99-f55d-4562-822e-0286ab30566e`::finished: 
>> {'b0a0e76b-f983-405b-a0af-d0314a1c381a': {'delay': 
>> '0.00292301177979',
>> 'lastCheck': 1346159839.788852, 'code': 0, 'valid': True}}
>> 
>> Thread-99790::DEBUG::2012-08-28
>> 09:17:26,011::task::568::TaskManager.Task::(_updateState)
>> Task=`ac99ba99-f55d-4562-822e-0286ab30566e`::moving from state 
>> preparing -> state finished
>> 
>> Thread-99790::DEBUG::2012-08-28
>> 09:17:26,011::resourceManager::809::ResourceManager.Owner::(releaseAl
>> l
>> ) Owner.releaseAll requests {} resources {}
>> 
>> Thread-99790::DEBUG::2012-08-28
>> 09:17:26,011::resourceManager::844::ResourceManager.Owner::(cancelAll
>> )
>> Owner.cancelAll requests {}
>> 
>> Thread-99790::DEBUG::2012-08-28
>> 09:17:26,011::task::957::TaskManager.Task::(_decref)
>> Task=`ac99ba99-f55d-4562-822e-0286ab30566e`::ref 0 aborting False
>> 
>> Thread-99792::DEBUG::2012-08-28
>> 09:17:26,473::BindingXMLRPC::160::vds::(wrapper) [10.1.20.2]
>> 
>> Thread-99792::DEBUG::2012-08-28
>> 09:17:26,474::task::568::TaskManager.Task::(_updateState)
>> Task=`e55145ac-1052-454b-92ec-a9eb981c1b04`::moving from state init 
>> -> state preparing
>> 
>> Thread-99792::INFO::2012-08-28
>> 09:17:26,474::logUtils::37::dispatcher::(wrapper) Run and protect: 
>> validateStorageServerConnection(domType=1,
>> spUUID='00000000-0000-0000-0000-000000000000', conList=[{'connection': 
>> '10.1.20.2:/home/nfs4', 'iqn': '', 'portal': '', 'user': '',
>> 'password': '******', 'id': '00000000-0000-0000-0000-000000000000',
>> 'port': ''}], options=None)
>> 
>> Thread-99792::INFO::2012-08-28
>> 09:17:26,474::logUtils::39::dispatcher::(wrapper) Run and protect: 
>> validateStorageServerConnection, Return response: {'statuslist': 
>> [{'status': 0, 'id': '00000000-0000-0000-0000-000000000000'}]}
>> 
>> Thread-99792::DEBUG::2012-08-28
>> 09:17:26,474::task::1151::TaskManager.Task::(prepare)
>> Task=`e55145ac-1052-454b-92ec-a9eb981c1b04`::finished: {'statuslist': 
>> [{'status': 0, 'id': '00000000-0000-0000-0000-000000000000'}]}
>> 
>> Thread-99792::DEBUG::2012-08-28
>> 09:17:26,474::task::568::TaskManager.Task::(_updateState)
>> Task=`e55145ac-1052-454b-92ec-a9eb981c1b04`::moving from state 
>> preparing -> state finished
>> 
>> Thread-99792::DEBUG::2012-08-28
>> 09:17:26,475::resourceManager::809::ResourceManager.Owner::(releaseAl
>> l
>> ) Owner.releaseAll requests {} resources {}
>> 
>> Thread-99792::DEBUG::2012-08-28
>> 09:17:26,475::resourceManager::844::ResourceManager.Owner::(cancelAll
>> )
>> Owner.cancelAll requests {}
>> 
>> Thread-99792::DEBUG::2012-08-28
>> 09:17:26,475::task::957::TaskManager.Task::(_decref)
>> Task=`e55145ac-1052-454b-92ec-a9eb981c1b04`::ref 0 aborting False
>> 
>> Thread-99793::DEBUG::2012-08-28
>> 09:17:26,494::BindingXMLRPC::160::vds::(wrapper) [10.1.20.2]
>> 
>> Thread-99793::DEBUG::2012-08-28
>> 09:17:26,495::task::568::TaskManager.Task::(_updateState)
>> Task=`700181ad-b9d4-411b-bfbc-25a28aa288e2`::moving from state init 
>> -> state preparing
>> 
>> Thread-99793::INFO::2012-08-28
>> 09:17:26,503::logUtils::37::dispatcher::(wrapper) Run and protect: 
>> connectStorageServer(domType=1,
>> spUUID='00000000-0000-0000-0000-000000000000', conList=[{'connection': 
>> '10.1.20.2:/home/nfs4', 'iqn': '', 'portal': '', 'user': '',
>> 'password': '******', 'id': '00000000-0000-0000-0000-000000000000',
>> 'port': ''}], options=None)
>> 
>> Thread-99793::DEBUG::2012-08-28
>> 09:17:26,505::__init__::1164::Storage.Misc.excCmd::(_log)
>> '/usr/bin/sudo -n /bin/mount -t nfs -o
>> soft,nosharecache,timeo=600,retrans=6 10.1.20.2:/home/nfs4 
>> /rhev/data-center/mnt/10.1.20.2:_home_nfs4' (cwd None)
>> 
>> Thread-99793::DEBUG::2012-08-28
>> 09:17:26,609::lvm::477::OperationMutex::(_invalidateAllPvs) Operation 
>> 'lvm invalidate operation' got the operation mutex
>> 
>> Thread-99793::DEBUG::2012-08-28
>> 09:17:26,609::lvm::479::OperationMutex::(_invalidateAllPvs) Operation 
>> 'lvm invalidate operation' released the operation mutex
>> 
>> Thread-99793::DEBUG::2012-08-28
>> 09:17:26,609::lvm::488::OperationMutex::(_invalidateAllVgs) Operation 
>> 'lvm invalidate operation' got the operation mutex
>> 
>> Thread-99793::DEBUG::2012-08-28
>> 09:17:26,610::lvm::490::OperationMutex::(_invalidateAllVgs) Operation 
>> 'lvm invalidate operation' released the operation mutex
>> 
>> Thread-99793::DEBUG::2012-08-28
>> 09:17:26,610::lvm::508::OperationMutex::(_invalidateAllLvs) Operation 
>> 'lvm invalidate operation' got the operation mutex
>> 
>> Thread-99793::DEBUG::2012-08-28
>> 09:17:26,610::lvm::510::OperationMutex::(_invalidateAllLvs) Operation 
>> 'lvm invalidate operation' released the operation mutex
>> 
>> Thread-99793::INFO::2012-08-28
>> 09:17:26,610::logUtils::39::dispatcher::(wrapper) Run and protect: 
>> connectStorageServer, Return response: {'statuslist': [{'status': 0,
>> 'id': '00000000-0000-0000-0000-000000000000'}]}
>> 
>> Thread-99793::DEBUG::2012-08-28
>> 09:17:26,610::task::1151::TaskManager.Task::(prepare)
>> Task=`700181ad-b9d4-411b-bfbc-25a28aa288e2`::finished: {'statuslist': 
>> [{'status': 0, 'id': '00000000-0000-0000-0000-000000000000'}]}
>> 
>> Thread-99793::DEBUG::2012-08-28
>> 09:17:26,611::task::568::TaskManager.Task::(_updateState)
>> Task=`700181ad-b9d4-411b-bfbc-25a28aa288e2`::moving from state 
>> preparing -> state finished
>> 
>> Thread-99793::DEBUG::2012-08-28
>> 09:17:26,611::resourceManager::809::ResourceManager.Owner::(releaseAl
>> l
>> ) Owner.releaseAll requests {} resources {}
>> 
>> Thread-99793::DEBUG::2012-08-28
>> 09:17:26,611::resourceManager::844::ResourceManager.Owner::(cancelAll
>> )
>> Owner.cancelAll requests {}
>> 
>> Thread-99793::DEBUG::2012-08-28
>> 09:17:26,611::task::957::TaskManager.Task::(_decref)
>> Task=`700181ad-b9d4-411b-bfbc-25a28aa288e2`::ref 0 aborting False
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,653::BindingXMLRPC::160::vds::(wrapper) [10.1.20.2]
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,654::task::568::TaskManager.Task::(_updateState)
>> Task=`8a3e33d5-4cfe-4ad6-87e9-55082b67394e`::moving from state init 
>> -> state preparing
>> 
>> Thread-99794::INFO::2012-08-28
>> 09:17:26,654::logUtils::37::dispatcher::(wrapper) Run and protect: 
>> getStorageDomainsList(spUUID='00000000-0000-0000-0000-000000000000',
>> domainClass=3, storageType=1, remotePath='10.1.20.2:/home/nfs4',
>> options=None)
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,654::misc::1061::SamplingMethod::(__call__) Trying to enter 
>> sampling method (storage.sdc.refreshStorage)
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,654::misc::1063::SamplingMethod::(__call__) Got in to 
>> sampling method
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,655::misc::1061::SamplingMethod::(__call__) Trying to enter 
>> sampling method (storage.iscsi.rescan)
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,655::misc::1063::SamplingMethod::(__call__) Got in to 
>> sampling method
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,655::__init__::1164::Storage.Misc.excCmd::(_log)
>> '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None)
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,677::__init__::1164::Storage.Misc.excCmd::(_log) FAILED: 
>> <err> = 'iscsiadm: No session found.\n'; <rc> = 21
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,678::misc::1071::SamplingMethod::(__call__) Returning last 
>> result
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,843::__init__::1164::Storage.Misc.excCmd::(_log)
>> '/usr/bin/sudo -n /sbin/multipath' (cwd None)
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,935::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: 
>> <err> = ''; <rc> = 0
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,936::lvm::477::OperationMutex::(_invalidateAllPvs) Operation 
>> 'lvm invalidate operation' got the operation mutex
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,941::lvm::479::OperationMutex::(_invalidateAllPvs) Operation 
>> 'lvm invalidate operation' released the operation mutex
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,941::lvm::488::OperationMutex::(_invalidateAllVgs) Operation 
>> 'lvm invalidate operation' got the operation mutex
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,941::lvm::490::OperationMutex::(_invalidateAllVgs) Operation 
>> 'lvm invalidate operation' released the operation mutex
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,942::lvm::508::OperationMutex::(_invalidateAllLvs) Operation 
>> 'lvm invalidate operation' got the operation mutex
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,942::lvm::510::OperationMutex::(_invalidateAllLvs) Operation 
>> 'lvm invalidate operation' released the operation mutex
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,942::misc::1071::SamplingMethod::(__call__) Returning last 
>> result
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,942::lvm::368::OperationMutex::(_reloadvgs) Operation 'lvm 
>> reload operation' got the operation mutex
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:26,944::__init__::1164::Storage.Misc.excCmd::(_log)
>> '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { preferred_names 
>> = [\\"^/dev/mapper/\\"] ignore_suspended_devices=1 
>> write_cache_state=0
>> disable_after_error_count=3 filter = [ \\"a%35000c50001770ea3%\\", 
>> \\"r%.*%\\" ] }  global { locking_type=1  prioritise_write_locks=1
>> wait_for_locks=1 }  backup {  retain_min = 50  retain_days = 0 } " 
>> --noheadings --units b --nosuffix --separator | -o 
>> uuid,name,attr,size,free,extent_size,extent_count,free_count,tags,vg_mda_size,vg_mda_free'
>> (cwd None)
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:27,146::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: 
>> <err> = "  Couldn't find device with uuid 
>> sySrjj-b79L-jZ9D-8ZUe-UAwz-r08M-l7YWxe.\n"; <rc> = 0
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:27,148::lvm::397::OperationMutex::(_reloadvgs) Operation 'lvm 
>> reload operation' released the operation mutex
>> 
>> Thread-99794::INFO::2012-08-28
>> 09:17:27,156::logUtils::39::dispatcher::(wrapper) Run and protect: 
>> getStorageDomainsList, Return response: {'domlist': []}
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:27,157::task::1151::TaskManager.Task::(prepare)
>> Task=`8a3e33d5-4cfe-4ad6-87e9-55082b67394e`::finished: {'domlist': 
>> []}
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:27,157::task::568::TaskManager.Task::(_updateState)
>> Task=`8a3e33d5-4cfe-4ad6-87e9-55082b67394e`::moving from state 
>> preparing -> state finished
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:27,157::resourceManager::809::ResourceManager.Owner::(releaseAl
>> l
>> ) Owner.releaseAll requests {} resources {}
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:27,157::resourceManager::844::ResourceManager.Owner::(cancelAll
>> )
>> Owner.cancelAll requests {}
>> 
>> Thread-99794::DEBUG::2012-08-28
>> 09:17:27,158::task::957::TaskManager.Task::(_decref)
>> Task=`8a3e33d5-4cfe-4ad6-87e9-55082b67394e`::ref 0 aborting False
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,232::BindingXMLRPC::160::vds::(wrapper) [10.1.20.2]
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,232::task::568::TaskManager.Task::(_updateState)
>> Task=`bfd73de7-79b7-4c24-b87b-7ecd234ce505`::moving from state init 
>> -> state preparing
>> 
>> Thread-99803::INFO::2012-08-28
>> 09:17:27,233::logUtils::37::dispatcher::(wrapper) Run and protect: 
>> disconnectStorageServer(domType=1,
>> spUUID='00000000-0000-0000-0000-000000000000', conList=[{'connection': 
>> '10.1.20.2:/home/nfs4', 'iqn': '', 'portal': '', 'user': '',
>> 'password': '******', 'id': '00000000-0000-0000-0000-000000000000',
>> 'port': ''}], options=None)
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,233::__init__::1164::Storage.Misc.excCmd::(_log)
>> '/usr/bin/sudo -n /bin/umount -f -l
>> /rhev/data-center/mnt/10.1.20.2:_home_nfs4' (cwd None)
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,265::misc::1061::SamplingMethod::(__call__) Trying to enter 
>> sampling method (storage.sdc.refreshStorage)
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,266::misc::1063::SamplingMethod::(__call__) Got in to 
>> sampling method
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,266::misc::1061::SamplingMethod::(__call__) Trying to enter 
>> sampling method (storage.iscsi.rescan)
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,266::misc::1063::SamplingMethod::(__call__) Got in to 
>> sampling method
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,267::__init__::1164::Storage.Misc.excCmd::(_log)
>> '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None)
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,284::__init__::1164::Storage.Misc.excCmd::(_log) FAILED: 
>> <err> = 'iscsiadm: No session found.\n'; <rc> = 21
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,284::misc::1071::SamplingMethod::(__call__) Returning last 
>> result
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,449::__init__::1164::Storage.Misc.excCmd::(_log)
>> '/usr/bin/sudo -n /sbin/multipath' (cwd None)
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,514::__init__::1164::Storage.Misc.excCmd::(_log) SUCCESS: 
>> <err> = ''; <rc> = 0
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,515::lvm::477::OperationMutex::(_invalidateAllPvs) Operation 
>> 'lvm invalidate operation' got the operation mutex
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,515::lvm::479::OperationMutex::(_invalidateAllPvs) Operation 
>> 'lvm invalidate operation' released the operation mutex
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,515::lvm::488::OperationMutex::(_invalidateAllVgs) Operation 
>> 'lvm invalidate operation' got the operation mutex
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,515::lvm::490::OperationMutex::(_invalidateAllVgs) Operation 
>> 'lvm invalidate operation' released the operation mutex
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,516::lvm::508::OperationMutex::(_invalidateAllLvs) Operation 
>> 'lvm invalidate operation' got the operation mutex
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,516::lvm::510::OperationMutex::(_invalidateAllLvs) Operation 
>> 'lvm invalidate operation' released the operation mutex
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,516::misc::1071::SamplingMethod::(__call__) Returning last 
>> result
>> 
>> Thread-99803::INFO::2012-08-28
>> 09:17:27,516::logUtils::39::dispatcher::(wrapper) Run and protect: 
>> disconnectStorageServer, Return response: {'statuslist': [{'status': 
>> 0, 'id': '00000000-0000-0000-0000-000000000000'}]}
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,517::task::1151::TaskManager.Task::(prepare)
>> Task=`bfd73de7-79b7-4c24-b87b-7ecd234ce505`::finished: {'statuslist': 
>> [{'status': 0, 'id': '00000000-0000-0000-0000-000000000000'}]}
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,517::task::568::TaskManager.Task::(_updateState)
>> Task=`bfd73de7-79b7-4c24-b87b-7ecd234ce505`::moving from state 
>> preparing -> state finished
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,517::resourceManager::809::ResourceManager.Owner::(releaseAl
>> l
>> ) Owner.releaseAll requests {} resources {}
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,517::resourceManager::844::ResourceManager.Owner::(cancelAll
>> )
>> Owner.cancelAll requests {}
>> 
>> Thread-99803::DEBUG::2012-08-28
>> 09:17:27,517::task::957::TaskManager.Task::(_decref)
>> Task=`bfd73de7-79b7-4c24-b87b-7ecd234ce505`::ref 0 aborting False
>> 
>> Version:
>> 
>> [root at noc-3-synt ~]# rpm -qa | grep lvm
>> 
>> lvm2-2.02.95-10.el6.x86_64
>> 
>> lvm2-libs-2.02.95-10.el6.x86_64
>> 
>> [root at noc-3-synt ~]# rpm -qa | grep vdsm
>> 
>> vdsm-xmlrpc-4.10.0-0.283.13.el6.noarch
>> 
>> vdsm-python-4.10.0-0.283.13.el6.x86_64
>> 
>> vdsm-gluster-4.10.0-0.283.13.el6.noarch
>> 
>> vdsm-4.10.0-0.283.13.el6.x86_64
>> 
>> vdsm-cli-4.10.0-0.283.13.el6.noarch
>> 
>> [root at noc-2-synt ~]# cat
>> /home/nfs4/b23c7ab6-b1d4-4888-8d4a-adc78e61db38/dom_md/metadata
>> 
>> CLASS=Backup
>> 
>> DESCRIPTION=export
>> 
>> IOOPTIMEOUTSEC=1
>> 
>> LEASERETRIES=3
>> 
>> LEASETIMESEC=5
>> 
>> LOCKPOLICY=
>> 
>> LOCKRENEWALINTERVALSEC=5
>> 
>> MASTER_VERSION=0
>> 
>> POOL_UUID=dd424005-9444-4c73-8653-3b5192ec39ae
>> 
>> REMOTE_PATH=10.1.20.2:/home/nfs4
>> 
>> ROLE=Regular
>> 
>> SDUUID=b23c7ab6-b1d4-4888-8d4a-adc78e61db38
>> 
>> TYPE=NFS
>> 
>> VERSION=0
>> 
>> _SHA_CKSUM=e59674cf8d506af569a6540b9d075147da3b490d
>> 
>> [root at noc-2-synt ~]#
>> 
>> 
>> 
>> _______________________________________________
>> Users mailing list
>> Users at ovirt.org
>> http://lists.ovirt.org/mailman/listinfo/users
> 
> 
> 
> _______________________________________________
> Users mailing list
> Users at ovirt.org
> http://lists.ovirt.org/mailman/listinfo/users
> 





More information about the Users mailing list