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.
On Aug 28, 2012, at 21:34, зоррыч <zorro@megatrone.ru> wrote: 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@ovirt.org [mailto:users-bounces@ovirt.org] On Behalf Of зоррыч Sent: Tuesday, August 28, 2012 7:10 PM To: 'Haim' Cc: users@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.ValidateStorageServerConnectionVDSCommand] (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.ValidateStorageServerConnectionVDSCommand] (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.ConnectStorageServerVDSCommand] (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.RemoveStorageServerConnectionCommand] (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.DisconnectStorageServerVDSCommand] (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.DisconnectStorageServerVDSCommand] (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.ValidateStorageServerConnectionVDSCommand] (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.ValidateStorageServerConnectionVDSCommand] (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.ConnectStorageServerVDSCommand] (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.ConnectStorageServerVDSCommand] (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@7cde8097), log id: 2f278e3 2012-08-28 10:49:37,846 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetStorageDomainsListVDSCommand] (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.HSMGetStorageDomainsListVDSCommand] (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.RemoveStorageServerConnectionCommand] (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.DisconnectStorageServerVDSCommand] (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.DisconnectStorageServerVDSCommand] (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_mda_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@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@noc-3-synt ~]# mkdir /rhev/data-center/mnt/10.1.20.2:_home_nfs4 [root@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@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@noc-3-synt ~]# vdsClient -s 0 getStorageDomainsList c1a00353-e7e0-4ff6-822a-faa0e7243137 b0a0e76b-f983-405b-a0af-d0314a1c381a
[root@noc-3-synt ~]# vdsClient -s 0 getStorageDomainInfo b23c7ab6-b1d4-4888-8d4a-adc78e61db38 Storage domain does not exist: ('b23c7ab6-b1d4-4888-8d4a-adc78e61db38',) [root@noc-3-synt ~]#
-----Original Message----- From: Haim [mailto:hateya@redhat.com] Sent: Tuesday, August 28, 2012 6:44 PM To: зоррыч Cc: users@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::(releaseAll ) 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::(releaseAll ) 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::(releaseAll ) 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::(releaseAll ) 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::(releaseAll ) 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@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@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@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@noc-2-synt ~]#
_______________________________________________ Users mailing list Users@ovirt.org http://lists.ovirt.org/mailman/listinfo/users
_______________________________________________ Users mailing list Users@ovirt.org http://lists.ovirt.org/mailman/listinfo/users