Login
[x]
Log in using an account from:
Fedora Account System
Red Hat Associate
Red Hat Customer
Or login using a Red Hat Bugzilla account
Forgot Password
Login:
Hide Forgot
Create an Account
Red Hat Bugzilla – Attachment 704089 Details for
Bug 916485
RHEVH show "Install failed" status in RHEV-M after upgrade from 6.3GA to latest6.4 with UEFI machine.
[?]
New
Simple Search
Advanced Search
My Links
Browse
Requests
Reports
Current State
Search
Tabular reports
Graphical reports
Duplicates
Other Reports
User Changes
Plotly Reports
Bug Status
Bug Severity
Non-Defaults
|
Product Dashboard
Help
Page Help!
Bug Writing Guidelines
What's new
Browser Support Policy
5.0.4.rh83 Release notes
FAQ
Guides index
User guide
Web Services
Contact
Legal
This site requires JavaScript to be enabled to function correctly, please enable it.
rhevm.log
rhevm.log (text/plain), 168.99 KB, created by
cshao
on 2013-03-01 08:49:42 UTC
(
hide
)
Description:
rhevm.log
Filename:
MIME Type:
Creator:
cshao
Created:
2013-03-01 08:49:42 UTC
Size:
168.99 KB
patch
obsolete
>2013-02-21 09:54:07,569 INFO [org.ovirt.engine.core.bll.Backend] (main) Start time: 2/21/13 9:54 AM >2013-02-21 09:54:07,709 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: CARhevmKey >2013-02-21 09:54:07,833 ERROR [org.ovirt.engine.core.rhevmencryptutils.EncryptionUtils] (main) Failed to decrypt >2013-02-21 09:54:07,833 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (main) Failed to decrypt value for property TruststorePass will be used encrypted value >2013-02-21 09:54:07,869 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: CbcCheckOnVdsChange >2013-02-21 09:54:09,702 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: ScriptsPath >2013-02-21 09:54:09,703 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: SQLServerI18NPrefix >2013-02-21 09:54:09,723 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: MinimalETLVersion >2013-02-21 09:54:09,723 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: RHEVMEARLib >2013-02-21 09:54:09,742 INFO [org.ovirt.engine.core.bll.Backend] (main) VDSBrokerFrontend: 2/21/13 9:54 AM >2013-02-21 09:54:09,748 INFO [org.ovirt.engine.core.bll.Backend] (main) CpuFlagsManager: 2/21/13 9:54 AM >2013-02-21 09:54:09,750 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (main) Setting audit clean up manager to run at: 35 35 3 * * ? >2013-02-21 09:54:09,847 INFO [org.ovirt.engine.core.bll.Backend] (main) AuditLogCleanupManager: 2/21/13 9:54 AM >2013-02-21 09:54:09,873 INFO [org.ovirt.engine.core.bll.TagsDirector] (main) TagsDirector initialization >2013-02-21 09:54:09,893 INFO [org.ovirt.engine.core.bll.TagsDirector] (main) Tag root added to tree >2013-02-21 09:54:09,920 INFO [org.ovirt.engine.core.bll.Backend] (main) TagsDirector: 2/21/13 9:54 AM >2013-02-21 09:54:09,927 INFO [org.ovirt.engine.core.bll.Backend] (main) ImagesSyncronizer: 2/21/13 9:54 AM >2013-02-21 09:54:09,934 INFO [org.ovirt.engine.core.bll.Backend] (main) IsoDomainListSyncronizer: 2/21/13 9:54 AM >2013-02-21 09:54:09,976 INFO [org.ovirt.engine.core.bll.Backend] (main) InitHandlers: 2/21/13 9:54 AM >2013-02-21 09:54:10,001 INFO [org.ovirt.engine.core.bll.Backend] (main) ErrorTranslator: 2/21/13 9:54 AM >2013-02-21 09:54:10,002 INFO [org.ovirt.engine.core.bll.Backend] (main) VdsErrorTranslator: 2/21/13 9:54 AM >2013-02-21 09:54:10,114 INFO [org.ovirt.engine.core.bll.adbroker.UsersDomainsCacheManagerService] (main) UsersDomainsCacheManager: 2/21/13 9:54 AM >2013-02-21 09:54:10,149 INFO [org.ovirt.engine.core.bll.adbroker.UsersDomainsCacheManagerService] (main) DbUserCacheManager: 2/21/13 9:54 AM >2013-02-21 09:54:10,243 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-1) DbUserCacheManager::refreshAllUserData() - entered >2013-02-21 09:54:10,291 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) InitResourceManager: 2/21/13 9:54 AM >2013-02-21 09:54:10,309 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (main) ResourceManager::ResourceManager::Entered >2013-02-21 09:54:10,650 INFO [org.ovirt.engine.core.bll.AsyncTaskManager] (main) AsyncTaskManager: Initialization of AsyncTaskManager completed successfully. >2013-02-21 09:54:10,650 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) AsyncTaskManager: 2/21/13 9:54 AM >2013-02-21 09:54:10,659 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) VdsLoadBalancer: 2/21/13 9:54 AM >2013-02-21 09:54:10,725 INFO [org.ovirt.engine.core.bll.TimeLeasedVmPoolManager] (main) TimeLeasedVmPoolManager constractor entered >2013-02-21 09:54:10,726 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) TimeLeasedVmPoolManager: 2/21/13 9:54 AM >2013-02-21 09:54:10,773 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) MacPoolManager: 2/21/13 9:54 AM >2013-02-21 10:27:39,707 INFO [org.ovirt.engine.core.bll.Backend] (main) Start time: 2/21/13 10:27 AM >2013-02-21 10:27:40,015 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: CARhevmKey >2013-02-21 10:27:40,166 ERROR [org.ovirt.engine.core.rhevmencryptutils.EncryptionUtils] (main) Failed to decrypt >2013-02-21 10:27:40,166 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (main) Failed to decrypt value for property TruststorePass will be used encrypted value >2013-02-21 10:27:40,197 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: CbcCheckOnVdsChange >2013-02-21 10:27:42,091 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: ScriptsPath >2013-02-21 10:27:42,092 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: SQLServerI18NPrefix >2013-02-21 10:27:42,099 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: MinimalETLVersion >2013-02-21 10:27:42,099 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: RHEVMEARLib >2013-02-21 10:27:42,113 INFO [org.ovirt.engine.core.bll.Backend] (main) VDSBrokerFrontend: 2/21/13 10:27 AM >2013-02-21 10:27:42,134 INFO [org.ovirt.engine.core.bll.Backend] (main) CpuFlagsManager: 2/21/13 10:27 AM >2013-02-21 10:27:42,136 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (main) Setting audit clean up manager to run at: 35 35 3 * * ? >2013-02-21 10:27:42,233 INFO [org.ovirt.engine.core.bll.Backend] (main) AuditLogCleanupManager: 2/21/13 10:27 AM >2013-02-21 10:27:42,244 INFO [org.ovirt.engine.core.bll.TagsDirector] (main) TagsDirector initialization >2013-02-21 10:27:42,275 INFO [org.ovirt.engine.core.bll.TagsDirector] (main) Tag root added to tree >2013-02-21 10:27:42,313 INFO [org.ovirt.engine.core.bll.Backend] (main) TagsDirector: 2/21/13 10:27 AM >2013-02-21 10:27:42,320 INFO [org.ovirt.engine.core.bll.Backend] (main) ImagesSyncronizer: 2/21/13 10:27 AM >2013-02-21 10:27:42,327 INFO [org.ovirt.engine.core.bll.Backend] (main) IsoDomainListSyncronizer: 2/21/13 10:27 AM >2013-02-21 10:27:42,371 INFO [org.ovirt.engine.core.bll.Backend] (main) InitHandlers: 2/21/13 10:27 AM >2013-02-21 10:27:42,394 INFO [org.ovirt.engine.core.bll.Backend] (main) ErrorTranslator: 2/21/13 10:27 AM >2013-02-21 10:27:42,394 INFO [org.ovirt.engine.core.bll.Backend] (main) VdsErrorTranslator: 2/21/13 10:27 AM >2013-02-21 10:27:42,493 INFO [org.ovirt.engine.core.bll.adbroker.UsersDomainsCacheManagerService] (main) UsersDomainsCacheManager: 2/21/13 10:27 AM >2013-02-21 10:27:42,579 INFO [org.ovirt.engine.core.bll.adbroker.UsersDomainsCacheManagerService] (main) DbUserCacheManager: 2/21/13 10:27 AM >2013-02-21 10:27:42,682 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-1) DbUserCacheManager::refreshAllUserData() - entered >2013-02-21 10:27:42,754 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) InitResourceManager: 2/21/13 10:27 AM >2013-02-21 10:27:42,772 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (main) ResourceManager::ResourceManager::Entered >2013-02-21 10:27:43,013 INFO [org.ovirt.engine.core.bll.AsyncTaskManager] (main) AsyncTaskManager: Initialization of AsyncTaskManager completed successfully. >2013-02-21 10:27:43,014 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) AsyncTaskManager: 2/21/13 10:27 AM >2013-02-21 10:27:43,019 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) VdsLoadBalancer: 2/21/13 10:27 AM >2013-02-21 10:27:43,047 INFO [org.ovirt.engine.core.bll.TimeLeasedVmPoolManager] (main) TimeLeasedVmPoolManager constractor entered >2013-02-21 10:27:43,048 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) TimeLeasedVmPoolManager: 2/21/13 10:27 AM >2013-02-21 10:27:43,062 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) MacPoolManager: 2/21/13 10:27 AM >2013-02-21 13:16:55,211 INFO [org.ovirt.engine.core.bll.Backend] (main) Start time: 2/21/13 1:16 PM >2013-02-21 13:16:55,542 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: CARhevmKey >2013-02-21 13:16:55,883 ERROR [org.ovirt.engine.core.rhevmencryptutils.EncryptionUtils] (main) Failed to decrypt >2013-02-21 13:16:55,883 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (main) Failed to decrypt value for property TruststorePass will be used encrypted value >2013-02-21 13:16:55,900 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: CbcCheckOnVdsChange >2013-02-21 13:16:57,213 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: ScriptsPath >2013-02-21 13:16:57,218 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: SQLServerI18NPrefix >2013-02-21 13:16:57,242 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: MinimalETLVersion >2013-02-21 13:16:57,242 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: RHEVMEARLib >2013-02-21 13:16:58,569 INFO [org.ovirt.engine.core.bll.Backend] (main) VDSBrokerFrontend: 2/21/13 1:16 PM >2013-02-21 13:16:58,577 INFO [org.ovirt.engine.core.bll.Backend] (main) CpuFlagsManager: 2/21/13 1:16 PM >2013-02-21 13:16:58,579 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (main) Setting audit clean up manager to run at: 35 35 3 * * ? >2013-02-21 13:16:58,624 INFO [org.ovirt.engine.core.bll.Backend] (main) AuditLogCleanupManager: 2/21/13 1:16 PM >2013-02-21 13:16:58,910 INFO [org.ovirt.engine.core.bll.TagsDirector] (main) TagsDirector initialization >2013-02-21 13:16:58,947 INFO [org.ovirt.engine.core.bll.TagsDirector] (main) Tag root added to tree >2013-02-21 13:16:59,123 INFO [org.ovirt.engine.core.bll.Backend] (main) TagsDirector: 2/21/13 1:16 PM >2013-02-21 13:16:59,140 INFO [org.ovirt.engine.core.bll.Backend] (main) ImagesSyncronizer: 2/21/13 1:16 PM >2013-02-21 13:16:59,164 INFO [org.ovirt.engine.core.bll.Backend] (main) IsoDomainListSyncronizer: 2/21/13 1:16 PM >2013-02-21 13:16:59,245 INFO [org.ovirt.engine.core.bll.Backend] (main) InitHandlers: 2/21/13 1:16 PM >2013-02-21 13:16:59,291 INFO [org.ovirt.engine.core.bll.Backend] (main) ErrorTranslator: 2/21/13 1:16 PM >2013-02-21 13:16:59,293 INFO [org.ovirt.engine.core.bll.Backend] (main) VdsErrorTranslator: 2/21/13 1:16 PM >2013-02-21 13:16:59,579 INFO [org.ovirt.engine.core.bll.adbroker.UsersDomainsCacheManagerService] (main) UsersDomainsCacheManager: 2/21/13 1:16 PM >2013-02-21 13:17:00,099 INFO [org.ovirt.engine.core.bll.adbroker.UsersDomainsCacheManagerService] (main) DbUserCacheManager: 2/21/13 1:17 PM >2013-02-21 13:17:00,263 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-1) DbUserCacheManager::refreshAllUserData() - entered >2013-02-21 13:17:00,401 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) InitResourceManager: 2/21/13 1:17 PM >2013-02-21 13:17:00,437 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (main) ResourceManager::ResourceManager::Entered >2013-02-21 13:17:02,631 INFO [org.ovirt.engine.core.bll.AsyncTaskManager] (main) AsyncTaskManager: Initialization of AsyncTaskManager completed successfully. >2013-02-21 13:17:02,631 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) AsyncTaskManager: 2/21/13 1:17 PM >2013-02-21 13:17:02,640 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) VdsLoadBalancer: 2/21/13 1:17 PM >2013-02-21 13:17:02,709 INFO [org.ovirt.engine.core.bll.TimeLeasedVmPoolManager] (main) TimeLeasedVmPoolManager constractor entered >2013-02-21 13:17:02,711 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) TimeLeasedVmPoolManager: 2/21/13 1:17 PM >2013-02-21 13:17:02,741 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) MacPoolManager: 2/21/13 1:17 PM >2013-02-21 14:01:45,556 INFO [org.ovirt.engine.core.bll.Backend] (main) Start time: 2/21/13 2:01 PM >2013-02-21 14:01:45,916 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: CARhevmKey >2013-02-21 14:01:46,067 ERROR [org.ovirt.engine.core.rhevmencryptutils.EncryptionUtils] (main) Failed to decrypt >2013-02-21 14:01:46,067 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (main) Failed to decrypt value for property TruststorePass will be used encrypted value >2013-02-21 14:01:46,097 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: CbcCheckOnVdsChange >2013-02-21 14:01:47,228 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: ScriptsPath >2013-02-21 14:01:47,236 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: SQLServerI18NPrefix >2013-02-21 14:01:47,255 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: MinimalETLVersion >2013-02-21 14:01:47,255 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (main) Could not find enum value for option: RHEVMEARLib >2013-02-21 14:01:48,551 INFO [org.ovirt.engine.core.bll.Backend] (main) VDSBrokerFrontend: 2/21/13 2:01 PM >2013-02-21 14:01:48,563 INFO [org.ovirt.engine.core.bll.Backend] (main) CpuFlagsManager: 2/21/13 2:01 PM >2013-02-21 14:01:48,565 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (main) Setting audit clean up manager to run at: 35 35 3 * * ? >2013-02-21 14:01:48,672 INFO [org.ovirt.engine.core.bll.Backend] (main) AuditLogCleanupManager: 2/21/13 2:01 PM >2013-02-21 14:01:48,716 INFO [org.ovirt.engine.core.bll.TagsDirector] (main) TagsDirector initialization >2013-02-21 14:01:48,755 INFO [org.ovirt.engine.core.bll.TagsDirector] (main) Tag root added to tree >2013-02-21 14:01:48,794 INFO [org.ovirt.engine.core.bll.Backend] (main) TagsDirector: 2/21/13 2:01 PM >2013-02-21 14:01:48,801 INFO [org.ovirt.engine.core.bll.Backend] (main) ImagesSyncronizer: 2/21/13 2:01 PM >2013-02-21 14:01:48,809 INFO [org.ovirt.engine.core.bll.Backend] (main) IsoDomainListSyncronizer: 2/21/13 2:01 PM >2013-02-21 14:01:48,872 INFO [org.ovirt.engine.core.bll.Backend] (main) InitHandlers: 2/21/13 2:01 PM >2013-02-21 14:01:48,908 INFO [org.ovirt.engine.core.bll.Backend] (main) ErrorTranslator: 2/21/13 2:01 PM >2013-02-21 14:01:48,909 INFO [org.ovirt.engine.core.bll.Backend] (main) VdsErrorTranslator: 2/21/13 2:01 PM >2013-02-21 14:01:49,026 INFO [org.ovirt.engine.core.bll.adbroker.UsersDomainsCacheManagerService] (main) UsersDomainsCacheManager: 2/21/13 2:01 PM >2013-02-21 14:01:49,069 INFO [org.ovirt.engine.core.bll.adbroker.UsersDomainsCacheManagerService] (main) DbUserCacheManager: 2/21/13 2:01 PM >2013-02-21 14:01:49,194 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-1) DbUserCacheManager::refreshAllUserData() - entered >2013-02-21 14:01:49,283 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) InitResourceManager: 2/21/13 2:01 PM >2013-02-21 14:01:49,326 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (main) ResourceManager::ResourceManager::Entered >2013-02-21 14:01:49,631 INFO [org.ovirt.engine.core.bll.AsyncTaskManager] (main) AsyncTaskManager: Initialization of AsyncTaskManager completed successfully. >2013-02-21 14:01:49,631 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) AsyncTaskManager: 2/21/13 2:01 PM >2013-02-21 14:01:49,633 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) VdsLoadBalancer: 2/21/13 2:01 PM >2013-02-21 14:01:49,669 INFO [org.ovirt.engine.core.bll.TimeLeasedVmPoolManager] (main) TimeLeasedVmPoolManager constractor entered >2013-02-21 14:01:49,670 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) TimeLeasedVmPoolManager: 2/21/13 2:01 PM >2013-02-21 14:01:49,690 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (main) MacPoolManager: 2/21/13 2:01 PM >2013-02-21 14:18:09,073 INFO [org.ovirt.engine.core.bll.LoginAdminUserCommand] (http-0.0.0.0-8443-3) Running command: LoginAdminUserCommand internal: false. >2013-02-21 14:18:09,151 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (http-0.0.0.0-8443-3) AuditLogType: UNASSIGNED not exist in string table >2013-02-21 14:18:09,155 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (http-0.0.0.0-8443-3) AuditLogType: USER_UPDATE_VM_CLUSTER_DEFAULT_HOST_CLEARED not have severity. Assumed Normal >2013-02-21 14:18:09,156 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (http-0.0.0.0-8443-3) AuditLogType: USER_REMOVE_VM_TEMPLATE_FINISHED not have severity. Assumed Normal >2013-02-21 14:18:09,156 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (http-0.0.0.0-8443-3) AuditLogType: VM_IMPORT_INFO not have severity. Assumed Normal >2013-02-21 14:18:09,156 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (http-0.0.0.0-8443-3) AuditLogType: SYSTEM_UPDATE_VDS_GROUP not have severity. Assumed Normal >2013-02-21 14:18:09,156 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (http-0.0.0.0-8443-3) AuditLogType: SYSTEM_UPDATE_VDS_GROUP_FAILED not have severity. Assumed Normal >2013-02-21 14:18:09,157 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (http-0.0.0.0-8443-3) AuditLogType: SYSTEM_CHANGE_STORAGE_POOL_STATUS_RESET_IRS not have severity. Assumed Normal >2013-02-21 14:18:09,596 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:09,597 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:09,704 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:09,706 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:09,728 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:09,731 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:09,761 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:09,817 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:09,882 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:09,883 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:09,916 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:09,939 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:09,948 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:09,993 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:10,045 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:10,087 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:10,113 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:10,120 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:10,170 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:10,201 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:10,206 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:10,242 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:10,245 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-3) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:18:10,800 WARN [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (http-0.0.0.0-8443-3) Adding new value to configuration cache. >2013-02-21 14:18:10,801 WARN [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (http-0.0.0.0-8443-3) Didnt find the value of DBPagingType in DB for version general - using default: Offset >2013-02-21 14:18:10,807 WARN [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (http-0.0.0.0-8443-3) Adding new value to configuration cache. >2013-02-21 14:18:10,812 WARN [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (http-0.0.0.0-8443-3) Didnt find the value of DBPagingSyntax in DB for version general - using default: OFFSET (%1$s -1) LIMIT %2$s >2013-02-21 14:18:10,812 WARN [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (http-0.0.0.0-8443-3) Adding new value to configuration cache. >2013-02-21 14:18:10,813 WARN [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (http-0.0.0.0-8443-3) Didnt find the value of DBSearchTemplate in DB for version general - using default: SELECT * FROM (%2$s) %1$s) as T1 %3$s >2013-02-21 14:20:57,507 INFO [org.ovirt.engine.core.bll.LoginAdminUserCommand] (http-0.0.0.0-8443-1) Running command: LoginAdminUserCommand internal: false. >2013-02-21 14:20:57,715 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:57,720 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:57,782 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:57,786 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:57,812 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:57,814 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:57,846 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:57,847 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:57,886 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:57,888 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:57,961 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:58,002 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:58,024 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:58,029 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:58,056 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:58,059 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:58,093 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:58,134 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:58,138 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:58,170 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:58,173 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:58,198 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:20:58,232 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-21 14:22:31,751 WARN [org.ovirt.engine.core.bll.BackendCallBacksDirector] (pool-19-thread-50) Client did not poll async queries updates for 30 cycles, suspending server side updates for session id = FB97774869EC2678B3A24460199F09CC >2013-02-21 14:22:32,752 WARN [org.ovirt.engine.core.bll.BackendCallBacksDirector] (pool-19-thread-50) Client did not poll async queries updates for 30 cycles sessionId = FB97774869EC2678B3A24460199F09CC. Callback will be removed. >2013-02-21 15:01:49,232 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-2) DbUserCacheManager::refreshAllUserData() - entered >2013-02-21 15:02:20,112 WARN [org.ovirt.engine.core.bll.BackendCallBacksDirector] (pool-19-thread-49) Client did not poll async queries updates for 30 cycles, suspending server side updates for session id = 5BE8399C8507BE4351806766F371502D >2013-02-21 15:02:21,115 WARN [org.ovirt.engine.core.bll.BackendCallBacksDirector] (pool-19-thread-49) Client did not poll async queries updates for 30 cycles sessionId = 5BE8399C8507BE4351806766F371502D. Callback will be removed. >2013-02-21 16:01:49,236 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-95) DbUserCacheManager::refreshAllUserData() - entered >2013-02-21 17:01:49,241 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-66) DbUserCacheManager::refreshAllUserData() - entered >2013-02-21 18:01:49,244 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-75) DbUserCacheManager::refreshAllUserData() - entered >2013-02-21 19:01:49,249 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-82) DbUserCacheManager::refreshAllUserData() - entered >2013-02-21 20:01:49,252 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-49) DbUserCacheManager::refreshAllUserData() - entered >2013-02-21 21:01:49,256 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-31) DbUserCacheManager::refreshAllUserData() - entered >2013-02-21 22:01:49,261 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-32) DbUserCacheManager::refreshAllUserData() - entered >2013-02-21 23:01:49,264 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-43) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 00:01:49,268 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-48) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 01:01:49,272 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-72) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 02:01:49,276 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-100) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 03:01:49,280 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-33) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 03:35:35,004 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (QuartzScheduler_Worker-58) AuditLogCleanupManager::deleteAgedOutAuditLogs - entered >2013-02-22 04:01:49,285 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-14) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 05:01:49,291 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-8) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 06:01:49,295 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-16) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 07:01:49,300 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-79) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 08:01:49,303 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-12) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 09:01:49,308 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-80) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 10:01:49,312 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-35) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 11:01:49,317 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-94) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 12:01:49,322 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-75) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 13:01:49,326 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-70) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 14:01:49,331 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-51) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 15:01:49,335 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-15) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 16:01:49,340 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-54) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 17:01:49,344 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-90) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 18:01:49,348 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-14) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 19:01:49,351 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-9) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 20:01:49,356 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-87) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 21:01:49,359 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-40) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 22:01:49,364 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-11) DbUserCacheManager::refreshAllUserData() - entered >2013-02-22 23:01:49,369 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-89) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 00:01:49,374 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-42) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 01:01:49,380 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-52) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 02:01:49,385 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-6) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 03:01:49,390 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-45) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 03:35:35,003 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (QuartzScheduler_Worker-81) AuditLogCleanupManager::deleteAgedOutAuditLogs - entered >2013-02-23 04:01:49,396 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-79) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 05:01:49,400 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-74) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 06:01:49,404 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-24) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 07:01:49,410 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-13) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 08:01:49,416 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-7) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 09:01:49,421 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-43) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 10:01:49,426 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-45) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 11:01:49,432 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-46) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 12:01:49,437 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-58) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 13:01:49,442 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-40) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 14:01:49,448 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-55) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 15:01:49,453 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-15) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 16:01:49,458 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-71) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 17:01:49,463 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-25) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 18:01:49,469 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-8) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 19:01:49,474 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-60) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 20:01:49,480 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-29) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 21:01:49,486 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-49) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 22:01:49,491 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-85) DbUserCacheManager::refreshAllUserData() - entered >2013-02-23 23:01:49,497 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-73) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 00:01:49,502 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-38) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 01:01:49,507 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-99) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 02:01:49,516 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-64) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 03:01:49,521 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-19) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 03:35:35,003 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (QuartzScheduler_Worker-13) AuditLogCleanupManager::deleteAgedOutAuditLogs - entered >2013-02-24 04:01:49,526 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-16) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 05:01:49,532 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-40) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 06:01:49,537 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-54) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 07:01:49,541 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-21) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 08:01:49,546 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-58) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 09:01:49,551 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-52) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 10:01:49,556 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-93) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 11:01:49,561 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-30) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 12:01:49,567 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-70) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 13:01:49,573 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-21) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 14:01:49,578 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-95) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 15:01:49,583 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-40) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 16:01:49,588 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-77) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 17:01:49,594 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-11) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 18:01:49,599 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-18) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 19:01:49,605 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-91) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 20:01:49,610 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-29) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 21:01:49,616 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-22) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 22:01:49,621 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-16) DbUserCacheManager::refreshAllUserData() - entered >2013-02-24 23:01:49,626 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-74) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 00:01:49,631 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-15) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 01:01:49,636 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-76) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 02:01:49,642 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-49) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 03:01:49,647 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-96) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 03:35:35,002 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (QuartzScheduler_Worker-3) AuditLogCleanupManager::deleteAgedOutAuditLogs - entered >2013-02-25 04:01:49,652 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-20) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 05:01:49,658 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-95) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 06:01:49,664 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-55) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 07:01:49,669 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-16) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 08:01:49,674 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-84) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 09:01:49,679 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-81) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 10:01:49,684 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-90) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 11:01:49,689 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-38) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 12:01:49,695 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-52) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 13:01:49,701 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-9) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 14:01:49,705 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-46) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 15:01:49,709 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-49) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 16:01:49,715 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-21) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 17:01:49,720 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-2) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 18:01:49,723 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-98) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 19:01:49,728 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-38) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 20:01:49,734 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-30) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 21:01:49,739 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-86) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 22:01:49,745 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-95) DbUserCacheManager::refreshAllUserData() - entered >2013-02-25 23:01:49,750 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-13) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 00:01:49,756 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-78) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 01:01:49,761 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-53) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 02:01:49,767 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-40) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 03:01:49,773 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-80) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 03:35:35,002 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (QuartzScheduler_Worker-93) AuditLogCleanupManager::deleteAgedOutAuditLogs - entered >2013-02-26 04:01:49,778 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-100) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 05:01:49,784 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-88) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 06:01:49,790 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-42) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 07:01:49,795 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-74) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 08:01:49,800 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-71) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 09:01:49,805 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-97) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 10:01:49,811 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-22) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 11:01:49,816 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-7) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 12:01:49,821 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-90) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 13:01:49,825 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-80) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 14:01:49,830 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-1) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 15:01:49,835 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-70) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 16:01:49,842 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-40) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 17:01:49,847 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-40) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 18:01:49,854 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-17) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 19:01:49,859 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-59) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 20:01:49,864 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-58) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 21:01:49,869 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-82) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 22:01:49,873 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-82) DbUserCacheManager::refreshAllUserData() - entered >2013-02-26 23:01:49,880 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-28) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 00:01:49,886 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-28) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 01:01:49,891 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-70) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 02:01:49,896 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-26) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 03:01:49,902 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-94) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 03:35:35,002 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (QuartzScheduler_Worker-9) AuditLogCleanupManager::deleteAgedOutAuditLogs - entered >2013-02-27 04:01:49,907 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-55) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 05:01:49,914 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-58) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 06:01:49,919 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-25) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 07:01:49,925 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-84) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 08:01:49,930 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-46) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 09:01:49,936 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-45) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 10:01:49,941 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-89) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 11:01:49,946 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-48) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 12:01:49,951 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-50) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 13:01:49,956 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-75) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 14:01:49,961 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-77) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 15:01:49,966 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-18) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 16:01:49,973 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-56) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 17:01:49,978 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-33) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 18:01:49,984 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-89) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 19:01:49,989 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-11) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 20:01:49,994 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-3) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 21:01:49,999 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-18) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 22:01:50,005 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-45) DbUserCacheManager::refreshAllUserData() - entered >2013-02-27 23:01:50,009 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-96) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 00:01:50,014 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-41) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 01:01:50,020 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-74) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 02:01:50,025 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-99) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 03:01:50,029 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-86) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 03:35:35,010 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (QuartzScheduler_Worker-4) AuditLogCleanupManager::deleteAgedOutAuditLogs - entered >2013-02-28 04:01:50,035 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-19) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 05:01:50,043 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-2) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 06:01:50,049 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-72) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 07:01:50,054 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-85) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 08:01:50,059 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-55) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 09:01:50,064 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-30) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 09:50:54,503 INFO [org.ovirt.engine.core.bll.LoginAdminUserCommand] (http-0.0.0.0-8443-1) Running command: LoginAdminUserCommand internal: false. >2013-02-28 09:50:54,549 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,557 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,573 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,585 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,594 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,602 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,607 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-5) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,611 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,616 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-5) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,621 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,625 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-5) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,632 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,636 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-5) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,646 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,653 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-5) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,658 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,664 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-5) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,668 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,674 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-5) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,683 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-5) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,691 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-5) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,699 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:50:54,708 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:53:25,546 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-5) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:53:25,793 INFO [org.ovirt.engine.core.bll.storage.AddEmptyStoragePoolCommand] (http-0.0.0.0-8443-5) Running command: AddEmptyStoragePoolCommand internal: false. Entities affected : ID: aaa00000-0000-0000-0000-123456789aaa Type: System >2013-02-28 09:53:26,971 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-5) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:53:26,980 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-5) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 09:53:30,518 INFO [org.ovirt.engine.core.bll.AddVdsGroupCommand] (http-0.0.0.0-8443-5) Running command: AddVdsGroupCommand internal: false. Entities affected : ID: 32d0d070-ad0c-4383-8f69-ea2a806a8eed Type: StoragePool >2013-02-28 10:01:50,069 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-1) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 10:08:44,268 INFO [org.ovirt.engine.core.bll.RegisterVdsQuery] (http-0.0.0.0-8443-2) Running Command: RegisterVds >2013-02-28 10:08:44,274 WARN [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (http-0.0.0.0-8443-2) Adding new value to configuration cache. >2013-02-28 10:08:44,274 WARN [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (http-0.0.0.0-8443-2) Didnt find the value of LogVdsRegistration in DB for version general - using default: false >2013-02-28 10:08:44,473 INFO [org.ovirt.engine.core.bll.AddVdsCommand] (pool-19-thread-49) Running command: AddVdsCommand internal: true. Entities affected : ID: 99408929-82cf-4dc7-a532-9d998063fa95 Type: VdsGroups >2013-02-28 10:08:44,673 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (pool-19-thread-49) Running command: AddVdsSpmIdCommand internal: true. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:08:44,701 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (pool-19-thread-49) No string for UNASSIGNED type. Use default Log >2013-02-28 10:08:44,724 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (pool-19-thread-49) Cannot get vdsManager for vdsid=c78adde2-814b-11e2-9202-001a4a420b20 >2013-02-28 10:08:44,725 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (pool-19-thread-49) START, RemoveVdsVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20), log id: 7f332e2c >2013-02-28 10:08:44,725 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (pool-19-thread-49) Cannot get vdsManager for vdsid=c78adde2-814b-11e2-9202-001a4a420b20 >2013-02-28 10:08:44,725 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (pool-19-thread-49) FINISH, RemoveVdsVDSCommand, log id: 7f332e2c >2013-02-28 10:08:44,729 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (pool-19-thread-49) Cannot get vdsManager for vdsid=c78adde2-814b-11e2-9202-001a4a420b20 >2013-02-28 10:08:44,729 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (pool-19-thread-49) START, AddVdsVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20), log id: 1c02be9a >2013-02-28 10:08:44,729 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (pool-19-thread-49) AddVds - entered , starting logic to add VDS c78adde2-814b-11e2-9202-001a4a420b20 >2013-02-28 10:08:44,734 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (pool-19-thread-49) AddVds - VDS c78adde2-814b-11e2-9202-001a4a420b20 was added, will try to add it to the resource manager >2013-02-28 10:08:44,743 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (pool-19-thread-49) Eneterd VdsManager:constructor >2013-02-28 10:08:44,744 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (pool-19-thread-49) vdsBroker(10.66.72.21,54,321) >2013-02-28 10:08:45,016 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (pool-19-thread-49) ResourceManager::AddVds - VDS c78adde2-814b-11e2-9202-001a4a420b20 was added to the Resource Manager >2013-02-28 10:08:45,017 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (pool-19-thread-49) FINISH, AddVdsVDSCommand, log id: 1c02be9a >2013-02-28 10:08:45,049 INFO [org.ovirt.engine.core.bll.RegisterVdsQuery] (http-0.0.0.0-8443-2) RegisterVdsQuery::Register - Registered a new VDS pending approval - Name: dell-pet105-01.qe.lab.eng.nay.redhat.com, Hostname: 10.66.72.21, UniqueID: 44454C4C-3900-104A-8048-B8C04F4D3258_00:22:19:27:54:c7 >2013-02-28 10:08:45,083 INFO [org.ovirt.engine.core.register.RegisterServlet] (http-0.0.0.0-8443-2) Succeeded to run RegisterVds. >2013-02-28 10:11:53,465 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:11:54,223 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:11:54,225 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:11:54,243 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:11:54,258 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:11:54,269 ERROR [org.ovirt.engine.core.bll.GetoVirtISOsQuery] (http-0.0.0.0-8443-1) ovirt ISOs directory not found. Search in: /usr/share/rhev-hypervisor >2013-02-28 10:11:54,291 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:11:58,340 INFO [org.ovirt.engine.core.bll.ChangeVDSClusterCommand] (http-0.0.0.0-8443-1) Running command: ChangeVDSClusterCommand internal: false. Entities affected : ID: a6c82f58-8149-11e2-92b2-001a4a420b20 Type: VdsGroups, ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:11:58,445 INFO [org.ovirt.engine.core.bll.RemoveVdsSpmIdCommand] (http-0.0.0.0-8443-1) Running command: RemoveVdsSpmIdCommand internal: true. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:11:58,474 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (http-0.0.0.0-8443-1) Running command: AddVdsSpmIdCommand internal: true. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:11:58,488 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (http-0.0.0.0-8443-1) No string for UNASSIGNED type. Use default Log >2013-02-28 10:11:58,625 INFO [org.ovirt.engine.core.bll.UpdateVdsCommand] (http-0.0.0.0-8443-1) Running command: UpdateVdsCommand internal: false. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:11:58,761 INFO [org.ovirt.engine.core.bll.ApproveVdsCommand] (pool-19-thread-49) Running command: ApproveVdsCommand internal: false. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:11:58,762 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-19-thread-49) Before Installation pool-19-thread-49, Powerclient/oVirtNode case: setting status to installing >2013-02-28 10:11:58,785 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-49) START, SetVdsStatusVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, status=Installing, nonOperationalReason=NONE), log id: 714136e2 >2013-02-28 10:11:58,815 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-49) FINISH, SetVdsStatusVDSCommand, log id: 714136e2 >2013-02-28 10:11:59,346 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-19-thread-49) Before Installation pool-19-thread-49 >2013-02-28 10:11:59,348 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Executing oVirt installation stage. (Stage: Starting Host installation) >2013-02-28 10:11:59,350 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Executing oVirt installation stage. (Stage: Connecting to Host) >2013-02-28 10:11:59,467 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-8) Initializing Host: dell-pet105-01.qe.lab.eng.nay.redhat.com >2013-02-28 10:12:00,334 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Recieved message: <BSTRAP component='RHEV_INSTALL' status='OK' message='Connected to Host 10.66.72.21 with SSH key fingerprint: 30:7c:5e:50:9d:e0:2e:f8:e2:4e:88:0b:81:e3:3f:16'/>. FYI. (Stage: Connecting to Host) >2013-02-28 10:12:00,367 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Successfully connected to server ssh. (Stage: Connecting to Host) >2013-02-28 10:12:00,368 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Executing oVirt installation stage. (Stage: Running first installation script on Host) >2013-02-28 10:12:00,368 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) Invoking /usr/share/vdsm-reg/vdsm-gen-cert -O "rhevhhh" 10.66.72.21 4f6e3cea-fc1d-4a85-8e13-37793f523327 on 10.66.72.21 >2013-02-28 10:12:00,519 ERROR [org.ovirt.engine.core.bll.GetoVirtISOsQuery] (http-0.0.0.0-8443-1) ovirt ISOs directory not found. Search in: /usr/share/rhev-hypervisor >2013-02-28 10:12:02,276 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Recieved message: <BSTRAP component='Encryption setup' status='OK'/> ><BSTRAP component='RHEV_INSTALL' status='OK'/> >. Stage completed. (Stage: Running first installation script on Host) >2013-02-28 10:12:02,303 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) RunSSHCommand returns true >2013-02-28 10:12:02,303 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Executing oVirt installation stage. (Stage: Downloading certificate request from Host) >2013-02-28 10:12:02,303 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) Downloading file /tmp/cert_4f6e3cea-fc1d-4a85-8e13-37793f523327.req from 10.66.72.21 to /etc/pki/rhevm/requests/cert_4f6e3cea-fc1d-4a85-8e13-37793f523327.req >2013-02-28 10:12:03,072 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. successfully done sftp operation ( Stage: Downloading certificate request from Host) >2013-02-28 10:12:03,073 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) return true >2013-02-28 10:12:03,073 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) DownloadCertificateRequest ended:true >2013-02-28 10:12:03,073 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Executing oVirt installation stage. (Stage: Sign certificate request and generate certificate) >2013-02-28 10:12:04,090 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) SignCertificateRequest ended:true >2013-02-28 10:12:04,090 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Executing oVirt installation stage. (Stage: Upload signed sertificate to Host) >2013-02-28 10:12:04,091 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) Uploading file /etc/pki/rhevm/certs/10.66.72.21cert.pem to /tmp/cert_4f6e3cea-fc1d-4a85-8e13-37793f523327.pem on 10.66.72.21 >2013-02-28 10:12:04,091 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) Uploading file /etc/pki/rhevm/certs/10.66.72.21cert.pem to /tmp/cert_4f6e3cea-fc1d-4a85-8e13-37793f523327.pem on 10.66.72.21 >2013-02-28 10:12:04,347 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. successfully done sftp operation ( Stage: Upload signed sertificate to Host) >2013-02-28 10:12:04,347 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) return true >2013-02-28 10:12:04,347 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) UploadSignedCertificate ended:true >2013-02-28 10:12:04,348 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Executing oVirt installation stage. (Stage: Upload Cerficate Autority to Host) >2013-02-28 10:12:04,348 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) Uploading file /etc/pki/rhevm/ca.pem to /tmp/CA_4f6e3cea-fc1d-4a85-8e13-37793f523327.pem on 10.66.72.21 >2013-02-28 10:12:04,348 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) Uploading file /etc/pki/rhevm/ca.pem to /tmp/CA_4f6e3cea-fc1d-4a85-8e13-37793f523327.pem on 10.66.72.21 >2013-02-28 10:12:04,561 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. successfully done sftp operation ( Stage: Upload Cerficate Autority to Host) >2013-02-28 10:12:04,561 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) return true >2013-02-28 10:12:04,562 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Executing oVirt installation stage, sending SSH Command /usr/share/vdsm-reg/vdsm-complete -c 'ssl=true' 4f6e3cea-fc1d-4a85-8e13-37793f523327 0. (Stage: Running second installation script on Host) >2013-02-28 10:12:04,562 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) Invoking /usr/share/vdsm-reg/vdsm-complete -c 'ssl=true' 4f6e3cea-fc1d-4a85-8e13-37793f523327 0 on 10.66.72.21 >2013-02-28 10:12:20,164 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Recieved message: <BSTRAP component='instCert' status='OK'/> ><BSTRAP component='CoreDump' status='OK'/> ><BSTRAP component='cleanAll' status='OK'/> ><BSTRAP component='VDS Configuration' status='OK'/> ><BSTRAP component='Restart' status='OK' message='Restarting vdsmd service' /> ><BSTRAP component='RHEV_INSTALL' status='OK'/> >. Stage completed. (Stage: Running second installation script on Host) >2013-02-28 10:12:20,295 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) RunSSHCommand returns true >2013-02-28 10:12:20,315 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-19-thread-49) After Installation pool-19-thread-49 >2013-02-28 10:12:20,317 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-49) START, SetVdsStatusVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, status=Reboot, nonOperationalReason=NONE), log id: 56b5ec1b >2013-02-28 10:12:20,337 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-49) FINISH, SetVdsStatusVDSCommand, log id: 56b5ec1b >2013-02-28 10:12:20,343 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-50) START, SetVdsStatusVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, status=NonResponsive, nonOperationalReason=NONE), log id: 22d68530 >2013-02-28 10:12:20,345 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-49) START, SetVdsStatusVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, status=Unassigned, nonOperationalReason=NONE), log id: 78f60751 >2013-02-28 10:12:20,368 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-50) FINISH, SetVdsStatusVDSCommand, log id: 22d68530 >2013-02-28 10:12:20,379 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-49) FINISH, SetVdsStatusVDSCommand, log id: 78f60751 >2013-02-28 10:12:20,874 ERROR [org.ovirt.engine.core.bll.GetoVirtISOsQuery] (http-0.0.0.0-8443-2) ovirt ISOs directory not found. Search in: /usr/share/rhev-hypervisor >2013-02-28 10:12:22,245 WARN [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-53) ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds = c78adde2-814b-11e2-9202-001a4a420b20 : dell-pet105-01.qe.lab.eng.nay.redhat.com, VDS Network Error, continuing. >VDSNetworkException: >2013-02-28 10:12:22,964 ERROR [org.ovirt.engine.core.bll.GetoVirtISOsQuery] (http-0.0.0.0-8443-2) ovirt ISOs directory not found. Search in: /usr/share/rhev-hypervisor >2013-02-28 10:12:24,629 WARN [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (http-0.0.0.0-8443-2) Adding new value to configuration cache. >2013-02-28 10:12:24,629 WARN [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (http-0.0.0.0-8443-2) Didnt find the value of DBI18NPrefix in DB for version general - using default: >2013-02-28 10:12:25,269 INFO [org.ovirt.engine.core.bll.InitVdsOnUpCommand] (QuartzScheduler_Worker-6) Running command: InitVdsOnUpCommand internal: true. >2013-02-28 10:12:25,297 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-6) No string for UNASSIGNED type. Use default Log >2013-02-28 10:12:25,338 INFO [org.ovirt.engine.core.bll.MultipleActionsRunner] (pool-19-thread-50) MultipleActionsRunner of type MigrateVmToServer invoked with no actions >2013-02-28 10:12:25,387 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (QuartzScheduler_Worker-6) Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:12:25,479 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (QuartzScheduler_Worker-6) Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:12:33,757 INFO [org.ovirt.engine.core.bll.MaintananceNumberOfVdssCommand] (pool-19-thread-50) Running command: MaintananceNumberOfVdssCommand internal: false. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:12:33,760 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-50) START, SetVdsStatusVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, status=PreparingForMaintenance, nonOperationalReason=NONE), log id: 7ccd8aa5 >2013-02-28 10:12:33,786 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-50) FINISH, SetVdsStatusVDSCommand, log id: 7ccd8aa5 >2013-02-28 10:12:33,867 INFO [org.ovirt.engine.core.bll.MaintananceVdsCommand] (pool-19-thread-50) Running command: MaintananceVdsCommand internal: true. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:12:35,324 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (QuartzScheduler_Worker-55) vds::Updated vds status from Preparing for Maintenance to Maintenance in database, vds = c78adde2-814b-11e2-9202-001a4a420b20 : dell-pet105-01.qe.lab.eng.nay.redhat.com >2013-02-28 10:23:08,032 INFO [org.ovirt.engine.core.bll.UpdateVdsCommand] (http-0.0.0.0-8443-2) Running command: UpdateVdsCommand internal: false. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:23:08,057 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (http-0.0.0.0-8443-2) START, SetVdsStatusVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, status=Installing, nonOperationalReason=NONE), log id: 73734dd9 >2013-02-28 10:23:08,066 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (http-0.0.0.0-8443-2) FINISH, SetVdsStatusVDSCommand, log id: 73734dd9 >2013-02-28 10:23:08,098 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-19-thread-49) Running command: InstallVdsCommand internal: true. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:23:08,098 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-19-thread-49) Before Installation pool-19-thread-49, Powerclient/oVirtNode case: setting status to installing >2013-02-28 10:23:08,098 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-49) START, SetVdsStatusVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, status=Installing, nonOperationalReason=NONE), log id: 20d580fb >2013-02-28 10:23:08,127 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-49) FINISH, SetVdsStatusVDSCommand, log id: 20d580fb >2013-02-28 10:23:08,134 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-19-thread-49) Before Installation pool-19-thread-49 >2013-02-28 10:23:08,136 INFO [org.ovirt.engine.core.bll.OVirtInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Executing oVirt reinstall/upgrade stage. (Stage: Starting Host installation) >2013-02-28 10:23:08,136 INFO [org.ovirt.engine.core.bll.OVirtInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Executing oVirt reinstall/upgrade stage. (Stage: Connecting to Host) >2013-02-28 10:23:08,778 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Recieved message: <BSTRAP component='RHEV_INSTALL' status='OK' message='Connected to Host 10.66.72.21 with SSH key fingerprint: 30:7c:5e:50:9d:e0:2e:f8:e2:4e:88:0b:81:e3:3f:16'/>. FYI. (Stage: Connecting to Host) >2013-02-28 10:23:08,789 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Successfully connected to server ssh. (Stage: Connecting to Host) >2013-02-28 10:23:08,790 INFO [org.ovirt.engine.core.bll.OVirtInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Executing oVirt reinstall/upgrade stage. (Stage: Upload upgrade ISO to oVirt Node) >2013-02-28 10:23:08,790 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) Uploading file /usr/share/rhev-hypervisor/rhevh-6.4-20130227.0.el6_4.iso to /data/updates/ovirt-node-image.iso on 10.66.72.21 >2013-02-28 10:23:08,790 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Recieved message: Preparing ISO file. FYI. (Stage: Upload upgrade ISO to oVirt Node) >2013-02-28 10:23:08,790 INFO [org.ovirt.engine.core.bll.InstallerMessages] (pool-19-thread-49) VDS message: Preparing ISO file >2013-02-28 10:23:09,160 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Recieved message: Determining current address from host perspective. FYI. (Stage: Upload upgrade ISO to oVirt Node) >2013-02-28 10:23:09,160 INFO [org.ovirt.engine.core.bll.InstallerMessages] (pool-19-thread-49) VDS message: Determining current address from host perspective >2013-02-28 10:23:09,160 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) getLocalIP entry >2013-02-28 10:23:09,209 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) getLocalIP return: 10.66.104.178 > >2013-02-28 10:23:09,209 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Recieved message: Starting ISO upload. FYI. (Stage: Upload upgrade ISO to oVirt Node) >2013-02-28 10:23:09,209 INFO [org.ovirt.engine.core.bll.InstallerMessages] (pool-19-thread-49) VDS message: Starting ISO upload >2013-02-28 10:23:12,674 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Recieved message: ISO upload ended successfully. FYI. (Stage: Upload upgrade ISO to oVirt Node) >2013-02-28 10:23:12,674 INFO [org.ovirt.engine.core.bll.InstallerMessages] (pool-19-thread-49) VDS message: ISO upload ended successfully >2013-02-28 10:23:12,674 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. successfully done sftp operation ( Stage: Upload upgrade ISO to oVirt Node) >2013-02-28 10:23:12,842 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) uploadLargeFile returns true >2013-02-28 10:23:12,842 INFO [org.ovirt.engine.core.bll.OVirtInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Executing oVirt reinstall/upgrade stage. (Stage: Running upgrade / reinstall script on oVirt Node) >2013-02-28 10:23:12,842 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) Invoking /usr/share/vdsm-reg/vdsm-upgrade on 10.66.72.21 >2013-02-28 10:23:32,357 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-49) Installation of 10.66.72.21. Recieved message: <BSTRAP component='RHEL_INSTALL' status='OK'message='vdsm daemon stopped for upgrade process!'/> ><BSTRAP component='setMountPoint' status='OK' message='Mount succeeded.'/> ><BSTRAP component='doUpgrade' status='OK' message='Upgrade Succeeded. Rebooting'/> ><BSTRAP component='umount' status='OK' message='umount Succeeded'/> ><BSTRAP component='RHEV_INSTALL' status='OK'/> >. Stage completed. (Stage: Running upgrade / reinstall script on oVirt Node) >2013-02-28 10:23:32,364 ERROR [org.ovirt.engine.core.bll.InstallerMessages] (pool-19-thread-49) Installation of Host. Received illegal XML from Host. Message: org.ovirt.engine.core.compat.CompatException: Element type "BSTRAP" must be followed by either attribute specifications, ">" or "/>"., Exception: {2} >2013-02-28 10:23:32,409 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-49) RunSSHCommand returns true >2013-02-28 10:23:32,411 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-19-thread-49) After Installation pool-19-thread-49 >2013-02-28 10:23:32,413 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-49) START, SetVdsStatusVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, status=Reboot, nonOperationalReason=NONE), log id: 168ddfa6 >2013-02-28 10:23:32,431 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-49) FINISH, SetVdsStatusVDSCommand, log id: 168ddfa6 >2013-02-28 10:23:32,435 INFO [org.ovirt.engine.core.bll.VdsCommand] (pool-19-thread-50) Waiting 300 seconds, for server to finish reboot process. >2013-02-28 10:26:43,432 ERROR [org.ovirt.engine.core.bll.RegisterVdsQuery] (http-0.0.0.0-8443-2) RegisterVdsQuery::ExecuteQueryCommand: CanDoAction failed: VDS_STATUS_NOT_VALID_FOR_UPDATE >2013-02-28 10:26:43,433 ERROR [org.ovirt.engine.core.bll.RegisterVdsQuery] (http-0.0.0.0-8443-2) Query RegisterVdsQuery failed. Exception message is VDS_STATUS_NOT_VALID_FOR_UPDATE >2013-02-28 10:26:43,434 INFO [org.ovirt.engine.core.register.RegisterServlet] (http-0.0.0.0-8443-2) Succeeded to run RegisterVds. >2013-02-28 10:28:32,452 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-50) START, SetVdsStatusVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, status=NonResponsive, nonOperationalReason=NONE), log id: 2468d2b >2013-02-28 10:28:32,470 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-50) FINISH, SetVdsStatusVDSCommand, log id: 2468d2b >2013-02-28 10:28:34,100 INFO [org.ovirt.engine.core.bll.InitVdsOnUpCommand] (QuartzScheduler_Worker-32) Running command: InitVdsOnUpCommand internal: true. >2013-02-28 10:28:34,120 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-32) No string for UNASSIGNED type. Use default Log >2013-02-28 10:28:34,123 INFO [org.ovirt.engine.core.bll.MultipleActionsRunner] (pool-19-thread-50) MultipleActionsRunner of type MigrateVmToServer invoked with no actions >2013-02-28 10:28:34,145 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (QuartzScheduler_Worker-32) Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:28:34,165 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (QuartzScheduler_Worker-32) Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:41:34,092 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:41:34,142 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetDeviceListVDSCommand] (http-0.0.0.0-8443-1) START, GetDeviceListVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, storageType=FCP), log id: 1cd6a083 >2013-02-28 10:41:37,062 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetDeviceListVDSCommand] (http-0.0.0.0-8443-1) FINISH, GetDeviceListVDSCommand, return: [org.ovirt.engine.core.common.businessentities.LUNs@cf5196b6, org.ovirt.engine.core.common.businessentities.LUNs@bb87bacb], log id: 1cd6a083 >2013-02-28 10:43:09,379 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:43:09,621 INFO [org.ovirt.engine.core.bll.storage.AddSANStorageDomainCommand] (http-0.0.0.0-8443-1) Running command: AddSANStorageDomainCommand internal: false. Entities affected : ID: aaa00000-0000-0000-0000-123456789aaa Type: System >2013-02-28 10:43:09,697 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVGVDSCommand] (http-0.0.0.0-8443-1) START, CreateVGVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, storageDomainId=c6c77717-201d-47fc-aff3-023806e79ac5, deviceList=[3600a0b80005adb0b00004d834f0b7954]), log id: 25dfb408 >2013-02-28 10:43:11,388 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVGVDSCommand] (http-0.0.0.0-8443-1) FINISH, CreateVGVDSCommand, return: gF89u0-W59W-K2JD-qGrk-Pfzb-l1hW-xG74VM, log id: 25dfb408 >2013-02-28 10:43:11,397 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStorageDomainVDSCommand] (http-0.0.0.0-8443-1) START, CreateStorageDomainVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, storageDomain=org.ovirt.engine.core.common.businessentities.storage_domain_static@25a41e88, args=gF89u0-W59W-K2JD-qGrk-Pfzb-l1hW-xG74VM), log id: 56ab9e8 >2013-02-28 10:43:19,617 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStorageDomainVDSCommand] (http-0.0.0.0-8443-1) FINISH, CreateStorageDomainVDSCommand, log id: 56ab9e8 >2013-02-28 10:43:19,635 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetStorageDomainStatsVDSCommand] (http-0.0.0.0-8443-1) START, GetStorageDomainStatsVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, storageDomainId=c6c77717-201d-47fc-aff3-023806e79ac5), log id: 32ed0551 >2013-02-28 10:43:20,034 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetStorageDomainStatsVDSCommand] (http-0.0.0.0-8443-1) FINISH, GetStorageDomainStatsVDSCommand, return: org.ovirt.engine.core.common.businessentities.storage_domains@1243246f, log id: 32ed0551 >2013-02-28 10:43:20,068 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVGInfoVDSCommand] (http-0.0.0.0-8443-1) START, GetVGInfoVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, VGID=gF89u0-W59W-K2JD-qGrk-Pfzb-l1hW-xG74VM), log id: 3415b1b5 >2013-02-28 10:43:20,117 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVGInfoVDSCommand] (http-0.0.0.0-8443-1) FINISH, GetVGInfoVDSCommand, return: [org.ovirt.engine.core.common.businessentities.LUNs@81bd230b], log id: 3415b1b5 >2013-02-28 10:43:20,328 INFO [org.ovirt.engine.core.bll.storage.AddStoragePoolWithStoragesCommand] (pool-19-thread-50) Lock Aquired to object 32d0d070-ad0c-4383-8f69-ea2a806a8eed >2013-02-28 10:43:20,328 INFO [org.ovirt.engine.core.bll.storage.AddStoragePoolWithStoragesCommand] (pool-19-thread-50) Running command: AddStoragePoolWithStoragesCommand internal: false. Entities affected : ID: 32d0d070-ad0c-4383-8f69-ea2a806a8eed Type: StoragePool >2013-02-28 10:43:20,527 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStoragePoolVDSCommand] (pool-19-thread-50) START, CreateStoragePoolVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, storagePoolId=32d0d070-ad0c-4383-8f69-ea2a806a8eed, storageType=FCP, storagePoolName=fc, masterDomainId=c6c77717-201d-47fc-aff3-023806e79ac5, domainsIdList=[c6c77717-201d-47fc-aff3-023806e79ac5], masterVersion=1), log id: 33265a35 >2013-02-28 10:43:46,828 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateStoragePoolVDSCommand] (pool-19-thread-50) FINISH, CreateStoragePoolVDSCommand, log id: 33265a35 >2013-02-28 10:43:46,889 INFO [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-19-thread-50) Lock Aquired to object c6c77717-201d-47fc-aff3-023806e79ac5 >2013-02-28 10:43:46,890 INFO [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-19-thread-50) Running command: ActivateStorageDomainCommand internal: true. Entities affected : ID: c6c77717-201d-47fc-aff3-023806e79ac5 Type: Storage >2013-02-28 10:43:46,914 INFO [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-19-thread-50) ActivateStorage Domain. Before Connect all hosts to pool. Time:2/28/13 10:43 AM >2013-02-28 10:43:46,989 INFO [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-19-thread-50) ActivateStorage Domain. After Connect all hosts to pool. Time:2/28/13 10:43 AM >2013-02-28 10:43:46,994 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand] (pool-19-thread-50) START, ActivateStorageDomainVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = null, storageDomainId = c6c77717-201d-47fc-aff3-023806e79ac5), log id: 4fb2ba90 >2013-02-28 10:43:47,047 INFO [org.ovirt.engine.core.bll.storage.SetStoragePoolStatusCommand] (pool-19-thread-50) Running command: SetStoragePoolStatusCommand internal: true. Entities affected : ID: 32d0d070-ad0c-4383-8f69-ea2a806a8eed Type: StoragePool >2013-02-28 10:43:47,148 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (pool-19-thread-50) hostFromVds::selectedVds - dell-pet105-01.qe.lab.eng.nay.redhat.com, spmStatus Unknown_Pool, storage pool fc >2013-02-28 10:43:47,165 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (pool-19-thread-50) START, ConnectStoragePoolVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, vds_spm_id = 1, masterDomainId = c6c77717-201d-47fc-aff3-023806e79ac5, masterVersion = 1), log id: 785fe334 >2013-02-28 10:43:52,285 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (pool-19-thread-50) FINISH, ConnectStoragePoolVDSCommand, log id: 785fe334 >2013-02-28 10:43:52,304 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (pool-19-thread-50) hostFromVds::Connected host to pool - selectedVds - dell-pet105-01.qe.lab.eng.nay.redhat.com, spmStatus Free, storage pool fc >2013-02-28 10:43:52,322 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (pool-19-thread-50) starting spm on vds dell-pet105-01.qe.lab.eng.nay.redhat.com, storage pool fc, prevId -1, LVER -1 >2013-02-28 10:43:52,330 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (pool-19-thread-50) START, SpmStartVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, prevId=-1, prevLVER=-1, storagePoolFormatType=V2, recoveryMode=Manual, SCSIFencing=false), log id: 23086074 >2013-02-28 10:43:52,356 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (pool-19-thread-50) spmStart polling started: taskId = e0dbb96a-6921-4573-a6bc-f0676552e4b4 >2013-02-28 10:44:15,911 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (pool-19-thread-50) spmStart polling ended: taskId = e0dbb96a-6921-4573-a6bc-f0676552e4b4 task status = finished >2013-02-28 10:44:15,929 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (pool-19-thread-50) spmStart polling ended. spm status: SPM >2013-02-28 10:44:15,945 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (pool-19-thread-50) START, HSMClearTaskVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, taskId=e0dbb96a-6921-4573-a6bc-f0676552e4b4), log id: 4c071488 >2013-02-28 10:44:15,964 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (pool-19-thread-50) FINISH, HSMClearTaskVDSCommand, log id: 4c071488 >2013-02-28 10:44:15,964 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (pool-19-thread-50) FINISH, SpmStartVDSCommand, return: org.ovirt.engine.core.common.businessentities.SpmStatusResult@45267cda, log id: 23086074 >2013-02-28 10:44:15,966 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (pool-19-thread-50) ResourceManager:StoragePoolStatusChange - no event listener defined, nothing done. >2013-02-28 10:44:15,966 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (pool-19-thread-50) Initialize Irs proxy from vds: 10.66.72.21 >2013-02-28 10:44:16,042 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.ActivateStorageDomainVDSCommand] (pool-19-thread-50) FINISH, ActivateStorageDomainVDSCommand, log id: 4fb2ba90 >2013-02-28 10:44:16,043 INFO [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-19-thread-50) ActivateStorage Domain. After Activate storage domain in vds. Time:2/28/13 10:44 AM >2013-02-28 10:44:16,092 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (pool-19-thread-48) START, ConnectStoragePoolVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, vds_spm_id = 1, masterDomainId = c6c77717-201d-47fc-aff3-023806e79ac5, masterVersion = 1), log id: d97c7a3 >2013-02-28 10:44:16,111 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (pool-19-thread-48) FINISH, ConnectStoragePoolVDSCommand, log id: d97c7a3 >2013-02-28 10:44:16,111 INFO [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-19-thread-50) ActivateStorage Domain. After Refresh all pools . Time:2/28/13 10:44 AM >2013-02-28 10:44:16,130 INFO [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-19-thread-50) ActivateStorage Domain. After change storage pool status in vds. Time:2/28/13 10:44 AM >2013-02-28 10:44:16,133 INFO [org.ovirt.engine.core.bll.storage.ActivateStorageDomainCommand] (pool-19-thread-50) Lock freed to object c6c77717-201d-47fc-aff3-023806e79ac5 >2013-02-28 10:44:16,138 INFO [org.ovirt.engine.core.bll.storage.AddStoragePoolWithStoragesCommand] (pool-19-thread-50) Lock freed to object 32d0d070-ad0c-4383-8f69-ea2a806a8eed >2013-02-28 10:48:56,069 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:48:56,071 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:48:56,393 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:48:56,401 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:49:09,672 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand] (http-0.0.0.0-8443-1) START, IsValidVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = null), log id: f2152e1 >2013-02-28 10:49:09,673 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand] (http-0.0.0.0-8443-1) FINISH, IsValidVDSCommand, return: true, log id: f2152e1 >2013-02-28 10:49:09,691 INFO [org.ovirt.engine.core.bll.AddVmFromScratchCommand] (http-0.0.0.0-8443-1) Running command: AddVmFromScratchCommand internal: false. Entities affected : ID: a6c82f58-8149-11e2-92b2-001a4a420b20 Type: VdsGroups >2013-02-28 10:49:09,694 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand] (http-0.0.0.0-8443-1) START, IsValidVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = null), log id: 796241a4 >2013-02-28 10:49:09,695 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand] (http-0.0.0.0-8443-1) FINISH, IsValidVDSCommand, return: true, log id: 796241a4 >2013-02-28 10:49:10,052 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.UpdateVMVDSCommand] (http-0.0.0.0-8443-1) START, UpdateVMVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = null, storageDomainId = 00000000-0000-0000-0000-000000000000, infoDictionary.size = 1), log id: 4726915e >2013-02-28 10:49:10,092 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.UpdateVMVDSCommand] (http-0.0.0.0-8443-1) FINISH, UpdateVMVDSCommand, log id: 4726915e >2013-02-28 10:49:13,042 INFO [org.ovirt.engine.core.bll.AddVmInterfaceCommand] (http-0.0.0.0-8443-1) Running command: AddVmInterfaceCommand internal: false. Entities affected : ID: a4554520-43da-4575-9c6e-59c0feecdc02 Type: VM >2013-02-28 10:49:13,045 INFO [org.ovirt.engine.core.bll.MacPoolManager] (http-0.0.0.0-8443-1) MacPoolManager::allocateNewMac entered >2013-02-28 10:49:13,045 INFO [org.ovirt.engine.core.bll.MacPoolManager] (http-0.0.0.0-8443-1) MacPoolManager::allocateNewMac allocated mac = 00:1a:4a:42:68:00 >2013-02-28 10:49:13,841 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:49:19,501 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:49:19,699 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand] (http-0.0.0.0-8443-1) START, IsValidVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = null), log id: 253158e4 >2013-02-28 10:49:19,700 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand] (http-0.0.0.0-8443-1) FINISH, IsValidVDSCommand, return: true, log id: 253158e4 >2013-02-28 10:49:19,736 INFO [org.ovirt.engine.core.bll.AddDiskToVmCommand] (http-0.0.0.0-8443-1) Running command: AddDiskToVmCommand internal: false. Entities affected : ID: a4554520-43da-4575-9c6e-59c0feecdc02 Type: VM >2013-02-28 10:49:19,786 INFO [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (http-0.0.0.0-8443-1) START, SetVmStatusVDSCommand(vmId = a4554520-43da-4575-9c6e-59c0feecdc02, status = ImageLocked), log id: 333b3088 >2013-02-28 10:49:19,863 INFO [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (http-0.0.0.0-8443-1) FINISH, SetVmStatusVDSCommand, log id: 333b3088 >2013-02-28 10:49:19,951 INFO [org.ovirt.engine.core.bll.AddImageFromScratchCommand] (http-0.0.0.0-8443-1) Running command: AddImageFromScratchCommand internal: true. Entities affected : ID: c6c77717-201d-47fc-aff3-023806e79ac5 Type: Storage >2013-02-28 10:49:19,996 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (http-0.0.0.0-8443-1) START, CreateImageVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = 3.0, storageDomainId = c6c77717-201d-47fc-aff3-023806e79ac5, imageGroupId = 788f9532-0e38-491e-b842-ddc095a0aa16, imageSizeInBytes = 8589934592, volumeFormat = COW, diskType = System, newImageId = a84fd6f7-4229-42f2-829e-074753442325, newImageDescription = _ActiveImage_fc1_Thu Feb 28 10:49:19 CST 2013), log id: 4eddfa4 >2013-02-28 10:49:19,996 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (http-0.0.0.0-8443-1) -- CreateImageVDSCommand::ExecuteIrsBrokerCommand: calling 'createVolume' with two new parameters: description and UUID >2013-02-28 10:49:19,997 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (http-0.0.0.0-8443-1) -- createVolume parameters: > sdUUID=c6c77717-201d-47fc-aff3-023806e79ac5 > spUUID=32d0d070-ad0c-4383-8f69-ea2a806a8eed > imgGUID=788f9532-0e38-491e-b842-ddc095a0aa16 > size=8,589,934,592 bytes > volFormat=COW > volType=Sparse > diskType=System > volUUID=a84fd6f7-4229-42f2-829e-074753442325 > descr=_ActiveImage_fc1_Thu Feb 28 10:49:19 CST 2013 > srcImgGUID=00000000-0000-0000-0000-000000000000 > srcVolUUID=00000000-0000-0000-0000-000000000000 > >2013-02-28 10:49:20,904 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (http-0.0.0.0-8443-1) FINISH, CreateImageVDSCommand, return: a84fd6f7-4229-42f2-829e-074753442325, log id: 4eddfa4 >2013-02-28 10:49:20,920 INFO [org.ovirt.engine.core.bll.SPMAsyncTask] (http-0.0.0.0-8443-1) BaseAsyncTask::AddOrUpdateTaskInDB: Adding task 3d04ed05-3856-422a-a84b-c0ff4c840f10 to DataBase >2013-02-28 10:49:20,943 INFO [org.ovirt.engine.core.bll.EntityAsyncTask] (http-0.0.0.0-8443-1) EntityAsyncTask::Adding EntityMultiAsyncTasks object for entity a4554520-43da-4575-9c6e-59c0feecdc02 >2013-02-28 10:49:20,945 INFO [org.ovirt.engine.core.bll.EntityMultiAsyncTasks] (http-0.0.0.0-8443-1) EntityMultiAsyncTasks::AttachTask: Attaching task 3d04ed05-3856-422a-a84b-c0ff4c840f10 to entity a4554520-43da-4575-9c6e-59c0feecdc02. >2013-02-28 10:49:20,945 INFO [org.ovirt.engine.core.bll.AsyncTaskManager] (http-0.0.0.0-8443-1) AsyncTaskManager::AddTaskToManager: Adding task 3d04ed05-3856-422a-a84b-c0ff4c840f10 (Parent Command AddDiskToVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters), polling hasn't started yet.. >2013-02-28 10:49:21,006 INFO [org.ovirt.engine.core.bll.SPMAsyncTask] (http-0.0.0.0-8443-1) BaseAsyncTask::StartPollingTask: Starting to poll task 3d04ed05-3856-422a-a84b-c0ff4c840f10. >2013-02-28 10:49:21,006 INFO [org.ovirt.engine.core.bll.EntityMultiAsyncTasks] (http-0.0.0.0-8443-1) EntityMultiAsyncTasks::StartPollingTask: Current Action Type for entity a4554520-43da-4575-9c6e-59c0feecdc02 is AddDiskToVm (determined by task 3d04ed05-3856-422a-a84b-c0ff4c840f10) >2013-02-28 10:49:25,086 INFO [org.ovirt.engine.core.bll.AsyncTaskManager] (QuartzScheduler_Worker-66) AsyncTaskManager::PollAndUpdateAsyncTasks: 1 tasks, 1 tasks to poll now >2013-02-28 10:49:25,142 INFO [org.ovirt.engine.core.bll.SPMAsyncTask] (QuartzScheduler_Worker-66) SPMAsyncTask::PollTask: Polling task 3d04ed05-3856-422a-a84b-c0ff4c840f10 (Parent Command AddDiskToVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) returned status finished, result 'success'. >2013-02-28 10:49:25,146 INFO [org.ovirt.engine.core.bll.SPMAsyncTask] (QuartzScheduler_Worker-66) BaseAsyncTask::OnTaskEndSuccess: Task 3d04ed05-3856-422a-a84b-c0ff4c840f10 (Parent Command AddDiskToVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) ended successfully. >2013-02-28 10:49:25,146 INFO [org.ovirt.engine.core.bll.EntityAsyncTask] (QuartzScheduler_Worker-66) EntityAsyncTask::EndActionIfNecessary: All tasks of entity a4554520-43da-4575-9c6e-59c0feecdc02 has ended -> executing EndAction >2013-02-28 10:49:25,147 INFO [org.ovirt.engine.core.bll.EntityAsyncTask] (QuartzScheduler_Worker-66) EntityAsyncTask::EndAction: Ending action for 1 tasks (entity ID: a4554520-43da-4575-9c6e-59c0feecdc02): calling EndAction for action type AddDiskToVm. >2013-02-28 10:49:25,153 INFO [org.ovirt.engine.core.bll.EntityAsyncTask] (pool-19-thread-49) EntityAsyncTask::EndCommandAction [within thread]: Attempting to EndAction AddDiskToVm >2013-02-28 10:49:25,158 INFO [org.ovirt.engine.core.bll.AddDiskToVmCommand] (pool-19-thread-49) Ending command successfully: org.ovirt.engine.core.bll.AddDiskToVmCommand >2013-02-28 10:49:25,159 INFO [org.ovirt.engine.core.bll.AddImageFromScratchCommand] (pool-19-thread-49) Ending command successfully: org.ovirt.engine.core.bll.AddImageFromScratchCommand >2013-02-28 10:49:25,188 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand] (pool-19-thread-49) START, GetImageInfoVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = null, storageDomainId = c6c77717-201d-47fc-aff3-023806e79ac5, imageGroupId = 788f9532-0e38-491e-b842-ddc095a0aa16, imageId = a84fd6f7-4229-42f2-829e-074753442325), log id: 73f81d33 >2013-02-28 10:49:25,978 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand] (pool-19-thread-49) FINISH, GetImageInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.DiskImage@a140702, log id: 73f81d33 >2013-02-28 10:49:26,093 INFO [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (pool-19-thread-49) START, SetVmStatusVDSCommand(vmId = a4554520-43da-4575-9c6e-59c0feecdc02, status = Down), log id: 2d06c686 >2013-02-28 10:49:26,121 INFO [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (pool-19-thread-49) FINISH, SetVmStatusVDSCommand, log id: 2d06c686 >2013-02-28 10:49:26,198 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.UpdateVMVDSCommand] (pool-19-thread-49) START, UpdateVMVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = null, storageDomainId = 00000000-0000-0000-0000-000000000000, infoDictionary.size = 1), log id: 13340e6d >2013-02-28 10:49:26,228 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.UpdateVMVDSCommand] (pool-19-thread-49) FINISH, UpdateVMVDSCommand, log id: 13340e6d >2013-02-28 10:49:26,254 INFO [org.ovirt.engine.core.bll.EntityAsyncTask] (pool-19-thread-49) EntityAsyncTask::HandleEndActionResult [within thread]: EndAction for action type AddDiskToVm completed, handling the result. >2013-02-28 10:49:26,254 INFO [org.ovirt.engine.core.bll.EntityAsyncTask] (pool-19-thread-49) EntityAsyncTask::HandleEndActionResult [within thread]: EndAction for action type AddDiskToVm succeeded, clearing tasks. >2013-02-28 10:49:26,254 INFO [org.ovirt.engine.core.bll.SPMAsyncTask] (pool-19-thread-49) SPMAsyncTask::ClearAsyncTask: Attempting to clear task 3d04ed05-3856-422a-a84b-c0ff4c840f10 >2013-02-28 10:49:26,258 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (pool-19-thread-49) START, SPMClearTaskVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = null, taskId = 3d04ed05-3856-422a-a84b-c0ff4c840f10), log id: 6f10d867 >2013-02-28 10:49:26,262 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (pool-19-thread-49) START, HSMClearTaskVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, taskId=3d04ed05-3856-422a-a84b-c0ff4c840f10), log id: cac0f55 >2013-02-28 10:49:26,279 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (pool-19-thread-49) FINISH, HSMClearTaskVDSCommand, log id: cac0f55 >2013-02-28 10:49:26,279 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (pool-19-thread-49) FINISH, SPMClearTaskVDSCommand, log id: 6f10d867 >2013-02-28 10:49:26,288 INFO [org.ovirt.engine.core.bll.SPMAsyncTask] (pool-19-thread-49) BaseAsyncTask::RemoveTaskFromDB: Removing task 3d04ed05-3856-422a-a84b-c0ff4c840f10 from DataBase >2013-02-28 10:49:26,298 INFO [org.ovirt.engine.core.bll.EntityAsyncTask] (pool-19-thread-49) EntityAsyncTask::HandleEndActionResult [within thread]: Removing EntityMultiAsyncTasks object for entity a4554520-43da-4575-9c6e-59c0feecdc02 >2013-02-28 10:49:56,277 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:49:56,280 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:49:56,286 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:49:56,289 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:49:56,301 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:49:56,337 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:49:57,640 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand] (http-0.0.0.0-8443-2) START, IsValidVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = null), log id: 7603a89d >2013-02-28 10:49:57,643 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand] (http-0.0.0.0-8443-2) FINISH, IsValidVDSCommand, return: true, log id: 7603a89d >2013-02-28 10:49:57,682 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (http-0.0.0.0-8443-2) START, IsVmDuringInitiatingVDSCommand(vmId = a4554520-43da-4575-9c6e-59c0feecdc02), log id: 22591b0 >2013-02-28 10:49:57,683 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (http-0.0.0.0-8443-2) FINISH, IsVmDuringInitiatingVDSCommand, return: false, log id: 22591b0 >2013-02-28 10:49:57,761 INFO [org.ovirt.engine.core.bll.RunVmCommand] (pool-19-thread-47) Running command: RunVmCommand internal: false. Entities affected : ID: a4554520-43da-4575-9c6e-59c0feecdc02 Type: VM >2013-02-28 10:49:57,819 INFO [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] (pool-19-thread-47) START, CreateVmVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, vmId=a4554520-43da-4575-9c6e-59c0feecdc02, vm=org.ovirt.engine.core.common.businessentities.VM@628bec66), log id: 2942d47b >2013-02-28 10:49:57,830 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (pool-19-thread-47) START, CreateVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, vmId=a4554520-43da-4575-9c6e-59c0feecdc02, vm=org.ovirt.engine.core.common.businessentities.VM@628bec66), log id: 30487c0f >2013-02-28 10:49:57,912 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (pool-19-thread-47) org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand kvmEnable=true,nicModel=pv,keyboardLayout=en-us,nice=0,timeOffset=0,transparentHugePages=true,drives=[Ljava.util.Map;@6a19b8f,vmId=a4554520-43da-4575-9c6e-59c0feecdc02,acpiEnable=true,custom={},spiceSslCipherSuite=DEFAULT,memSize=666,boot=n,smp=1,emulatedMachine=rhel6.2.0,vmType=kvm,display=vnc,tabletEnable=true,spiceSecureChannels=smain,sinputs,smpCoresPerSocket=1,spiceMonitors=1,macAddr=00:1a:4a:42:68:00,bridge=rhevm,vmName=fc1,cpuType=Opteron_G2 >2013-02-28 10:49:57,913 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (pool-19-thread-47) FINISH, CreateVDSCommand, log id: 30487c0f >2013-02-28 10:49:57,926 INFO [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] (pool-19-thread-47) IncreasePendingVms::CreateVmIncreasing vds dell-pet105-01.qe.lab.eng.nay.redhat.com pending vcpu count, now 1. Vm: fc1 >2013-02-28 10:49:57,942 INFO [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] (pool-19-thread-47) FINISH, CreateVmVDSCommand, return: WaitForLaunch, log id: 2942d47b >2013-02-28 10:50:01,006 INFO [org.ovirt.engine.core.bll.SetVmTicketCommand] (http-0.0.0.0-8443-1) Running command: SetVmTicketCommand internal: false. Entities affected : ID: a4554520-43da-4575-9c6e-59c0feecdc02 Type: VM >2013-02-28 10:50:01,020 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetVmTicketVDSCommand] (http-0.0.0.0-8443-1) START, SetVmTicketVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, vmId=a4554520-43da-4575-9c6e-59c0feecdc02, ticket=HYq8mx92RXJU, validTime=120), log id: 207ed0e6 >2013-02-28 10:50:01,049 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetVmTicketVDSCommand] (http-0.0.0.0-8443-1) FINISH, SetVmTicketVDSCommand, log id: 207ed0e6 >2013-02-28 10:50:45,060 INFO [org.ovirt.engine.core.bll.AsyncTaskManager] (QuartzScheduler_Worker-36) AsyncTaskManager::SetNewMap: The map contains now 0 tasks >2013-02-28 10:50:45,060 INFO [org.ovirt.engine.core.bll.AsyncTaskManager] (QuartzScheduler_Worker-36) AsyncTaskManager::RemoveOldAndCleanedTasks: Cleared all tasks of pool 32d0d070-ad0c-4383-8f69-ea2a806a8eed. >2013-02-28 10:50:45,065 INFO [org.ovirt.engine.core.bll.AsyncTaskManager] (QuartzScheduler_Worker-36) AsyncTaskManager::RemoveOldAndCleanedTasks: could not find vds that is spm and non-operational. >2013-02-28 10:50:59,426 INFO [org.ovirt.engine.core.vdsbroker.UpdateVdsDynamicDataVDSCommand] (QuartzScheduler_Worker-30) START, UpdateVdsDynamicDataVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, vdsDynamic=org.ovirt.engine.core.common.businessentities.VdsDynamic@507f2c84), log id: 3d4f36f7 >2013-02-28 10:50:59,433 INFO [org.ovirt.engine.core.vdsbroker.UpdateVdsDynamicDataVDSCommand] (QuartzScheduler_Worker-30) FINISH, UpdateVdsDynamicDataVDSCommand, log id: 3d4f36f7 >2013-02-28 10:57:58,797 INFO [org.ovirt.engine.core.bll.SetVmTicketCommand] (http-0.0.0.0-8443-2) Running command: SetVmTicketCommand internal: false. Entities affected : ID: a4554520-43da-4575-9c6e-59c0feecdc02 Type: VM >2013-02-28 10:57:58,806 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetVmTicketVDSCommand] (http-0.0.0.0-8443-2) START, SetVmTicketVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, vmId=a4554520-43da-4575-9c6e-59c0feecdc02, ticket=9orrHQehuaBH, validTime=120), log id: 7441a095 >2013-02-28 10:57:58,837 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetVmTicketVDSCommand] (http-0.0.0.0-8443-2) FINISH, SetVmTicketVDSCommand, log id: 7441a095 >2013-02-28 10:58:06,136 INFO [org.ovirt.engine.core.bll.ShutdownVmCommand] (pool-19-thread-48) Running command: ShutdownVmCommand internal: false. Entities affected : ID: a4554520-43da-4575-9c6e-59c0feecdc02 Type: VM >2013-02-28 10:58:06,140 INFO [org.ovirt.engine.core.bll.ShutdownVmCommand] (pool-19-thread-48) VmHandler.cs:ShutdownVmCommand:Perform: entered (Desktop fc1). >2013-02-28 10:58:06,140 INFO [org.ovirt.engine.core.bll.ShutdownVmCommand] (pool-19-thread-48) VmHandler.cs:ShutdownVmCommand:Perform: sending shutdown command for Desktop fc1. >2013-02-28 10:58:06,155 INFO [org.ovirt.engine.core.vdsbroker.DestroyVmVDSCommand] (pool-19-thread-48) START, DestroyVmVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, vmId=a4554520-43da-4575-9c6e-59c0feecdc02, force=false, secondsToWait=30, gracefully=true), log id: 3c818d59 >2013-02-28 10:58:06,164 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (pool-19-thread-48) START, DestroyVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, vmId=a4554520-43da-4575-9c6e-59c0feecdc02, force=false, secondsToWait=30, gracefully=true), log id: 1865d69f >2013-02-28 10:58:06,186 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (pool-19-thread-48) FINISH, DestroyVDSCommand, log id: 1865d69f >2013-02-28 10:58:06,201 INFO [org.ovirt.engine.core.vdsbroker.DestroyVmVDSCommand] (pool-19-thread-48) FINISH, DestroyVmVDSCommand, return: PoweringDown, log id: 3c818d59 >2013-02-28 10:58:26,381 INFO [org.ovirt.engine.core.bll.StopVmCommand] (pool-19-thread-49) Running command: StopVmCommand internal: false. Entities affected : ID: a4554520-43da-4575-9c6e-59c0feecdc02 Type: VM >2013-02-28 10:58:26,386 INFO [org.ovirt.engine.core.vdsbroker.DestroyVmVDSCommand] (pool-19-thread-49) START, DestroyVmVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, vmId=a4554520-43da-4575-9c6e-59c0feecdc02, force=false, secondsToWait=0, gracefully=false), log id: 2336f67d >2013-02-28 10:58:26,395 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (pool-19-thread-49) START, DestroyVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, vmId=a4554520-43da-4575-9c6e-59c0feecdc02, force=false, secondsToWait=0, gracefully=false), log id: a0fb585 >2013-02-28 10:58:27,396 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DestroyVDSCommand] (pool-19-thread-49) FINISH, DestroyVDSCommand, log id: a0fb585 >2013-02-28 10:58:27,438 INFO [org.ovirt.engine.core.vdsbroker.DestroyVmVDSCommand] (pool-19-thread-49) FINISH, DestroyVmVDSCommand, return: Down, log id: 2336f67d >2013-02-28 10:58:33,365 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand] (http-0.0.0.0-8443-1) START, IsValidVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = null), log id: 2aa3cd90 >2013-02-28 10:58:33,367 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IsValidVDSCommand] (http-0.0.0.0-8443-1) FINISH, IsValidVDSCommand, return: true, log id: 2aa3cd90 >2013-02-28 10:58:33,394 INFO [org.ovirt.engine.core.bll.RemoveVmCommand] (pool-19-thread-48) Lock Aquired to object a4554520-43da-4575-9c6e-59c0feecdc02 >2013-02-28 10:58:33,394 INFO [org.ovirt.engine.core.bll.RemoveVmCommand] (pool-19-thread-48) Running command: RemoveVmCommand internal: false. Entities affected : ID: a4554520-43da-4575-9c6e-59c0feecdc02 Type: VM >2013-02-28 10:58:33,433 INFO [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (pool-19-thread-48) START, SetVmStatusVDSCommand(vmId = a4554520-43da-4575-9c6e-59c0feecdc02, status = ImageLocked), log id: 52d8a496 >2013-02-28 10:58:33,459 INFO [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (pool-19-thread-48) FINISH, SetVmStatusVDSCommand, log id: 52d8a496 >2013-02-28 10:58:33,500 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.RemoveVMVDSCommand] (pool-19-thread-48) START, RemoveVMVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = null, storageDomainId = 00000000-0000-0000-0000-000000000000, vmGuid = a4554520-43da-4575-9c6e-59c0feecdc02), log id: 4d27c1ab >2013-02-28 10:58:33,562 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.RemoveVMVDSCommand] (pool-19-thread-48) FINISH, RemoveVMVDSCommand, log id: 4d27c1ab >2013-02-28 10:58:33,573 INFO [org.ovirt.engine.core.bll.RemoveAllVmImagesCommand] (pool-19-thread-48) Running command: RemoveAllVmImagesCommand internal: true. Entities affected : ID: a4554520-43da-4575-9c6e-59c0feecdc02 Type: VM >2013-02-28 10:58:33,584 INFO [org.ovirt.engine.core.bll.RemoveImageCommand] (pool-19-thread-48) Running command: RemoveImageCommand internal: true. Entities affected : ID: 00000000-0000-0000-0000-000000000000 Type: Storage >2013-02-28 10:58:33,587 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (pool-19-thread-48) START, DeleteImageGroupVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = 3.0, storageDomainId = c6c77717-201d-47fc-aff3-023806e79ac5, imageGroupId = 788f9532-0e38-491e-b842-ddc095a0aa16, postZeros = false, forceDelete = false), log id: 74f7fa25 >2013-02-28 10:58:35,202 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (pool-19-thread-48) FINISH, DeleteImageGroupVDSCommand, log id: 74f7fa25 >2013-02-28 10:58:35,211 INFO [org.ovirt.engine.core.bll.SPMAsyncTask] (pool-19-thread-48) BaseAsyncTask::AddOrUpdateTaskInDB: Adding task d4882270-edc7-42c8-8fb4-1ce3bb56aa86 to DataBase >2013-02-28 10:58:35,222 INFO [org.ovirt.engine.core.bll.EntityAsyncTask] (pool-19-thread-48) EntityAsyncTask::Adding EntityMultiAsyncTasks object for entity a4554520-43da-4575-9c6e-59c0feecdc02 >2013-02-28 10:58:35,223 INFO [org.ovirt.engine.core.bll.EntityMultiAsyncTasks] (pool-19-thread-48) EntityMultiAsyncTasks::AttachTask: Attaching task d4882270-edc7-42c8-8fb4-1ce3bb56aa86 to entity a4554520-43da-4575-9c6e-59c0feecdc02. >2013-02-28 10:58:35,223 INFO [org.ovirt.engine.core.bll.AsyncTaskManager] (pool-19-thread-48) AsyncTaskManager::AddTaskToManager: Adding task d4882270-edc7-42c8-8fb4-1ce3bb56aa86 (Parent Command RemoveVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters), polling hasn't started yet.. >2013-02-28 10:58:35,295 INFO [org.ovirt.engine.core.bll.RemoveVmCommand] (pool-19-thread-48) Lock freed to object a4554520-43da-4575-9c6e-59c0feecdc02 >2013-02-28 10:58:35,325 INFO [org.ovirt.engine.core.bll.SPMAsyncTask] (pool-19-thread-48) BaseAsyncTask::StartPollingTask: Starting to poll task d4882270-edc7-42c8-8fb4-1ce3bb56aa86. >2013-02-28 10:58:35,325 INFO [org.ovirt.engine.core.bll.EntityMultiAsyncTasks] (pool-19-thread-48) EntityMultiAsyncTasks::StartPollingTask: Current Action Type for entity a4554520-43da-4575-9c6e-59c0feecdc02 is RemoveVm (determined by task d4882270-edc7-42c8-8fb4-1ce3bb56aa86) >2013-02-28 10:58:45,172 INFO [org.ovirt.engine.core.bll.AsyncTaskManager] (QuartzScheduler_Worker-73) AsyncTaskManager::PollAndUpdateAsyncTasks: 1 tasks, 1 tasks to poll now >2013-02-28 10:58:45,198 INFO [org.ovirt.engine.core.bll.SPMAsyncTask] (QuartzScheduler_Worker-73) SPMAsyncTask::PollTask: Polling task d4882270-edc7-42c8-8fb4-1ce3bb56aa86 (Parent Command RemoveVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) returned status finished, result 'success'. >2013-02-28 10:58:45,198 INFO [org.ovirt.engine.core.bll.SPMAsyncTask] (QuartzScheduler_Worker-73) BaseAsyncTask::OnTaskEndSuccess: Task d4882270-edc7-42c8-8fb4-1ce3bb56aa86 (Parent Command RemoveVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) ended successfully. >2013-02-28 10:58:45,198 INFO [org.ovirt.engine.core.bll.EntityAsyncTask] (QuartzScheduler_Worker-73) EntityAsyncTask::EndActionIfNecessary: All tasks of entity a4554520-43da-4575-9c6e-59c0feecdc02 has ended -> executing EndAction >2013-02-28 10:58:45,198 INFO [org.ovirt.engine.core.bll.EntityAsyncTask] (QuartzScheduler_Worker-73) EntityAsyncTask::EndAction: Ending action for 1 tasks (entity ID: a4554520-43da-4575-9c6e-59c0feecdc02): calling EndAction for action type RemoveVm. >2013-02-28 10:58:45,198 INFO [org.ovirt.engine.core.bll.EntityAsyncTask] (pool-19-thread-48) EntityAsyncTask::EndCommandAction [within thread]: Attempting to EndAction RemoveVm >2013-02-28 10:58:45,200 INFO [org.ovirt.engine.core.bll.RemoveVmCommand] (pool-19-thread-48) Ending command successfully: org.ovirt.engine.core.bll.RemoveVmCommand >2013-02-28 10:58:45,200 INFO [org.ovirt.engine.core.bll.RemoveVmCommand] (pool-19-thread-48) Lock Aquired to object a4554520-43da-4575-9c6e-59c0feecdc02 >2013-02-28 10:58:45,239 INFO [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (pool-19-thread-48) START, SetVmStatusVDSCommand(vmId = a4554520-43da-4575-9c6e-59c0feecdc02, status = Down), log id: 1ceb93ec >2013-02-28 10:58:45,254 INFO [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (pool-19-thread-48) FINISH, SetVmStatusVDSCommand, log id: 1ceb93ec >2013-02-28 10:58:45,279 INFO [org.ovirt.engine.core.bll.MacPoolManager] (pool-19-thread-48) MacPoolManager::freeMac(mac = 00:1a:4a:42:68:00) - entered >2013-02-28 10:58:45,286 INFO [org.ovirt.engine.core.bll.RemoveVmCommand] (pool-19-thread-48) Lock freed to object a4554520-43da-4575-9c6e-59c0feecdc02 >2013-02-28 10:58:45,298 INFO [org.ovirt.engine.core.bll.EntityAsyncTask] (pool-19-thread-48) EntityAsyncTask::HandleEndActionResult [within thread]: EndAction for action type RemoveVm completed, handling the result. >2013-02-28 10:58:45,299 INFO [org.ovirt.engine.core.bll.EntityAsyncTask] (pool-19-thread-48) EntityAsyncTask::HandleEndActionResult [within thread]: EndAction for action type RemoveVm succeeded, clearing tasks. >2013-02-28 10:58:45,299 INFO [org.ovirt.engine.core.bll.SPMAsyncTask] (pool-19-thread-48) SPMAsyncTask::ClearAsyncTask: Attempting to clear task d4882270-edc7-42c8-8fb4-1ce3bb56aa86 >2013-02-28 10:58:45,300 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (pool-19-thread-48) START, SPMClearTaskVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = null, taskId = d4882270-edc7-42c8-8fb4-1ce3bb56aa86), log id: 59857d4f >2013-02-28 10:58:45,303 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (pool-19-thread-48) START, HSMClearTaskVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, taskId=d4882270-edc7-42c8-8fb4-1ce3bb56aa86), log id: 19b05f03 >2013-02-28 10:58:45,322 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (pool-19-thread-48) FINISH, HSMClearTaskVDSCommand, log id: 19b05f03 >2013-02-28 10:58:45,322 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (pool-19-thread-48) FINISH, SPMClearTaskVDSCommand, log id: 59857d4f >2013-02-28 10:58:45,328 INFO [org.ovirt.engine.core.bll.SPMAsyncTask] (pool-19-thread-48) BaseAsyncTask::RemoveTaskFromDB: Removing task d4882270-edc7-42c8-8fb4-1ce3bb56aa86 from DataBase >2013-02-28 10:58:45,335 INFO [org.ovirt.engine.core.bll.EntityAsyncTask] (pool-19-thread-48) EntityAsyncTask::HandleEndActionResult [within thread]: Removing EntityMultiAsyncTasks object for entity a4554520-43da-4575-9c6e-59c0feecdc02 >2013-02-28 10:59:10,193 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:59:10,195 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:59:10,203 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:59:10,204 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:59:10,212 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-02-28 10:59:15,189 INFO [org.ovirt.engine.core.bll.MaintananceNumberOfVdssCommand] (pool-19-thread-50) Running command: MaintananceNumberOfVdssCommand internal: false. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:59:15,191 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-50) START, SetVdsStatusVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, status=PreparingForMaintenance, nonOperationalReason=NONE), log id: 62cdf02b >2013-02-28 10:59:15,207 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-50) SetVdsStatusVDSCommand::VSD dell-pet105-01.qe.lab.eng.nay.redhat.com is spm and moved from up calling ResetIrs. >2013-02-28 10:59:15,221 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.ResetIrsVDSCommand] (pool-19-thread-50) START, ResetIrsVDSCommand(storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, ignoreFailoverLimit = false, compatabilityVersion = null, hostName = 10.66.72.21, vdsId = c78adde2-814b-11e2-9202-001a4a420b20, ignoreStopFailed = false), log id: 44be9585 >2013-02-28 10:59:15,227 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand] (pool-19-thread-50) START, SpmStopVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed), log id: 4492d963 >2013-02-28 10:59:15,247 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand] (pool-19-thread-50) SpmStopVDSCommand::Stopping SPM on vds dell-pet105-01.qe.lab.eng.nay.redhat.com, pool id 32d0d070-ad0c-4383-8f69-ea2a806a8eed >2013-02-28 10:59:17,227 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand] (pool-19-thread-50) FINISH, SpmStopVDSCommand, log id: 4492d963 >2013-02-28 10:59:17,236 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.ResetIrsVDSCommand] (pool-19-thread-50) FINISH, ResetIrsVDSCommand, log id: 44be9585 >2013-02-28 10:59:17,241 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-50) FINISH, SetVdsStatusVDSCommand, log id: 62cdf02b >2013-02-28 10:59:17,299 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (QuartzScheduler_Worker-47) vds::Updated vds status from Preparing for Maintenance to Maintenance in database, vds = c78adde2-814b-11e2-9202-001a4a420b20 : dell-pet105-01.qe.lab.eng.nay.redhat.com >2013-02-28 10:59:17,321 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (QuartzScheduler_Worker-47) Clearing cache of pool: 32d0d070-ad0c-4383-8f69-ea2a806a8eed for problematic entities of VDS: dell-pet105-01.qe.lab.eng.nay.redhat.com. >2013-02-28 10:59:17,324 INFO [org.ovirt.engine.core.bll.MaintananceVdsCommand] (pool-19-thread-50) Running command: MaintananceVdsCommand internal: true. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 10:59:17,343 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStoragePoolVDSCommand] (QuartzScheduler_Worker-47) START, DisconnectStoragePoolVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, vds_spm_id = 1, masterDomainId = 00000000-0000-0000-0000-000000000000, masterVersion = 0), log id: 42527357 >2013-02-28 10:59:18,526 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStoragePoolVDSCommand] (QuartzScheduler_Worker-47) FINISH, DisconnectStoragePoolVDSCommand, log id: 42527357 >2013-02-28 10:59:18,547 INFO [org.ovirt.engine.core.bll.storage.DisconnectHostFromStoragePoolServersCommand] (QuartzScheduler_Worker-47) Running command: DisconnectHostFromStoragePoolServersCommand internal: true. Entities affected : ID: 32d0d070-ad0c-4383-8f69-ea2a806a8eed Type: StoragePool >2013-02-28 10:59:18,607 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSCommand] (QuartzScheduler_Worker-47) START, DisconnectStorageServerVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20, storagePoolId = 32d0d070-ad0c-4383-8f69-ea2a806a8eed, storageType = FCP, connectionList = []), log id: 6e6d6191 >2013-02-28 10:59:20,752 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DisconnectStorageServerVDSCommand] (QuartzScheduler_Worker-47) FINISH, DisconnectStorageServerVDSCommand, return: {}, log id: 6e6d6191 >2013-02-28 10:59:22,178 INFO [org.ovirt.engine.core.bll.storage.SetStoragePoolStatusCommand] (QuartzScheduler_Worker-77) Running command: SetStoragePoolStatusCommand internal: true. Entities affected : ID: 32d0d070-ad0c-4383-8f69-ea2a806a8eed Type: StoragePool >2013-02-28 10:59:56,565 INFO [org.ovirt.engine.core.bll.storage.RemoveStoragePoolCommand] (http-0.0.0.0-8443-1) Running command: RemoveStoragePoolCommand internal: false. Entities affected : ID: 32d0d070-ad0c-4383-8f69-ea2a806a8eed Type: StoragePool >2013-02-28 11:00:00,461 INFO [org.ovirt.engine.core.bll.RemoveVdsCommand] (pool-19-thread-47) Running command: RemoveVdsCommand internal: false. Entities affected : ID: c78adde2-814b-11e2-9202-001a4a420b20 Type: VDS >2013-02-28 11:00:00,490 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (pool-19-thread-47) START, RemoveVdsVDSCommand(vdsId = c78adde2-814b-11e2-9202-001a4a420b20), log id: 11b2bee >2013-02-28 11:00:00,490 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (pool-19-thread-47) vdsManager::disposing >2013-02-28 11:00:00,491 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (pool-19-thread-47) FINISH, RemoveVdsVDSCommand, log id: 11b2bee >2013-02-28 11:00:15,070 INFO [org.ovirt.engine.core.bll.AsyncTaskManager] (QuartzScheduler_Worker-25) AsyncTaskManager::SetNewMap: The map contains now 0 tasks >2013-02-28 11:00:15,070 INFO [org.ovirt.engine.core.bll.AsyncTaskManager] (QuartzScheduler_Worker-25) AsyncTaskManager::RemoveOldAndCleanedTasks: Cleared all tasks of pool 32d0d070-ad0c-4383-8f69-ea2a806a8eed. >2013-02-28 11:01:50,073 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-46) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 11:32:19,716 WARN [org.ovirt.engine.core.bll.BackendCallBacksDirector] (pool-19-thread-47) Client did not poll async queries updates for 30 cycles, suspending server side updates for session id = 0D0D32886B39799347F2D9A225656268 >2013-02-28 11:32:20,717 WARN [org.ovirt.engine.core.bll.BackendCallBacksDirector] (pool-19-thread-47) Client did not poll async queries updates for 30 cycles sessionId = 0D0D32886B39799347F2D9A225656268. Callback will be removed. >2013-02-28 12:01:50,078 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-37) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 13:01:50,083 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-44) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 14:01:50,086 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-1) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 15:01:50,090 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-55) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 16:01:50,093 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-69) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 17:01:50,098 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-86) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 18:01:50,101 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-14) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 19:01:50,106 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-85) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 20:01:50,110 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-99) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 21:01:50,116 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-94) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 22:01:50,120 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-20) DbUserCacheManager::refreshAllUserData() - entered >2013-02-28 23:01:50,125 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-36) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 00:01:50,129 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-85) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 01:01:50,134 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-29) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 02:01:50,138 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-85) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 03:01:50,143 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-14) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 03:35:35,002 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (QuartzScheduler_Worker-49) AuditLogCleanupManager::deleteAgedOutAuditLogs - entered >2013-03-01 04:01:50,148 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-48) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 05:01:50,152 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-45) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 06:01:50,157 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-11) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 07:01:50,162 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-97) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 08:01:50,168 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-57) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 09:01:50,172 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-82) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 10:01:50,177 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-20) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 11:01:50,182 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-23) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 12:01:50,187 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-67) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 13:01:50,191 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-36) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 14:01:50,195 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-16) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 15:01:50,200 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-29) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 16:01:50,205 INFO [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-84) DbUserCacheManager::refreshAllUserData() - entered >2013-03-01 16:17:05,583 INFO [org.ovirt.engine.core.bll.LoginAdminUserCommand] (http-0.0.0.0-8443-2) Running command: LoginAdminUserCommand internal: false. >2013-03-01 16:17:05,650 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,653 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,690 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,692 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,698 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,701 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,706 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,709 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,717 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,719 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,751 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,759 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,769 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,771 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,778 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,780 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,787 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,793 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,796 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,804 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,806 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,810 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:05,816 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:18,377 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:18,454 INFO [org.ovirt.engine.core.bll.storage.AddEmptyStoragePoolCommand] (http-0.0.0.0-8443-2) Running command: AddEmptyStoragePoolCommand internal: false. Entities affected : ID: aaa00000-0000-0000-0000-123456789aaa Type: System >2013-03-01 16:17:19,326 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:19,333 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:22,131 INFO [org.ovirt.engine.core.bll.AddVdsGroupCommand] (http-0.0.0.0-8443-2) Running command: AddVdsGroupCommand internal: false. Entities affected : ID: 4c0e062a-fd20-4406-b3a6-31c227422825 Type: StoragePool >2013-03-01 16:17:56,881 INFO [org.ovirt.engine.core.bll.RegisterVdsQuery] (http-0.0.0.0-8443-2) Running Command: RegisterVds >2013-03-01 16:17:56,987 INFO [org.ovirt.engine.core.bll.AddVdsCommand] (pool-19-thread-47) Running command: AddVdsCommand internal: true. Entities affected : ID: 99408929-82cf-4dc7-a532-9d998063fa95 Type: VdsGroups >2013-03-01 16:17:57,024 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (pool-19-thread-47) Running command: AddVdsSpmIdCommand internal: true. Entities affected : ID: 85e23806-8248-11e2-9f62-001a4a420b20 Type: VDS >2013-03-01 16:17:57,035 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (pool-19-thread-47) No string for UNASSIGNED type. Use default Log >2013-03-01 16:17:57,037 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (pool-19-thread-47) Cannot get vdsManager for vdsid=85e23806-8248-11e2-9f62-001a4a420b20 >2013-03-01 16:17:57,037 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (pool-19-thread-47) START, RemoveVdsVDSCommand(vdsId = 85e23806-8248-11e2-9f62-001a4a420b20), log id: 44ba6ef >2013-03-01 16:17:57,037 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (pool-19-thread-47) Cannot get vdsManager for vdsid=85e23806-8248-11e2-9f62-001a4a420b20 >2013-03-01 16:17:57,037 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (pool-19-thread-47) FINISH, RemoveVdsVDSCommand, log id: 44ba6ef >2013-03-01 16:17:57,038 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (pool-19-thread-47) Cannot get vdsManager for vdsid=85e23806-8248-11e2-9f62-001a4a420b20 >2013-03-01 16:17:57,039 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (pool-19-thread-47) START, AddVdsVDSCommand(vdsId = 85e23806-8248-11e2-9f62-001a4a420b20), log id: 2bc971d >2013-03-01 16:17:57,039 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (pool-19-thread-47) AddVds - entered , starting logic to add VDS 85e23806-8248-11e2-9f62-001a4a420b20 >2013-03-01 16:17:57,042 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (pool-19-thread-47) AddVds - VDS 85e23806-8248-11e2-9f62-001a4a420b20 was added, will try to add it to the resource manager >2013-03-01 16:17:57,042 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (pool-19-thread-47) Eneterd VdsManager:constructor >2013-03-01 16:17:57,042 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (pool-19-thread-47) vdsBroker(10.66.110.242,54,321) >2013-03-01 16:17:57,046 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (pool-19-thread-47) ResourceManager::AddVds - VDS 85e23806-8248-11e2-9f62-001a4a420b20 was added to the Resource Manager >2013-03-01 16:17:57,046 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (pool-19-thread-47) FINISH, AddVdsVDSCommand, log id: 2bc971d >2013-03-01 16:17:57,067 INFO [org.ovirt.engine.core.bll.RegisterVdsQuery] (http-0.0.0.0-8443-2) RegisterVdsQuery::Register - Registered a new VDS pending approval - Name: dell-per510-01.qe.lab.eng.nay.redhat.com, Hostname: 10.66.110.242, UniqueID: 4C4C4544-0058-3810-8033-B2C04F363358_00:1b:21:36:79:f0 >2013-03-01 16:17:57,098 INFO [org.ovirt.engine.core.register.RegisterServlet] (http-0.0.0.0-8443-2) Succeeded to run RegisterVds. >2013-03-01 16:17:57,332 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:58,971 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:58,978 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:58,981 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:58,986 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-2) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:17:58,989 WARN [org.ovirt.engine.core.bll.GetConfigurationValueQuery] (http-0.0.0.0-8443-1) calling GetConfigurationValueQuery with null version, using default general for version >2013-03-01 16:18:04,992 INFO [org.ovirt.engine.core.bll.ChangeVDSClusterCommand] (http-0.0.0.0-8443-1) Running command: ChangeVDSClusterCommand internal: false. Entities affected : ID: 711add10-8248-11e2-9b66-001a4a420b20 Type: VdsGroups, ID: 85e23806-8248-11e2-9f62-001a4a420b20 Type: VDS >2013-03-01 16:18:05,024 INFO [org.ovirt.engine.core.bll.RemoveVdsSpmIdCommand] (http-0.0.0.0-8443-1) Running command: RemoveVdsSpmIdCommand internal: true. Entities affected : ID: 85e23806-8248-11e2-9f62-001a4a420b20 Type: VDS >2013-03-01 16:18:05,041 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (http-0.0.0.0-8443-1) Running command: AddVdsSpmIdCommand internal: true. Entities affected : ID: 85e23806-8248-11e2-9f62-001a4a420b20 Type: VDS >2013-03-01 16:18:05,050 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (http-0.0.0.0-8443-1) No string for UNASSIGNED type. Use default Log >2013-03-01 16:18:05,122 INFO [org.ovirt.engine.core.bll.UpdateVdsCommand] (http-0.0.0.0-8443-1) Running command: UpdateVdsCommand internal: false. Entities affected : ID: 85e23806-8248-11e2-9f62-001a4a420b20 Type: VDS >2013-03-01 16:18:05,214 INFO [org.ovirt.engine.core.bll.ApproveVdsCommand] (pool-19-thread-47) Running command: ApproveVdsCommand internal: false. Entities affected : ID: 85e23806-8248-11e2-9f62-001a4a420b20 Type: VDS >2013-03-01 16:18:05,214 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-19-thread-47) Before Installation pool-19-thread-47, Powerclient/oVirtNode case: setting status to installing >2013-03-01 16:18:05,215 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-47) START, SetVdsStatusVDSCommand(vdsId = 85e23806-8248-11e2-9f62-001a4a420b20, status=Installing, nonOperationalReason=NONE), log id: 7f8610fe >2013-03-01 16:18:05,235 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-47) FINISH, SetVdsStatusVDSCommand, log id: 7f8610fe >2013-03-01 16:18:05,249 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-19-thread-47) Before Installation pool-19-thread-47 >2013-03-01 16:18:05,249 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Executing oVirt installation stage. (Stage: Starting Host installation) >2013-03-01 16:18:05,249 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Executing oVirt installation stage. (Stage: Connecting to Host) >2013-03-01 16:18:05,989 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Recieved message: <BSTRAP component='RHEV_INSTALL' status='OK' message='Connected to Host 10.66.110.242 with SSH key fingerprint: 0b:dd:04:27:bf:d7:db:82:9f:f9:62:4f:1b:8f:ad:42'/>. FYI. (Stage: Connecting to Host) >2013-03-01 16:18:06,003 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Successfully connected to server ssh. (Stage: Connecting to Host) >2013-03-01 16:18:06,003 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Executing oVirt installation stage. (Stage: Running upgrade / reinstall script on oVirt Node) >2013-03-01 16:18:06,003 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) Invoking /usr/share/vdsm-reg/vdsm-gen-cert -O "rhevhhh" 10.66.110.242 8e8ece88-c98f-4d1c-a94a-46a9ae7d1d8a on 10.66.110.242 >2013-03-01 16:18:07,093 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-47) Initializing Host: dell-per510-01.qe.lab.eng.nay.redhat.com >2013-03-01 16:18:19,007 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Recieved message: <BSTRAP component='Encryption setup' status='OK'/> ><BSTRAP component='RHEV_INSTALL' status='OK'/> >. Stage completed. (Stage: Running upgrade / reinstall script on oVirt Node) >2013-03-01 16:18:19,030 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) RunSSHCommand returns true >2013-03-01 16:18:19,030 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Executing oVirt installation stage. (Stage: Downloading certificate request from Host) >2013-03-01 16:18:19,031 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) Downloading file /tmp/cert_8e8ece88-c98f-4d1c-a94a-46a9ae7d1d8a.req from 10.66.110.242 to /etc/pki/rhevm/requests/cert_8e8ece88-c98f-4d1c-a94a-46a9ae7d1d8a.req >2013-03-01 16:18:19,726 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242. successfully done sftp operation ( Stage: Downloading certificate request from Host) >2013-03-01 16:18:19,727 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) return true >2013-03-01 16:18:19,727 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) DownloadCertificateRequest ended:true >2013-03-01 16:18:19,727 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Executing oVirt installation stage. (Stage: Sign certificate request and generate certificate) >2013-03-01 16:18:20,740 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) SignCertificateRequest ended:true >2013-03-01 16:18:20,740 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Executing oVirt installation stage. (Stage: Upload signed sertificate to Host) >2013-03-01 16:18:20,740 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) Uploading file /etc/pki/rhevm/certs/10.66.110.242cert.pem to /tmp/cert_8e8ece88-c98f-4d1c-a94a-46a9ae7d1d8a.pem on 10.66.110.242 >2013-03-01 16:18:20,740 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) Uploading file /etc/pki/rhevm/certs/10.66.110.242cert.pem to /tmp/cert_8e8ece88-c98f-4d1c-a94a-46a9ae7d1d8a.pem on 10.66.110.242 >2013-03-01 16:18:20,995 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242. successfully done sftp operation ( Stage: Upload signed sertificate to Host) >2013-03-01 16:18:20,995 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) return true >2013-03-01 16:18:20,995 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) UploadSignedCertificate ended:true >2013-03-01 16:18:20,995 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Executing oVirt installation stage. (Stage: Upload Cerficate Autority to Host) >2013-03-01 16:18:20,996 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) Uploading file /etc/pki/rhevm/ca.pem to /tmp/CA_8e8ece88-c98f-4d1c-a94a-46a9ae7d1d8a.pem on 10.66.110.242 >2013-03-01 16:18:20,996 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) Uploading file /etc/pki/rhevm/ca.pem to /tmp/CA_8e8ece88-c98f-4d1c-a94a-46a9ae7d1d8a.pem on 10.66.110.242 >2013-03-01 16:18:21,210 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242. successfully done sftp operation ( Stage: Upload Cerficate Autority to Host) >2013-03-01 16:18:21,210 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) return true >2013-03-01 16:18:21,210 INFO [org.ovirt.engine.core.bll.CBCInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Executing oVirt installation stage, sending SSH Command /usr/share/vdsm-reg/vdsm-complete -c 'ssl=true' 8e8ece88-c98f-4d1c-a94a-46a9ae7d1d8a 0. (Stage: Running second installation script on Host) >2013-03-01 16:18:21,210 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) Invoking /usr/share/vdsm-reg/vdsm-complete -c 'ssl=true' 8e8ece88-c98f-4d1c-a94a-46a9ae7d1d8a 0 on 10.66.110.242 >2013-03-01 16:18:24,567 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Recieved message: <BSTRAP component='instCert' status='OK'/> ><BSTRAP component='CoreDump' status='OK'/> ><BSTRAP component='cleanAll' status='OK'/> ><BSTRAP component='VDS Configuration' status='OK'/> ><BSTRAP component='Restart' status='OK' message='Restarting vdsmd service' /> ><BSTRAP component='RHEV_INSTALL' status='OK'/> >. Stage completed. (Stage: Running second installation script on Host) >2013-03-01 16:18:24,610 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) RunSSHCommand returns true >2013-03-01 16:18:24,611 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-19-thread-47) After Installation pool-19-thread-47 >2013-03-01 16:18:24,612 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-47) START, SetVdsStatusVDSCommand(vdsId = 85e23806-8248-11e2-9f62-001a4a420b20, status=Reboot, nonOperationalReason=NONE), log id: 7f1f29a6 >2013-03-01 16:18:24,620 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-47) FINISH, SetVdsStatusVDSCommand, log id: 7f1f29a6 >2013-03-01 16:18:24,621 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-50) START, SetVdsStatusVDSCommand(vdsId = 85e23806-8248-11e2-9f62-001a4a420b20, status=NonResponsive, nonOperationalReason=NONE), log id: 2db55a6 >2013-03-01 16:18:24,624 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-47) START, SetVdsStatusVDSCommand(vdsId = 85e23806-8248-11e2-9f62-001a4a420b20, status=Unassigned, nonOperationalReason=NONE), log id: 22f2bfd5 >2013-03-01 16:18:24,631 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-50) FINISH, SetVdsStatusVDSCommand, log id: 2db55a6 >2013-03-01 16:18:24,639 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-47) FINISH, SetVdsStatusVDSCommand, log id: 22f2bfd5 >2013-03-01 16:18:28,478 INFO [org.ovirt.engine.core.bll.InitVdsOnUpCommand] (QuartzScheduler_Worker-58) Running command: InitVdsOnUpCommand internal: true. >2013-03-01 16:18:28,494 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-58) No string for UNASSIGNED type. Use default Log >2013-03-01 16:18:28,497 INFO [org.ovirt.engine.core.bll.MultipleActionsRunner] (pool-19-thread-47) MultipleActionsRunner of type MigrateVmToServer invoked with no actions >2013-03-01 16:18:28,517 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (QuartzScheduler_Worker-58) Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: 85e23806-8248-11e2-9f62-001a4a420b20 Type: VDS >2013-03-01 16:18:28,527 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (QuartzScheduler_Worker-58) Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: 85e23806-8248-11e2-9f62-001a4a420b20 Type: VDS >2013-03-01 16:18:34,549 INFO [org.ovirt.engine.core.bll.MaintananceNumberOfVdssCommand] (pool-19-thread-50) Running command: MaintananceNumberOfVdssCommand internal: false. Entities affected : ID: 85e23806-8248-11e2-9f62-001a4a420b20 Type: VDS >2013-03-01 16:18:34,551 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-50) START, SetVdsStatusVDSCommand(vdsId = 85e23806-8248-11e2-9f62-001a4a420b20, status=PreparingForMaintenance, nonOperationalReason=NONE), log id: 6008570e >2013-03-01 16:18:34,567 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-50) FINISH, SetVdsStatusVDSCommand, log id: 6008570e >2013-03-01 16:18:34,577 INFO [org.ovirt.engine.core.bll.MaintananceVdsCommand] (pool-19-thread-50) Running command: MaintananceVdsCommand internal: true. Entities affected : ID: 85e23806-8248-11e2-9f62-001a4a420b20 Type: VDS >2013-03-01 16:18:34,704 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (QuartzScheduler_Worker-29) vds::Updated vds status from Preparing for Maintenance to Maintenance in database, vds = 85e23806-8248-11e2-9f62-001a4a420b20 : dell-per510-01.qe.lab.eng.nay.redhat.com >2013-03-01 16:18:41,219 INFO [org.ovirt.engine.core.bll.UpdateVdsCommand] (http-0.0.0.0-8443-2) Running command: UpdateVdsCommand internal: false. Entities affected : ID: 85e23806-8248-11e2-9f62-001a4a420b20 Type: VDS >2013-03-01 16:18:41,240 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (http-0.0.0.0-8443-2) START, SetVdsStatusVDSCommand(vdsId = 85e23806-8248-11e2-9f62-001a4a420b20, status=Installing, nonOperationalReason=NONE), log id: 4f0a99c0 >2013-03-01 16:18:41,250 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (http-0.0.0.0-8443-2) FINISH, SetVdsStatusVDSCommand, log id: 4f0a99c0 >2013-03-01 16:18:41,256 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-19-thread-47) Running command: InstallVdsCommand internal: true. Entities affected : ID: 85e23806-8248-11e2-9f62-001a4a420b20 Type: VDS >2013-03-01 16:18:41,256 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-19-thread-47) Before Installation pool-19-thread-47, Powerclient/oVirtNode case: setting status to installing >2013-03-01 16:18:41,258 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-47) START, SetVdsStatusVDSCommand(vdsId = 85e23806-8248-11e2-9f62-001a4a420b20, status=Installing, nonOperationalReason=NONE), log id: 431ab9a6 >2013-03-01 16:18:41,291 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-47) FINISH, SetVdsStatusVDSCommand, log id: 431ab9a6 >2013-03-01 16:18:41,303 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-19-thread-47) Before Installation pool-19-thread-47 >2013-03-01 16:18:41,304 INFO [org.ovirt.engine.core.bll.OVirtInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Executing oVirt reinstall/upgrade stage. (Stage: Starting Host installation) >2013-03-01 16:18:41,304 INFO [org.ovirt.engine.core.bll.OVirtInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Executing oVirt reinstall/upgrade stage. (Stage: Connecting to Host) >2013-03-01 16:18:41,420 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Recieved message: <BSTRAP component='RHEV_INSTALL' status='OK' message='Connected to Host 10.66.110.242 with SSH key fingerprint: 0b:dd:04:27:bf:d7:db:82:9f:f9:62:4f:1b:8f:ad:42'/>. FYI. (Stage: Connecting to Host) >2013-03-01 16:18:41,432 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Successfully connected to server ssh. (Stage: Connecting to Host) >2013-03-01 16:18:41,432 INFO [org.ovirt.engine.core.bll.OVirtInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Executing oVirt reinstall/upgrade stage. (Stage: Upload upgrade ISO to oVirt Node) >2013-03-01 16:18:41,432 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) Uploading file /usr/share/rhev-hypervisor/rhevh-6.4-20130227.0.el6_4.iso to /data/updates/ovirt-node-image.iso on 10.66.110.242 >2013-03-01 16:18:41,433 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Recieved message: Preparing ISO file. FYI. (Stage: Upload upgrade ISO to oVirt Node) >2013-03-01 16:18:41,433 INFO [org.ovirt.engine.core.bll.InstallerMessages] (pool-19-thread-47) VDS message: Preparing ISO file >2013-03-01 16:18:42,048 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Recieved message: Determining current address from host perspective. FYI. (Stage: Upload upgrade ISO to oVirt Node) >2013-03-01 16:18:42,048 INFO [org.ovirt.engine.core.bll.InstallerMessages] (pool-19-thread-47) VDS message: Determining current address from host perspective >2013-03-01 16:18:42,048 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) getLocalIP entry >2013-03-01 16:18:42,094 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) getLocalIP return: 10.66.104.178 > >2013-03-01 16:18:42,095 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Recieved message: Starting ISO upload. FYI. (Stage: Upload upgrade ISO to oVirt Node) >2013-03-01 16:18:42,095 INFO [org.ovirt.engine.core.bll.InstallerMessages] (pool-19-thread-47) VDS message: Starting ISO upload >2013-03-01 16:18:44,698 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Recieved message: ISO upload ended successfully. FYI. (Stage: Upload upgrade ISO to oVirt Node) >2013-03-01 16:18:44,698 INFO [org.ovirt.engine.core.bll.InstallerMessages] (pool-19-thread-47) VDS message: ISO upload ended successfully >2013-03-01 16:18:44,698 INFO [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242. successfully done sftp operation ( Stage: Upload upgrade ISO to oVirt Node) >2013-03-01 16:18:44,741 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) uploadLargeFile returns true >2013-03-01 16:18:44,741 INFO [org.ovirt.engine.core.bll.OVirtInstaller] (pool-19-thread-47) Installation of 10.66.110.242. Executing oVirt reinstall/upgrade stage. (Stage: Running upgrade / reinstall script on oVirt Node) >2013-03-01 16:18:44,741 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) Invoking /usr/share/vdsm-reg/vdsm-upgrade on 10.66.110.242 >2013-03-01 16:28:44,902 ERROR [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) The required action is taking longer than allowed by configuration. Verify host networking and storage settings. Current timeout is set to: 600000 >2013-03-01 16:28:44,903 ERROR [org.ovirt.engine.core.bll.VdsInstaller] (pool-19-thread-47) Installation of 10.66.110.242 has failed. Failure details: The required action is taking longer than allowed by configuration. Verify host networking and storage settings.. (Stage: Running upgrade / reinstall script on oVirt Node) >2013-03-01 16:28:44,903 INFO [org.ovirt.engine.core.bll.InstallerMessages] (pool-19-thread-47) VDS message: The required action is taking longer than allowed by configuration. Verify host networking and storage settings. >2013-03-01 16:28:44,903 ERROR [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) Error running command /usr/share/vdsm-reg/vdsm-upgrade >javax.naming.TimeLimitExceededException: The required action is taking longer than allowed by configuration. Verify host networking and storage settings. > at org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper.RunSSHCommand(MinaInstallWrapper.java:200) > at org.ovirt.engine.core.bll.OVirtInstaller.RunStage(OVirtInstaller.java:54) > at org.ovirt.engine.core.bll.VdsInstaller.Install(VdsInstaller.java:207) > at org.ovirt.engine.core.bll.InstallVdsCommand.executeCommand(InstallVdsCommand.java:113) > at org.ovirt.engine.core.bll.CommandBase.ExecuteWithoutTransaction(CommandBase.java:629) > at org.ovirt.engine.core.bll.CommandBase.executeActionInTransactionScope(CommandBase.java:718) > at org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1022) > at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInSuppressed(TransactionSupport.java:168) > at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInScope(TransactionSupport.java:107) > at org.ovirt.engine.core.bll.CommandBase.Execute(CommandBase.java:733) > at org.ovirt.engine.core.bll.CommandBase.ExecuteAction(CommandBase.java:207) > at org.ovirt.engine.core.bll.MultipleActionsRunner.RunCommands(MultipleActionsRunner.java:140) > at org.ovirt.engine.core.bll.MultipleActionsRunner$1.run(MultipleActionsRunner.java:61) > at org.ovirt.engine.core.utils.threadpool.ThreadPoolUtil$InternalWrapperRunnable.run(ThreadPoolUtil.java:52) > at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:439) > at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303) > at java.util.concurrent.FutureTask.run(FutureTask.java:138) > at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886) > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908) > at java.lang.Thread.run(Thread.java:662) >2013-03-01 16:28:44,905 INFO [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-19-thread-47) RunSSHCommand returns false >2013-03-01 16:28:44,906 INFO [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-19-thread-47) After Installation pool-19-thread-47 >2013-03-01 16:28:44,908 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-47) START, SetVdsStatusVDSCommand(vdsId = 85e23806-8248-11e2-9f62-001a4a420b20, status=InstallFailed, nonOperationalReason=NONE), log id: db0b8c7 >2013-03-01 16:28:44,928 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-19-thread-47) FINISH, SetVdsStatusVDSCommand, log id: db0b8c7
You cannot view the attachment while viewing its details because your browser does not support IFRAMEs.
View the attachment on a separate page
.
View Attachment As Raw
Actions:
View
Attachments on
bug 916485
:
703829
|
703830
| 704089