Thread-268::DEBUG::2012-11-07 21:23:56,869::resourceManager::212::ResourceManager.Request::(grant) ResName=`Storage.f90a0d1c-06ca-11e2-a05b-00151712f280`ReqID=`deb48132-9c75-4d88-9779-1728c537b599`::Granted request Thread-268::DEBUG::2012-11-07 21:23:56,870::task::794::TaskManager.Task::(resourceAcquired) Task=`bb36e4e5-a305-4596-92f4-e292515921df`::_resourcesAcquired: Storage.f90a0d1c-06ca-11e2-a05b-00151712f280 (shared) Thread-268::DEBUG::2012-11-07 21:23:56,870::task::957::TaskManager.Task::(_decref) Task=`bb36e4e5-a305-4596-92f4-e292515921df`::ref 1 aborting False Thread-268::INFO::2012-11-07 21:23:56,873::logUtils::39::dispatcher::(wrapper) Run and protect: getStoragePoolInfo, Return response: {'info': {'spm_id': 1, 'master_uuid': 'c331a800-839d-4d23-9059-870a7471240a', 'name': 'Azeroth', 'version': '3', 'domains': '0549ee91-4498-4130-8c23-4c173b5c0959:Active,d8b55105-c90a-465d-9803-8130da9a671e:Active,67534cca-1327-462a-b455-a04464084b31:Active,c331a800-839d-4d23-9059-870a7471240a:Active,f8984825-ff8d-43d9-91db-0d0959f8bae9:Active,c434056e-96be-4702-8beb-82a408a5c8cb:Active,f7da73c7-b5fe-48b6-93a0-0c773018c94f:Active,82e3b34a-6f89-4299-8cd8-2cc8f973a3b4:Active,e615c975-6b00-469f-8fb6-ff58ae3fdb2c:Active,5bc86532-55f7-4a91-a52c-fad261f322d5:Active,1130b87a-3b34-45d6-8016-d435825c68ef:Active', 'pool_status': 'connected', 'isoprefix': '/rhev/data-center/f90a0d1c-06ca-11e2-a05b-00151712f280/d8b55105-c90a-465d-9803-8130da9a671e/images/11111111-1111-1111-1111-111111111111', 'type': 'NFS', 'master_ver': 160, 'lver': 2}, 'dominfo': {'0549ee91-4498-4130-8c23-4c173b5c0959': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'd8b55105-c90a-465d-9803-8130da9a671e': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'e615c975-6b00-469f-8fb6-ff58ae3fdb2c': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'c331a800-839d-4d23-9059-870a7471240a': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'f8984825-ff8d-43d9-91db-0d0959f8bae9': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'c434056e-96be-4702-8beb-82a408a5c8cb': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'f7da73c7-b5fe-48b6-93a0-0c773018c94f': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '82e3b34a-6f89-4299-8cd8-2cc8f973a3b4': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '67534cca-1327-462a-b455-a04464084b31': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '5bc86532-55f7-4a91-a52c-fad261f322d5': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '1130b87a-3b34-45d6-8016-d435825c68ef': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}}} Thread-268::DEBUG::2012-11-07 21:23:56,873::task::1151::TaskManager.Task::(prepare) Task=`bb36e4e5-a305-4596-92f4-e292515921df`::finished: {'info': {'spm_id': 1, 'master_uuid': 'c331a800-839d-4d23-9059-870a7471240a', 'name': 'Azeroth', 'version': '3', 'domains': '0549ee91-4498-4130-8c23-4c173b5c0959:Active,d8b55105-c90a-465d-9803-8130da9a671e:Active,67534cca-1327-462a-b455-a04464084b31:Active,c331a800-839d-4d23-9059-870a7471240a:Active,f8984825-ff8d-43d9-91db-0d0959f8bae9:Active,c434056e-96be-4702-8beb-82a408a5c8cb:Active,f7da73c7-b5fe-48b6-93a0-0c773018c94f:Active,82e3b34a-6f89-4299-8cd8-2cc8f973a3b4:Active,e615c975-6b00-469f-8fb6-ff58ae3fdb2c:Active,5bc86532-55f7-4a91-a52c-fad261f322d5:Active,1130b87a-3b34-45d6-8016-d435825c68ef:Active', 'pool_status': 'connected', 'isoprefix': '/rhev/data-center/f90a0d1c-06ca-11e2-a05b-00151712f280/d8b55105-c90a-465d-9803-8130da9a671e/images/11111111-1111-1111-1111-111111111111', 'type': 'NFS', 'master_ver': 160, 'lver': 2}, 'dominfo': {'0549ee91-4498-4130-8c23-4c173b5c0959': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'd8b55105-c90a-465d-9803-8130da9a671e': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'e615c975-6b00-469f-8fb6-ff58ae3fdb2c': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'c331a800-839d-4d23-9059-870a7471240a': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'f8984825-ff8d-43d9-91db-0d0959f8bae9': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'c434056e-96be-4702-8beb-82a408a5c8cb': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'f7da73c7-b5fe-48b6-93a0-0c773018c94f': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '82e3b34a-6f89-4299-8cd8-2cc8f973a3b4': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '67534cca-1327-462a-b455-a04464084b31': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '5bc86532-55f7-4a91-a52c-fad261f322d5': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '1130b87a-3b34-45d6-8016-d435825c68ef': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}}} Thread-268::DEBUG::2012-11-07 21:23:56,874::task::568::TaskManager.Task::(_updateState) Task=`bb36e4e5-a305-4596-92f4-e292515921df`::moving from state preparing -> state finished Thread-268::DEBUG::2012-11-07 21:23:56,874::resourceManager::809::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {'Storage.f90a0d1c-06ca-11e2-a05b-00151712f280': < ResourceRef 'Storage.f90a0d1c-06ca-11e2-a05b-00151712f280', isValid: 'True' obj: 'None'>} Thread-268::DEBUG::2012-11-07 21:23:56,874::resourceManager::844::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-268::DEBUG::2012-11-07 21:23:56,874::resourceManager::538::ResourceManager::(releaseResource) Trying to release resource 'Storage.f90a0d1c-06ca-11e2-a05b-00151712f280' Thread-268::DEBUG::2012-11-07 21:23:56,874::resourceManager::553::ResourceManager::(releaseResource) Released resource 'Storage.f90a0d1c-06ca-11e2-a05b-00151712f280' (0 active users) Thread-268::DEBUG::2012-11-07 21:23:56,874::resourceManager::558::ResourceManager::(releaseResource) Resource 'Storage.f90a0d1c-06ca-11e2-a05b-00151712f280' is free, finding out if anyone is waiting for it. Thread-268::DEBUG::2012-11-07 21:23:56,875::resourceManager::565::ResourceManager::(releaseResource) No one is waiting for resource 'Storage.f90a0d1c-06ca-11e2-a05b-00151712f280', Clearing records. Thread-268::DEBUG::2012-11-07 21:23:56,875::task::957::TaskManager.Task::(_decref) Task=`bb36e4e5-a305-4596-92f4-e292515921df`::ref 0 aborting False Thread-270::DEBUG::2012-11-07 21:23:59,233::task::568::TaskManager.Task::(_updateState) Task=`635a225a-ed01-45bf-a73e-0c06050d6b24`::moving from state init -> state preparing Thread-270::INFO::2012-11-07 21:23:59,233::logUtils::37::dispatcher::(wrapper) Run and protect: repoStats(options=None) Thread-270::INFO::2012-11-07 21:23:59,234::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {'0549ee91-4498-4130-8c23-4c173b5c0959': {'delay': '0.00227499008179', 'lastCheck': '5.6', 'code': 0, 'valid': True}, 'd8b55105-c90a-465d-9803-8130da9a671e': {'delay': '0.00180912017822', 'lastCheck': '5.6', 'code': 0, 'valid': True}, 'e615c975-6b00-469f-8fb6-ff58ae3fdb2c': {'delay': '0.00380206108093', 'lastCheck': '5.5', 'code': 0, 'valid': True}, 'c331a800-839d-4d23-9059-870a7471240a': {'delay': '0.00253009796143', 'lastCheck': '5.8', 'code': 0, 'valid': True}, 'f8984825-ff8d-43d9-91db-0d0959f8bae9': {'delay': '0.0022668838501', 'lastCheck': '5.5', 'code': 0, 'valid': True}, 'c434056e-96be-4702-8beb-82a408a5c8cb': {'delay': '0.00436902046204', 'lastCheck': '5.5', 'code': 0, 'valid': True}, 'f7da73c7-b5fe-48b6-93a0-0c773018c94f': {'delay': '0.00419092178345', 'lastCheck': '5.5', 'code': 0, 'valid': True}, '82e3b34a-6f89-4299-8cd8-2cc8f973a3b4': {'delay': '0.00350999832153', 'lastCheck': '5.5', 'code': 0, 'valid': True}, '67534cca-1327-462a-b455-a04464084b31': {'delay': '0.00193190574646', 'lastCheck': '5.5', 'code': 0, 'valid': True}, '5bc86532-55f7-4a91-a52c-fad261f322d5': {'delay': '0.00200700759888', 'lastCheck': '5.4', 'code': 0, 'valid': True}, '1130b87a-3b34-45d6-8016-d435825c68ef': {'delay': '0.00202393531799', 'lastCheck': '5.5', 'code': 0, 'valid': True}} Thread-270::DEBUG::2012-11-07 21:23:59,234::task::1151::TaskManager.Task::(prepare) Task=`635a225a-ed01-45bf-a73e-0c06050d6b24`::finished: {'0549ee91-4498-4130-8c23-4c173b5c0959': {'delay': '0.00227499008179', 'lastCheck': '5.6', 'code': 0, 'valid': True}, 'd8b55105-c90a-465d-9803-8130da9a671e': {'delay': '0.00180912017822', 'lastCheck': '5.6', 'code': 0, 'valid': True}, 'e615c975-6b00-469f-8fb6-ff58ae3fdb2c': {'delay': '0.00380206108093', 'lastCheck': '5.5', 'code': 0, 'valid': True}, 'c331a800-839d-4d23-9059-870a7471240a': {'delay': '0.00253009796143', 'lastCheck': '5.8', 'code': 0, 'valid': True}, 'f8984825-ff8d-43d9-91db-0d0959f8bae9': {'delay': '0.0022668838501', 'lastCheck': '5.5', 'code': 0, 'valid': True}, 'c434056e-96be-4702-8beb-82a408a5c8cb': {'delay': '0.00436902046204', 'lastCheck': '5.5', 'code': 0, 'valid': True}, 'f7da73c7-b5fe-48b6-93a0-0c773018c94f': {'delay': '0.00419092178345', 'lastCheck': '5.5', 'code': 0, 'valid': True}, '82e3b34a-6f89-4299-8cd8-2cc8f973a3b4': {'delay': '0.00350999832153', 'lastCheck': '5.5', 'code': 0, 'valid': True}, '67534cca-1327-462a-b455-a04464084b31': {'delay': '0.00193190574646', 'lastCheck': '5.5', 'code': 0, 'valid': True}, '5bc86532-55f7-4a91-a52c-fad261f322d5': {'delay': '0.00200700759888', 'lastCheck': '5.4', 'code': 0, 'valid': True}, '1130b87a-3b34-45d6-8016-d435825c68ef': {'delay': '0.00202393531799', 'lastCheck': '5.5', 'code': 0, 'valid': True}} Thread-270::DEBUG::2012-11-07 21:23:59,234::task::568::TaskManager.Task::(_updateState) Task=`635a225a-ed01-45bf-a73e-0c06050d6b24`::moving from state preparing -> state finished Thread-270::DEBUG::2012-11-07 21:23:59,234::resourceManager::809::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {} Thread-270::DEBUG::2012-11-07 21:23:59,235::resourceManager::844::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-270::DEBUG::2012-11-07 21:23:59,235::task::957::TaskManager.Task::(_decref) Task=`635a225a-ed01-45bf-a73e-0c06050d6b24`::ref 0 aborting False Thread-275::DEBUG::2012-11-07 21:24:07,059::BindingXMLRPC::161::vds::(wrapper) [3.57.111.30] Thread-275::DEBUG::2012-11-07 21:24:07,059::task::568::TaskManager.Task::(_updateState) Task=`3c8af79a-be86-4e20-9b27-4b854c65273e`::moving from state init -> state preparing Thread-275::INFO::2012-11-07 21:24:07,060::logUtils::37::dispatcher::(wrapper) Run and protect: getSpmStatus(spUUID='f90a0d1c-06ca-11e2-a05b-00151712f280', options=None) Thread-275::INFO::2012-11-07 21:24:07,060::logUtils::39::dispatcher::(wrapper) Run and protect: getSpmStatus, Return response: {'spm_st': {'spmId': 1, 'spmStatus': 'SPM', 'spmLver': 2}} Thread-275::DEBUG::2012-11-07 21:24:07,060::task::1151::TaskManager.Task::(prepare) Task=`3c8af79a-be86-4e20-9b27-4b854c65273e`::finished: {'spm_st': {'spmId': 1, 'spmStatus': 'SPM', 'spmLver': 2}} Thread-275::DEBUG::2012-11-07 21:24:07,060::task::568::TaskManager.Task::(_updateState) Task=`3c8af79a-be86-4e20-9b27-4b854c65273e`::moving from state preparing -> state finished Thread-275::DEBUG::2012-11-07 21:24:07,060::resourceManager::809::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {} Thread-275::DEBUG::2012-11-07 21:24:07,060::resourceManager::844::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-275::DEBUG::2012-11-07 21:24:07,061::task::957::TaskManager.Task::(_decref) Task=`3c8af79a-be86-4e20-9b27-4b854c65273e`::ref 0 aborting False Thread-276::DEBUG::2012-11-07 21:24:07,068::BindingXMLRPC::161::vds::(wrapper) [3.57.111.30] Thread-276::DEBUG::2012-11-07 21:24:07,068::task::568::TaskManager.Task::(_updateState) Task=`3539595a-6805-4131-9f61-7270cc5bff92`::moving from state init -> state preparing Thread-276::INFO::2012-11-07 21:24:07,068::logUtils::37::dispatcher::(wrapper) Run and protect: getStoragePoolInfo(spUUID='f90a0d1c-06ca-11e2-a05b-00151712f280', options=None) Thread-276::DEBUG::2012-11-07 21:24:07,069::resourceManager::175::ResourceManager.Request::(__init__) ResName=`Storage.f90a0d1c-06ca-11e2-a05b-00151712f280`ReqID=`321c6776-a0c4-4131-a48d-f42e9fb4da15`::Request was made in '/usr/share/vdsm/storage/resourceManager.py' line '174' at '__init__' Thread-276::DEBUG::2012-11-07 21:24:07,069::resourceManager::486::ResourceManager::(registerResource) Trying to register resource 'Storage.f90a0d1c-06ca-11e2-a05b-00151712f280' for lock type 'shared' Thread-276::DEBUG::2012-11-07 21:24:07,069::resourceManager::528::ResourceManager::(registerResource) Resource 'Storage.f90a0d1c-06ca-11e2-a05b-00151712f280' is free. Now locking as 'shared' (1 active user) Thread-276::DEBUG::2012-11-07 21:24:07,069::resourceManager::212::ResourceManager.Request::(grant) ResName=`Storage.f90a0d1c-06ca-11e2-a05b-00151712f280`ReqID=`321c6776-a0c4-4131-a48d-f42e9fb4da15`::Granted request Thread-276::DEBUG::2012-11-07 21:24:07,070::task::794::TaskManager.Task::(resourceAcquired) Task=`3539595a-6805-4131-9f61-7270cc5bff92`::_resourcesAcquired: Storage.f90a0d1c-06ca-11e2-a05b-00151712f280 (shared) Thread-276::DEBUG::2012-11-07 21:24:07,070::task::957::TaskManager.Task::(_decref) Task=`3539595a-6805-4131-9f61-7270cc5bff92`::ref 1 aborting False Thread-276::INFO::2012-11-07 21:24:07,073::logUtils::39::dispatcher::(wrapper) Run and protect: getStoragePoolInfo, Return response: {'info': {'spm_id': 1, 'master_uuid': 'c331a800-839d-4d23-9059-870a7471240a', 'name': 'Azeroth', 'version': '3', 'domains': '0549ee91-4498-4130-8c23-4c173b5c0959:Active,d8b55105-c90a-465d-9803-8130da9a671e:Active,67534cca-1327-462a-b455-a04464084b31:Active,c331a800-839d-4d23-9059-870a7471240a:Active,f8984825-ff8d-43d9-91db-0d0959f8bae9:Active,c434056e-96be-4702-8beb-82a408a5c8cb:Active,f7da73c7-b5fe-48b6-93a0-0c773018c94f:Active,82e3b34a-6f89-4299-8cd8-2cc8f973a3b4:Active,e615c975-6b00-469f-8fb6-ff58ae3fdb2c:Active,5bc86532-55f7-4a91-a52c-fad261f322d5:Active,1130b87a-3b34-45d6-8016-d435825c68ef:Active', 'pool_status': 'connected', 'isoprefix': '/rhev/data-center/f90a0d1c-06ca-11e2-a05b-00151712f280/d8b55105-c90a-465d-9803-8130da9a671e/images/11111111-1111-1111-1111-111111111111', 'type': 'NFS', 'master_ver': 160, 'lver': 2}, 'dominfo': {'0549ee91-4498-4130-8c23-4c173b5c0959': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'd8b55105-c90a-465d-9803-8130da9a671e': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'e615c975-6b00-469f-8fb6-ff58ae3fdb2c': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'c331a800-839d-4d23-9059-870a7471240a': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'f8984825-ff8d-43d9-91db-0d0959f8bae9': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'c434056e-96be-4702-8beb-82a408a5c8cb': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'f7da73c7-b5fe-48b6-93a0-0c773018c94f': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '82e3b34a-6f89-4299-8cd8-2cc8f973a3b4': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '67534cca-1327-462a-b455-a04464084b31': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '5bc86532-55f7-4a91-a52c-fad261f322d5': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '1130b87a-3b34-45d6-8016-d435825c68ef': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}}} Thread-276::DEBUG::2012-11-07 21:24:07,073::task::1151::TaskManager.Task::(prepare) Task=`3539595a-6805-4131-9f61-7270cc5bff92`::finished: {'info': {'spm_id': 1, 'master_uuid': 'c331a800-839d-4d23-9059-870a7471240a', 'name': 'Azeroth', 'version': '3', 'domains': '0549ee91-4498-4130-8c23-4c173b5c0959:Active,d8b55105-c90a-465d-9803-8130da9a671e:Active,67534cca-1327-462a-b455-a04464084b31:Active,c331a800-839d-4d23-9059-870a7471240a:Active,f8984825-ff8d-43d9-91db-0d0959f8bae9:Active,c434056e-96be-4702-8beb-82a408a5c8cb:Active,f7da73c7-b5fe-48b6-93a0-0c773018c94f:Active,82e3b34a-6f89-4299-8cd8-2cc8f973a3b4:Active,e615c975-6b00-469f-8fb6-ff58ae3fdb2c:Active,5bc86532-55f7-4a91-a52c-fad261f322d5:Active,1130b87a-3b34-45d6-8016-d435825c68ef:Active', 'pool_status': 'connected', 'isoprefix': '/rhev/data-center/f90a0d1c-06ca-11e2-a05b-00151712f280/d8b55105-c90a-465d-9803-8130da9a671e/images/11111111-1111-1111-1111-111111111111', 'type': 'NFS', 'master_ver': 160, 'lver': 2}, 'dominfo': {'0549ee91-4498-4130-8c23-4c173b5c0959': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'd8b55105-c90a-465d-9803-8130da9a671e': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'e615c975-6b00-469f-8fb6-ff58ae3fdb2c': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'c331a800-839d-4d23-9059-870a7471240a': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'f8984825-ff8d-43d9-91db-0d0959f8bae9': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'c434056e-96be-4702-8beb-82a408a5c8cb': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, 'f7da73c7-b5fe-48b6-93a0-0c773018c94f': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '82e3b34a-6f89-4299-8cd8-2cc8f973a3b4': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '67534cca-1327-462a-b455-a04464084b31': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '5bc86532-55f7-4a91-a52c-fad261f322d5': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}, '1130b87a-3b34-45d6-8016-d435825c68ef': {'status': 'Active', 'diskfree': '5391642525696', 'alerts': [], 'disktotal': '5894624509952'}}} Thread-276::DEBUG::2012-11-07 21:24:07,073::task::568::TaskManager.Task::(_updateState) Task=`3539595a-6805-4131-9f61-7270cc5bff92`::moving from state preparing -> state finished Thread-276::DEBUG::2012-11-07 21:24:07,073::resourceManager::809::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {'Storage.f90a0d1c-06ca-11e2-a05b-00151712f280': < ResourceRef 'Storage.f90a0d1c-06ca-11e2-a05b-00151712f280', isValid: 'True' obj: 'None'>} Thread-276::DEBUG::2012-11-07 21:24:07,074::resourceManager::844::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-276::DEBUG::2012-11-07 21:24:07,074::resourceManager::538::ResourceManager::(releaseResource) Trying to release resource 'Storage.f90a0d1c-06ca-11e2-a05b-00151712f280' Thread-276::DEBUG::2012-11-07 21:24:07,074::resourceManager::553::ResourceManager::(releaseResource) Released resource 'Storage.f90a0d1c-06ca-11e2-a05b-00151712f280' (0 active users) Thread-276::DEBUG::2012-11-07 21:24:07,074::resourceManager::558::ResourceManager::(releaseResource) Resource 'Storage.f90a0d1c-06ca-11e2-a05b-00151712f280' is free, finding out if anyone is waiting for it. Thread-276::DEBUG::2012-11-07 21:24:07,074::resourceManager::565::ResourceManager::(releaseResource) No one is waiting for resource 'Storage.f90a0d1c-06ca-11e2-a05b-00151712f280', Clearing records. Thread-276::DEBUG::2012-11-07 21:24:07,074::task::957::TaskManager.Task::(_decref) Task=`3539595a-6805-4131-9f61-7270cc5bff92`::ref 0 aborting False