[Users] Error importing export storage
зоррыч
zorro at megatrone.ru
Tue Aug 28 18:34:44 UTC 2012
Again reproduce this problem.
algorithm:
1. Create export storage, using ovirt (successfully)
2. Mounting it in a data center ovirt (successfully)
3. umount export storage in ovirt (without deleting the files)
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
-----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.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 at 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 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::(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 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