Attachment 698802 Details for Bug 906795 – refreshing host - engine log

refreshing host - engine log

log906795.log (text/x-log), 45.33 KB, created by Yaniv Bronhaim on 2013-02-18 10:05:48 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Yaniv Bronhaim

Created: 2013-02-18 10:05:48 UTC

Size: 45.33 KB

patch

obsolete

>2013-02-18 10:57:15,600 WARN  [org.ovirt.engine.core.dal.dbbroker.DbFacadeLocator] (MSC service thread 1-7) /etc/ovirt-engine/engine.conf file is not found. Please check your engine installation. Default values will be used
>2013-02-18 10:57:21,535 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-7) Start initializing Backend
>2013-02-18 10:57:23,432 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (MSC service thread 1-7) Can't load keystore from file "/home/ybronhei/Projects/vdsm/keys/engine.p12". FileNotFoundException: keys/engine.p12 (No such file or directory)
>2013-02-18 10:57:23,434 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (MSC service thread 1-7) Failed to decrypt java.io.FileNotFoundException: keys/engine.p12 (No such file or directory)
>2013-02-18 10:57:23,435 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-7) Failed to decrypt value for property AdminPassword will be used encrypted value
>2013-02-18 10:57:23,441 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (MSC service thread 1-7) Can't load keystore from file "/home/ybronhei/Projects/vdsm/keys/engine.p12". FileNotFoundException: keys/engine.p12 (No such file or directory)
>2013-02-18 10:57:23,442 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (MSC service thread 1-7) Failed to decrypt java.io.FileNotFoundException: keys/engine.p12 (No such file or directory)
>2013-02-18 10:57:23,443 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-7) Failed to decrypt value for property LocalAdminPassword will be used encrypted value
>2013-02-18 10:57:23,469 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (MSC service thread 1-7) Can't load keystore from file "/home/ybronhei/Projects/vdsm/keys/engine.p12". FileNotFoundException: keys/engine.p12 (No such file or directory)
>2013-02-18 10:57:23,471 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (MSC service thread 1-7) Failed to decrypt java.io.FileNotFoundException: keys/engine.p12 (No such file or directory)
>2013-02-18 10:57:23,472 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-7) Failed to decrypt value for property TruststorePass will be used encrypted value
>2013-02-18 10:57:24,958 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-7) Could not parse option AutoRecoveryAllowedTypes value.
>2013-02-18 10:57:24,964 INFO  [org.ovirt.engine.core.bll.CpuFlagsManagerHandler] (MSC service thread 1-7) Start initializing dictionaries
>2013-02-18 10:57:24,968 INFO  [org.ovirt.engine.core.bll.CpuFlagsManagerHandler] (MSC service thread 1-7) Finished initializing dictionaries
>2013-02-18 10:57:24,969 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-7) Start initializing AuditLogCleanupManager
>2013-02-18 10:57:24,970 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-7) Setting audit cleanup manager to run at: 35 35 3 * * ?
>2013-02-18 10:57:24,986 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-7) Finished initializing AuditLogCleanupManager
>2013-02-18 10:57:24,990 INFO  [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-7) Start initializing TagsDirector
>2013-02-18 10:57:25,050 INFO  [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-7) Tag root added to tree
>2013-02-18 10:57:25,671 INFO  [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-7) Finished initializing TagsDirector
>2013-02-18 10:57:25,675 INFO  [org.ovirt.engine.core.bll.IsoDomainListSyncronizer] (MSC service thread 1-7) Start initializing IsoDomainListSyncronizer
>2013-02-18 10:57:25,682 INFO  [org.ovirt.engine.core.bll.IsoDomainListSyncronizer] (MSC service thread 1-7) Finished initializing IsoDomainListSyncronizer
>2013-02-18 10:57:25,699 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-7) Completed initializing handlers
>2013-02-18 10:57:25,700 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-7) Start initializing ErrorTranslatorImpl
>2013-02-18 10:57:25,705 WARN  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-7) Code MAC_ADDRESS_IS_IN_USE appears more than once in string table.
>2013-02-18 10:57:25,707 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-7) Finished initializing ErrorTranslatorImpl
>2013-02-18 10:57:25,707 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-7) Start initializing ErrorTranslatorImpl
>2013-02-18 10:57:25,708 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-7) Finished initializing ErrorTranslatorImpl
>2013-02-18 10:57:25,709 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-7) Mark incomplete jobs as UNKNOWN
>2013-02-18 10:57:29,235 INFO  [org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager] (MSC service thread 1-7) Start initializing JobRepositoryCleanupManager
>2013-02-18 10:57:29,637 INFO  [org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager] (MSC service thread 1-7) Finished initializing JobRepositoryCleanupManager
>2013-02-18 10:57:29,640 INFO  [org.ovirt.engine.core.bll.AutoRecoveryManager] (MSC service thread 1-7) Start initializing AutoRecoveryManager
>2013-02-18 10:57:29,658 INFO  [org.ovirt.engine.core.bll.AutoRecoveryManager] (MSC service thread 1-7) Finished initializing AutoRecoveryManager
>2013-02-18 10:57:29,674 INFO  [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (MSC service thread 1-7) Start initializing ExecutionMessageDirector
>2013-02-18 10:57:29,676 INFO  [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (MSC service thread 1-7) Finished initializing ExecutionMessageDirector
>2013-02-18 10:57:29,986 INFO  [org.ovirt.engine.core.bll.adbroker.UsersDomainsCacheManagerService] (MSC service thread 1-8) Start initializing UsersDomainsCacheManagerService
>2013-02-18 10:57:29,991 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) Start initializing ResourceManager
>2013-02-18 10:57:29,997 INFO  [org.ovirt.engine.core.bll.DbUserCacheManager] (MSC service thread 1-8) Start initializing DbUserCacheManager
>2013-02-18 10:57:30,632 INFO  [org.ovirt.engine.core.bll.DbUserCacheManager] (MSC service thread 1-8) Finished initializing DbUserCacheManager
>2013-02-18 10:57:30,633 INFO  [org.ovirt.engine.core.bll.adbroker.UsersDomainsCacheManagerService] (MSC service thread 1-8) Finished initializing UsersDomainsCacheManagerService
>2013-02-18 10:57:30,783 INFO  [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-1) Start refreshing all users data
>2013-02-18 10:57:31,349 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Entered VdsManager constructor
>2013-02-18 10:57:31,385 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Initialize vdsBroker (10.35.1.201,54,321)
>2013-02-18 10:57:31,517 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) VDS 809c4ca0-2c51-44f4-a97a-697885d9b4af was added to the Resource Manager
>2013-02-18 10:57:31,572 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) Finished initializing ResourceManager
>2013-02-18 10:57:31,575 INFO  [org.ovirt.engine.core.bll.AsyncTaskManager] (MSC service thread 1-2) Initialization of AsyncTaskManager completed successfully.
>2013-02-18 10:57:31,581 INFO  [org.ovirt.engine.core.bll.OvfDataUpdater] (MSC service thread 1-2) Initialization of OvfDataUpdater completed successfully.
>2013-02-18 10:57:31,582 INFO  [org.ovirt.engine.core.bll.VdsLoadBalancer] (MSC service thread 1-2) Start scheduling to enable vds load balancer
>2013-02-18 10:57:31,584 INFO  [org.ovirt.engine.core.bll.VdsLoadBalancer] (MSC service thread 1-2) Finished scheduling to enable vds load balancer
>2013-02-18 10:57:31,588 INFO  [org.ovirt.engine.core.bll.network.MacPoolManager] (pool-10-thread-1) Start initializing MacPoolManager
>2013-02-18 10:57:31,598 INFO  [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-2) Init VM custom properties utilities
>2013-02-18 10:57:31,796 INFO  [org.ovirt.engine.core.bll.network.MacPoolManager] (pool-10-thread-1) Finished initializing MacPoolManager
>2013-02-18 10:57:36,620 ERROR [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (QuartzScheduler_Worker-2) vds::refreshVdsStats Failed getVdsStats,  vds = 809c4ca0-2c51-44f4-a97a-697885d9b4af : d, error = VDSNetworkException: java.net.NoRouteToHostException: No route to host
>2013-02-18 10:57:37,966 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-2) Failed to refresh VDS , vds = 809c4ca0-2c51-44f4-a97a-697885d9b4af : d, VDS Network Error, continuing.
>2013-02-18 10:57:40,787 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Loaded file "/home/ybronhei/Projects/ovirt-engine/backend/manager/conf/engine.conf.defaults".
>2013-02-18 10:57:40,788 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Loaded file "/home/ybronhei/Projects/ovirt-engine/myengine.conf".
>2013-02-18 10:57:40,789 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_DB_URL" is "jdbc:postgresql://localhost/engine".
>2013-02-18 10:57:40,790 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_PROPERTIES" is "".
>2013-02-18 10:57:40,791 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_PKI" is "/etc/pki/ovirt-engine/".
>2013-02-18 10:57:40,792 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_PERM_MIN" is "256m".
>2013-02-18 10:57:40,793 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "JBOSS_HOME" is "/usr/share/jboss-as".
>2013-02-18 10:57:40,793 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_DB_USER" is "engine".
>2013-02-18 10:57:40,794 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_LOG" is "/usr/share/jboss-as-7.1.1.Final/standalone/log/engine/engine.log".
>2013-02-18 10:57:40,795 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_PROXY_HTTP_PORT" is "80".
>2013-02-18 10:57:40,796 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_STOP_TIME" is "10".
>2013-02-18 10:57:40,797 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_FQDN" is "localhost.localdomain".
>2013-02-18 10:57:40,798 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_HEAP_MAX" is "1g".
>2013-02-18 10:57:40,799 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_DB_MIN_CONNECTIONS" is "1".
>2013-02-18 10:57:40,800 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_LOCK" is "".
>2013-02-18 10:57:40,801 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_STOP_INTERVAL" is "1".
>2013-02-18 10:57:40,802 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_PROXY_ENABLED" is "true".
>2013-02-18 10:57:40,802 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_DB_DRIVER" is "org.postgresql.Driver".
>2013-02-18 10:57:40,803 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_APPS" is "engine.ear".
>2013-02-18 10:57:40,804 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_DB_PASSWORD" is "".
>2013-02-18 10:57:40,804 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_ETC" is "/etc/ovirt-engine".
>2013-02-18 10:57:40,805 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_VAR" is "".
>2013-02-18 10:57:40,805 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_DB_MAX_CONNECTIONS" is "100".
>2013-02-18 10:57:40,806 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_HTTP_PORT" is "8700".
>2013-02-18 10:57:40,807 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_AJP_PORT" is "8702".
>2013-02-18 10:57:40,807 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_PERM_MAX" is "256m".
>2013-02-18 10:57:40,808 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_VERBOSE_GC" is "false".
>2013-02-18 10:57:40,808 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_HTTPS_PORT" is "8701".
>2013-02-18 10:57:40,809 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_DEBUG_ADDRESS" is "".
>2013-02-18 10:57:40,809 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_CACHE" is "/tmp/".
>2013-02-18 10:57:40,810 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_NOFILE" is "65535".
>2013-02-18 10:57:40,810 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_HTTPS_PROTOCOLS" is "SSLv3,TLSv1,TLSv1.1,TLSv1.2".
>2013-02-18 10:57:40,811 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_PROXY_HTTPS_PORT" is "443".
>2013-02-18 10:57:40,811 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_PID" is "@ENGINE_PID@".
>2013-02-18 10:57:40,812 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_USR" is "ybronhei".
>2013-02-18 10:57:40,813 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_HTTP_ENABLED" is "false".
>2013-02-18 10:57:40,813 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_GROUP" is "ovirt".
>2013-02-18 10:57:40,814 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "JAVA_HOME" is "/usr/lib/jvm/jre-1.7.0-openjdk.x86_64".
>2013-02-18 10:57:40,814 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_HTTPS_ENABLED" is "false".
>2013-02-18 10:57:40,815 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_DB_SSL" is "false".
>2013-02-18 10:57:40,816 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_TMP" is "/tmp/".
>2013-02-18 10:57:40,816 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_HEAP_MIN" is "1g".
>2013-02-18 10:57:40,817 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_AJP_ENABLED" is "true".
>2013-02-18 10:57:40,818 INFO  [org.ovirt.engine.core.utils.LocalConfig] (http--0.0.0.0-8700-2) Value of property "ENGINE_USER" is "ovirt".
>2013-02-18 10:57:40,820 WARN  [org.ovirt.engine.ui.frontend.server.gwt.plugin.PluginDataManager] (http--0.0.0.0-8700-2) Cannot list UI plugin descriptor files in [/home/ybronhei/Projects/vdsm/ybronhei/ui-plugins]
>2013-02-18 10:57:41,750 INFO  [org.ovirt.engine.core.bll.storage.SetStoragePoolStatusCommand] (QuartzScheduler_Worker-5) [22054ad7] Running command: SetStoragePoolStatusCommand internal: true. Entities affected :  ID: f512a8a1-88be-492a-ae72-8b11c71621ea Type: StoragePool
>2013-02-18 10:57:41,879 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: UNASSIGNED not exist in string table
>2013-02-18 10:57:41,880 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: USER_RUN_UNLOCK_ENTITY_SCRIPT not exist in string table
>2013-02-18 10:57:41,882 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: VDS_NETWORK_MTU_DIFFER_FROM_LOGICAL_NETWORK not exist in string table
>2013-02-18 10:57:41,883 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: STORAGE_ACTIVATE_ASYNC not exist in string table
>2013-02-18 10:57:41,884 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: DWH_STOPPED not exist in string table
>2013-02-18 10:57:41,885 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: DWH_STARTED not exist in string table
>2013-02-18 10:57:41,887 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: DWH_ERROR not exist in string table
>2013-02-18 10:57:41,888 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: EXTERNAL_EVENT_NORMAL not exist in string table
>2013-02-18 10:57:41,889 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: EXTERNAL_EVENT_WARNING not exist in string table
>2013-02-18 10:57:41,890 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: EXTERNAL_EVENT_ERROR not exist in string table
>2013-02-18 10:57:41,891 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: EXTERNAL_ALERT not exist in string table
>2013-02-18 10:57:41,896 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: USER_ATTACH_DISK_TO_VM not have severity. Assumed Normal
>2013-02-18 10:57:41,897 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: USER_DETACH_DISK_FROM_VM not have severity. Assumed Normal
>2013-02-18 10:57:41,898 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: USER_FAILED_DETACH_DISK_FROM_VM not have severity. Assumed Normal
>2013-02-18 10:57:41,899 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: USER_RUN_UNLOCK_ENTITY_SCRIPT not have severity. Assumed Normal
>2013-02-18 10:57:41,900 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: GLUSTER_VOLUME_OPTION_CHANGED_FROM_CLI not have severity. Assumed Normal
>2013-02-18 10:57:41,901 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: VM_MIGRATION_START_SYSTEM_INITIATED not have severity. Assumed Normal
>2013-02-18 10:57:41,902 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (QuartzScheduler_Worker-5) [22054ad7] AuditLogType: VDS_NETWORK_MTU_DIFFER_FROM_LOGICAL_NETWORK not have severity. Assumed Normal
>
>=== Recognize network errors
>
>2013-02-18 10:57:43,003 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-4) Failed to refresh VDS , vds = 809c4ca0-2c51-44f4-a97a-697885d9b4af : d, VDS Network Error, continuing.
>2013-02-18 10:57:46,008 ERROR [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-9) Server failed to respond, vds_id = 809c4ca0-2c51-44f4-a97a-697885d9b4af, vds_name = d, error = java.net.NoRouteToHostException: No route to host
>2013-02-18 10:57:46,043 INFO  [org.ovirt.engine.core.bll.VdsEventListener] (pool-10-thread-5) ResourceManager::vdsNotResponding entered for Host 809c4ca0-2c51-44f4-a97a-697885d9b4af, 10.35.1.201
>2013-02-18 10:57:46,221 WARN  [org.ovirt.engine.core.bll.VdsNotRespondingTreatmentCommand] (pool-10-thread-5) [a896fca] CanDoAction of action VdsNotRespondingTreatment failed. Reasons:VDS_FENCE_DISABLED
>2013-02-18 10:57:46,481 INFO  [org.ovirt.engine.core.bll.LoginAdminUserCommand] (http--0.0.0.0-8700-2) Running command: LoginAdminUserCommand internal: false.
>2013-02-18 10:57:46,643 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (http--0.0.0.0-8700-2) Can't load keystore from file "/home/ybronhei/Projects/vdsm/keys/engine.p12". FileNotFoundException: keys/engine.p12 (No such file or directory)
>2013-02-18 10:57:46,644 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (http--0.0.0.0-8700-2) Failed to decrypt java.io.FileNotFoundException: keys/engine.p12 (No such file or directory)
>2013-02-18 10:57:46,645 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (http--0.0.0.0-8700-2) Failed to decrypt value for property LocalAdminPassword will be used encrypted value
>2013-02-18 10:57:46,647 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (http--0.0.0.0-8700-2) Can't load keystore from file "/home/ybronhei/Projects/vdsm/keys/engine.p12". FileNotFoundException: keys/engine.p12 (No such file or directory)
>2013-02-18 10:57:46,647 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (http--0.0.0.0-8700-2) Failed to decrypt java.io.FileNotFoundException: keys/engine.p12 (No such file or directory)
>2013-02-18 10:57:46,648 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (http--0.0.0.0-8700-2) Failed to decrypt value for property LocalAdminPassword will be used encrypted value
>2013-02-18 10:57:46,649 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (http--0.0.0.0-8700-2) Can't load keystore from file "/home/ybronhei/Projects/vdsm/keys/engine.p12". FileNotFoundException: keys/engine.p12 (No such file or directory)
>2013-02-18 10:57:46,650 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (http--0.0.0.0-8700-2) Failed to decrypt java.io.FileNotFoundException: keys/engine.p12 (No such file or directory)
>2013-02-18 10:57:46,651 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (http--0.0.0.0-8700-2) Failed to decrypt value for property LocalAdminPassword will be used encrypted value
>2013-02-18 10:57:46,652 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (http--0.0.0.0-8700-2) Can't load keystore from file "/home/ybronhei/Projects/vdsm/keys/engine.p12". FileNotFoundException: keys/engine.p12 (No such file or directory)
>2013-02-18 10:57:46,653 ERROR [org.ovirt.engine.core.engineencryptutils.EncryptionUtils] (http--0.0.0.0-8700-2) Failed to decrypt java.io.FileNotFoundException: keys/engine.p12 (No such file or directory)
>2013-02-18 10:57:46,654 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (http--0.0.0.0-8700-2) Failed to decrypt value for property LocalAdminPassword will be used encrypted value
>2013-02-18 10:57:47,843 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-3) Running command: LoginUserCommand internal: false.
>2013-02-18 10:57:47,879 ERROR [org.ovirt.engine.core.utils.ServletUtils] (http--0.0.0.0-8700-5) Can't read file "/usr/share/ovirt-engine/docs/DocumentationPath.csv" for request "/docs/DocumentationPath.csv", will send a 404 error response.
>2013-02-18 10:58:50,054 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 10:59:50,077 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:00:50,062 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:01:50,063 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:02:12,649 INFO  [org.ovirt.engine.core.bll.InitVdsOnUpCommand] (QuartzScheduler_Worker-19) [72830983] Running command: InitVdsOnUpCommand internal: true.
>2013-02-18 11:02:12,679 INFO  [org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServersCommand] (QuartzScheduler_Worker-19) [7e1bf2bb] Running command: ConnectHostToStoragePoolServersCommand internal: true. Entities affected :  ID: f512a8a1-88be-492a-ae72-8b11c71621ea Type: StoragePool
>2013-02-18 11:02:12,762 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (QuartzScheduler_Worker-19) [7e1bf2bb] START, ConnectStorageServerVDSCommand(HostName = d, HostId = 809c4ca0-2c51-44f4-a97a-697885d9b4af, storagePoolId = f512a8a1-88be-492a-ae72-8b11c71621ea, storageType = NFS, connectionList = [{ id: 866a6182-b87e-425e-8bc4-d9d586748ece, connection: multipass.eng.lab.tlv.redhat.com:/home/kvm/rnd/yanivbr, iqn: null, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 6bf75e55
>2013-02-18 11:02:13,163 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (QuartzScheduler_Worker-19) [7e1bf2bb] FINISH, ConnectStorageServerVDSCommand, return: {866a6182-b87e-425e-8bc4-d9d586748ece=0}, log id: 6bf75e55
>2013-02-18 11:02:13,170 INFO  [org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServersCommand] (QuartzScheduler_Worker-19) [7e1bf2bb] Host d storage connection was succeeded 
>2013-02-18 11:02:13,182 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (pool-10-thread-49) START, ConnectStoragePoolVDSCommand(HostName = d, HostId = 809c4ca0-2c51-44f4-a97a-697885d9b4af, storagePoolId = f512a8a1-88be-492a-ae72-8b11c71621ea, vds_spm_id = 1, masterDomainId = ed5cf803-5dba-4d74-86c9-fdb503967d85, masterVersion = 1), log id: 69dfa5e6
>2013-02-18 11:02:18,579 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (pool-10-thread-49) FINISH, ConnectStoragePoolVDSCommand, log id: 69dfa5e6
>2013-02-18 11:02:18,641 INFO  [org.ovirt.engine.core.bll.MultipleActionsRunner] (pool-10-thread-50) [7e1bf2bb] MultipleActionsRunner of type MigrateVmToServer invoked with no actions
>2013-02-18 11:02:18,673 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-19) [7e1bf2bb] Initializing Host: d
>2013-02-18 11:02:18,688 INFO  [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (QuartzScheduler_Worker-19) [748355b5] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected :  ID: 809c4ca0-2c51-44f4-a97a-697885d9b4af Type: VDS
>2013-02-18 11:02:18,727 INFO  [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (QuartzScheduler_Worker-19) [339fd217] Running command: HandleVdsVersionCommand internal: true. Entities affected :  ID: 809c4ca0-2c51-44f4-a97a-697885d9b4af Type: VDS
>2013-02-18 11:02:22,474 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (QuartzScheduler_Worker-33) hostFromVds::selectedVds - d, spmStatus Free, storage pool d
>2013-02-18 11:02:22,485 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (QuartzScheduler_Worker-33) SpmStatus on vds 809c4ca0-2c51-44f4-a97a-697885d9b4af: Free
>2013-02-18 11:02:22,522 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (QuartzScheduler_Worker-33) starting spm on vds d, storage pool d, prevId 1, LVER 1
>2013-02-18 11:02:22,526 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (QuartzScheduler_Worker-33) START, SpmStartVDSCommand(HostName = d, HostId = 809c4ca0-2c51-44f4-a97a-697885d9b4af, storagePoolId = f512a8a1-88be-492a-ae72-8b11c71621ea, prevId=1, prevLVER=1, storagePoolFormatType=V3, recoveryMode=Manual, SCSIFencing=false), log id: 395bbb79
>2013-02-18 11:02:22,536 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (QuartzScheduler_Worker-33) spmStart polling started: taskId = aa634905-d294-47d7-b583-256bb45aaf2d
>2013-02-18 11:02:50,069 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:03:50,067 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:04:50,067 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:05:00,668 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (QuartzScheduler_Worker-33) spmStart polling ended: taskId = aa634905-d294-47d7-b583-256bb45aaf2d task status = finished
>2013-02-18 11:05:00,680 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (QuartzScheduler_Worker-33) spmStart polling ended, spm status: SPM
>2013-02-18 11:05:00,685 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (QuartzScheduler_Worker-33) START, HSMClearTaskVDSCommand(HostName = d, HostId = 809c4ca0-2c51-44f4-a97a-697885d9b4af, taskId=aa634905-d294-47d7-b583-256bb45aaf2d), log id: 1223245d
>2013-02-18 11:05:00,696 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (QuartzScheduler_Worker-33) FINISH, HSMClearTaskVDSCommand, log id: 1223245d
>2013-02-18 11:05:00,697 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (QuartzScheduler_Worker-33) FINISH, SpmStartVDSCommand, return: org.ovirt.engine.core.common.businessentities.SpmStatusResult@6867b0d6, log id: 395bbb79
>2013-02-18 11:05:00,742 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (QuartzScheduler_Worker-33) Initialize Irs proxy from vds: 10.35.1.201
>2013-02-18 11:05:00,802 INFO  [org.ovirt.engine.core.bll.AsyncTaskManager] (pool-10-thread-50) Attempting to get and stop tasks on storage pool d
>2013-02-18 11:05:00,805 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (pool-10-thread-50) START, SPMGetAllTasksInfoVDSCommand( storagePoolId = f512a8a1-88be-492a-ae72-8b11c71621ea, ignoreFailoverLimit = false, compatabilityVersion = null), log id: 4eda2e59
>2013-02-18 11:05:00,808 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (pool-10-thread-50) -- SPMGetAllTasksInfoVDSCommand::ExecuteIrsBrokerCommand: Attempting on storage pool f512a8a1-88be-492a-ae72-8b11c71621ea
>2013-02-18 11:05:00,814 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksInfoVDSCommand] (pool-10-thread-50) START, HSMGetAllTasksInfoVDSCommand(HostName = d, HostId = 809c4ca0-2c51-44f4-a97a-697885d9b4af), log id: 45286e7e
>2013-02-18 11:05:00,821 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksInfoVDSCommand] (pool-10-thread-50) FINISH, HSMGetAllTasksInfoVDSCommand, return: [], log id: 45286e7e
>2013-02-18 11:05:00,823 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (pool-10-thread-50) FINISH, SPMGetAllTasksInfoVDSCommand, return: [], log id: 4eda2e59
>2013-02-18 11:05:00,825 INFO  [org.ovirt.engine.core.bll.AsyncTaskManager] (pool-10-thread-50) Discovered no tasks on Storage Pool d
>2013-02-18 11:05:50,070 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:06:50,098 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:07:50,101 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:08:50,106 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-3) Running command: LoginUserCommand internal: false.
>2013-02-18 11:09:23,267 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.ListVDSCommand] (QuartzScheduler_Worker-75) XML RPC error in command ListVDS ( HostName = d ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:09:23,309 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-75) Failed to refresh VDS , vds = 809c4ca0-2c51-44f4-a97a-697885d9b4af : d, VDS Network Error, continuing.
>2013-02-18 11:09:31,463 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStatusVDSCommand] (QuartzScheduler_Worker-77) XML RPC error in command SpmStatusVDS (  ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:09:31,475 INFO  [org.ovirt.engine.core.bll.storage.SetStoragePoolStatusCommand] (QuartzScheduler_Worker-77) [2113caed] Running command: SetStoragePoolStatusCommand internal: true. Entities affected :  ID: f512a8a1-88be-492a-ae72-8b11c71621ea Type: StoragePool
>2013-02-18 11:09:50,111 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-3) Running command: LoginUserCommand internal: false.
>2013-02-18 11:10:50,115 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:11:50,121 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>
>=== From now on, trying to call GetCapabilitiesVDS every 2 seconds
>
>
>2013-02-18 11:12:25,328 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand] (QuartzScheduler_Worker-63) XML RPC error in command GetCapabilitiesVDS ( HostName = d ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:12:25,333 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-63) Failed to refresh VDS , vds = 809c4ca0-2c51-44f4-a97a-697885d9b4af : d, VDS Network Error, continuing.
>2013-02-18 11:12:31,538 ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (QuartzScheduler_Worker-77) [2113caed] IrsBroker::Failed::GetStoragePoolInfoVDS due to: TimeoutException: 
>2013-02-18 11:12:50,120 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:13:50,113 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:14:50,112 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:15:27,345 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand] (QuartzScheduler_Worker-49) XML RPC error in command GetCapabilitiesVDS ( HostName = d ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:15:27,348 ERROR [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-49) Server failed to respond, vds_id = 809c4ca0-2c51-44f4-a97a-697885d9b4af, vds_name = d, error = java.util.concurrent.TimeoutException
>2013-02-18 11:15:27,400 INFO  [org.ovirt.engine.core.bll.VdsEventListener] (pool-10-thread-50) ResourceManager::vdsNotResponding entered for Host 809c4ca0-2c51-44f4-a97a-697885d9b4af, 10.35.1.201
>2013-02-18 11:15:27,448 WARN  [org.ovirt.engine.core.bll.VdsNotRespondingTreatmentCommand] (pool-10-thread-50) [3d3ce66b] CanDoAction of action VdsNotRespondingTreatment failed. Reasons:VDS_FENCE_DISABLED
>2013-02-18 11:15:41,552 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStatusVDSCommand] (QuartzScheduler_Worker-57) XML RPC error in command SpmStatusVDS (  ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:15:50,133 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:16:50,136 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:17:50,140 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:18:29,434 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand] (QuartzScheduler_Worker-37) XML RPC error in command GetCapabilitiesVDS ( HostName = d ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:18:41,559 ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (QuartzScheduler_Worker-57) IrsBroker::Failed::GetStoragePoolInfoVDS due to: TimeoutException: 
>2013-02-18 11:18:50,135 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:19:50,134 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:20:50,139 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:21:31,489 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand] (QuartzScheduler_Worker-24) XML RPC error in command GetCapabilitiesVDS ( HostName = d ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:21:50,143 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:21:51,578 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStatusVDSCommand] (QuartzScheduler_Worker-49) XML RPC error in command SpmStatusVDS (  ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:22:50,155 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:23:50,149 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:24:33,530 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand] (QuartzScheduler_Worker-15) XML RPC error in command GetCapabilitiesVDS ( HostName = d ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:24:50,148 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:24:51,584 ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (QuartzScheduler_Worker-49) IrsBroker::Failed::GetStoragePoolInfoVDS due to: TimeoutException: 
>2013-02-18 11:25:50,156 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:26:50,161 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:27:35,619 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand] (QuartzScheduler_Worker-1) XML RPC error in command GetCapabilitiesVDS ( HostName = d ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:27:50,166 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:28:01,596 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStatusVDSCommand] (QuartzScheduler_Worker-100) XML RPC error in command SpmStatusVDS (  ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:28:50,179 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:29:50,181 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:30:37,704 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand] (QuartzScheduler_Worker-90) XML RPC error in command GetCapabilitiesVDS ( HostName = d ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:30:50,191 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:31:01,599 ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (QuartzScheduler_Worker-100) IrsBroker::Failed::GetStoragePoolInfoVDS due to: TimeoutException: 
>2013-02-18 11:31:50,174 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:32:50,184 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:33:39,765 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand] (QuartzScheduler_Worker-78) XML RPC error in command GetCapabilitiesVDS ( HostName = d ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:33:50,198 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:34:11,611 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStatusVDSCommand] (QuartzScheduler_Worker-91) XML RPC error in command SpmStatusVDS (  ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:34:50,205 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:35:50,201 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:36:41,817 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.GetCapabilitiesVDSCommand] (QuartzScheduler_Worker-64) XML RPC error in command GetCapabilitiesVDS ( HostName = d ), the error was: java.util.concurrent.TimeoutException, null 
>2013-02-18 11:36:50,214 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:37:11,617 ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (QuartzScheduler_Worker-91) IrsBroker::Failed::GetStoragePoolInfoVDS due to: TimeoutException: 
>
>=== Refresh worked, getting Vds up automatically
>
>2013-02-18 11:37:34,440 INFO  [org.ovirt.engine.core.bll.InitVdsOnUpCommand] (QuartzScheduler_Worker-50) [38b634da] Running command: InitVdsOnUpCommand internal: true.
>2013-02-18 11:37:34,462 INFO  [org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServersCommand] (QuartzScheduler_Worker-50) [4e4b5e10] Running command: ConnectHostToStoragePoolServersCommand internal: true. Entities affected :  ID: f512a8a1-88be-492a-ae72-8b11c71621ea Type: StoragePool
>2013-02-18 11:37:34,513 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (QuartzScheduler_Worker-50) [4e4b5e10] START, ConnectStorageServerVDSCommand(HostName = d, HostId = 809c4ca0-2c51-44f4-a97a-697885d9b4af, storagePoolId = f512a8a1-88be-492a-ae72-8b11c71621ea, storageType = NFS, connectionList = [{ id: 866a6182-b87e-425e-8bc4-d9d586748ece, connection: multipass.eng.lab.tlv.redhat.com:/home/kvm/rnd/yanivbr, iqn: null, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 3591ef75
>2013-02-18 11:37:34,534 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (QuartzScheduler_Worker-50) [4e4b5e10] FINISH, ConnectStorageServerVDSCommand, return: {866a6182-b87e-425e-8bc4-d9d586748ece=0}, log id: 3591ef75
>2013-02-18 11:37:34,539 INFO  [org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServersCommand] (QuartzScheduler_Worker-50) [4e4b5e10] Host d storage connection was succeeded 
>2013-02-18 11:37:34,562 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (pool-10-thread-49) START, ConnectStoragePoolVDSCommand(HostName = d, HostId = 809c4ca0-2c51-44f4-a97a-697885d9b4af, storagePoolId = f512a8a1-88be-492a-ae72-8b11c71621ea, vds_spm_id = 1, masterDomainId = ed5cf803-5dba-4d74-86c9-fdb503967d85, masterVersion = 1), log id: 31fcd2a6
>2013-02-18 11:37:34,577 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (pool-10-thread-49) FINISH, ConnectStoragePoolVDSCommand, log id: 31fcd2a6
>2013-02-18 11:37:34,620 INFO  [org.ovirt.engine.core.bll.MultipleActionsRunner] (pool-10-thread-46) [4e4b5e10] MultipleActionsRunner of type MigrateVmToServer invoked with no actions
>2013-02-18 11:37:34,638 INFO  [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (QuartzScheduler_Worker-50) [1f53cf17] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected :  ID: 809c4ca0-2c51-44f4-a97a-697885d9b4af Type: VDS
>2013-02-18 11:37:34,646 INFO  [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (QuartzScheduler_Worker-50) [3475b4e1] Running command: HandleVdsVersionCommand internal: true. Entities affected :  ID: 809c4ca0-2c51-44f4-a97a-697885d9b4af Type: VDS
>2013-02-18 11:37:50,220 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:38:50,225 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:39:50,229 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:40:50,240 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:41:08,559 INFO  [org.ovirt.engine.core.bll.storage.SetStoragePoolStatusCommand] (QuartzScheduler_Worker-94) [2a9ed1de] Running command: SetStoragePoolStatusCommand internal: true. Entities affected :  ID: f512a8a1-88be-492a-ae72-8b11c71621ea Type: StoragePool
>2013-02-18 11:41:08,593 ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (QuartzScheduler_Worker-94) [2a9ed1de] IrsBroker::Failed::GetStoragePoolInfoVDS due to: ConnectException: Network is unreachable
>2013-02-18 11:41:50,237 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:42:50,242 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.
>2013-02-18 11:43:50,240 INFO  [org.ovirt.engine.core.bll.LoginUserCommand] (http--0.0.0.0-8700-7) Running command: LoginUserCommand internal: false.

Actions: View

Attachments on bug 906795: 691590 | 698802