5:22 a.m.
After an normal "yum update" i am unable to get one of the storage
domains "UP".
My systems is running Centos 6.3.
If I try to activate the domain in GUI I got following errors:
---------------------------------
2012-08-14 12:16:22,594 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(pool-5-thread-50) [539cbd7e] Lock Acquired to object EngineLock
[exclusiveLocks= key:
org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand value:
5de36f78-8303-401b-b6c3-e04091077f9e
2012-08-14 12:16:22,610 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(pool-5-thread-50) [539cbd7e] Running command:
ActivateStorageDomainCommand internal: false. Entities affected : ID:
5de36f78-8303-401b-b6c3-e04091077f9e Type: Storage
2012-08-14 12:16:22,618 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(pool-5-thread-50) [539cbd7e] Lock freed to object EngineLock
[exclusiveLocks= key:
org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand value:
5de36f78-8303-401b-b6c3-e04091077f9e
2012-08-14 12:16:22,709 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand]
(pool-5-thread-50) [539cbd7e] START,
ActivateStorageDomainVDSCommand(storagePoolId =
64a0f560-b9a1-4c87-8a30-0967b4ce3c81, ignoreFailoverLimit = false,
compatabilityVersion = null, storageDomainId =
5de36f78-8303-401b-b6c3-e04091077f9e), log id: 152cc8c3
2012-08-14 12:16:25,050 ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase]
(pool-5-thread-50) [539cbd7e] Error code StorageDomainDoesNotExist and
error message IRSGenericException: IRSErrorException: Failed to
ActivateStorageDomainVDS, error = Storage domain does not exist:
('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 12:16:25,050 ERROR
[org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(pool-5-thread-50) [539cbd7e]
IrsBroker::Failed::ActivateStorageDomainVDS due to: IRSErrorException:
IRSGenericException: IRSErrorException: Failed to
ActivateStorageDomainVDS, error = Storage domain does not exist:
('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 12:16:25,058 ERROR
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(pool-5-thread-50) [539cbd7e] Command
org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand throw Vdc
Bll exception. With error message VdcBLLException:
org.ovirt.engine.core.vdsbroker.irsbroker.IRSErrorException:
IRSGenericException: IRSErrorException: Failed to
ActivateStorageDomainVDS, error = Storage domain does not exist:
('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 12:16:25,074 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(pool-5-thread-50) [539cbd7e] Command
[id=6db5eb90-af14-43f7-8494-d59528a77c27]: Compensating
CHANGED_STATUS_ONLY of
org.ovirt.engine.core.common.businessentities.storage_pool_iso_map;
snapshot: EntityStatusSnapshot [id=storagePoolId =
64a0f560-b9a1-4c87-8a30-0967b4ce3c81, storageId =
5de36f78-8303-401b-b6c3-e04091077f9e, status=InActive].
-------------------------------------
Ho can I try to resolv it?
Regards //Ricky
5:56 a.m.
Hi Ricky can you please add the log of VDSM, also the full engine log.
Regards,
Maor
On 08/14/2012 01:22 PM, Ricky Schneberger wrote:
After an normal "yum update" i am unable to get one of the
storage
domains "UP".
My systems is running Centos 6.3.
If I try to activate the domain in GUI I got following errors:
---------------------------------
2012-08-14 12:16:22,594 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(pool-5-thread-50) [539cbd7e] Lock Acquired to object EngineLock
[exclusiveLocks= key:
org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand value:
5de36f78-8303-401b-b6c3-e04091077f9e
2012-08-14 12:16:22,610 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(pool-5-thread-50) [539cbd7e] Running command:
ActivateStorageDomainCommand internal: false. Entities affected : ID:
5de36f78-8303-401b-b6c3-e04091077f9e Type: Storage
2012-08-14 12:16:22,618 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(pool-5-thread-50) [539cbd7e] Lock freed to object EngineLock
[exclusiveLocks= key:
org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand value:
5de36f78-8303-401b-b6c3-e04091077f9e
2012-08-14 12:16:22,709 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand]
(pool-5-thread-50) [539cbd7e] START,
ActivateStorageDomainVDSCommand(storagePoolId =
64a0f560-b9a1-4c87-8a30-0967b4ce3c81, ignoreFailoverLimit = false,
compatabilityVersion = null, storageDomainId =
5de36f78-8303-401b-b6c3-e04091077f9e), log id: 152cc8c3
2012-08-14 12:16:25,050 ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase]
(pool-5-thread-50) [539cbd7e] Error code StorageDomainDoesNotExist and
error message IRSGenericException: IRSErrorException: Failed to
ActivateStorageDomainVDS, error = Storage domain does not exist:
('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 12:16:25,050 ERROR
[org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(pool-5-thread-50) [539cbd7e]
IrsBroker::Failed::ActivateStorageDomainVDS due to: IRSErrorException:
IRSGenericException: IRSErrorException: Failed to
ActivateStorageDomainVDS, error = Storage domain does not exist:
('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 12:16:25,058 ERROR
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(pool-5-thread-50) [539cbd7e] Command
org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand throw Vdc
Bll exception. With error message VdcBLLException:
org.ovirt.engine.core.vdsbroker.irsbroker.IRSErrorException:
IRSGenericException: IRSErrorException: Failed to
ActivateStorageDomainVDS, error = Storage domain does not exist:
('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 12:16:25,074 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(pool-5-thread-50) [539cbd7e] Command
[id=6db5eb90-af14-43f7-8494-d59528a77c27]: Compensating
CHANGED_STATUS_ONLY of
org.ovirt.engine.core.common.businessentities.storage_pool_iso_map;
snapshot: EntityStatusSnapshot [id=storagePoolId =
64a0f560-b9a1-4c87-8a30-0967b4ce3c81, storageId =
5de36f78-8303-401b-b6c3-e04091077f9e, status=InActive].
-------------------------------------
Ho can I try to resolv it?
Regards //Ricky
_______________________________________________
Users mailing list
Users(a)ovirt.org
http://lists.ovirt.org/mailman/listinfo/users
6:53 a.m.
This is a MIME-formatted message. If you see this text it means that your
E-mail software does not support MIME-formatted messages.
--=_bauhaus.teknikservice.nu-24776-1344945707-0001-2
Content-Type: text/plain; charset=iso-8859-1
Content-Transfer-Encoding: 7bit
Hi
I attached the logs.
//Ricky
On 2012-08-14 12:56, Maor Lipchuk wrote:
Hi Ricky can you please add the log of VDSM, also the full engine
log.
Regards,
Maor
On 08/14/2012 01:22 PM, Ricky Schneberger wrote:
> After an normal "yum update" i am unable to get one of the storage
> domains "UP".
>
> My systems is running Centos 6.3.
>
> If I try to activate the domain in GUI I got following errors:
>
> ---------------------------------
>
> 2012-08-14 12:16:22,594 INFO
> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
> (pool-5-thread-50) [539cbd7e] Lock Acquired to object EngineLock
> [exclusiveLocks= key:
> org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand value:
> 5de36f78-8303-401b-b6c3-e04091077f9e
> 2012-08-14 12:16:22,610 INFO
> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
> (pool-5-thread-50) [539cbd7e] Running command:
> ActivateStorageDomainCommand internal: false. Entities affected : ID:
> 5de36f78-8303-401b-b6c3-e04091077f9e Type: Storage
> 2012-08-14 12:16:22,618 INFO
> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
> (pool-5-thread-50) [539cbd7e] Lock freed to object EngineLock
> [exclusiveLocks= key:
> org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand value:
> 5de36f78-8303-401b-b6c3-e04091077f9e
> 2012-08-14 12:16:22,709 INFO
> [org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand]
> (pool-5-thread-50) [539cbd7e] START,
> ActivateStorageDomainVDSCommand(storagePoolId =
> 64a0f560-b9a1-4c87-8a30-0967b4ce3c81, ignoreFailoverLimit = false,
> compatabilityVersion = null, storageDomainId =
> 5de36f78-8303-401b-b6c3-e04091077f9e), log id: 152cc8c3
> 2012-08-14 12:16:25,050 ERROR
> [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase]
> (pool-5-thread-50) [539cbd7e] Error code StorageDomainDoesNotExist and
> error message IRSGenericException: IRSErrorException: Failed to
> ActivateStorageDomainVDS, error = Storage domain does not exist:
> ('5de36f78-8303-401b-b6c3-e04091077f9e',)
> 2012-08-14 12:16:25,050 ERROR
> [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
> (pool-5-thread-50) [539cbd7e]
> IrsBroker::Failed::ActivateStorageDomainVDS due to: IRSErrorException:
> IRSGenericException: IRSErrorException: Failed to
> ActivateStorageDomainVDS, error = Storage domain does not exist:
> ('5de36f78-8303-401b-b6c3-e04091077f9e',)
> 2012-08-14 12:16:25,058 ERROR
> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
> (pool-5-thread-50) [539cbd7e] Command
> org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand throw Vdc
> Bll exception. With error message VdcBLLException:
> org.ovirt.engine.core.vdsbroker.irsbroker.IRSErrorException:
> IRSGenericException: IRSErrorException: Failed to
> ActivateStorageDomainVDS, error = Storage domain does not exist:
> ('5de36f78-8303-401b-b6c3-e04091077f9e',)
> 2012-08-14 12:16:25,074 INFO
> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
> (pool-5-thread-50) [539cbd7e] Command
> [id=6db5eb90-af14-43f7-8494-d59528a77c27]: Compensating
> CHANGED_STATUS_ONLY of
> org.ovirt.engine.core.common.businessentities.storage_pool_iso_map;
> snapshot: EntityStatusSnapshot [id=storagePoolId =
> 64a0f560-b9a1-4c87-8a30-0967b4ce3c81, storageId =
> 5de36f78-8303-401b-b6c3-e04091077f9e, status=InActive].
> -------------------------------------
>
> Ho can I try to resolv it?
>
> Regards //Ricky
>
>
>
> _______________________________________________
> Users mailing list
> Users(a)ovirt.org
> http://lists.ovirt.org/mailman/listinfo/users
>
--=_bauhaus.teknikservice.nu-24776-1344945707-0001-2
Content-Type: text/x-log; name="engine.log"; charset=iso-8859-1
Content-Transfer-Encoding: 7bit
Content-Disposition: attachment;
filename="engine.log"
2012-08-14 13:40:00,127 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(QuartzScheduler_Worker-68) [535b7281] ActivateStorage Domain. After Connect all hosts to
pool. Time:8/14/12 1:40 PM
2012-08-14 13:40:00,128 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand]
(QuartzScheduler_Worker-68) [535b7281] START,
ActivateStorageDomainVDSCommand(storagePoolId = 64a0f560-b9a1-4c87-8a30-0967b4ce3c81,
ignoreFailoverLimit = false, compatabilityVersion = null, storageDomainId =
5de36f78-8303-401b-b6c3-e04091077f9e), log id: 709d91e5
2012-08-14 13:40:02,451 ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] (QuartzScheduler_Worker-68)
[535b7281] Failed in ActivateStorageDomainVDS method
2012-08-14 13:40:02,452 ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] (QuartzScheduler_Worker-68)
[535b7281] Error code StorageDomainDoesNotExist and error message IRSGenericException:
IRSErrorException: Failed to ActivateStorageDomainVDS, error = Storage domain does not
exist: ('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 13:40:02,453 ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(QuartzScheduler_Worker-68) [535b7281] IrsBroker::Failed::ActivateStorageDomainVDS due to:
IRSErrorException: IRSGenericException: IRSErrorException: Failed to
ActivateStorageDomainVDS, error = Storage domain does not exist:
('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 13:40:02,458 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand]
(QuartzScheduler_Worker-68) [535b7281] FINISH, ActivateStorageDomainVDSCommand, log id:
709d91e5
2012-08-14 13:40:02,458 ERROR
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(QuartzScheduler_Worker-68) [535b7281] Command
org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand throw Vdc Bll exception.
With error message VdcBLLException:
org.ovirt.engine.core.vdsbroker.irsbroker.IRSErrorException: IRSGenericException:
IRSErrorException: Failed to ActivateStorageDomainVDS, error = Storage domain does not
exist: ('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 13:40:02,468 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(QuartzScheduler_Worker-68) [535b7281] Command [id=72e050b9-ab4c-4bbf-b7ca-4765db1291fc]:
Compensating CHANGED_STATUS_ONLY of
org.ovirt.engine.core.common.businessentities.storage_pool_iso_map; snapshot:
EntityStatusSnapshot [id=storagePoolId = 64a0f560-b9a1-4c87-8a30-0967b4ce3c81, storageId =
5de36f78-8303-401b-b6c3-e04091077f9e, status=InActive].
2012-08-14 13:40:02,485 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager]
(QuartzScheduler_Worker-68) [535b7281] Checking autorecoverable storage domains done
2012-08-14 13:40:25,880 INFO [org.ovirt.engine.core.bll.DbUserCacheManager]
(QuartzScheduler_Worker-69) DbUserCacheManager::refreshAllUserData() - entered
2012-08-14 13:44:34,380 INFO [org.ovirt.engine.core.bll.LoginAdminUserCommand]
(http--0.0.0.0-8443-8) Running command: LoginAdminUserCommand internal: false.
2012-08-14 13:44:34,479 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,532 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,549 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,555 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,569 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,575 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,578 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,580 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,588 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,593 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,602 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,609 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,619 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,621 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,622 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,623 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,635 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,640 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,650 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,669 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,665 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,656 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,654 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,697 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,726 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,728 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,733 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,739 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,758 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,763 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,765 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,768 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,789 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,792 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,796 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,840 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,844 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,846 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,847 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,849 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,850 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,872 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,885 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,886 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,887 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,891 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,893 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,905 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,918 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,925 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,928 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,931 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,953 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,959 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,960 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,968 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,974 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,988 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,995 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:34,998 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,006 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,062 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,065 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,069 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,071 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,071 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,099 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,101 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,106 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,108 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,113 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,134 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,140 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,146 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,149 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,151 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,166 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,181 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,183 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,188 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,191 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,196 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,214 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,217 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,219 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,222 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,262 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,270 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,276 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,278 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,278 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,296 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,311 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,311 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,319 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,322 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,329 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,346 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,346 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,354 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,360 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,362 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,382 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,390 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,394 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,397 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,400 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,416 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,427 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,430 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,433 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,450 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,460 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,462 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,468 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,470 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,473 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,485 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,494 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,499 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,505 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,505 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,510 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,518 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,527 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,537 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,539 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,541 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,546 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,551 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,558 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-6) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,569 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-7) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,572 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-4) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,594 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-8) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:35,600 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery]
(http--0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default
general for version
2012-08-14 13:44:52,861 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand] (pool-5-thread-48) START,
IsValidVDSCommand(storagePoolId = 64a0f560-b9a1-4c87-8a30-0967b4ce3c81,
ignoreFailoverLimit = false, compatabilityVersion = null), log id: 499a9725
2012-08-14 13:44:52,891 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand] (pool-5-thread-48) FINISH,
IsValidVDSCommand, return: true, log id: 499a9725
2012-08-14 13:44:52,892 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.GetIsoListVDSCommand] (pool-5-thread-48) START,
GetIsoListVDSCommand(storagePoolId = 64a0f560-b9a1-4c87-8a30-0967b4ce3c81,
ignoreFailoverLimit = false, compatabilityVersion = null), log id: 335db027
2012-08-14 13:44:52,898 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HsmGetIsoListVDSCommand] (pool-5-thread-48)
START, HsmGetIsoListVDSCommand(vdsId = a153a0e6-dbd8-11e1-95da-cf8b5c612611,
storagePoolId=64a0f560-b9a1-4c87-8a30-0967b4ce3c81), log id: 4ac2d594
2012-08-14 13:44:52,940 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.HsmGetIsoListVDSCommand] (pool-5-thread-48)
FINISH, HsmGetIsoListVDSCommand, return: [Fedora-16-i686-Live-Desktop.iso,
SW_CD_Windows_Svr_Std_2003_R2_32-BIT_English_-2_R2_CD1_ISO_MLF_X12-58049.ISO,
virtio-win-0.1-22.iso, Windows.7.SP1.ENG.x86-x64.ACTiVATED.iso,
W7_pro_HP-x64_Rickys_barbar.iso, Fedora-16-x86_64-DVD.iso, CentOS-6.2-x86_64-bin-DVD1.iso,
CentOS-6.0-x86_64-bin-DVD1.iso, ABR11SW_ABR11SWUR_en-US.iso,
MigrateToRHEV_17454_en-US.iso], log id: 4ac2d594
2012-08-14 13:44:52,941 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.GetIsoListVDSCommand] (pool-5-thread-48)
FINISH, GetIsoListVDSCommand, return: [Fedora-16-i686-Live-Desktop.iso,
SW_CD_Windows_Svr_Std_2003_R2_32-BIT_English_-2_R2_CD1_ISO_MLF_X12-58049.ISO,
virtio-win-0.1-22.iso, Windows.7.SP1.ENG.x86-x64.ACTiVATED.iso,
W7_pro_HP-x64_Rickys_barbar.iso, Fedora-16-x86_64-DVD.iso, CentOS-6.2-x86_64-bin-DVD1.iso,
CentOS-6.0-x86_64-bin-DVD1.iso, ABR11SW_ABR11SWUR_en-US.iso,
MigrateToRHEV_17454_en-US.iso], log id: 335db027
2012-08-14 13:44:52,979 INFO [org.ovirt.engine.core.bll.IsoDomainListSyncronizer]
(pool-5-thread-48) Finished automatic refresh process for ISO file type with success, for
storage domain id 14368440-9620-423d-b816-a3d42a1b50d7.
2012-08-14 13:44:57,327 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-5-thread-48)
[130fd9db] Lock Acquired to object EngineLock [exclusiveLocks= key:
org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand value:
5de36f78-8303-401b-b6c3-e04091077f9e
, sharedLocks= ]
2012-08-14 13:44:57,352 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-5-thread-48)
[130fd9db] Running command: ActivateStorageDomainCommand internal: false. Entities
affected : ID: 5de36f78-8303-401b-b6c3-e04091077f9e Type: Storage
2012-08-14 13:44:57,377 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-5-thread-48)
[130fd9db] Lock freed to object EngineLock [exclusiveLocks= key:
org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand value:
5de36f78-8303-401b-b6c3-e04091077f9e
, sharedLocks= ]
2012-08-14 13:44:57,379 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-5-thread-48)
[130fd9db] ActivateStorage Domain. Before Connect all hosts to pool. Time:8/14/12 1:44 PM
2012-08-14 13:44:57,423 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-49) [356895df] START, ValidateStorageServerConnectionVDSCommand(vdsId =
a153a0e6-dbd8-11e1-95da-cf8b5c612611, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS, connectionList = [{ id:
0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945, connection: 10.10.6.107:/md2/oVirt/data-win };]),
log id: 10943b34
2012-08-14 13:44:57,434 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-49) [356895df] FINISH, ValidateStorageServerConnectionVDSCommand, return:
{0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945=0}, log id: 10943b34
2012-08-14 13:44:57,434 INFO
[org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand] (pool-5-thread-49)
[356895df] Running command: ConnectStorageToVdsCommand internal: true. Entities affected :
ID: aaa00000-0000-0000-0000-123456789aaa Type: System
2012-08-14 13:44:57,437 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-49) [356895df] START, ConnectStorageServerVDSCommand(vdsId =
a153a0e6-dbd8-11e1-95da-cf8b5c612611, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS, connectionList = [{ id:
0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945, connection: 10.10.6.107:/md2/oVirt/data-win };]),
log id: 5676c48a
2012-08-14 13:44:57,451 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-49) [356895df] FINISH, ConnectStorageServerVDSCommand, return:
{0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945=0}, log id: 5676c48a
2012-08-14 13:44:57,453 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-5-thread-48)
[130fd9db] ActivateStorage Domain. After Connect all hosts to pool. Time:8/14/12 1:44 PM
2012-08-14 13:44:57,455 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand]
(pool-5-thread-48) [130fd9db] START, ActivateStorageDomainVDSCommand(storagePoolId =
64a0f560-b9a1-4c87-8a30-0967b4ce3c81, ignoreFailoverLimit = false, compatabilityVersion =
null, storageDomainId = 5de36f78-8303-401b-b6c3-e04091077f9e), log id: 21ecd3dc
2012-08-14 13:44:59,776 ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] (pool-5-thread-48)
[130fd9db] Failed in ActivateStorageDomainVDS method
2012-08-14 13:44:59,777 ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] (pool-5-thread-48)
[130fd9db] Error code StorageDomainDoesNotExist and error message IRSGenericException:
IRSErrorException: Failed to ActivateStorageDomainVDS, error = Storage domain does not
exist: ('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 13:44:59,778 ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(pool-5-thread-48) [130fd9db] IrsBroker::Failed::ActivateStorageDomainVDS due to:
IRSErrorException: IRSGenericException: IRSErrorException: Failed to
ActivateStorageDomainVDS, error = Storage domain does not exist:
('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 13:44:59,783 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand]
(pool-5-thread-48) [130fd9db] FINISH, ActivateStorageDomainVDSCommand, log id: 21ecd3dc
2012-08-14 13:44:59,784 ERROR
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-5-thread-48)
[130fd9db] Command org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand throw
Vdc Bll exception. With error message VdcBLLException:
org.ovirt.engine.core.vdsbroker.irsbroker.IRSErrorException: IRSGenericException:
IRSErrorException: Failed to ActivateStorageDomainVDS, error = Storage domain does not
exist: ('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 13:44:59,792 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-5-thread-48)
[130fd9db] Command [id=a4584ad3-2e0a-4f74-9d87-4e8c6267b944]: Compensating
CHANGED_STATUS_ONLY of org.ovirt.engine.core.common.businessentities.storage_pool_iso_map;
snapshot: EntityStatusSnapshot [id=storagePoolId = 64a0f560-b9a1-4c87-8a30-0967b4ce3c81,
storageId = 5de36f78-8303-401b-b6c3-e04091077f9e, status=InActive].
2012-08-14 13:45:00,003 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager]
(QuartzScheduler_Worker-75) [6c6941d3] Checking autorecoverable hosts
2012-08-14 13:45:00,052 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager]
(QuartzScheduler_Worker-75) [6c6941d3] Checking autorecoverable hosts done
2012-08-14 13:45:00,053 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager]
(QuartzScheduler_Worker-75) [6c6941d3] Checking autorecoverable storage domains
2012-08-14 13:45:00,103 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(QuartzScheduler_Worker-75) [4d542bb1] Lock Acquired to object EngineLock [exclusiveLocks=
key: org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand value:
5de36f78-8303-401b-b6c3-e04091077f9e
, sharedLocks= ]
2012-08-14 13:45:00,169 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(QuartzScheduler_Worker-75) [4d542bb1] Running command: ActivateStorageDomainCommand
internal: true. Entities affected : ID: 5de36f78-8303-401b-b6c3-e04091077f9e Type:
Storage
2012-08-14 13:45:00,194 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(QuartzScheduler_Worker-75) [4d542bb1] Lock freed to object EngineLock [exclusiveLocks=
key: org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand value:
5de36f78-8303-401b-b6c3-e04091077f9e
, sharedLocks= ]
2012-08-14 13:45:00,195 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(QuartzScheduler_Worker-75) [4d542bb1] ActivateStorage Domain. Before Connect all hosts to
pool. Time:8/14/12 1:45 PM
2012-08-14 13:45:00,249 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-48) [fa3d734] START, ValidateStorageServerConnectionVDSCommand(vdsId =
a153a0e6-dbd8-11e1-95da-cf8b5c612611, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS, connectionList = [{ id:
0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945, connection: 10.10.6.107:/md2/oVirt/data-win };]),
log id: 299b139
2012-08-14 13:45:00,294 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ValidateStorageServerConnectionVDSCommand]
(pool-5-thread-48) [fa3d734] FINISH, ValidateStorageServerConnectionVDSCommand, return:
{0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945=0}, log id: 299b139
2012-08-14 13:45:00,294 INFO
[org.ovirt.engine.core.bll.storage.ConnectStorageToVdsCommand] (pool-5-thread-48)
[fa3d734] Running command: ConnectStorageToVdsCommand internal: true. Entities affected :
ID: aaa00000-0000-0000-0000-123456789aaa Type: System
2012-08-14 13:45:00,299 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-48) [fa3d734] START, ConnectStorageServerVDSCommand(vdsId =
a153a0e6-dbd8-11e1-95da-cf8b5c612611, storagePoolId =
00000000-0000-0000-0000-000000000000, storageType = NFS, connectionList = [{ id:
0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945, connection: 10.10.6.107:/md2/oVirt/data-win };]),
log id: 18888cc2
2012-08-14 13:45:00,314 INFO
[org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand]
(pool-5-thread-48) [fa3d734] FINISH, ConnectStorageServerVDSCommand, return:
{0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945=0}, log id: 18888cc2
2012-08-14 13:45:00,316 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(QuartzScheduler_Worker-75) [4d542bb1] ActivateStorage Domain. After Connect all hosts to
pool. Time:8/14/12 1:45 PM
2012-08-14 13:45:00,316 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand]
(QuartzScheduler_Worker-75) [4d542bb1] START,
ActivateStorageDomainVDSCommand(storagePoolId = 64a0f560-b9a1-4c87-8a30-0967b4ce3c81,
ignoreFailoverLimit = false, compatabilityVersion = null, storageDomainId =
5de36f78-8303-401b-b6c3-e04091077f9e), log id: 716ac307
2012-08-14 13:45:02,640 ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] (QuartzScheduler_Worker-75)
[4d542bb1] Failed in ActivateStorageDomainVDS method
2012-08-14 13:45:02,641 ERROR
[org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase] (QuartzScheduler_Worker-75)
[4d542bb1] Error code StorageDomainDoesNotExist and error message IRSGenericException:
IRSErrorException: Failed to ActivateStorageDomainVDS, error = Storage domain does not
exist: ('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 13:45:02,642 ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
(QuartzScheduler_Worker-75) [4d542bb1] IrsBroker::Failed::ActivateStorageDomainVDS due to:
IRSErrorException: IRSGenericException: IRSErrorException: Failed to
ActivateStorageDomainVDS, error = Storage domain does not exist:
('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 13:45:02,646 INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand]
(QuartzScheduler_Worker-75) [4d542bb1] FINISH, ActivateStorageDomainVDSCommand, log id:
716ac307
2012-08-14 13:45:02,647 ERROR
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(QuartzScheduler_Worker-75) [4d542bb1] Command
org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand throw Vdc Bll exception.
With error message VdcBLLException:
org.ovirt.engine.core.vdsbroker.irsbroker.IRSErrorException: IRSGenericException:
IRSErrorException: Failed to ActivateStorageDomainVDS, error = Storage domain does not
exist: ('5de36f78-8303-401b-b6c3-e04091077f9e',)
2012-08-14 13:45:02,655 INFO
[org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
(QuartzScheduler_Worker-75) [4d542bb1] Command [id=5b0cfb78-35a3-4033-bc32-b83375f47352]:
Compensating CHANGED_STATUS_ONLY of
org.ovirt.engine.core.common.businessentities.storage_pool_iso_map; snapshot:
EntityStatusSnapshot [id=storagePoolId = 64a0f560-b9a1-4c87-8a30-0967b4ce3c81, storageId =
5de36f78-8303-401b-b6c3-e04091077f9e, status=InActive].
2012-08-14 13:45:02,720 INFO
[org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector]
(QuartzScheduler_Worker-75) [4d542bb1] No severity for
USER_ACTIVATE_STORAGE_DOMAIN_FAILED_ASYNC type
2012-08-14 13:45:02,735 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager]
(QuartzScheduler_Worker-75) [4d542bb1] Checking autorecoverable storage domains done
--=_bauhaus.teknikservice.nu-24776-1344945707-0001-2
Content-Type: text/x-log; name="vdsm.log"; charset=iso-8859-1
Content-Transfer-Encoding: quoted-printable
Content-Disposition: attachment;
filename="vdsm.log"
Thread-1190096::INFO::2012-08-14 13:43:51,624::logUtils::39::dispatcher::=
(wrapper) Run and protect: getStoragePoolInfo, Return response: {'info': =
{'spm_id': 1, 'master_uuid':
'75b7f4bc-1c46-4847-ba1b-2bbc84c771ce', 'nam=
e': 'Default-30', 'version': '0', 'domains':
'14368440-9620-423d-b816-a3d=
42a1b50d7:Active,5de36f78-8303-401b-b6c3-e04091077f9e:Attached,2563b7db-b=
bca-44f4-ba68-98a516bae14b:Active,75b7f4bc-1c46-4847-ba1b-2bbc84c771ce:Ac=
tive', 'pool_status': 'connected', 'isoprefix':
'/rhev/data-center/64a0f5=
60-b9a1-4c87-8a30-0967b4ce3c81/14368440-9620-423d-b816-a3d42a1b50d7/image=
s/11111111-1111-1111-1111-111111111111', 'type': 'NFS',
'master_ver': 605=
9, 'lver': 8}, 'dominfo': {'14368440-9620-423d-b816-a3d42a1b50d7':
{'stat=
us': 'Active', 'diskfree': '284985524224', 'alerts':
[], 'disktotal': '39=
96801957888'}, '5de36f78-8303-401b-b6c3-e04091077f9e': {'status':
'Attach=
ed'}, '2563b7db-bbca-44f4-ba68-98a516bae14b': {'status':
'Active', 'diskf=
ree': '284985524224', 'alerts': [], 'disktotal':
'3996801957888'}, '75b7f=
4bc-1c46-4847-ba1b-2bbc84c771ce': {'status': 'Active',
'diskfree': '28498=
5524224', 'alerts': [], 'disktotal': '3996801957888'}}}
Thread-1190096::DEBUG::2012-08-14 13:43:51,625::task::1172::TaskManager.T=
ask::(prepare) Task=3D`591249eb-49e5-4488-85f3-3298c0517509`::finished: {=
'info': {'spm_id': 1, 'master_uuid':
'75b7f4bc-1c46-4847-ba1b-2bbc84c771c=
e', 'name': 'Default-30', 'version': '0',
'domains': '14368440-9620-423d-=
b816-a3d42a1b50d7:Active,5de36f78-8303-401b-b6c3-e04091077f9e:Attached,25=
63b7db-bbca-44f4-ba68-98a516bae14b:Active,75b7f4bc-1c46-4847-ba1b-2bbc84c=
771ce:Active', 'pool_status': 'connected', 'isoprefix':
'/rhev/data-cente=
r/64a0f560-b9a1-4c87-8a30-0967b4ce3c81/14368440-9620-423d-b816-a3d42a1b50=
d7/images/11111111-1111-1111-1111-111111111111', 'type': 'NFS',
'master_v=
er': 6059, 'lver': 8}, 'dominfo':
{'14368440-9620-423d-b816-a3d42a1b50d7'=
: {'status': 'Active', 'diskfree': '284985524224',
'alerts': [], 'disktot=
al': '3996801957888'}, '5de36f78-8303-401b-b6c3-e04091077f9e':
{'status':=
'Attached'}, '2563b7db-bbca-44f4-ba68-98a516bae14b': {'status':
'Active'=
, 'diskfree': '284985524224', 'alerts': [], 'disktotal':
'3996801957888'}=
, '75b7f4bc-1c46-4847-ba1b-2bbc84c771ce': {'status': 'Active',
'diskfree'=
: '284985524224', 'alerts': [], 'disktotal':
'3996801957888'}}}
Thread-1190096::DEBUG::2012-08-14 13:43:51,625::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`591249eb-49e5-4488-85f3-3298c0517509`::moving =
from state preparing -> state finished
Thread-1190096::DEBUG::2012-08-14 13:43:51,625::resourceManager::809::Res=
ourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {=
'Storage.64a0f560-b9a1-4c87-8a30-0967b4ce3c81': < ResourceRef 'Storage.64=
a0f560-b9a1-4c87-8a30-0967b4ce3c81', isValid: 'True' obj: 'None'>}
Thread-1190096::DEBUG::2012-08-14 13:43:51,625::resourceManager::844::Res=
ourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
Thread-1190096::DEBUG::2012-08-14 13:43:51,625::resourceManager::538::Res=
ourceManager::(releaseResource) Trying to release resource 'Storage.64a0f=
560-b9a1-4c87-8a30-0967b4ce3c81'
Thread-1190096::DEBUG::2012-08-14 13:43:51,626::resourceManager::553::Res=
ourceManager::(releaseResource) Released resource 'Storage.64a0f560-b9a1-=
4c87-8a30-0967b4ce3c81' (0 active users)
Thread-1190096::DEBUG::2012-08-14 13:43:51,626::resourceManager::558::Res=
ourceManager::(releaseResource) Resource 'Storage.64a0f560-b9a1-4c87-8a30=
-0967b4ce3c81' is free, finding out if anyone is waiting for it.
Thread-1190096::DEBUG::2012-08-14 13:43:51,626::resourceManager::565::Res=
ourceManager::(releaseResource) No one is waiting for resource 'Storage.6=
4a0f560-b9a1-4c87-8a30-0967b4ce3c81', Clearing records.
Thread-1190096::DEBUG::2012-08-14 13:43:51,626::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`591249eb-49e5-4488-85f3-3298c0517509`::ref 0 aborti=
ng False
Thread-1190099::DEBUG::2012-08-14 13:43:55,576::BindingXMLRPC::160::vds::=
(wrapper) [10.10.1.105]
Thread-1190099::DEBUG::2012-08-14 13:43:55,576::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`89856844-3e05-4750-929e-6639bdf346d6`::moving =
from state init -> state preparing
Thread-1190099::INFO::2012-08-14 13:43:55,577::logUtils::37::dispatcher::=
(wrapper) Run and protect: validateStorageServerConnection(domType=3D1, s=
pUUID=3D'00000000-0000-0000-0000-000000000000',
conList=3D[{'connection':=
'10.10.6.107:/md2/oVirt/data-win', 'iqn': '', 'portal':
'', 'user': '', =
'password': '******', 'id':
'0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945', 'port=
': ''}], options=3DNone)
Thread-1190099::INFO::2012-08-14 13:43:55,577::logUtils::39::dispatcher::=
(wrapper) Run and protect: validateStorageServerConnection, Return respon=
se: {'statuslist': [{'status': 0, 'id':
'0157c4d0-9d74-42c9-ae0b-b3d8fa1f=
a945'}]}
Thread-1190099::DEBUG::2012-08-14 13:43:55,577::task::1172::TaskManager.T=
ask::(prepare) Task=3D`89856844-3e05-4750-929e-6639bdf346d6`::finished: {=
'statuslist': [{'status': 0, 'id':
'0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945'=
}]}
Thread-1190099::DEBUG::2012-08-14 13:43:55,577::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`89856844-3e05-4750-929e-6639bdf346d6`::moving =
from state preparing -> state finished
Thread-1190099::DEBUG::2012-08-14 13:43:55,577::resourceManager::809::Res=
ourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {=
}
Thread-1190099::DEBUG::2012-08-14 13:43:55,577::resourceManager::844::Res=
ourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
Thread-1190099::DEBUG::2012-08-14 13:43:55,577::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`89856844-3e05-4750-929e-6639bdf346d6`::ref 0 aborti=
ng False
Thread-1190100::DEBUG::2012-08-14 13:43:55,590::BindingXMLRPC::160::vds::=
(wrapper) [10.10.1.105]
Thread-1190100::DEBUG::2012-08-14 13:43:55,590::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`8f211b90-78f7-4493-9dac-d48899d844f2`::moving =
from state init -> state preparing
Thread-1190100::INFO::2012-08-14 13:43:55,590::logUtils::37::dispatcher::=
(wrapper) Run and protect: connectStorageServer(domType=3D1, spUUID=3D'00=
000000-0000-0000-0000-000000000000', conList=3D[{'connection':
'10.10.6.1=
07:/md2/oVirt/data-win', 'iqn': '', 'portal': '',
'user': '', 'password':=
'******', 'id': '0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945',
'port': ''}], op=
tions=3DNone)
Thread-1190100::DEBUG::2012-08-14 13:43:55,593::lvm::459::OperationMutex:=
:(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operati=
on mutex
Thread-1190100::DEBUG::2012-08-14 13:43:55,593::lvm::461::OperationMutex:=
:(_invalidateAllPvs) Operation 'lvm invalidate operation' released the op=
eration mutex
Thread-1190100::DEBUG::2012-08-14 13:43:55,593::lvm::471::OperationMutex:=
:(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operati=
on mutex
Thread-1190100::DEBUG::2012-08-14 13:43:55,594::lvm::473::OperationMutex:=
:(_invalidateAllVgs) Operation 'lvm invalidate operation' released the op=
eration mutex
Thread-1190100::DEBUG::2012-08-14 13:43:55,594::lvm::492::OperationMutex:=
:(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operati=
on mutex
Thread-1190100::DEBUG::2012-08-14 13:43:55,594::lvm::494::OperationMutex:=
:(_invalidateAllLvs) Operation 'lvm invalidate operation' released the op=
eration mutex
Thread-1190100::INFO::2012-08-14 13:43:55,594::logUtils::39::dispatcher::=
(wrapper) Run and protect: connectStorageServer, Return response: {'statu=
slist': [{'status': 0, 'id':
'0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945'}]}
Thread-1190100::DEBUG::2012-08-14 13:43:55,594::task::1172::TaskManager.T=
ask::(prepare) Task=3D`8f211b90-78f7-4493-9dac-d48899d844f2`::finished: {=
'statuslist': [{'status': 0, 'id':
'0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945'=
}]}
Thread-1190100::DEBUG::2012-08-14 13:43:55,594::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`8f211b90-78f7-4493-9dac-d48899d844f2`::moving =
from state preparing -> state finished
Thread-1190100::DEBUG::2012-08-14 13:43:55,595::resourceManager::809::Res=
ourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {=
}
Thread-1190100::DEBUG::2012-08-14 13:43:55,595::resourceManager::844::Res=
ourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
Thread-1190100::DEBUG::2012-08-14 13:43:55,595::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`8f211b90-78f7-4493-9dac-d48899d844f2`::ref 0 aborti=
ng False
Thread-1190101::DEBUG::2012-08-14 13:43:55,609::BindingXMLRPC::160::vds::=
(wrapper) [10.10.1.105]
Thread-1190101::DEBUG::2012-08-14 13:43:55,609::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::moving =
from state init -> state preparing
Thread-1190101::INFO::2012-08-14 13:43:55,609::logUtils::37::dispatcher::=
(wrapper) Run and protect: activateStorageDomain(sdUUID=3D'5de36f78-8303-=
401b-b6c3-e04091077f9e', spUUID=3D'64a0f560-b9a1-4c87-8a30-0967b4ce3c81',=
options=3DNone)
Thread-1190101::DEBUG::2012-08-14 13:43:55,610::resourceManager::175::Res=
ourceManager.Request::(__init__) ResName=3D`Storage.64a0f560-b9a1-4c87-8a=
30-0967b4ce3c81`ReqID=3D`58d3fbf6-ea11-4f8e-adbc-5c9126ef24c1`::Request w=
as made in '/usr/share/vdsm/storage/resourceManager.py' line '485' at
're=
gisterResource'
Thread-1190101::DEBUG::2012-08-14 13:43:55,610::resourceManager::486::Res=
ourceManager::(registerResource) Trying to register resource 'Storage.64a=
0f560-b9a1-4c87-8a30-0967b4ce3c81' for lock type 'exclusive'
Thread-1190101::DEBUG::2012-08-14 13:43:55,610::resourceManager::528::Res=
ourceManager::(registerResource) Resource 'Storage.64a0f560-b9a1-4c87-8a3=
0-0967b4ce3c81' is free. Now locking as 'exclusive' (1 active user)
Thread-1190101::DEBUG::2012-08-14 13:43:55,610::resourceManager::212::Res=
ourceManager.Request::(grant) ResName=3D`Storage.64a0f560-b9a1-4c87-8a30-=
0967b4ce3c81`ReqID=3D`58d3fbf6-ea11-4f8e-adbc-5c9126ef24c1`::Granted requ=
est
Thread-1190101::DEBUG::2012-08-14 13:43:55,611::task::817::TaskManager.Ta=
sk::(resourceAcquired) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::_re=
sourcesAcquired: Storage.64a0f560-b9a1-4c87-8a30-0967b4ce3c81 (exclusive)=
Thread-1190101::DEBUG::2012-08-14 13:43:55,611::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::ref 1 aborti=
ng False
Thread-1190101::DEBUG::2012-08-14 13:43:55,611::resourceManager::175::Res=
ourceManager.Request::(__init__) ResName=3D`Storage.5de36f78-8303-401b-b6=
c3-e04091077f9e`ReqID=3D`3305116b-a5f4-4354-b6f2-3357b285c14c`::Request w=
as made in '/usr/share/vdsm/storage/resourceManager.py' line '485' at
're=
gisterResource'
Thread-1190101::DEBUG::2012-08-14 13:43:55,612::resourceManager::486::Res=
ourceManager::(registerResource) Trying to register resource 'Storage.5de=
36f78-8303-401b-b6c3-e04091077f9e' for lock type 'exclusive'
Thread-1190101::DEBUG::2012-08-14 13:43:55,612::resourceManager::528::Res=
ourceManager::(registerResource) Resource 'Storage.5de36f78-8303-401b-b6c=
3-e04091077f9e' is free. Now locking as 'exclusive' (1 active user)
Thread-1190101::DEBUG::2012-08-14 13:43:55,612::resourceManager::212::Res=
ourceManager.Request::(grant) ResName=3D`Storage.5de36f78-8303-401b-b6c3-=
e04091077f9e`ReqID=3D`3305116b-a5f4-4354-b6f2-3357b285c14c`::Granted requ=
est
Thread-1190101::DEBUG::2012-08-14 13:43:55,612::task::817::TaskManager.Ta=
sk::(resourceAcquired) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::_re=
sourcesAcquired: Storage.5de36f78-8303-401b-b6c3-e04091077f9e (exclusive)=
Thread-1190101::DEBUG::2012-08-14 13:43:55,612::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::ref 1 aborti=
ng False
Thread-1190101::INFO::2012-08-14 13:43:55,613::sp::986::Storage.StoragePo=
ol::(activateSD) sdUUID=3D5de36f78-8303-401b-b6c3-e04091077f9e spUUID=3D6=
4a0f560-b9a1-4c87-8a30-0967b4ce3c81
Thread-1190101::DEBUG::2012-08-14 13:43:55,613::misc::1053::SamplingMetho=
d::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage=
)
Thread-1190101::DEBUG::2012-08-14 13:43:55,613::misc::1055::SamplingMetho=
d::(__call__) Got in to sampling method
Thread-1190101::DEBUG::2012-08-14 13:43:55,613::misc::1053::SamplingMetho=
d::(__call__) Trying to enter sampling method (storage.iscsi.rescan)
Thread-1190101::DEBUG::2012-08-14 13:43:55,613::misc::1055::SamplingMetho=
d::(__call__) Got in to sampling method
Thread-1190101::DEBUG::2012-08-14 13:43:55,613::__init__::1164::Storage.M=
isc.excCmd::(_log) '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd N=
one)
Thread-1190101::DEBUG::2012-08-14 13:43:55,633::__init__::1164::Storage.M=
isc.excCmd::(_log) FAILED: <err> =3D 'iscsiadm: No session found.\n';
<rc=
=3D 21
Thread-1190101::DEBUG::2012-08-14
13:43:55,633::misc::1063::SamplingMetho=
d::(__call__) Returning last result
Thread-1190101::DEBUG::2012-08-14 13:43:57,790::__init__::1164::Storage.M=
isc.excCmd::(_log) '/usr/bin/sudo -n /sbin/multipath' (cwd None)
Thread-1190101::DEBUG::2012-08-14 13:43:57,869::__init__::1164::Storage.M=
isc.excCmd::(_log) SUCCESS: <err> =3D ''; <rc> =3D 0
Thread-1190101::DEBUG::2012-08-14 13:43:57,869::lvm::459::OperationMutex:=
:(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operati=
on mutex
Thread-1190101::DEBUG::2012-08-14 13:43:57,870::lvm::461::OperationMutex:=
:(_invalidateAllPvs) Operation 'lvm invalidate operation' released the op=
eration mutex
Thread-1190101::DEBUG::2012-08-14 13:43:57,870::lvm::471::OperationMutex:=
:(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operati=
on mutex
Thread-1190101::DEBUG::2012-08-14 13:43:57,870::lvm::473::OperationMutex:=
:(_invalidateAllVgs) Operation 'lvm invalidate operation' released the op=
eration mutex
Thread-1190101::DEBUG::2012-08-14 13:43:57,870::lvm::492::OperationMutex:=
:(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operati=
on mutex
Thread-1190101::DEBUG::2012-08-14 13:43:57,870::lvm::494::OperationMutex:=
:(_invalidateAllLvs) Operation 'lvm invalidate operation' released the op=
eration mutex
Thread-1190101::DEBUG::2012-08-14 13:43:57,871::misc::1063::SamplingMetho=
d::(__call__) Returning last result
Thread-1190101::DEBUG::2012-08-14 13:43:57,871::lvm::351::OperationMutex:=
:(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
Thread-1190101::DEBUG::2012-08-14 13:43:57,872::__init__::1164::Storage.M=
isc.excCmd::(_log) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { p=
referred_names =3D [\\"^/dev/mapper/\\"] ignore_suspended_devices=3D1 wri=
te_cache_state=3D0 disable_after_error_count=3D3 filter =3D [ \\"r%.*%\\"=
] } global { locking_type=3D1 prioritise_write_locks=3D1 wait_for_lo=
cks=3D1 } backup { retain_min =3D 50 retain_days =3D 0 } " --noheading=
s --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_s=
ize,extent_count,free_count,tags,vg_mda_size,vg_mda_free 5de36f78-8303-40=
1b-b6c3-e04091077f9e' (cwd None)
Thread-1190101::DEBUG::2012-08-14 13:43:57,901::__init__::1164::Storage.M=
isc.excCmd::(_log) FAILED: <err> =3D ' Volume group "5de36f78-8303-401b-=
b6c3-e04091077f9e" not found\n'; <rc> =3D 5
Thread-1190101::WARNING::2012-08-14 13:43:57,902::lvm::355::Storage.LVM::=
(_reloadvgs) lvm vgs failed: 5 [] [' Volume group "5de36f78-8303-401b-b6=
c3-e04091077f9e" not found']
Thread-1190101::DEBUG::2012-08-14 13:43:57,902::lvm::378::OperationMutex:=
:(_reloadvgs) Operation 'lvm reload operation' released the operation mut=
ex
Thread-1190101::DEBUG::2012-08-14 13:43:57,909::fileSD::107::Storage.Stor=
ageDomain::(__init__) Reading domain in path /rhev/data-center/mnt/10.10.=
6.107:_md2_oVirt_data-win/5de36f78-8303-401b-b6c3-e04091077f9e
Thread-1190101::DEBUG::2012-08-14 13:43:57,910::persistentDict::185::Stor=
age.PersistentDict::(__init__) Created a persistent dict with FileMetadat=
aRW backend
Thread-1190101::DEBUG::2012-08-14 13:43:57,912::persistentDict::226::Stor=
age.PersistentDict::(refresh) read lines (FileMetadataRW)=3D['CLASS=3DDat=
a', 'DESCRIPTION=3Ddata-win', 'IOOPTIMEOUTSEC=3D10',
'LEASERETRIES=3D3', =
'LEASETIMESEC=3D60', 'LOCKPOLICY=3D',
'LOCKRENEWALINTERVALSEC=3D5', 'MAST=
ER_VERSION=3D6060', 'POOL_DESCRIPTION=3DDefault-30',
'POOL_DOMAINS=3D1436=
8440-9620-423d-b816-a3d42a1b50d7:Active,5de36f78-8303-401b-b6c3-e04091077=
f9e:Active,2563b7db-bbca-44f4-ba68-98a516bae14b:Active,75b7f4bc-1c46-4847=
-ba1b-2bbc84c771ce:Attached', 'POOL_SPM_ID=3D2', 'POOL_SPM_LVER=3D61',
'P=
OOL_UUID=3D64a0f560-b9a1-4c87-8a30-0967b4ce3c81', 'REMOTE_PATH=3D10.10.1.=
107:/md2/oVirt/data-win', 'ROLE=3DRegular',
'SDUUID=3D5de36f78-8303-401b-=
b6c3-e04091077f9e', 'TYPE=3DNFS', 'VERSION=3D0',
'_SHA_CKSUM=3De0d678db83=
901ff6986147da4c0490a95d2f72d0']
Thread-1190101::WARNING::2012-08-14 13:43:57,912::persistentDict::264::St=
orage.PersistentDict::(refresh) data seal is broken metadata declares `e0=
d678db83901ff6986147da4c0490a95d2f72d0` should be `e214065c8753aa7965ac9c=
e0d1f64cc2dd2c3339` (lines=3D{'VERSION': '0', 'LEASETIMESEC':
'60', 'DESC=
RIPTION': 'data-win', 'TYPE': 'NFS', 'LOCKPOLICY':
'', 'LEASERETRIES': '3=
', 'POOL_DESCRIPTION': 'Default-30', 'POOL_SPM_LVER':
'61', 'REMOTE_PATH'=
: '10.10.1.107:/md2/oVirt/data-win', 'SDUUID':
'5de36f78-8303-401b-b6c3-e=
04091077f9e', 'MASTER_VERSION': '6060', 'IOOPTIMEOUTSEC':
'10', 'ROLE': '=
Regular', 'LOCKRENEWALINTERVALSEC': '5', 'POOL_DOMAINS':
'14368440-9620-4=
23d-b816-a3d42a1b50d7:Active,5de36f78-8303-401b-b6c3-e04091077f9e:Active,=
2563b7db-bbca-44f4-ba68-98a516bae14b:Active,75b7f4bc-1c46-4847-ba1b-2bbc8=
4c771ce:Attached', 'POOL_UUID':
'64a0f560-b9a1-4c87-8a30-0967b4ce3c81', '=
POOL_SPM_ID': '2', 'CLASS': 'Data'})
Thread-1190101::ERROR::2012-08-14 13:43:57,912::sdc::116::Storage.Storage=
DomainCache::(_findDomain) Error while looking for domain `5de36f78-8303-=
401b-b6c3-e04091077f9e`
Traceback (most recent call last):
File "/usr/share/vdsm/storage/sdc.py", line 111, in _findDomain
return mod.findDomain(sdUUID)
File "/usr/share/vdsm/storage/nfsSD.py", line 122, in findDomain
return NfsStorageDomain(NfsStorageDomain.findDomainPath(sdUUID))
File "/usr/share/vdsm/storage/fileSD.py", line 113, in __init__
sdUUID =3D metadata[sd.DMDK_SDUUID]
File "/usr/share/vdsm/storage/persistentDict.py", line 85, in __getitem=
__
return dec(self._dict[key])
File "/usr/share/vdsm/storage/persistentDict.py", line 193, in __getite=
m__
with self._accessWrapper():
File "/usr/lib64/python2.6/contextlib.py", line 16, in __enter__
return self.gen.next()
File "/usr/share/vdsm/storage/persistentDict.py", line 147, in _accessW=
rapper
self.refresh()
File "/usr/share/vdsm/storage/persistentDict.py", line 265, in refresh
raise se.MetaDataSealIsBroken(declaredChecksum, computedChecksum)
MetaDataSealIsBroken: Meta Data seal is broken (checksum mismatch): 'cksu=
m =3D e0d678db83901ff6986147da4c0490a95d2f72d0, computed_cksum =3D e21406=
5c8753aa7965ac9ce0d1f64cc2dd2c3339'
Thread-1190101::ERROR::2012-08-14 13:43:57,913::task::853::TaskManager.Ta=
sk::(_setError) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::Unexpected=
error
Traceback (most recent call last):
File "/usr/share/vdsm/storage/task.py", line 861, in _run
return fn(*args, **kargs)
File "/usr/share/vdsm/logUtils.py", line 38, in wrapper
res =3D f(*args, **kwargs)
File "/usr/share/vdsm/storage/hsm.py", line 1012, in activateStorageDom=
ain
pool.activateSD(sdUUID)
File "/usr/share/vdsm/storage/securable.py", line 63, in wrapper
return f(self, *args, **kwargs)
File "/usr/share/vdsm/storage/sp.py", line 989, in activateSD
dom =3D sdCache.produce(sdUUID)
File "/usr/share/vdsm/storage/sdc.py", line 93, in produce
dom =3D self._findDomain(sdUUID)
File "/usr/share/vdsm/storage/sdc.py", line 118, in _findDomain
raise se.StorageDomainDoesNotExist(sdUUID)
StorageDomainDoesNotExist: Storage domain does not exist: ('5de36f78-8303=
-401b-b6c3-e04091077f9e',)
Thread-1190101::DEBUG::2012-08-14 13:43:57,913::task::872::TaskManager.Ta=
sk::(_run) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::Task._run: 2bb8=
c3bd-3115-414c-9e07-0a5464949c56 ('5de36f78-8303-401b-b6c3-e04091077f9e',=
'64a0f560-b9a1-4c87-8a30-0967b4ce3c81') {} failed - stopping task
Thread-1190101::DEBUG::2012-08-14 13:43:57,914::task::1199::TaskManager.T=
ask::(stop) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::stopping in st=
ate preparing (force False)
Thread-1190101::DEBUG::2012-08-14 13:43:57,914::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::ref 1 aborti=
ng True
Thread-1190101::INFO::2012-08-14 13:43:57,914::task::1157::TaskManager.Ta=
sk::(prepare) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::aborting: Ta=
sk is aborted: 'Storage domain does not exist' - code 358
Thread-1190101::DEBUG::2012-08-14 13:43:57,914::task::1162::TaskManager.T=
ask::(prepare) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::Prepare: ab=
orted: Storage domain does not exist
Thread-1190101::DEBUG::2012-08-14 13:43:57,914::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::ref 0 aborti=
ng True
Thread-1190101::DEBUG::2012-08-14 13:43:57,914::task::913::TaskManager.Ta=
sk::(_doAbort) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::Task._doAbo=
rt: force False
Thread-1190101::DEBUG::2012-08-14 13:43:57,915::resourceManager::844::Res=
ourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
Thread-1190101::DEBUG::2012-08-14 13:43:57,915::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::moving =
from state preparing -> state aborting
Thread-1190101::DEBUG::2012-08-14 13:43:57,915::task::537::TaskManager.Ta=
sk::(__state_aborting) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::_ab=
orting: recover policy none
Thread-1190101::DEBUG::2012-08-14 13:43:57,915::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`2bb8c3bd-3115-414c-9e07-0a5464949c56`::moving =
from state aborting -> state failed
Thread-1190101::DEBUG::2012-08-14 13:43:57,915::resourceManager::809::Res=
ourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {=
'Storage.5de36f78-8303-401b-b6c3-e04091077f9e': < ResourceRef 'Storage.5d=
e36f78-8303-401b-b6c3-e04091077f9e', isValid: 'True' obj: 'None'>,
'Stora=
ge.64a0f560-b9a1-4c87-8a30-0967b4ce3c81': < ResourceRef 'Storage.64a0f560=
-b9a1-4c87-8a30-0967b4ce3c81', isValid: 'True' obj: 'None'>}
Thread-1190101::DEBUG::2012-08-14 13:43:57,915::resourceManager::844::Res=
ourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
Thread-1190101::DEBUG::2012-08-14 13:43:57,915::resourceManager::538::Res=
ourceManager::(releaseResource) Trying to release resource 'Storage.5de36=
f78-8303-401b-b6c3-e04091077f9e'
Thread-1190101::DEBUG::2012-08-14 13:43:57,916::resourceManager::553::Res=
ourceManager::(releaseResource) Released resource 'Storage.5de36f78-8303-=
401b-b6c3-e04091077f9e' (0 active users)
Thread-1190101::DEBUG::2012-08-14 13:43:57,916::resourceManager::558::Res=
ourceManager::(releaseResource) Resource 'Storage.5de36f78-8303-401b-b6c3=
-e04091077f9e' is free, finding out if anyone is waiting for it.
Thread-1190101::DEBUG::2012-08-14 13:43:57,916::resourceManager::565::Res=
ourceManager::(releaseResource) No one is waiting for resource 'Storage.5=
de36f78-8303-401b-b6c3-e04091077f9e', Clearing records.
Thread-1190101::DEBUG::2012-08-14 13:43:57,916::resourceManager::538::Res=
ourceManager::(releaseResource) Trying to release resource 'Storage.64a0f=
560-b9a1-4c87-8a30-0967b4ce3c81'
Thread-1190101::DEBUG::2012-08-14 13:43:57,917::resourceManager::553::Res=
ourceManager::(releaseResource) Released resource 'Storage.64a0f560-b9a1-=
4c87-8a30-0967b4ce3c81' (0 active users)
Thread-1190101::DEBUG::2012-08-14 13:43:57,917::resourceManager::558::Res=
ourceManager::(releaseResource) Resource 'Storage.64a0f560-b9a1-4c87-8a30=
-0967b4ce3c81' is free, finding out if anyone is waiting for it.
Thread-1190101::DEBUG::2012-08-14 13:43:57,917::resourceManager::565::Res=
ourceManager::(releaseResource) No one is waiting for resource 'Storage.6=
4a0f560-b9a1-4c87-8a30-0967b4ce3c81', Clearing records.
Thread-1190101::ERROR::2012-08-14 13:43:57,917::dispatcher::66::Storage.D=
ispatcher.Protect::(run) {'status': {'message': "Storage domain does
not =
exist: ('5de36f78-8303-401b-b6c3-e04091077f9e',)", 'code': 358}}
Thread-1190107::DEBUG::2012-08-14 13:43:58,411::BindingXMLRPC::160::vds::=
(wrapper) [10.10.1.105]
Thread-1190107::DEBUG::2012-08-14 13:43:58,412::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`ec537973-a494-4aa7-aed7-a7b926da824c`::moving =
from state init -> state preparing
Thread-1190107::INFO::2012-08-14 13:43:58,412::logUtils::37::dispatcher::=
(wrapper) Run and protect: validateStorageServerConnection(domType=3D1, s=
pUUID=3D'00000000-0000-0000-0000-000000000000',
conList=3D[{'connection':=
'10.10.6.107:/md2/oVirt/data-win', 'iqn': '', 'portal':
'', 'user': '', =
'password': '******', 'id':
'0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945', 'port=
': ''}], options=3DNone)
Thread-1190107::INFO::2012-08-14 13:43:58,413::logUtils::39::dispatcher::=
(wrapper) Run and protect: validateStorageServerConnection, Return respon=
se: {'statuslist': [{'status': 0, 'id':
'0157c4d0-9d74-42c9-ae0b-b3d8fa1f=
a945'}]}
Thread-1190107::DEBUG::2012-08-14 13:43:58,413::task::1172::TaskManager.T=
ask::(prepare) Task=3D`ec537973-a494-4aa7-aed7-a7b926da824c`::finished: {=
'statuslist': [{'status': 0, 'id':
'0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945'=
}]}
Thread-1190107::DEBUG::2012-08-14 13:43:58,413::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`ec537973-a494-4aa7-aed7-a7b926da824c`::moving =
from state preparing -> state finished
Thread-1190107::DEBUG::2012-08-14 13:43:58,413::resourceManager::809::Res=
ourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {=
}
Thread-1190107::DEBUG::2012-08-14 13:43:58,413::resourceManager::844::Res=
ourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
Thread-1190107::DEBUG::2012-08-14 13:43:58,413::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`ec537973-a494-4aa7-aed7-a7b926da824c`::ref 0 aborti=
ng False
Thread-1190108::DEBUG::2012-08-14 13:43:58,452::BindingXMLRPC::160::vds::=
(wrapper) [10.10.1.105]
Thread-1190108::DEBUG::2012-08-14 13:43:58,453::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`57ba347b-83aa-474f-8486-040613e335ac`::moving =
from state init -> state preparing
Thread-1190108::INFO::2012-08-14 13:43:58,453::logUtils::37::dispatcher::=
(wrapper) Run and protect: connectStorageServer(domType=3D1, spUUID=3D'00=
000000-0000-0000-0000-000000000000', conList=3D[{'connection':
'10.10.6.1=
07:/md2/oVirt/data-win', 'iqn': '', 'portal': '',
'user': '', 'password':=
'******', 'id': '0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945',
'port': ''}], op=
tions=3DNone)
Thread-1190108::DEBUG::2012-08-14 13:43:58,455::lvm::459::OperationMutex:=
:(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operati=
on mutex
Thread-1190108::DEBUG::2012-08-14 13:43:58,456::lvm::461::OperationMutex:=
:(_invalidateAllPvs) Operation 'lvm invalidate operation' released the op=
eration mutex
Thread-1190108::DEBUG::2012-08-14 13:43:58,456::lvm::471::OperationMutex:=
:(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operati=
on mutex
Thread-1190108::DEBUG::2012-08-14 13:43:58,456::lvm::473::OperationMutex:=
:(_invalidateAllVgs) Operation 'lvm invalidate operation' released the op=
eration mutex
Thread-1190108::DEBUG::2012-08-14 13:43:58,456::lvm::492::OperationMutex:=
:(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operati=
on mutex
Thread-1190108::DEBUG::2012-08-14 13:43:58,457::lvm::494::OperationMutex:=
:(_invalidateAllLvs) Operation 'lvm invalidate operation' released the op=
eration mutex
Thread-1190108::INFO::2012-08-14 13:43:58,457::logUtils::39::dispatcher::=
(wrapper) Run and protect: connectStorageServer, Return response: {'statu=
slist': [{'status': 0, 'id':
'0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945'}]}
Thread-1190108::DEBUG::2012-08-14 13:43:58,457::task::1172::TaskManager.T=
ask::(prepare) Task=3D`57ba347b-83aa-474f-8486-040613e335ac`::finished: {=
'statuslist': [{'status': 0, 'id':
'0157c4d0-9d74-42c9-ae0b-b3d8fa1fa945'=
}]}
Thread-1190108::DEBUG::2012-08-14 13:43:58,457::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`57ba347b-83aa-474f-8486-040613e335ac`::moving =
from state preparing -> state finished
Thread-1190108::DEBUG::2012-08-14 13:43:58,457::resourceManager::809::Res=
ourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {=
}
Thread-1190108::DEBUG::2012-08-14 13:43:58,457::resourceManager::844::Res=
ourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
Thread-1190108::DEBUG::2012-08-14 13:43:58,458::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`57ba347b-83aa-474f-8486-040613e335ac`::ref 0 aborti=
ng False
Thread-1190109::DEBUG::2012-08-14 13:43:58,469::BindingXMLRPC::160::vds::=
(wrapper) [10.10.1.105]
Thread-1190109::DEBUG::2012-08-14 13:43:58,469::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::moving =
from state init -> state preparing
Thread-1190109::INFO::2012-08-14 13:43:58,469::logUtils::37::dispatcher::=
(wrapper) Run and protect: activateStorageDomain(sdUUID=3D'5de36f78-8303-=
401b-b6c3-e04091077f9e', spUUID=3D'64a0f560-b9a1-4c87-8a30-0967b4ce3c81',=
options=3DNone)
Thread-1190109::DEBUG::2012-08-14 13:43:58,470::resourceManager::175::Res=
ourceManager.Request::(__init__) ResName=3D`Storage.64a0f560-b9a1-4c87-8a=
30-0967b4ce3c81`ReqID=3D`01084267-8059-4872-92f1-def68ff78c5f`::Request w=
as made in '/usr/share/vdsm/storage/resourceManager.py' line '485' at
're=
gisterResource'
Thread-1190109::DEBUG::2012-08-14 13:43:58,470::resourceManager::486::Res=
ourceManager::(registerResource) Trying to register resource 'Storage.64a=
0f560-b9a1-4c87-8a30-0967b4ce3c81' for lock type 'exclusive'
Thread-1190109::DEBUG::2012-08-14 13:43:58,470::resourceManager::528::Res=
ourceManager::(registerResource) Resource 'Storage.64a0f560-b9a1-4c87-8a3=
0-0967b4ce3c81' is free. Now locking as 'exclusive' (1 active user)
Thread-1190109::DEBUG::2012-08-14 13:43:58,471::resourceManager::212::Res=
ourceManager.Request::(grant) ResName=3D`Storage.64a0f560-b9a1-4c87-8a30-=
0967b4ce3c81`ReqID=3D`01084267-8059-4872-92f1-def68ff78c5f`::Granted requ=
est
Thread-1190109::DEBUG::2012-08-14 13:43:58,471::task::817::TaskManager.Ta=
sk::(resourceAcquired) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::_re=
sourcesAcquired: Storage.64a0f560-b9a1-4c87-8a30-0967b4ce3c81 (exclusive)=
Thread-1190109::DEBUG::2012-08-14 13:43:58,471::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::ref 1 aborti=
ng False
Thread-1190109::DEBUG::2012-08-14 13:43:58,472::resourceManager::175::Res=
ourceManager.Request::(__init__) ResName=3D`Storage.5de36f78-8303-401b-b6=
c3-e04091077f9e`ReqID=3D`5fcab071-1d80-4a5d-855d-c57aa7daf8e9`::Request w=
as made in '/usr/share/vdsm/storage/resourceManager.py' line '485' at
're=
gisterResource'
Thread-1190109::DEBUG::2012-08-14 13:43:58,472::resourceManager::486::Res=
ourceManager::(registerResource) Trying to register resource 'Storage.5de=
36f78-8303-401b-b6c3-e04091077f9e' for lock type 'exclusive'
Thread-1190109::DEBUG::2012-08-14 13:43:58,472::resourceManager::528::Res=
ourceManager::(registerResource) Resource 'Storage.5de36f78-8303-401b-b6c=
3-e04091077f9e' is free. Now locking as 'exclusive' (1 active user)
Thread-1190109::DEBUG::2012-08-14 13:43:58,472::resourceManager::212::Res=
ourceManager.Request::(grant) ResName=3D`Storage.5de36f78-8303-401b-b6c3-=
e04091077f9e`ReqID=3D`5fcab071-1d80-4a5d-855d-c57aa7daf8e9`::Granted requ=
est
Thread-1190109::DEBUG::2012-08-14 13:43:58,473::task::817::TaskManager.Ta=
sk::(resourceAcquired) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::_re=
sourcesAcquired: Storage.5de36f78-8303-401b-b6c3-e04091077f9e (exclusive)=
Thread-1190109::DEBUG::2012-08-14 13:43:58,473::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::ref 1 aborti=
ng False
Thread-1190109::INFO::2012-08-14 13:43:58,473::sp::986::Storage.StoragePo=
ol::(activateSD) sdUUID=3D5de36f78-8303-401b-b6c3-e04091077f9e spUUID=3D6=
4a0f560-b9a1-4c87-8a30-0967b4ce3c81
Thread-1190109::DEBUG::2012-08-14 13:43:58,473::misc::1053::SamplingMetho=
d::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage=
)
Thread-1190109::DEBUG::2012-08-14 13:43:58,473::misc::1055::SamplingMetho=
d::(__call__) Got in to sampling method
Thread-1190109::DEBUG::2012-08-14 13:43:58,473::misc::1053::SamplingMetho=
d::(__call__) Trying to enter sampling method (storage.iscsi.rescan)
Thread-1190109::DEBUG::2012-08-14 13:43:58,474::misc::1055::SamplingMetho=
d::(__call__) Got in to sampling method
Thread-1190109::DEBUG::2012-08-14 13:43:58,474::__init__::1164::Storage.M=
isc.excCmd::(_log) '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd N=
one)
Thread-1190109::DEBUG::2012-08-14 13:43:58,494::__init__::1164::Storage.M=
isc.excCmd::(_log) FAILED: <err> =3D 'iscsiadm: No session found.\n';
<rc=
=3D 21
Thread-1190109::DEBUG::2012-08-14
13:43:58,494::misc::1063::SamplingMetho=
d::(__call__) Returning last result
Thread-1190110::DEBUG::2012-08-14 13:43:58,806::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`994db129-2bf2-49cf-a593-25e9be3940b8`::moving =
from state init -> state preparing
Thread-1190110::INFO::2012-08-14 13:43:58,806::logUtils::37::dispatcher::=
(wrapper) Run and protect: repoStats(options=3DNone)
Thread-1190110::INFO::2012-08-14 13:43:58,806::logUtils::39::dispatcher::=
(wrapper) Run and protect: repoStats, Return response: {'14368440-9620-42=
3d-b816-a3d42a1b50d7': {'delay': '0.00109887123108',
'lastCheck': 1344944=
633.614243, 'code': 0, 'valid': True},
'2563b7db-bbca-44f4-ba68-98a516bae=
14b': {'delay': '0.0012149810791', 'lastCheck':
1344944633.207345, 'code'=
: 0, 'valid': True}, '75b7f4bc-1c46-4847-ba1b-2bbc84c771ce':
{'delay': '0=
=2E00146293640137', 'lastCheck': 1344944636.989584, 'code': 0,
'valid': T=
rue}}
Thread-1190110::DEBUG::2012-08-14 13:43:58,806::task::1172::TaskManager.T=
ask::(prepare) Task=3D`994db129-2bf2-49cf-a593-25e9be3940b8`::finished: {=
'14368440-9620-423d-b816-a3d42a1b50d7': {'delay':
'0.00109887123108', 'la=
stCheck': 1344944633.614243, 'code': 0, 'valid': True},
'2563b7db-bbca-44=
f4-ba68-98a516bae14b': {'delay': '0.0012149810791',
'lastCheck': 13449446=
33.207345, 'code': 0, 'valid': True},
'75b7f4bc-1c46-4847-ba1b-2bbc84c771=
ce': {'delay': '0.00146293640137', 'lastCheck':
1344944636.989584, 'code'=
: 0, 'valid': True}}
Thread-1190110::DEBUG::2012-08-14 13:43:58,807::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`994db129-2bf2-49cf-a593-25e9be3940b8`::moving =
from state preparing -> state finished
Thread-1190110::DEBUG::2012-08-14 13:43:58,807::resourceManager::809::Res=
ourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {=
}
Thread-1190110::DEBUG::2012-08-14 13:43:58,807::resourceManager::844::Res=
ourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
Thread-1190110::DEBUG::2012-08-14 13:43:58,807::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`994db129-2bf2-49cf-a593-25e9be3940b8`::ref 0 aborti=
ng False
Thread-1190109::DEBUG::2012-08-14 13:44:00,643::__init__::1164::Storage.M=
isc.excCmd::(_log) '/usr/bin/sudo -n /sbin/multipath' (cwd None)
Thread-1190109::DEBUG::2012-08-14 13:44:00,733::__init__::1164::Storage.M=
isc.excCmd::(_log) SUCCESS: <err> =3D ''; <rc> =3D 0
Thread-1190109::DEBUG::2012-08-14 13:44:00,734::lvm::459::OperationMutex:=
:(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operati=
on mutex
Thread-1190109::DEBUG::2012-08-14 13:44:00,734::lvm::461::OperationMutex:=
:(_invalidateAllPvs) Operation 'lvm invalidate operation' released the op=
eration mutex
Thread-1190109::DEBUG::2012-08-14 13:44:00,734::lvm::471::OperationMutex:=
:(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operati=
on mutex
Thread-1190109::DEBUG::2012-08-14 13:44:00,735::lvm::473::OperationMutex:=
:(_invalidateAllVgs) Operation 'lvm invalidate operation' released the op=
eration mutex
Thread-1190109::DEBUG::2012-08-14 13:44:00,735::lvm::492::OperationMutex:=
:(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operati=
on mutex
Thread-1190109::DEBUG::2012-08-14 13:44:00,735::lvm::494::OperationMutex:=
:(_invalidateAllLvs) Operation 'lvm invalidate operation' released the op=
eration mutex
Thread-1190109::DEBUG::2012-08-14 13:44:00,735::misc::1063::SamplingMetho=
d::(__call__) Returning last result
Thread-1190109::DEBUG::2012-08-14 13:44:00,735::lvm::351::OperationMutex:=
:(_reloadvgs) Operation 'lvm reload operation' got the operation mutex
Thread-1190109::DEBUG::2012-08-14 13:44:00,736::__init__::1164::Storage.M=
isc.excCmd::(_log) '/usr/bin/sudo -n /sbin/lvm vgs --config " devices { p=
referred_names =3D [\\"^/dev/mapper/\\"] ignore_suspended_devices=3D1 wri=
te_cache_state=3D0 disable_after_error_count=3D3 filter =3D [ \\"r%.*%\\"=
] } global { locking_type=3D1 prioritise_write_locks=3D1 wait_for_lo=
cks=3D1 } backup { retain_min =3D 50 retain_days =3D 0 } " --noheading=
s --units b --nosuffix --separator | -o uuid,name,attr,size,free,extent_s=
ize,extent_count,free_count,tags,vg_mda_size,vg_mda_free 5de36f78-8303-40=
1b-b6c3-e04091077f9e' (cwd None)
Thread-1190109::DEBUG::2012-08-14 13:44:00,766::__init__::1164::Storage.M=
isc.excCmd::(_log) FAILED: <err> =3D ' Volume group "5de36f78-8303-401b-=
b6c3-e04091077f9e" not found\n'; <rc> =3D 5
Thread-1190109::WARNING::2012-08-14 13:44:00,767::lvm::355::Storage.LVM::=
(_reloadvgs) lvm vgs failed: 5 [] [' Volume group "5de36f78-8303-401b-b6=
c3-e04091077f9e" not found']
Thread-1190109::DEBUG::2012-08-14 13:44:00,767::lvm::378::OperationMutex:=
:(_reloadvgs) Operation 'lvm reload operation' released the operation mut=
ex
Thread-1190109::DEBUG::2012-08-14 13:44:00,774::fileSD::107::Storage.Stor=
ageDomain::(__init__) Reading domain in path /rhev/data-center/mnt/10.10.=
6.107:_md2_oVirt_data-win/5de36f78-8303-401b-b6c3-e04091077f9e
Thread-1190109::DEBUG::2012-08-14 13:44:00,774::persistentDict::185::Stor=
age.PersistentDict::(__init__) Created a persistent dict with FileMetadat=
aRW backend
Thread-1190109::DEBUG::2012-08-14 13:44:00,776::persistentDict::226::Stor=
age.PersistentDict::(refresh) read lines (FileMetadataRW)=3D['CLASS=3DDat=
a', 'DESCRIPTION=3Ddata-win', 'IOOPTIMEOUTSEC=3D10',
'LEASERETRIES=3D3', =
'LEASETIMESEC=3D60', 'LOCKPOLICY=3D',
'LOCKRENEWALINTERVALSEC=3D5', 'MAST=
ER_VERSION=3D6060', 'POOL_DESCRIPTION=3DDefault-30',
'POOL_DOMAINS=3D1436=
8440-9620-423d-b816-a3d42a1b50d7:Active,5de36f78-8303-401b-b6c3-e04091077=
f9e:Active,2563b7db-bbca-44f4-ba68-98a516bae14b:Active,75b7f4bc-1c46-4847=
-ba1b-2bbc84c771ce:Attached', 'POOL_SPM_ID=3D2', 'POOL_SPM_LVER=3D61',
'P=
OOL_UUID=3D64a0f560-b9a1-4c87-8a30-0967b4ce3c81', 'REMOTE_PATH=3D10.10.1.=
107:/md2/oVirt/data-win', 'ROLE=3DRegular',
'SDUUID=3D5de36f78-8303-401b-=
b6c3-e04091077f9e', 'TYPE=3DNFS', 'VERSION=3D0',
'_SHA_CKSUM=3De0d678db83=
901ff6986147da4c0490a95d2f72d0']
Thread-1190109::WARNING::2012-08-14 13:44:00,776::persistentDict::264::St=
orage.PersistentDict::(refresh) data seal is broken metadata declares `e0=
d678db83901ff6986147da4c0490a95d2f72d0` should be `e214065c8753aa7965ac9c=
e0d1f64cc2dd2c3339` (lines=3D{'VERSION': '0', 'LEASETIMESEC':
'60', 'DESC=
RIPTION': 'data-win', 'TYPE': 'NFS', 'LOCKPOLICY':
'', 'LEASERETRIES': '3=
', 'POOL_DESCRIPTION': 'Default-30', 'POOL_SPM_LVER':
'61', 'REMOTE_PATH'=
: '10.10.1.107:/md2/oVirt/data-win', 'SDUUID':
'5de36f78-8303-401b-b6c3-e=
04091077f9e', 'MASTER_VERSION': '6060', 'IOOPTIMEOUTSEC':
'10', 'ROLE': '=
Regular', 'LOCKRENEWALINTERVALSEC': '5', 'POOL_DOMAINS':
'14368440-9620-4=
23d-b816-a3d42a1b50d7:Active,5de36f78-8303-401b-b6c3-e04091077f9e:Active,=
2563b7db-bbca-44f4-ba68-98a516bae14b:Active,75b7f4bc-1c46-4847-ba1b-2bbc8=
4c771ce:Attached', 'POOL_UUID':
'64a0f560-b9a1-4c87-8a30-0967b4ce3c81', '=
POOL_SPM_ID': '2', 'CLASS': 'Data'})
Thread-1190109::ERROR::2012-08-14 13:44:00,777::sdc::116::Storage.Storage=
DomainCache::(_findDomain) Error while looking for domain `5de36f78-8303-=
401b-b6c3-e04091077f9e`
Traceback (most recent call last):
File "/usr/share/vdsm/storage/sdc.py", line 111, in _findDomain
return mod.findDomain(sdUUID)
File "/usr/share/vdsm/storage/nfsSD.py", line 122, in findDomain
return NfsStorageDomain(NfsStorageDomain.findDomainPath(sdUUID))
File "/usr/share/vdsm/storage/fileSD.py", line 113, in __init__
sdUUID =3D metadata[sd.DMDK_SDUUID]
File "/usr/share/vdsm/storage/persistentDict.py", line 85, in __getitem=
__
return dec(self._dict[key])
File "/usr/share/vdsm/storage/persistentDict.py", line 193, in __getite=
m__
with self._accessWrapper():
File "/usr/lib64/python2.6/contextlib.py", line 16, in __enter__
return self.gen.next()
File "/usr/share/vdsm/storage/persistentDict.py", line 147, in _accessW=
rapper
self.refresh()
File "/usr/share/vdsm/storage/persistentDict.py", line 265, in refresh
raise se.MetaDataSealIsBroken(declaredChecksum, computedChecksum)
MetaDataSealIsBroken: Meta Data seal is broken (checksum mismatch): 'cksu=
m =3D e0d678db83901ff6986147da4c0490a95d2f72d0, computed_cksum =3D e21406=
5c8753aa7965ac9ce0d1f64cc2dd2c3339'
Thread-1190109::ERROR::2012-08-14 13:44:00,777::task::853::TaskManager.Ta=
sk::(_setError) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::Unexpected=
error
Traceback (most recent call last):
File "/usr/share/vdsm/storage/task.py", line 861, in _run
return fn(*args, **kargs)
File "/usr/share/vdsm/logUtils.py", line 38, in wrapper
res =3D f(*args, **kwargs)
File "/usr/share/vdsm/storage/hsm.py", line 1012, in activateStorageDom=
ain
pool.activateSD(sdUUID)
File "/usr/share/vdsm/storage/securable.py", line 63, in wrapper
return f(self, *args, **kwargs)
File "/usr/share/vdsm/storage/sp.py", line 989, in activateSD
dom =3D sdCache.produce(sdUUID)
File "/usr/share/vdsm/storage/sdc.py", line 93, in produce
dom =3D self._findDomain(sdUUID)
File "/usr/share/vdsm/storage/sdc.py", line 118, in _findDomain
raise se.StorageDomainDoesNotExist(sdUUID)
StorageDomainDoesNotExist: Storage domain does not exist: ('5de36f78-8303=
-401b-b6c3-e04091077f9e',)
Thread-1190109::DEBUG::2012-08-14 13:44:00,777::task::872::TaskManager.Ta=
sk::(_run) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::Task._run: e80a=
f100-65a9-4c1e-8518-c7172ef80efe ('5de36f78-8303-401b-b6c3-e04091077f9e',=
'64a0f560-b9a1-4c87-8a30-0967b4ce3c81') {} failed - stopping task
Thread-1190109::DEBUG::2012-08-14 13:44:00,778::task::1199::TaskManager.T=
ask::(stop) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::stopping in st=
ate preparing (force False)
Thread-1190109::DEBUG::2012-08-14 13:44:00,778::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::ref 1 aborti=
ng True
Thread-1190109::INFO::2012-08-14 13:44:00,778::task::1157::TaskManager.Ta=
sk::(prepare) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::aborting: Ta=
sk is aborted: 'Storage domain does not exist' - code 358
Thread-1190109::DEBUG::2012-08-14 13:44:00,778::task::1162::TaskManager.T=
ask::(prepare) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::Prepare: ab=
orted: Storage domain does not exist
Thread-1190109::DEBUG::2012-08-14 13:44:00,778::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::ref 0 aborti=
ng True
Thread-1190109::DEBUG::2012-08-14 13:44:00,778::task::913::TaskManager.Ta=
sk::(_doAbort) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::Task._doAbo=
rt: force False
Thread-1190109::DEBUG::2012-08-14 13:44:00,779::resourceManager::844::Res=
ourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
Thread-1190109::DEBUG::2012-08-14 13:44:00,779::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::moving =
from state preparing -> state aborting
Thread-1190109::DEBUG::2012-08-14 13:44:00,779::task::537::TaskManager.Ta=
sk::(__state_aborting) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::_ab=
orting: recover policy none
Thread-1190109::DEBUG::2012-08-14 13:44:00,779::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`e80af100-65a9-4c1e-8518-c7172ef80efe`::moving =
from state aborting -> state failed
Thread-1190109::DEBUG::2012-08-14 13:44:00,779::resourceManager::809::Res=
ourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {=
'Storage.5de36f78-8303-401b-b6c3-e04091077f9e': < ResourceRef 'Storage.5d=
e36f78-8303-401b-b6c3-e04091077f9e', isValid: 'True' obj: 'None'>,
'Stora=
ge.64a0f560-b9a1-4c87-8a30-0967b4ce3c81': < ResourceRef 'Storage.64a0f560=
-b9a1-4c87-8a30-0967b4ce3c81', isValid: 'True' obj: 'None'>}
Thread-1190109::DEBUG::2012-08-14 13:44:00,779::resourceManager::844::Res=
ourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
Thread-1190109::DEBUG::2012-08-14 13:44:00,780::resourceManager::538::Res=
ourceManager::(releaseResource) Trying to release resource 'Storage.5de36=
f78-8303-401b-b6c3-e04091077f9e'
Thread-1190109::DEBUG::2012-08-14 13:44:00,780::resourceManager::553::Res=
ourceManager::(releaseResource) Released resource 'Storage.5de36f78-8303-=
401b-b6c3-e04091077f9e' (0 active users)
Thread-1190109::DEBUG::2012-08-14 13:44:00,780::resourceManager::558::Res=
ourceManager::(releaseResource) Resource 'Storage.5de36f78-8303-401b-b6c3=
-e04091077f9e' is free, finding out if anyone is waiting for it.
Thread-1190109::DEBUG::2012-08-14 13:44:00,780::resourceManager::565::Res=
ourceManager::(releaseResource) No one is waiting for resource 'Storage.5=
de36f78-8303-401b-b6c3-e04091077f9e', Clearing records.
Thread-1190109::DEBUG::2012-08-14 13:44:00,780::resourceManager::538::Res=
ourceManager::(releaseResource) Trying to release resource 'Storage.64a0f=
560-b9a1-4c87-8a30-0967b4ce3c81'
Thread-1190109::DEBUG::2012-08-14 13:44:00,781::resourceManager::553::Res=
ourceManager::(releaseResource) Released resource 'Storage.64a0f560-b9a1-=
4c87-8a30-0967b4ce3c81' (0 active users)
Thread-1190109::DEBUG::2012-08-14 13:44:00,781::resourceManager::558::Res=
ourceManager::(releaseResource) Resource 'Storage.64a0f560-b9a1-4c87-8a30=
-0967b4ce3c81' is free, finding out if anyone is waiting for it.
Thread-1190109::DEBUG::2012-08-14 13:44:00,781::resourceManager::565::Res=
ourceManager::(releaseResource) No one is waiting for resource 'Storage.6=
4a0f560-b9a1-4c87-8a30-0967b4ce3c81', Clearing records.
Thread-1190109::ERROR::2012-08-14 13:44:00,781::dispatcher::66::Storage.D=
ispatcher.Protect::(run) {'status': {'message': "Storage domain does
not =
exist: ('5de36f78-8303-401b-b6c3-e04091077f9e',)", 'code': 358}}
Thread-1190117::DEBUG::2012-08-14 13:44:01,779::BindingXMLRPC::160::vds::=
(wrapper) [10.10.1.105]
Thread-1190117::DEBUG::2012-08-14 13:44:01,780::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`e26371b4-ce65-45d1-bb9c-3a6347decc8c`::moving =
from state init -> state preparing
Thread-1190117::INFO::2012-08-14 13:44:01,780::logUtils::37::dispatcher::=
(wrapper) Run and protect: getSpmStatus(spUUID=3D'64a0f560-b9a1-4c87-8a30=
-0967b4ce3c81', options=3DNone)
Thread-1190117::INFO::2012-08-14 13:44:01,780::logUtils::39::dispatcher::=
(wrapper) Run and protect: getSpmStatus, Return response: {'spm_st': {'sp=
mId': 1, 'spmStatus': 'SPM', 'spmLver': 8}}
Thread-1190117::DEBUG::2012-08-14 13:44:01,780::task::1172::TaskManager.T=
ask::(prepare) Task=3D`e26371b4-ce65-45d1-bb9c-3a6347decc8c`::finished: {=
'spm_st': {'spmId': 1, 'spmStatus': 'SPM',
'spmLver': 8}}
Thread-1190117::DEBUG::2012-08-14 13:44:01,780::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`e26371b4-ce65-45d1-bb9c-3a6347decc8c`::moving =
from state preparing -> state finished
Thread-1190117::DEBUG::2012-08-14 13:44:01,781::resourceManager::809::Res=
ourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {=
}
Thread-1190117::DEBUG::2012-08-14 13:44:01,781::resourceManager::844::Res=
ourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
Thread-1190117::DEBUG::2012-08-14 13:44:01,781::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`e26371b4-ce65-45d1-bb9c-3a6347decc8c`::ref 0 aborti=
ng False
Thread-1190118::DEBUG::2012-08-14 13:44:01,805::BindingXMLRPC::160::vds::=
(wrapper) [10.10.1.105]
Thread-1190118::DEBUG::2012-08-14 13:44:01,805::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`109f93dd-452b-4399-aecb-787c72f2c72d`::moving =
from state init -> state preparing
Thread-1190118::INFO::2012-08-14 13:44:01,805::logUtils::37::dispatcher::=
(wrapper) Run and protect: getStoragePoolInfo(spUUID=3D'64a0f560-b9a1-4c8=
7-8a30-0967b4ce3c81', options=3DNone)
Thread-1190118::DEBUG::2012-08-14 13:44:01,806::resourceManager::175::Res=
ourceManager.Request::(__init__) ResName=3D`Storage.64a0f560-b9a1-4c87-8a=
30-0967b4ce3c81`ReqID=3D`54ca4dab-e358-486e-9ccf-1adb414a045e`::Request w=
as made in '/usr/share/vdsm/storage/resourceManager.py' line '485' at
're=
gisterResource'
Thread-1190118::DEBUG::2012-08-14 13:44:01,806::resourceManager::486::Res=
ourceManager::(registerResource) Trying to register resource 'Storage.64a=
0f560-b9a1-4c87-8a30-0967b4ce3c81' for lock type 'shared'
Thread-1190118::DEBUG::2012-08-14 13:44:01,806::resourceManager::528::Res=
ourceManager::(registerResource) Resource 'Storage.64a0f560-b9a1-4c87-8a3=
0-0967b4ce3c81' is free. Now locking as 'shared' (1 active user)
Thread-1190118::DEBUG::2012-08-14 13:44:01,806::resourceManager::212::Res=
ourceManager.Request::(grant) ResName=3D`Storage.64a0f560-b9a1-4c87-8a30-=
0967b4ce3c81`ReqID=3D`54ca4dab-e358-486e-9ccf-1adb414a045e`::Granted requ=
est
Thread-1190118::DEBUG::2012-08-14 13:44:01,807::task::817::TaskManager.Ta=
sk::(resourceAcquired) Task=3D`109f93dd-452b-4399-aecb-787c72f2c72d`::_re=
sourcesAcquired: Storage.64a0f560-b9a1-4c87-8a30-0967b4ce3c81 (shared)
Thread-1190118::DEBUG::2012-08-14 13:44:01,807::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`109f93dd-452b-4399-aecb-787c72f2c72d`::ref 1 aborti=
ng False
Thread-1190118::INFO::2012-08-14 13:44:01,810::logUtils::39::dispatcher::=
(wrapper) Run and protect: getStoragePoolInfo, Return response: {'info': =
{'spm_id': 1, 'master_uuid':
'75b7f4bc-1c46-4847-ba1b-2bbc84c771ce', 'nam=
e': 'Default-30', 'version': '0', 'domains':
'14368440-9620-423d-b816-a3d=
42a1b50d7:Active,5de36f78-8303-401b-b6c3-e04091077f9e:Attached,2563b7db-b=
bca-44f4-ba68-98a516bae14b:Active,75b7f4bc-1c46-4847-ba1b-2bbc84c771ce:Ac=
tive', 'pool_status': 'connected', 'isoprefix':
'/rhev/data-center/64a0f5=
60-b9a1-4c87-8a30-0967b4ce3c81/14368440-9620-423d-b816-a3d42a1b50d7/image=
s/11111111-1111-1111-1111-111111111111', 'type': 'NFS',
'master_ver': 605=
9, 'lver': 8}, 'dominfo': {'14368440-9620-423d-b816-a3d42a1b50d7':
{'stat=
us': 'Active', 'diskfree': '284985524224', 'alerts':
[], 'disktotal': '39=
96801957888'}, '5de36f78-8303-401b-b6c3-e04091077f9e': {'status':
'Attach=
ed'}, '2563b7db-bbca-44f4-ba68-98a516bae14b': {'status':
'Active', 'diskf=
ree': '284985524224', 'alerts': [], 'disktotal':
'3996801957888'}, '75b7f=
4bc-1c46-4847-ba1b-2bbc84c771ce': {'status': 'Active',
'diskfree': '28498=
5524224', 'alerts': [], 'disktotal': '3996801957888'}}}
Thread-1190118::DEBUG::2012-08-14 13:44:01,810::task::1172::TaskManager.T=
ask::(prepare) Task=3D`109f93dd-452b-4399-aecb-787c72f2c72d`::finished: {=
'info': {'spm_id': 1, 'master_uuid':
'75b7f4bc-1c46-4847-ba1b-2bbc84c771c=
e', 'name': 'Default-30', 'version': '0',
'domains': '14368440-9620-423d-=
b816-a3d42a1b50d7:Active,5de36f78-8303-401b-b6c3-e04091077f9e:Attached,25=
63b7db-bbca-44f4-ba68-98a516bae14b:Active,75b7f4bc-1c46-4847-ba1b-2bbc84c=
771ce:Active', 'pool_status': 'connected', 'isoprefix':
'/rhev/data-cente=
r/64a0f560-b9a1-4c87-8a30-0967b4ce3c81/14368440-9620-423d-b816-a3d42a1b50=
d7/images/11111111-1111-1111-1111-111111111111', 'type': 'NFS',
'master_v=
er': 6059, 'lver': 8}, 'dominfo':
{'14368440-9620-423d-b816-a3d42a1b50d7'=
: {'status': 'Active', 'diskfree': '284985524224',
'alerts': [], 'disktot=
al': '3996801957888'}, '5de36f78-8303-401b-b6c3-e04091077f9e':
{'status':=
'Attached'}, '2563b7db-bbca-44f4-ba68-98a516bae14b': {'status':
'Active'=
, 'diskfree': '284985524224', 'alerts': [], 'disktotal':
'3996801957888'}=
, '75b7f4bc-1c46-4847-ba1b-2bbc84c771ce': {'status': 'Active',
'diskfree'=
: '284985524224', 'alerts': [], 'disktotal':
'3996801957888'}}}
Thread-1190118::DEBUG::2012-08-14 13:44:01,810::task::588::TaskManager.Ta=
sk::(_updateState) Task=3D`109f93dd-452b-4399-aecb-787c72f2c72d`::moving =
from state preparing -> state finished
Thread-1190118::DEBUG::2012-08-14 13:44:01,810::resourceManager::809::Res=
ourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {=
'Storage.64a0f560-b9a1-4c87-8a30-0967b4ce3c81': < ResourceRef 'Storage.64=
a0f560-b9a1-4c87-8a30-0967b4ce3c81', isValid: 'True' obj: 'None'>}
Thread-1190118::DEBUG::2012-08-14 13:44:01,810::resourceManager::844::Res=
ourceManager.Owner::(cancelAll) Owner.cancelAll requests {}
Thread-1190118::DEBUG::2012-08-14 13:44:01,811::resourceManager::538::Res=
ourceManager::(releaseResource) Trying to release resource 'Storage.64a0f=
560-b9a1-4c87-8a30-0967b4ce3c81'
Thread-1190118::DEBUG::2012-08-14 13:44:01,811::resourceManager::553::Res=
ourceManager::(releaseResource) Released resource 'Storage.64a0f560-b9a1-=
4c87-8a30-0967b4ce3c81' (0 active users)
Thread-1190118::DEBUG::2012-08-14 13:44:01,811::resourceManager::558::Res=
ourceManager::(releaseResource) Resource 'Storage.64a0f560-b9a1-4c87-8a30=
-0967b4ce3c81' is free, finding out if anyone is waiting for it.
Thread-1190118::DEBUG::2012-08-14 13:44:01,811::resourceManager::565::Res=
ourceManager::(releaseResource) No one is waiting for resource 'Storage.6=
4a0f560-b9a1-4c87-8a30-0967b4ce3c81', Clearing records.
Thread-1190118::DEBUG::2012-08-14 13:44:01,811::task::978::TaskManager.Ta=
sk::(_decref) Task=3D`109f93dd-452b-4399-aecb-787c72f2c72d`::ref 0 aborti=
ng False
--=_bauhaus.teknikservice.nu-24776-1344945707-0001-2
Content-Type: application/pgp-keys; name="0xB88C0B63.asc"
Content-Transfer-Encoding: 7bit
Content-Disposition: attachment;
filename="0xB88C0B63.asc"
-----BEGIN PGP PUBLIC KEY BLOCK-----
Version: GnuPG v1.4.11 (GNU/Linux)
mQGiBEN3nx4RBACx6yQ1m83u8PBPG6iivIWICsZJJn8JP6ccGCeS03bQpxXjk8kx
V9r3pbY2lJUfu6tlVd/0G/RDC2wixLirYIkelYd5QbL8mk3JIwA96zlIxVRBThmW
mig+nI189/vXTNPQKC33xm+/g7kkckD/e/jR2jGycyZiEfvmWQZRpEbnEwCgkOpp
Erfa3KmTZ4mk3ulTW4Q8KaUEAJmCZBuuy/CjhxpK4addENpsl7WT90aNZbrtzFIk
W1xxkEqRwP2BvNyvTv8EHFsmJehxwn9InQ5gSS2LMGKhKapfT5gMHnmyH+YEdcLj
h40L64ftXIyEFenfx8UN85cEKmHqhmrYZkCoRKUeakxZaKs2JZDmytrlLLoj5vAP
wV06BACvKm4eGGkTzx8jKRsZF0Y0B532KhV7tr7OhYE654cPQLdok/0exO1n6wR8
2nljL5G8lMEpB1LQp2Xdrz/6z7vbI0w1Qhxddg71EDIuRIJWADOMO6uf20Vg/Wh8
MGwXCGVtH1QZ4FY4tza5PpP6EqKcb5dqC4TyPYz0J4xpxlc5gbQ8Umlja3kgU2No
bmViZXJnZXIgKGFsdGVybmF0aXZlIHdvcmstZW1haWwpIDxyaWNreUBhY3RuZXQu
c2U+iGAEExECACAFAkh0smkCGyMGCwkIBwMCBBUCCAMEFgIDAQIeAQIXgAAKCRA5
qnzVuIwLY704AJ9sXKYXUMsxbEjmthggRkuPCLY8aQCdEMyWeiELV9BpWegz42cy
4WRC51u0J1JpY2sgU2NobmViZXJnZXIgPHJpY2t5QHNjaG5lYmVyZ2VyLnNlPohb
BBMRAgAbBQJDd58eBgsJCAcDAgMVAgMDFgIBAh4BAheAAAoJEDmqfNW4jAtjU8YA
n1t4P7UmK/MpTQ7FdtALG1Ul45x+AJwOaL66GsKKJLTfVDFvqLu+sFKj54heBBMR
AgAeBgsJCAcDAgMVAgMDFgIBAh4BAheABQJNZ2orAhkBAAoJEDmqfNW4jAtjuMUA
mwaHDOZF0CcAmZBopNfQJt7AZaGTAJwI+aN7wAg9VOFZcQ6W1YDAmOueOYhGBBAR
AgAGBQJLmeIYAAoJEC1o4PaBggLPb68An3ds1SETjFt7FuWNR9RRxxspPZNeAJ0R
kDWbt5WzBJEEEia3PmaK9zssgYhGBBARAgAGBQJDe5cHAAoJEO2/HhEm8iS4m9kA
n35gnntj0uU2E7qgRb27c+XDgsGNAKCSQIrEF36S8RK8SilPLLjhnrHnJYkBIQQQ
AQIADAUCQ3fQFwUDABJ1AAAKCRCXELibyletfNcVB/YyWm59UliFxj+94qpCr7DJ
CeuFZE7Yn3lzwnEOU3Y7pOD1s9BwGPeO5iKej4TCT2JtsWFao1HGSztrE3SrWkc/
rg0MYTIZQc/+wbi+6fTSedZVqxf9teW3FdRQXjOZ9JohJLdU0XxT23TPuSmk0ibo
lCD35hg93vEfePrC2+lACp41a2UP3VNbqUM4rL6F4PfmgyIqgY5FtTWJjNJN34Uv
Tb35YIud+UkQ6eKZggKwBPfma3nwEie1S4f9FskwTGyPNyKGr8Spl2r4snwmFk/Z
KP4k615ob8T8Wbza8TGeS5kYw+Za7MF+Oi+jkdXF/aZSdHBNb9pBcKafcbdEfsWJ
ASIEEAECAAwFAkR/OX0FAwASdQAACgkQlxC4m8pXrXyv3wf+I+Xr2BP1+0yRPh07
yNQQBDT+LaqmRZ0sxyauABbqQzs3R2GAdm/92CuRSXz7jgBiiRd7ZlzA/wm2ApBF
Q8jg9DCxSRNR8KYevTq38ZabMeU3tRkqH5rN++rTmdMbP+MtfoYtTb9+1URXuUBw
Ib4NJWV3QGbSSZLJyA/evha4KBu5A16W8LLb0U9CiSAM7y2ES5Qceg1GXVMVbF6q
TURf+yUxgJjSBBY3zPkTZVF9mxYWgDlzONj6tRUWThqZHtSSBoKfe63hlppLczND
x0TVtuRAFGDlC5HOWF+dAAm5T/Wv9YBmjZi/mcjPvbxhXN5aNff28AMVLW6DqBPX
cotg+4kBIgQQAQIADAUCRJBdEQUDABJ1AAAKCRCXELibyletfD0iB/4yljOGMCTh
u3Q2XQe8RYn3qMuzUOBpdDimoU0kewdkkDoDXF1Z0uTJPA8pdq6beIv5VXqaEGc3
TKFYuX7xMO6fkWryUKf7Vdbb3xNlChQvxBQwPRNdd2B3w+tBcRgJPUJalshl0IvO
DuNbasRyEWbm+LbJF8dZOe5Jr2KTLDPmWURF3faC9YzcfZGbH/Kl5W1SCAigdnzd
62JuAJ8fa/K2zITFF0XkHsXe4jnQSPHUD/sN60zTkeBQdvdjvdtqInRQEJnbJXz6
3Z3Ey3O0736rI9C7MtI9oCCa8U5ed3syPetjf8i3HuVkV8NdmgM+8Cy3MPpWGqm5
oIHDuyS1rh5tiQEiBBABAgAMBQJEoilQBQMAEnUAAAoJEJcQuJvKV618XHsIALtb
J9ZVm4e2KW9C9INBLytXXkiT+SJiwcFiZpbFYWQHGckw0YAyzXTXdxK+/qwCWJWV
z9lgMybf8JQ5bnFptKfnYVphT7R6s+1uzr4phdO1HHxI6p794m9bk+jFNVp4Uj67
JL7OYek2kn+ZZKf7caxOGrmjqzEN1CP8fZyP3p/ClbnH2hhV8OWrIyetP7+O4/a+
I/mHmdvDpwEiKfpHFXJOiuedKJCZ/4sZHFckdsNi8JJWK7/BZQEAlUesEVg38LV+
z7T7VV3fZRW2mbUz1qaOmZyKgUTBQkgH0zsp9OSrggiAsRUxfhqJLjqCWiiUa4Bb
ScPUzM227/5TzR/f/OCJASIEEAECAAwFAkSzTN0FAwASdQAACgkQlxC4m8pXrXxe
mwf+OLvUlDuw403e0R3O9mY3gzqPmQR8G2N6ze7cNQsFHQlSzsQ9HJlmbc0JmU9E
OkhqLDCGtSd/hZ7hLMK8xRkfanA5kHhBWLGOd+5lqZhJ1MvRY+EhBQ5iMZlhE5Op
luRGe5LiKK/esSgL5dr5AnCDl16GI7J8kxYtZcJWGXVj8jEHFyIH7s/E5RS+CJwP
3EAR643o+jtcY0Ut1977+rM18g0l9SRn/BD0AYDAHqYibNxMfVLcbT21MBwBQg/1
aXHBlGb/QmQbclKBWbwATPggc/4zo7kRizFxmVn7cEUPcyz+vA+eqsvuJO5SXZTm
gcz/ZbbwVMs6VmD1WrqDir+FIokBIgQQAQIADAUCRMRwwgUDABJ1AAAKCRCXELib
yletfLVuB/sGnNs1GYiwZJqiopKp+g+xDnRb4fAvy50hfnrZStaAJAHNhJgT3ekR
nLvmi4WWvWZm2d/Kdk/CUuC3LptFLo+nbptbcx6y6f3ulBgyoI+Nza9+fxdv5ieb
TNPi6Dk41xatmeEr2ZjQN9x41I1+Ta3pNEFL7XzbClLRtoTL9/qmSUcJtdHQ8Eux
9CD0LkUeqBgQGrH5mZgSNUMUkQJ1eoeKKsYXwXalH8ruphhiXiF3Zyl9Tc/LjLVU
5apJpTq/od/cN/F91Y+IGUX4zAZO/2qSJ9pDzsj9mOpwwTFCMy1f9f+z5It48Wig
u1nGDOBqyflwSQ1K4q/+pLWaFSpP2QcDiQEiBBABAgAMBQJE1j0WBQMAEnUAAAoJ
EJcQuJvKV618EVIH+gOZ35Wq0r0IwRIV37Cnx+N1MVy6YSEAhzIsEgMZwMSa7u08
8aGHEBvsP8D98Yh33v7Se2g23Ce5pWPYp65gskwxCD6v2K4uCEuJNcxLBq9cIHJv
DOuSLnbqVDomzT1qrrVaFiiLrTOMvqHpa4goxbVpjM8m1Yjpqwy6/vs92dYFVlpM
zBIpgcN+bDqUuwoHHemCc2h2Sc6EzcGxzOoHvPboo1lUi6JknUaQaJbUx5VkBEiz
t3oeV6f1yzvfWwmwWQ7TTHeBqvGSJwZhoyAIWxdP1Cw9GVgq3tSZyEAyNF4ODNic
qudk53jotsUIC3mJK3TWDWlXGNScu/Ffc6KexgiJASIEEAECAAwFAkToCVUFAwAS
dQAACgkQlxC4m8pXrXzyaAf8ChDiv1O1z4Oo7QHcEYP4HXWxx1sDICPzH2oIec2J
9qCIhTlIbKn7y2Og5CfUYvCPqiQOoxn+pYZm+jL1BHvQwYcKdxKnuMmE/OaLzzPv
MlskF2HhRxviN+nFYxWtc+WXNJX+GYJKT23b82P08NZisP/qLnILRur4YV0X3jd9
GbeYGflDdVAKlzsgJo3wWfBYVTVMzmlCeV5ZdE9V9Z1lQht2foD0KiXb+jGcWjFD
fMNK2bhofx/f/eowpFXVKuvQTLFxA3od77ngSnUVCoSXb4yF6hFLhfnMYvIdG4MI
rRIMWm65hBZa6YuEk1UC3FvPK0PCz2gvUI69J5SkkOpdfYkBIgQQAQIADAUCRPnV
igUDABJ1AAAKCRCXELibyletfEkOB/43lBTeg7oa6mDFJ3aL2u/RnzbIb0YYfMUm
1RCQe/3/EMIh+MxlTfbU6UBuc0nzXmdalyVOu1aB5+GbDMi7cKMPMcknd7ItrrmI
JNevcSjcXpCsESHjMcUdB1eUoq7VCirIes1+wLeilszDnNUVcC8FI0P9pAyki+w1
+YzyJX8jupnSOwYcqKuq8+AiLsoavKSvjukfJCMTjEtsCjOb2Z/hTBf37+xBVCKW
NIQR5Xjjp6d8bO9xrqv/PvjLzuhKYDUAM4PVVb9NXDvLAWBF2xKDxBUjpFZiln+/
ic4YpyMAFiH34moPIWM+LSJ0y826gQybpMqXvP8wU4y2PxtyajmpiQEiBBABAgAM
BQJFC6GOBQMAEnUAAAoJEJcQuJvKV618jdgH/2GHXwcE11zfI0Lmn0mLSawcb76b
n+wAZEohxWjxoGAjMZdEsuyFDJP/PnkAAT/5MzgyquxGF1+/WnhtEtsm54hqw44i
8/4fwbII7XZk85h+y3srmipOhhThqnmY8PkSz/+1qaq9UzifeqG82mJ16Y0QwG9J
tgbPntr11zN0h1+RWpZVnl2I9bFeZSDDV3AltYkmzkhtTa90AaA78jKanvsvfHyr
Scr+thgEO2bqJa5LAmtnQ9+Rg+mSSa7eJMhh1CzafOD3AaW9ebQIpkwqSz9VuBga
y2y07NUyULp2uSXQW/uVVH+fcrxNGn6E3WnzoLpEOpzVVZ7vFvxhTczu+YGJASIE
EAECAAwFAkV0fvAFAwASdQAACgkQlxC4m8pXrXy0bwf/YTPtF8P3WZC2YrVms3+v
WzdcreVa0anypXliwNrbZsqI/tUZF8LdNu3echo5kyJM8NVdqhIMU2vNB8Xo1Y8B
bE0U+hIWyv7TBl+CYru5HC8RFAvC69AYQbOLJIMsp/DqFLG8JuryxIh4zcRwNHHr
zSyAhq20O2Yn2v47kvl/fadsaMBt4YLXoLphJn7MRD2Je1qsCBjJzinNewq7Tf+y
fMSSz3b7GV3r5jOdTx5T8WWda+H/pgGLXG050nlZmmrmBFQJS85Jal4mTBpgKwLJ
SBG6HrUkmQ/CqiAlxWpmpL88wAtKBr9drCjJ/9pp1Na4onNA14gZKWqSm6ZvHPG4
KYkBIgQQAQIADAUCRYWijAUDABJ1AAAKCRCXELibyletfOvCCACtsRTvZw621Zal
RBHMsT1JAS8NRMJBkiesTi71q+/OXStQ7LSUGjSyxyir3c2ssblGT0UdZdeZLrx9
wL7618RSitxSswFAPTgStg3Exs3XqUcmgEAfQKYpIV5UZR237+Re4ViNaU6OxnxF
6DlArL02Mnq3EbfQRg33XRd1/EYk3zdMxzwMcnmBRXNnl/Ey0yJnxZ8GuXpIhRU0
3X8ZhpuCzsSReUQtfRPErQk9U6mp0r1QXr8XAetqb5ya6SVaZfO4gfHjIzpyQg3T
SVhwPQOL+nxxEz2EADHk7LQF/ZoGP3L2s++T/HETnlUmXCyCcFn+7nV3nTYUorPo
iVnG97pdiQEiBBABAgAMBQJFlsYRBQMAEnUAAAoJEJcQuJvKV618uqcIAKSeEor3
dw3DLmEOUQO7BM2vv2UBFdnDEQKhbsMIJsTtqZ3xBBOlbY3g6eym8qvucS4XSTwi
M4y1dJfLBsaT0q2oggla9320ysEaCRrJ1Sm+li8aZwjo8T0UfUGx8LQh53wvbP+i
mvH9Utzlo+RD2wrTyvyvxS6tK4wYuF08d44AAopSspgZD/d2Gf0E7WOKP4kQRcA0
7luXzkG7XdFOVmLL81GJEXkMiLSmMdIsmG4Ljw2YyIiTZ9APsV1o3iOKPlEATL4c
UnOYzV/5En7jlv95/m2wNYU442Ewm811QzuKdE/OsoQqnh1z9QwtcswWpwDIvr3s
SzJAck9BpmEg96eIWwQTEQIAGwUCQ3efHgYLCQgHAwIDFQIDAxYCAQIeAQIXgAAK
CRA5qnzVuIwLY1PGAKCF953pK4A/YN0+vXWqFKItF1Uj1QCeMwYzWiiZYJsnmyjj
8/cCta4YC6y0JFJpY2t5IFNjaG5lYmVyZ2VyIDxyaWNreUBhY3QyMDAwLnNlPohg
BBMRAgAgBQJFtoMUAhsjBgsJCAcDAgQVAggDBBYCAwECHgECF4AACgkQOap81biM
C2MMIQCfYBqhJT3nKJyimLZHNiqxklmM698An0xcrcoX/ltrAvTXZzipABm1Wn4I
tCpSaWNreSBTY2huZWJlcmdlciA8cmlja3lAdGVrbmlrc2VydmljZS5udT6IYAQT
EQIAIAUCRbaDKAIbIwYLCQgHAwIEFQIIAwQWAgMBAh4BAheAAAoJEDmqfNW4jAtj
OaYAoI+lG1KAFfylizmJ8Qee1dPjWurqAJ9aFY/iU7RA52dMXEb0PlnqyHAP3LQr
Umlja3kgU2NobmViZXJnZXIgPHJpY2t5QG1qb2xrY2VudHJhbGVuLnNlPohgBBMR
AgAgBQJGWBznAhsjBgsJCAcDAgQVAggDBBYCAwECHgECF4AACgkQOap81biMC2Mw
UQCdHjzBE528RJ7ZD/WU7Ht5WjZsq2YAnAs6DOHZXtWSsFWv13j9brOEWzWPuQIN
BEN3n0kQCAC585+HR4V/5M8/HHb6uRUdLhBzkVjWCiB7eln3E50HRnTfberPbAvK
ZZ9Ske4OS90I5PgGj4zjDleHX8/pGXgaSV+8CwFk9eDqoLKzFKvVJaSp8CX1JrO2
975oUNpFqOy2ejX0jXvphBJIquvBInjOPBpGOkRHIMN9p0rlVhMNywo+t8hEj9PI
nupnUqEUziZONSURPPH5J4yYHl0TLkcRNd2OvnDXgdF5ja+FMB5DhC6gOyylhCGU
8271KAYmE8T3TSFWM+sT6eXJSkMxDmTwQJsFVyNFKrSSukEljyraiZjY9xOj3G7A
tnqu8PVH968fK3jI5Ee0jfGZeDwduJovAAQNB/4rpdE7z3Xa37J+cGwOKrjA9A13
FwoHYa3i1KdfnU2WcxkIRh+BTzjvhdHLzLu2IBHFpGxCrJjO096xR1axhM901k/Q
irLaafqf/jt7QCFcC+kKxVk3rN1RWpfHeJxV62q4szS0k0CU8WHAeaF6/JmKnNq0
CNADBFj9XnQrrPV7RmwbF56cFDOqZpZG0BvWWrhdHOOgoi0Cz24rkMrP47IP9TTP
u64MZVflCJlEsBFOI1Qpf5XvW0GLnLeGrZfY+qTDwP8c0YoVsq3KfWGMLkc5lL7i
snA69d7GPmHpGzm5QqYvJAcoTwKvIHaqyx/JgYHV75imrRlsKKigcRdKrcQqiEYE
GBECAAYFAkN3n0kACgkQOap81biMC2NbzQCfXZJckZnUcuURLggeNvttInRgdloA
nAhULJ90SW2EyHG05qqI/iOeskY4
=A0DR
-----END PGP PUBLIC KEY BLOCK-----
--=_bauhaus.teknikservice.nu-24776-1344945707-0001-2--
7:50 a.m.
Ricky, Try do the following :
go to the meta data of the data storage (in the storage server
go to {storage_domain_name}/######..../dom_md/metadata)
delete the chksum line _SHA_CKSUM=################
try to activate the storage domain again the DC (it should fail again)
vdsm.log should print the computed cksum of the storage domain (Should
be an error there which say "Meta Data seal is broken (checksum
mismatch).... computed_cksum = ")
copy the comuted chksum to the meta data (_SHA_CKSUM={new chksum number}
try to activate it again.
Hope it will fix that.
Mean while I'm checking what caused the bug.
Regards,
Maor
On 08/14/2012 02:53 PM, Ricky Schneberger wrote:
Hi
I attached the logs.
//Ricky
On 2012-08-14 12:56, Maor Lipchuk wrote:
> Hi Ricky can you please add the log of VDSM, also the full engine log.
>
> Regards,
> Maor
>
>
> On 08/14/2012 01:22 PM, Ricky Schneberger wrote:
>> After an normal "yum update" i am unable to get one of the storage
>> domains "UP".
>>
>> My systems is running Centos 6.3.
>>
>> If I try to activate the domain in GUI I got following errors:
>>
>> ---------------------------------
>>
>> 2012-08-14 12:16:22,594 INFO
>> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
>> (pool-5-thread-50) [539cbd7e] Lock Acquired to object EngineLock
>> [exclusiveLocks= key:
>> org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand value:
>> 5de36f78-8303-401b-b6c3-e04091077f9e
>> 2012-08-14 12:16:22,610 INFO
>> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
>> (pool-5-thread-50) [539cbd7e] Running command:
>> ActivateStorageDomainCommand internal: false. Entities affected : ID:
>> 5de36f78-8303-401b-b6c3-e04091077f9e Type: Storage
>> 2012-08-14 12:16:22,618 INFO
>> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
>> (pool-5-thread-50) [539cbd7e] Lock freed to object EngineLock
>> [exclusiveLocks= key:
>> org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand value:
>> 5de36f78-8303-401b-b6c3-e04091077f9e
>> 2012-08-14 12:16:22,709 INFO
>> [org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand]
>> (pool-5-thread-50) [539cbd7e] START,
>> ActivateStorageDomainVDSCommand(storagePoolId =
>> 64a0f560-b9a1-4c87-8a30-0967b4ce3c81, ignoreFailoverLimit = false,
>> compatabilityVersion = null, storageDomainId =
>> 5de36f78-8303-401b-b6c3-e04091077f9e), log id: 152cc8c3
>> 2012-08-14 12:16:25,050 ERROR
>> [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase]
>> (pool-5-thread-50) [539cbd7e] Error code StorageDomainDoesNotExist and
>> error message IRSGenericException: IRSErrorException: Failed to
>> ActivateStorageDomainVDS, error = Storage domain does not exist:
>> ('5de36f78-8303-401b-b6c3-e04091077f9e',)
>> 2012-08-14 12:16:25,050 ERROR
>> [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
>> (pool-5-thread-50) [539cbd7e]
>> IrsBroker::Failed::ActivateStorageDomainVDS due to: IRSErrorException:
>> IRSGenericException: IRSErrorException: Failed to
>> ActivateStorageDomainVDS, error = Storage domain does not exist:
>> ('5de36f78-8303-401b-b6c3-e04091077f9e',)
>> 2012-08-14 12:16:25,058 ERROR
>> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
>> (pool-5-thread-50) [539cbd7e] Command
>> org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand throw Vdc
>> Bll exception. With error message VdcBLLException:
>> org.ovirt.engine.core.vdsbroker.irsbroker.IRSErrorException:
>> IRSGenericException: IRSErrorException: Failed to
>> ActivateStorageDomainVDS, error = Storage domain does not exist:
>> ('5de36f78-8303-401b-b6c3-e04091077f9e',)
>> 2012-08-14 12:16:25,074 INFO
>> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
>> (pool-5-thread-50) [539cbd7e] Command
>> [id=6db5eb90-af14-43f7-8494-d59528a77c27]: Compensating
>> CHANGED_STATUS_ONLY of
>> org.ovirt.engine.core.common.businessentities.storage_pool_iso_map;
>> snapshot: EntityStatusSnapshot [id=storagePoolId =
>> 64a0f560-b9a1-4c87-8a30-0967b4ce3c81, storageId =
>> 5de36f78-8303-401b-b6c3-e04091077f9e, status=InActive].
>> -------------------------------------
>>
>> Ho can I try to resolv it?
>>
>> Regards //Ricky
>>
>>
>>
>> _______________________________________________
>> Users mailing list
>> Users(a)ovirt.org
>> http://lists.ovirt.org/mailman/listinfo/users
>>
>
8:08 a.m.
New subject: [Users] Storage domain does not exist (SOLVED)
Thanks!
It did all the magic!
Regards //Ricky
On 2012-08-14 14:50, Maor Lipchuk wrote:
Ricky, Try do the following :
go to the meta data of the data storage (in the storage server
go to {storage_domain_name}/######..../dom_md/metadata)
delete the chksum line _SHA_CKSUM=################
try to activate the storage domain again the DC (it should fail again)
vdsm.log should print the computed cksum of the storage domain (Should
be an error there which say "Meta Data seal is broken (checksum
mismatch).... computed_cksum = ")
copy the comuted chksum to the meta data (_SHA_CKSUM={new chksum number}
try to activate it again.
Hope it will fix that.
Mean while I'm checking what caused the bug.
Regards,
Maor
On 08/14/2012 02:53 PM, Ricky Schneberger wrote:
> Hi
>
> I attached the logs.
>
> //Ricky
>
> On 2012-08-14 12:56, Maor Lipchuk wrote:
>> Hi Ricky can you please add the log of VDSM, also the full engine log.
>>
>> Regards,
>> Maor
>>
>>
>> On 08/14/2012 01:22 PM, Ricky Schneberger wrote:
>>> After an normal "yum update" i am unable to get one of the storage
>>> domains "UP".
>>>
>>> My systems is running Centos 6.3.
>>>
>>> If I try to activate the domain in GUI I got following errors:
>>>
>>> ---------------------------------
>>>
>>> 2012-08-14 12:16:22,594 INFO
>>> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
>>> (pool-5-thread-50) [539cbd7e] Lock Acquired to object EngineLock
>>> [exclusiveLocks= key:
>>> org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand value:
>>> 5de36f78-8303-401b-b6c3-e04091077f9e
>>> 2012-08-14 12:16:22,610 INFO
>>> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
>>> (pool-5-thread-50) [539cbd7e] Running command:
>>> ActivateStorageDomainCommand internal: false. Entities affected : ID:
>>> 5de36f78-8303-401b-b6c3-e04091077f9e Type: Storage
>>> 2012-08-14 12:16:22,618 INFO
>>> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
>>> (pool-5-thread-50) [539cbd7e] Lock freed to object EngineLock
>>> [exclusiveLocks= key:
>>> org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand value:
>>> 5de36f78-8303-401b-b6c3-e04091077f9e
>>> 2012-08-14 12:16:22,709 INFO
>>> [org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand]
>>> (pool-5-thread-50) [539cbd7e] START,
>>> ActivateStorageDomainVDSCommand(storagePoolId =
>>> 64a0f560-b9a1-4c87-8a30-0967b4ce3c81, ignoreFailoverLimit = false,
>>> compatabilityVersion = null, storageDomainId =
>>> 5de36f78-8303-401b-b6c3-e04091077f9e), log id: 152cc8c3
>>> 2012-08-14 12:16:25,050 ERROR
>>> [org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase]
>>> (pool-5-thread-50) [539cbd7e] Error code StorageDomainDoesNotExist and
>>> error message IRSGenericException: IRSErrorException: Failed to
>>> ActivateStorageDomainVDS, error = Storage domain does not exist:
>>> ('5de36f78-8303-401b-b6c3-e04091077f9e',)
>>> 2012-08-14 12:16:25,050 ERROR
>>> [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand]
>>> (pool-5-thread-50) [539cbd7e]
>>> IrsBroker::Failed::ActivateStorageDomainVDS due to: IRSErrorException:
>>> IRSGenericException: IRSErrorException: Failed to
>>> ActivateStorageDomainVDS, error = Storage domain does not exist:
>>> ('5de36f78-8303-401b-b6c3-e04091077f9e',)
>>> 2012-08-14 12:16:25,058 ERROR
>>> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
>>> (pool-5-thread-50) [539cbd7e] Command
>>> org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand throw Vdc
>>> Bll exception. With error message VdcBLLException:
>>> org.ovirt.engine.core.vdsbroker.irsbroker.IRSErrorException:
>>> IRSGenericException: IRSErrorException: Failed to
>>> ActivateStorageDomainVDS, error = Storage domain does not exist:
>>> ('5de36f78-8303-401b-b6c3-e04091077f9e',)
>>> 2012-08-14 12:16:25,074 INFO
>>> [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand]
>>> (pool-5-thread-50) [539cbd7e] Command
>>> [id=6db5eb90-af14-43f7-8494-d59528a77c27]: Compensating
>>> CHANGED_STATUS_ONLY of
>>> org.ovirt.engine.core.common.businessentities.storage_pool_iso_map;
>>> snapshot: EntityStatusSnapshot [id=storagePoolId =
>>> 64a0f560-b9a1-4c87-8a30-0967b4ce3c81, storageId =
>>> 5de36f78-8303-401b-b6c3-e04091077f9e, status=InActive].
>>> -------------------------------------
>>>
>>> Ho can I try to resolv it?
>>>
>>> Regards //Ricky
>>>
>>>
>>>
>>> _______________________________________________
>>> Users mailing list
>>> Users(a)ovirt.org
>>> http://lists.ovirt.org/mailman/listinfo/users
>>>
>>
>
4272
days inactive
4272
days old
4 comments
2 participants
participants (2)
-
Maor Lipchuk -
Ricky Schneberger