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 951454 Details for
Bug 1086032
If another network has the "required" flag a new host will fail and timeout
[?]
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.
engine
engine.log (text/plain), 164.59 KB, created by
Simone Tiraboschi
on 2014-10-28 16:51:08 UTC
(
hide
)
Description:
engine
Filename:
MIME Type:
Creator:
Simone Tiraboschi
Created:
2014-10-28 16:51:08 UTC
Size:
164.59 KB
patch
obsolete
>2014-10-28 16:25:49,670 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Loaded file "/usr/share/ovirt-engine/services/ovirt-engine/ovirt-engine.conf". >2014-10-28 16:25:49,670 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) The file "/etc/ovirt-engine/engine.conf" doesn't exist or isn't readable. Will return an empty set of properties. >2014-10-28 16:25:49,671 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Loaded file "/etc/ovirt-engine/engine.conf.d/10-setup-database.conf". >2014-10-28 16:25:49,671 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Loaded file "/etc/ovirt-engine/engine.conf.d/10-setup-jboss.conf". >2014-10-28 16:25:49,672 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Loaded file "/etc/ovirt-engine/engine.conf.d/10-setup-pki.conf". >2014-10-28 16:25:49,672 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Loaded file "/etc/ovirt-engine/engine.conf.d/10-setup-protocols.conf". >2014-10-28 16:25:49,672 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_AJP_ENABLED" is "true". >2014-10-28 16:25:49,672 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_AJP_PORT" is "8702". >2014-10-28 16:25:49,673 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_APPS" is "engine.ear restapi.war legacy_restapi.war". >2014-10-28 16:25:49,673 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_CACHE" is "/var/cache/ovirt-engine". >2014-10-28 16:25:49,673 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DB_CHECK_INTERVAL" is "1000". >2014-10-28 16:25:49,673 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DB_CONNECTION_TIMEOUT" is "300000". >2014-10-28 16:25:49,674 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DB_DATABASE" is "engine". >2014-10-28 16:25:49,682 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DB_DRIVER" is "org.postgresql.Driver". >2014-10-28 16:25:49,686 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DB_HOST" is "localhost". >2014-10-28 16:25:49,686 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DB_MAX_CONNECTIONS" is "100". >2014-10-28 16:25:49,686 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DB_MIN_CONNECTIONS" is "1". >2014-10-28 16:25:49,686 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DB_PASSWORD" is "***". >2014-10-28 16:25:49,687 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DB_PORT" is "5432". >2014-10-28 16:25:49,687 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DB_SECURED" is "False". >2014-10-28 16:25:49,687 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DB_SECURED_VALIDATION" is "False". >2014-10-28 16:25:49,687 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DB_URL" is "jdbc:postgresql://localhost:5432/engine?sslfactory=org.postgresql.ssl.NonValidatingFactory". >2014-10-28 16:25:49,688 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DB_USER" is "engine". >2014-10-28 16:25:49,688 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DEBUG_ADDRESS" is "". >2014-10-28 16:25:49,688 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_DOC" is "/usr/share/doc/ovirt-engine". >2014-10-28 16:25:49,688 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_ETC" is "/etc/ovirt-engine". >2014-10-28 16:25:49,689 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_EXTENSION_PATH" is "/usr/share/ovirt-engine/extensions.d:/etc/ovirt-engine/extensions.d". >2014-10-28 16:25:49,689 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_FQDN" is "c65eht.localdomain". >2014-10-28 16:25:49,689 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_GROUP" is "ovirt". >2014-10-28 16:25:49,689 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_HEAP_MAX" is "1g". >2014-10-28 16:25:49,690 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_HEAP_MIN" is "1g". >2014-10-28 16:25:49,690 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_HTTPS_ENABLED" is "false". >2014-10-28 16:25:49,690 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_HTTPS_PORT" is "None". >2014-10-28 16:25:49,690 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_HTTPS_PROTOCOLS" is "SSLv3,TLSv1,TLSv1.1,TLSv1.2". >2014-10-28 16:25:49,690 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_HTTP_ENABLED" is "false". >2014-10-28 16:25:49,691 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_HTTP_PORT" is "None". >2014-10-28 16:25:49,691 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_JAVA_MODULEPATH" is "/usr/share/ovirt-engine/modules". >2014-10-28 16:25:49,691 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_JVM_ARGS" is " -XX:+HeapDumpOnOutOfMemoryError -XX:HeapDumpPath="/var/log/ovirt-engine/dump"". >2014-10-28 16:25:49,692 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_LOG" is "/var/log/ovirt-engine". >2014-10-28 16:25:49,692 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_LOG_TO_CONSOLE" is "false". >2014-10-28 16:25:49,692 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_MANUAL" is "/usr/share/ovirt-engine/manual". >2014-10-28 16:25:49,692 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_PERM_MAX" is "256m". >2014-10-28 16:25:49,693 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_PERM_MIN" is "256m". >2014-10-28 16:25:49,693 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_PKI" is "/etc/pki/ovirt-engine". >2014-10-28 16:25:49,693 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_PKI_CA" is "/etc/pki/ovirt-engine/ca.pem". >2014-10-28 16:25:49,693 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_PKI_ENGINE_CERT" is "/etc/pki/ovirt-engine/certs/engine.cer". >2014-10-28 16:25:49,694 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_PKI_ENGINE_STORE" is "/etc/pki/ovirt-engine/keys/engine.p12". >2014-10-28 16:25:49,694 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_PKI_ENGINE_STORE_ALIAS" is "1". >2014-10-28 16:25:49,694 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_PKI_ENGINE_STORE_PASSWORD" is "***". >2014-10-28 16:25:49,694 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_PKI_TRUST_STORE" is "/etc/pki/ovirt-engine/.truststore". >2014-10-28 16:25:49,701 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_PKI_TRUST_STORE_PASSWORD" is "***". >2014-10-28 16:25:49,701 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_PROPERTIES" is " jsse.enableSNIExtension=false "java.security.krb5.conf=/etc/ovirt-engine/krb5.conf"". >2014-10-28 16:25:49,701 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_PROXY_ENABLED" is "true". >2014-10-28 16:25:49,702 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_PROXY_HTTPS_PORT" is "443". >2014-10-28 16:25:49,702 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_PROXY_HTTP_PORT" is "80". >2014-10-28 16:25:49,702 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_REPORTS_BASE_URL" is "". >2014-10-28 16:25:49,702 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_REPORTS_DASHBOARD_URL" is "/flow.html?viewAsDashboardFrame=true". >2014-10-28 16:25:49,702 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_REPORTS_PROXY_URL" is "/ovirt/reports-interface". >2014-10-28 16:25:49,703 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_REPORTS_READ_TIMEOUT" is "". >2014-10-28 16:25:49,704 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_REPORTS_RIGHTCLICK_URL" is "". >2014-10-28 16:25:49,704 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_REPORTS_VERIFY_CHAIN" is "true". >2014-10-28 16:25:49,704 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_REPORTS_VERIFY_HOST" is "true". >2014-10-28 16:25:49,705 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_STOP_INTERVAL" is "1". >2014-10-28 16:25:49,705 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_STOP_TIME" is "10". >2014-10-28 16:25:49,705 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_TMP" is "/var/tmp/ovirt-engine". >2014-10-28 16:25:49,705 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_UP_MARK" is "/var/lib/ovirt-engine/engine.up". >2014-10-28 16:25:49,705 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_URI" is "/ovirt-engine". >2014-10-28 16:25:49,706 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_USER" is "ovirt". >2014-10-28 16:25:49,706 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_USR" is "/usr/share/ovirt-engine". >2014-10-28 16:25:49,706 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_VAR" is "/var/lib/ovirt-engine". >2014-10-28 16:25:49,706 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "ENGINE_VERBOSE_GC" is "false". >2014-10-28 16:25:49,707 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "JBOSS_HOME" is "/usr/share/ovirt-engine-jboss-as". >2014-10-28 16:25:49,707 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "JBOSS_RUNTIME" is "/var/lib/ovirt-engine/jboss_runtime". >2014-10-28 16:25:49,707 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-2) Value of property "SENSITIVE_KEYS" is ",ENGINE_DB_PASSWORD,ENGINE_PKI_TRUST_STORE_PASSWORD,ENGINE_PKI_ENGINE_STORE_PASSWORD". >2014-10-28 16:25:50,087 INFO [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-1) Start initializing Backend >2014-10-28 16:25:50,303 INFO [org.ovirt.engine.core.utils.osinfo.OsInfoPreferencesLoader] (MSC service thread 1-1) Loaded file /etc/ovirt-engine/osinfo.conf.d/00-defaults.properties >2014-10-28 16:25:50,352 INFO [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-1) Running ovirt-engine 3.5.0.1-1.el6 >2014-10-28 16:25:50,353 INFO [org.ovirt.engine.core.bll.CpuFlagsManagerHandler] (MSC service thread 1-1) Start initializing dictionaries >2014-10-28 16:25:50,354 INFO [org.ovirt.engine.core.bll.CpuFlagsManagerHandler] (MSC service thread 1-1) Finished initializing dictionaries >2014-10-28 16:25:50,354 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-1) Start initializing AuditLogCleanupManager >2014-10-28 16:25:50,355 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-1) Setting audit cleanup manager to run at: 35 35 3 * * ? >2014-10-28 16:25:50,388 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-1) Finished initializing AuditLogCleanupManager >2014-10-28 16:25:50,389 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-1) Start initializing CommandEntityCleanupManager >2014-10-28 16:25:50,389 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-1) Setting command entity cleanup manager to run at: 35 35 3 * * ? >2014-10-28 16:25:50,390 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-1) Finished initializing CommandEntityCleanupManager >2014-10-28 16:25:50,391 INFO [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-1) Start initializing TagsDirector >2014-10-28 16:25:50,397 INFO [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-1) Tag root added to tree >2014-10-28 16:25:50,402 INFO [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-1) Finished initializing TagsDirector >2014-10-28 16:25:50,403 INFO [org.ovirt.engine.core.bll.IsoDomainListSyncronizer] (MSC service thread 1-1) Start initializing IsoDomainListSyncronizer >2014-10-28 16:25:50,408 INFO [org.ovirt.engine.core.bll.IsoDomainListSyncronizer] (MSC service thread 1-1) Finished initializing IsoDomainListSyncronizer >2014-10-28 16:25:50,474 INFO [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-1) Completed initializing handlers >2014-10-28 16:25:50,494 INFO [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-1) Start initializing ErrorTranslatorImpl >2014-10-28 16:25:50,502 WARN [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-1) Code MAC_ADDRESS_IS_IN_USE appears more than once in string table. >2014-10-28 16:25:50,503 INFO [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-1) Finished initializing ErrorTranslatorImpl >2014-10-28 16:25:50,503 INFO [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-1) Start initializing ErrorTranslatorImpl >2014-10-28 16:25:50,504 INFO [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-1) Finished initializing ErrorTranslatorImpl >2014-10-28 16:25:50,504 INFO [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-1) Mark incomplete jobs as UNKNOWN >2014-10-28 16:25:50,525 INFO [org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager] (MSC service thread 1-1) Start initializing JobRepositoryCleanupManager >2014-10-28 16:25:50,525 INFO [org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager] (MSC service thread 1-1) Finished initializing JobRepositoryCleanupManager >2014-10-28 16:25:50,526 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager] (MSC service thread 1-1) Start initializing AutoRecoveryManager >2014-10-28 16:25:50,527 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager] (MSC service thread 1-1) Finished initializing AutoRecoveryManager >2014-10-28 16:25:50,528 INFO [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (MSC service thread 1-1) Start initializing ExecutionMessageDirector >2014-10-28 16:25:50,529 INFO [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (MSC service thread 1-1) Finished initializing ExecutionMessageDirector >2014-10-28 16:25:50,556 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) Loading extension 'builtin-authn-internal' >2014-10-28 16:25:50,557 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) Extension 'builtin-authn-internal' loaded >2014-10-28 16:25:50,558 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) Loading extension 'internal' >2014-10-28 16:25:50,559 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) Extension 'internal' loaded >2014-10-28 16:25:50,560 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) Initializing extension 'builtin-authn-internal' >2014-10-28 16:25:50,560 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) Extension 'builtin-authn-internal' initialized >2014-10-28 16:25:50,561 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) Initializing extension 'internal' >2014-10-28 16:25:50,561 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) Extension 'internal' initialized >2014-10-28 16:25:50,562 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) Start of enabled extensions list >2014-10-28 16:25:50,562 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) Instance name: 'builtin-authn-internal', Extension name: 'Internal Authn (Built-in)', Version: 'N/A', Notes: '', License: 'ASL 2.0', Home: 'http://www.ovirt.org', Author 'The oVirt Project', Build interface Version: '0', File: 'N/A', Initialized: 'true' >2014-10-28 16:25:50,563 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) Instance name: 'internal', Extension name: 'Internal Authz (Built-in)', Version: 'N/A', Notes: '', License: 'ASL 2.0', Home: 'http://www.ovirt.org', Author 'The oVirt Project', Build interface Version: '0', File: 'N/A', Initialized: 'true' >2014-10-28 16:25:50,563 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) End of enabled extensions list >2014-10-28 16:25:50,608 INFO [org.ovirt.engine.core.bll.aaa.DbUserCacheManager] (MSC service thread 1-4) Start initializing DbUserCacheManager >2014-10-28 16:25:50,610 INFO [org.ovirt.engine.core.bll.aaa.DbUserCacheManager] (MSC service thread 1-4) Finished initializing DbUserCacheManager >2014-10-28 16:25:50,628 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (MSC service thread 1-4) Initialization of AsyncTaskManager completed successfully. >2014-10-28 16:25:50,636 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-4) Start initializing ResourceManager >2014-10-28 16:25:50,695 INFO [org.ovirt.engine.core.bll.aaa.SyncUsers] (DefaultQuartzScheduler_Worker-1) Principal admin::internal synchronized >2014-10-28 16:25:50,732 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-4) Finished initializing ResourceManager >2014-10-28 16:25:50,736 INFO [org.ovirt.engine.core.bll.OvfDataUpdater] (MSC service thread 1-4) Initialization of OvfDataUpdater completed successfully. >2014-10-28 16:25:50,736 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-4) Start scheduling to enable vds load balancer >2014-10-28 16:25:50,737 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-4) Finished scheduling to enable vds load balancer >2014-10-28 16:25:50,737 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-4) Start HA Reservation check >2014-10-28 16:25:50,737 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-4) Finished HA Reservation check >2014-10-28 16:25:50,740 INFO [org.ovirt.engine.core.bll.network.MacPoolManagerRanges] (org.ovirt.thread.pool-8-thread-1) Start initializing MacPoolManagerRanges >2014-10-28 16:25:50,755 INFO [org.ovirt.engine.core.bll.network.MacPoolManagerRanges] (org.ovirt.thread.pool-8-thread-1) Finished initializing. Available MACs in pool: 256 >2014-10-28 16:25:50,757 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-4) Init VM custom properties utilities >2014-10-28 16:25:50,759 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-4) Init device custom properties utilities >2014-10-28 16:25:50,761 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-4) Initializing Scheduling manager >2014-10-28 16:25:50,786 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-4) External scheduler disabled, discovery skipped >2014-10-28 16:25:50,786 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-4) Initialized Scheduling manager >2014-10-28 16:25:50,787 INFO [org.ovirt.engine.core.bll.dwh.DwhHeartBeat] (MSC service thread 1-4) Initializing DWH Heart Beat >2014-10-28 16:25:50,789 INFO [org.ovirt.engine.core.bll.dwh.DwhHeartBeat] (MSC service thread 1-4) DWH Heart Beat initialized >2014-10-28 16:27:38,265 INFO [org.ovirt.engine.core.bll.aaa.LoginUserCommand] (ajp--127.0.0.1-8702-4) Running command: LoginUserCommand internal: false. >2014-10-28 16:27:38,276 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: UNASSIGNED not exist in string table >2014-10-28 16:27:38,276 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: VDS_HIGH_NETWORK_USE not exist in string table >2014-10-28 16:27:38,277 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: USER_FAILED_REMOVE_VM not exist in string table >2014-10-28 16:27:38,277 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: USER_RUN_UNLOCK_ENTITY_SCRIPT not exist in string table >2014-10-28 16:27:38,278 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: VDS_NETWORK_MTU_DIFFER_FROM_LOGICAL_NETWORK not exist in string table >2014-10-28 16:27:38,278 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: STORAGE_ACTIVATE_ASYNC not exist in string table >2014-10-28 16:27:38,278 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: USER_ADDED_DISK_PROFILE not exist in string table >2014-10-28 16:27:38,279 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: USER_FAILED_TO_ADD_DISK_PROFILE not exist in string table >2014-10-28 16:27:38,279 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: USER_REMOVED_DISK_PROFILE not exist in string table >2014-10-28 16:27:38,279 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: USER_FAILED_TO_REMOVE_DISK_PROFILE not exist in string table >2014-10-28 16:27:38,280 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: USER_UPDATED_DISK_PROFILE not exist in string table >2014-10-28 16:27:38,280 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: USER_FAILED_TO_UPDATE_DISK_PROFILE not exist in string table >2014-10-28 16:27:38,280 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: USER_ADDED_CPU_PROFILE not exist in string table >2014-10-28 16:27:38,281 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: USER_FAILED_TO_ADD_CPU_PROFILE not exist in string table >2014-10-28 16:27:38,281 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: USER_REMOVED_CPU_PROFILE not exist in string table >2014-10-28 16:27:38,281 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: USER_FAILED_TO_REMOVE_CPU_PROFILE not exist in string table >2014-10-28 16:27:38,281 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: USER_UPDATED_CPU_PROFILE not exist in string table >2014-10-28 16:27:38,282 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) AuditLogType: USER_FAILED_TO_UPDATE_CPU_PROFILE not exist in string table >2014-10-28 16:27:38,412 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: User admin logged in. >2014-10-28 16:27:43,979 INFO [org.ovirt.engine.core.bll.AddVdsCommand] (ajp--127.0.0.1-8702-7) [4784b4bd] Running command: AddVdsCommand internal: false. Entities affected : ID: 00000001-0001-0001-0001-000000000384 Type: VdsGroupsAction group CREATE_HOST with role type ADMIN >2014-10-28 16:27:44,043 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (ajp--127.0.0.1-8702-7) [c9736e5] Running command: AddVdsSpmIdCommand internal: true. Entities affected : ID: 531933b6-31fc-487d-afd7-b6cb33ef2d38 Type: VDS >2014-10-28 16:27:44,053 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (ajp--127.0.0.1-8702-7) [c9736e5] Lock freed to object EngineLock [exclusiveLocks= key: 00000002-0002-0002-0002-00000000029b value: REGISTER_VDS >, sharedLocks= ] >2014-10-28 16:27:44,058 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (ajp--127.0.0.1-8702-7) [c9736e5] START, RemoveVdsVDSCommand(HostName = hosted_engine_1, HostId = 531933b6-31fc-487d-afd7-b6cb33ef2d38), log id: d1dc8d9 >2014-10-28 16:27:44,058 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (ajp--127.0.0.1-8702-7) [c9736e5] FINISH, RemoveVdsVDSCommand, log id: d1dc8d9 >2014-10-28 16:27:44,060 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-7) [c9736e5] START, AddVdsVDSCommand(HostName = hosted_engine_1, HostId = 531933b6-31fc-487d-afd7-b6cb33ef2d38), log id: 2f1d0882 >2014-10-28 16:27:44,061 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-7) [c9736e5] AddVds - entered , starting logic to add VDS 531933b6-31fc-487d-afd7-b6cb33ef2d38 >2014-10-28 16:27:44,062 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-7) [c9736e5] AddVds - VDS 531933b6-31fc-487d-afd7-b6cb33ef2d38 was added, will try to add it to the resource manager >2014-10-28 16:27:44,065 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (ajp--127.0.0.1-8702-7) [c9736e5] Entered VdsManager constructor >2014-10-28 16:27:44,078 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (ajp--127.0.0.1-8702-7) [c9736e5] Initialize vdsBroker (192.168.1.123,54,321) >2014-10-28 16:27:44,192 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--127.0.0.1-8702-7) [c9736e5] VDS 531933b6-31fc-487d-afd7-b6cb33ef2d38 was added to the Resource Manager >2014-10-28 16:27:44,196 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-7) [c9736e5] FINISH, AddVdsVDSCommand, log id: 2f1d0882 >2014-10-28 16:27:44,209 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-7) [c9736e5] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Failed to verify Power Management configuration for Host hosted_engine_1. >2014-10-28 16:27:44,248 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] Lock Acquired to object EngineLock [exclusiveLocks= key: 531933b6-31fc-487d-afd7-b6cb33ef2d38 value: VDS >, sharedLocks= ] >2014-10-28 16:27:44,273 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-7) [c9736e5] Correlation ID: 4784b4bd, Job ID: 2a0004a9-712b-482c-883d-01fcea7631e0, Call Stack: null, Custom Event ID: -1, Message: Host hosted_engine_1 was added by admin. >2014-10-28 16:27:44,275 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] Running command: InstallVdsInternalCommand internal: true. Entities affected : ID: 531933b6-31fc-487d-afd7-b6cb33ef2d38 Type: VDS >2014-10-28 16:27:44,284 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] Before Installation host 531933b6-31fc-487d-afd7-b6cb33ef2d38, hosted_engine_1 >2014-10-28 16:27:44,312 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] START, SetVdsStatusVDSCommand(HostName = hosted_engine_1, HostId = 531933b6-31fc-487d-afd7-b6cb33ef2d38, status=Installing, nonOperationalReason=NONE, stopSpmFailureLogged=false), log id: 142f39fc >2014-10-28 16:27:44,334 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] FINISH, SetVdsStatusVDSCommand, log id: 142f39fc >2014-10-28 16:27:44,395 INFO [org.ovirt.engine.core.bll.InstallerMessages] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] Installation 192.168.1.123: Connected to host 192.168.1.123 with SSH key fingerprint: 10:36:cd:d4:5b:87:e4:51:7f:6f:51:11:05:b9:df:f9 >2014-10-28 16:27:44,408 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Connected to host 192.168.1.123 with SSH key fingerprint: 10:36:cd:d4:5b:87:e4:51:7f:6f:51:11:05:b9:df:f9. >2014-10-28 16:27:44,474 INFO [org.ovirt.engine.core.bll.VdsDeploy] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] Installation of 192.168.1.123. Executing command via SSH umask 0077; MYTMP="$(TMPDIR="${OVIRT_TMPDIR}" mktemp -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; rm -fr "${MYTMP}" && mkdir "${MYTMP}" && tar --warning=no-timestamp -C "${MYTMP}" -x && "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True < /var/cache/ovirt-engine/ovirt-host-deploy.tar >2014-10-28 16:27:44,475 INFO [org.ovirt.engine.core.utils.archivers.tar.CachedTar] (org.ovirt.thread.pool-8-thread-3) Tarball '/var/cache/ovirt-engine/ovirt-host-deploy.tar' is missing, creating >2014-10-28 16:27:44,572 INFO [org.ovirt.engine.core.uutils.ssh.SSHDialog] (org.ovirt.thread.pool-8-thread-3) SSH execute root@192.168.1.123 'umask 0077; MYTMP="$(TMPDIR="${OVIRT_TMPDIR}" mktemp -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; rm -fr "${MYTMP}" && mkdir "${MYTMP}" && tar --warning=no-timestamp -C "${MYTMP}" -x && "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True' >2014-10-28 16:27:45,553 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stage: Initializing >2014-10-28 16:27:45,560 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stage: Initializing. >2014-10-28 16:27:45,575 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stage: Environment setup >2014-10-28 16:27:45,583 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stage: Environment setup. >2014-10-28 16:27:45,615 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stage: Environment packages setup >2014-10-28 16:27:45,622 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stage: Environment packages setup. >2014-10-28 16:27:47,196 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-16) Initializing Host: hosted_engine_1 >2014-10-28 16:28:00,359 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stage: Programs detection >2014-10-28 16:28:00,365 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stage: Programs detection. >2014-10-28 16:28:00,365 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stage: Environment customization >2014-10-28 16:28:00,370 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stage: Environment customization. >2014-10-28 16:28:03,832 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Kdump supported >2014-10-28 16:28:03,836 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Kdump supported. >2014-10-28 16:28:03,848 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Logs at host located at: '/tmp/ovirt-host-deploy-20141028112747-0rknkb.log' >2014-10-28 16:28:03,852 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Logs at host located at: '/tmp/ovirt-host-deploy-20141028112747-0rknkb.log'. >2014-10-28 16:28:03,881 INFO [org.ovirt.engine.core.bll.VdsDeploy] (VdsDeploy) Host 192.168.1.123 reports unique id C9343AA9-5C19-4871-8D6B-5024D3E52886 >2014-10-28 16:28:03,893 INFO [org.ovirt.engine.core.bll.VdsDeploy] (VdsDeploy) Assigning unique id C9343AA9-5C19-4871-8D6B-5024D3E52886 to Host 192.168.1.123 >2014-10-28 16:28:03,945 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Disabling Kdump integration >2014-10-28 16:28:03,949 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Disabling Kdump integration. >2014-10-28 16:28:03,975 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stage: Setup validation >2014-10-28 16:28:03,980 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stage: Setup validation. >2014-10-28 16:28:04,042 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Hardware supports virtualization >2014-10-28 16:28:04,053 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Hardware supports virtualization. >2014-10-28 16:28:04,194 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stage: Transaction setup >2014-10-28 16:28:04,199 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stage: Transaction setup. >2014-10-28 16:28:04,303 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stage: Misc configuration >2014-10-28 16:28:04,308 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stage: Misc configuration. >2014-10-28 16:28:04,308 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stage: Package installation >2014-10-28 16:28:04,314 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stage: Package installation. >2014-10-28 16:28:12,218 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Yum Status: Downloading Packages >2014-10-28 16:28:12,224 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Yum Status: Downloading Packages. >2014-10-28 16:28:12,787 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Yum Download/Verify: 2:qemu-kvm-rhev-tools-0.12.1.2-2.415.el6_5.14.x86_64 >2014-10-28 16:28:12,798 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Yum Download/Verify: 2:qemu-kvm-rhev-tools-0.12.1.2-2.415.el6_5.14.x86_64. >2014-10-28 16:28:12,800 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Yum Status: Check Package Signatures >2014-10-28 16:28:12,808 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Yum Status: Check Package Signatures. >2014-10-28 16:28:12,809 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Yum Status: Running Test Transaction >2014-10-28 16:28:12,817 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Yum Status: Running Test Transaction. >2014-10-28 16:28:12,852 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Yum Status: Running Transaction >2014-10-28 16:28:12,855 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Yum Status: Running Transaction. >2014-10-28 16:28:13,075 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Yum install: 1/1: 2:qemu-kvm-rhev-tools-0.12.1.2-2.415.el6_5.14.x86_64 >2014-10-28 16:28:13,088 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Yum install: 1/1: 2:qemu-kvm-rhev-tools-0.12.1.2-2.415.el6_5.14.x86_64. >2014-10-28 16:28:13,509 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Yum Verify: 1/1: qemu-kvm-rhev-tools.x86_64 2:0.12.1.2-2.415.el6_5.14 - u >2014-10-28 16:28:13,518 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Yum Verify: 1/1: qemu-kvm-rhev-tools.x86_64 2:0.12.1.2-2.415.el6_5.14 - u. >2014-10-28 16:28:13,772 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stage: Misc configuration >2014-10-28 16:28:13,777 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stage: Misc configuration. >2014-10-28 16:28:14,916 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Enrolling certificate >2014-10-28 16:28:14,920 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Enrolling certificate. >2014-10-28 16:28:16,313 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stage: Transaction commit >2014-10-28 16:28:16,323 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stage: Transaction commit. >2014-10-28 16:28:17,197 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stage: Closing up >2014-10-28 16:28:17,206 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stage: Closing up. >2014-10-28 16:28:18,213 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stopping libvirtd >2014-10-28 16:28:18,234 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stopping libvirtd. >2014-10-28 16:28:18,510 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Starting vdsm >2014-10-28 16:28:18,516 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Starting vdsm. >2014-10-28 16:28:20,485 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stage: Pre-termination >2014-10-28 16:28:20,504 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stage: Pre-termination. >2014-10-28 16:28:20,520 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Retrieving installation logs to: '/var/log/ovirt-engine/host-deploy/ovirt-20141028162820-192.168.1.123-7344a9ad.log' >2014-10-28 16:28:20,545 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Retrieving installation logs to: '/var/log/ovirt-engine/host-deploy/ovirt-20141028162820-192.168.1.123-7344a9ad.log'. >2014-10-28 16:28:20,698 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.123: Stage: Termination >2014-10-28 16:28:20,711 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 7344a9ad, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_1. Stage: Termination. >2014-10-28 16:28:20,818 INFO [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to /192.168.1.123 >2014-10-28 16:28:20,822 WARN [org.ovirt.vdsm.jsonrpc.client.utils.retry.Retryable] (SSL Stomp Reactor) Retry failed: java.net.ConnectException: Connection refused > at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method) [rt.jar:1.7.0_65] > at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:739) [rt.jar:1.7.0_65] > at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient$2.call(ReactorClient.java:111) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient$2.call(ReactorClient.java:97) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.utils.retry.Retryable.call(Retryable.java:26) [vdsm-jsonrpc-java-client.jar:] > at java.util.concurrent.FutureTask.run(FutureTask.java:262) [rt.jar:1.7.0_65] > at org.ovirt.vdsm.jsonrpc.client.utils.ReactorScheduler.performPendingOperations(ReactorScheduler.java:28) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.reactors.Reactor.run(Reactor.java:58) [vdsm-jsonrpc-java-client.jar:] > >2014-10-28 16:28:20,828 WARN [org.ovirt.vdsm.jsonrpc.client.utils.retry.Retryable] (SSL Stomp Reactor) Retry failed: java.net.ConnectException: Connection refused > at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method) [rt.jar:1.7.0_65] > at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:739) [rt.jar:1.7.0_65] > at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient$2.call(ReactorClient.java:111) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient$2.call(ReactorClient.java:97) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.utils.retry.Retryable.call(Retryable.java:26) [vdsm-jsonrpc-java-client.jar:] > at java.util.concurrent.FutureTask.run(FutureTask.java:262) [rt.jar:1.7.0_65] > at org.ovirt.vdsm.jsonrpc.client.utils.ReactorScheduler.performPendingOperations(ReactorScheduler.java:28) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.reactors.Reactor.run(Reactor.java:58) [vdsm-jsonrpc-java-client.jar:] > >2014-10-28 16:28:20,829 ERROR [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (org.ovirt.thread.pool-8-thread-4) Exception during connection: java.util.concurrent.ExecutionException: java.net.ConnectException: Connection refused > at java.util.concurrent.FutureTask.report(FutureTask.java:122) [rt.jar:1.7.0_65] > at java.util.concurrent.FutureTask.get(FutureTask.java:188) [rt.jar:1.7.0_65] > at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient.connect(ReactorClient.java:122) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.JsonRpcClient.getClient(JsonRpcClient.java:109) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.JsonRpcClient.call(JsonRpcClient.java:67) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.engine.core.vdsbroker.jsonrpc.FutureMap.<init>(FutureMap.java:60) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.jsonrpc.JsonRpcVdsServer$3.call(JsonRpcVdsServer.java:917) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.jsonrpc.JsonRpcVdsServer$3.call(JsonRpcVdsServer.java:913) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.jsonrpc.JsonRpcVdsServer$FutureCallable.call(JsonRpcVdsServer.java:405) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.jsonrpc.JsonRpcVdsServer$FutureCallable.call(JsonRpcVdsServer.java:394) [vdsbroker.jar:] > at java.util.concurrent.FutureTask.run(FutureTask.java:262) [rt.jar:1.7.0_65] > at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) [rt.jar:1.7.0_65] > at java.util.concurrent.FutureTask.run(FutureTask.java:262) [rt.jar:1.7.0_65] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_65] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_65] > at java.lang.Thread.run(Thread.java:745) [rt.jar:1.7.0_65] >Caused by: java.net.ConnectException: Connection refused > at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method) [rt.jar:1.7.0_65] > at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:739) [rt.jar:1.7.0_65] > at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient$2.call(ReactorClient.java:111) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient$2.call(ReactorClient.java:97) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.utils.retry.Retryable.call(Retryable.java:26) [vdsm-jsonrpc-java-client.jar:] > at java.util.concurrent.FutureTask.run(FutureTask.java:262) [rt.jar:1.7.0_65] > at org.ovirt.vdsm.jsonrpc.client.utils.ReactorScheduler.performPendingOperations(ReactorScheduler.java:28) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.reactors.Reactor.run(Reactor.java:58) [vdsm-jsonrpc-java-client.jar:] > >2014-10-28 16:28:20,834 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] java.util.concurrent.ExecutionException: org.ovirt.engine.core.vdsbroker.xmlrpc.XmlRpcRunTimeException: Connection issues during send request >2014-10-28 16:28:20,847 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] Command PollVDSCommand(HostName = hosted_engine_1, HostId = 531933b6-31fc-487d-afd7-b6cb33ef2d38) execution failed. Exception: RuntimeException: java.util.concurrent.ExecutionException: org.ovirt.engine.core.vdsbroker.xmlrpc.XmlRpcRunTimeException: Connection issues during send request >2014-10-28 16:28:21,359 INFO [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to /192.168.1.123 >2014-10-28 16:28:21,688 INFO [org.ovirt.engine.core.bll.network.NetworkConfigurator] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] Engine managed to communicate with VDSM agent on host hosted_engine_1 >2014-10-28 16:28:22,036 INFO [org.ovirt.engine.core.bll.network.NetworkConfigurator] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] The management network ovirtmgmt is already configured on host hosted_engine_1 >2014-10-28 16:28:22,040 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] START, SetVdsStatusVDSCommand(HostName = hosted_engine_1, HostId = 531933b6-31fc-487d-afd7-b6cb33ef2d38, status=Initializing, nonOperationalReason=NONE, stopSpmFailureLogged=false), log id: 35488577 >2014-10-28 16:28:22,049 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] FINISH, SetVdsStatusVDSCommand, log id: 35488577 >2014-10-28 16:28:22,050 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] After Installation host hosted_engine_1, VDS >2014-10-28 16:28:22,077 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] Correlation ID: 7344a9ad, Job ID: 2a0004a9-712b-482c-883d-01fcea7631e0, Call Stack: null, Custom Event ID: -1, Message: Host hosted_engine_1 installed >2014-10-28 16:28:22,085 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-3) [7344a9ad] Lock freed to object EngineLock [exclusiveLocks= key: 531933b6-31fc-487d-afd7-b6cb33ef2d38 value: VDS >, sharedLocks= ] >2014-10-28 16:28:23,387 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-1) START, GetHardwareInfoVDSCommand(HostName = hosted_engine_1, HostId = 531933b6-31fc-487d-afd7-b6cb33ef2d38, vds=Host[hosted_engine_1,531933b6-31fc-487d-afd7-b6cb33ef2d38]), log id: 35b894d0 >2014-10-28 16:28:23,432 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-1) FINISH, GetHardwareInfoVDSCommand, log id: 35b894d0 >2014-10-28 16:28:23,481 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler_Worker-1) [7b8a0fd1] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: 531933b6-31fc-487d-afd7-b6cb33ef2d38 Type: VDS >2014-10-28 16:28:23,543 INFO [org.ovirt.engine.core.bll.UpdateVdsGroupCommand] (DefaultQuartzScheduler_Worker-1) [5f4d4bb9] Running command: UpdateVdsGroupCommand internal: true. Entities affected : ID: 00000001-0001-0001-0001-000000000384 Type: VdsGroupsAction group EDIT_CLUSTER_CONFIGURATION with role type ADMIN >2014-10-28 16:28:23,575 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-1) [5f4d4bb9] Correlation ID: 5f4d4bb9, Call Stack: null, Custom Event ID: -1, Message: Host cluster Default was updated by system >2014-10-28 16:28:23,618 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-1) [5f4d4bb9] START, GetHardwareInfoVDSCommand(HostName = hosted_engine_1, HostId = 531933b6-31fc-487d-afd7-b6cb33ef2d38, vds=Host[hosted_engine_1,531933b6-31fc-487d-afd7-b6cb33ef2d38]), log id: 43734c35 >2014-10-28 16:28:23,624 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-1) [5f4d4bb9] FINISH, GetHardwareInfoVDSCommand, log id: 43734c35 >2014-10-28 16:28:23,671 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand] (DefaultQuartzScheduler_Worker-1) [5f4d4bb9] START, FullListVdsCommand(HostName = hosted_engine_1, HostId = 531933b6-31fc-487d-afd7-b6cb33ef2d38, vds=Host[hosted_engine_1,531933b6-31fc-487d-afd7-b6cb33ef2d38], vmIds=[8f884179-cff8-4583-a954-fce35bcc435d]), log id: 493b1613 >2014-10-28 16:28:23,686 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand] (DefaultQuartzScheduler_Worker-1) [5f4d4bb9] FINISH, FullListVdsCommand, return: [{status=Up, guestFQDN=, emulatedMachine=pc, vmId=8f884179-cff8-4583-a954-fce35bcc435d, spiceSecureChannels=smain,sdisplay,sinputs,scursor,splayback,srecord,ssmartcard,susbredir, pid=14721, vmName=HostedEngine, devices=[Ljava.lang.Object;@d11b5ae, nicModel=rtl8139,pv, username=Unknown, vmType=kvm, displayIp=0, display=vnc, displaySecurePort=-1, memSize=4096, displayPort=5900, cpuType=Haswell, guestIPs=, smp=2, pauseCode=NOERR, clientIp=}], log id: 493b1613 >2014-10-28 16:28:23,687 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-1) [5f4d4bb9] Importing VM HostedEngine as HostedEngine, as it is running on the on Host, but does not exist in the engine. >2014-10-28 16:28:23,715 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-1) [5f4d4bb9] VDS::UpdateVmRunTimeInfo Error: found VM on a VDS that is not in the database! >2014-10-28 16:28:23,723 INFO [org.ovirt.engine.core.bll.InitVdsOnUpCommand] (DefaultQuartzScheduler_Worker-1) [6107f674] Running command: InitVdsOnUpCommand internal: true. Entities affected : ID: 00000002-0002-0002-0002-00000000029b Type: StoragePool >2014-10-28 16:28:23,734 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetMOMPolicyParametersVDSCommand] (DefaultQuartzScheduler_Worker-1) [6107f674] START, SetMOMPolicyParametersVDSCommand(HostName = hosted_engine_1, HostId = 531933b6-31fc-487d-afd7-b6cb33ef2d38), log id: 1a4d0233 >2014-10-28 16:28:23,780 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetMOMPolicyParametersVDSCommand] (DefaultQuartzScheduler_Worker-1) [6107f674] FINISH, SetMOMPolicyParametersVDSCommand, log id: 1a4d0233 >2014-10-28 16:28:23,786 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-1) [6107f674] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Status of host hosted_engine_1 was set to Up. >2014-10-28 16:28:23,789 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-1) [6107f674] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Failed to verify Power Management configuration for Host hosted_engine_1. >2014-10-28 16:28:23,986 INFO [org.ovirt.engine.core.bll.AddVmFromScratchCommand] (DefaultQuartzScheduler_Worker-1) [47679b51] Lock Acquired to object EngineLock [exclusiveLocks= key: HostedEngine value: VM_NAME >, sharedLocks= ] >2014-10-28 16:28:24,357 INFO [org.ovirt.engine.core.bll.AddVmFromScratchCommand] (DefaultQuartzScheduler_Worker-1) [47679b51] Running command: AddVmFromScratchCommand internal: true. Entities affected : ID: 00000001-0001-0001-0001-000000000384 Type: VdsGroupsAction group CREATE_VM with role type USER >2014-10-28 16:28:24,532 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-1) [47679b51] Correlation ID: 47679b51, Call Stack: null, Custom Event ID: -1, Message: VM HostedEngine was created by <UNKNOWN>. >2014-10-28 16:28:24,532 INFO [org.ovirt.engine.core.bll.AddVmFromScratchCommand] (DefaultQuartzScheduler_Worker-1) [47679b51] Lock freed to object EngineLock [exclusiveLocks= key: HostedEngine value: VM_NAME >, sharedLocks= ] >2014-10-28 16:28:24,543 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler_Worker-1) [2889df02] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: 531933b6-31fc-487d-afd7-b6cb33ef2d38 Type: VDS >2014-10-28 16:28:24,547 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler_Worker-1) [4a203af0] Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: 531933b6-31fc-487d-afd7-b6cb33ef2d38 Type: VDS >2014-10-28 16:28:25,188 INFO [org.ovirt.engine.core.bll.UpdateVdsGroupCommand] (ajp--127.0.0.1-8702-5) [14e6e94e] Running command: UpdateVdsGroupCommand internal: false. Entities affected : ID: 00000001-0001-0001-0001-000000000384 Type: VdsGroupsAction group EDIT_CLUSTER_CONFIGURATION with role type ADMIN >2014-10-28 16:28:25,205 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) [14e6e94e] Correlation ID: 14e6e94e, Call Stack: null, Custom Event ID: -1, Message: Host cluster Default was updated by admin >2014-10-28 16:28:27,585 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand] (DefaultQuartzScheduler_Worker-8) START, FullListVdsCommand(HostName = hosted_engine_1, HostId = 531933b6-31fc-487d-afd7-b6cb33ef2d38, vds=Host[hosted_engine_1,531933b6-31fc-487d-afd7-b6cb33ef2d38], vmIds=[8f884179-cff8-4583-a954-fce35bcc435d]), log id: 122ab972 >2014-10-28 16:28:27,598 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand] (DefaultQuartzScheduler_Worker-8) FINISH, FullListVdsCommand, return: [{status=Up, guestFQDN=, emulatedMachine=pc, vmId=8f884179-cff8-4583-a954-fce35bcc435d, spiceSecureChannels=smain,sdisplay,sinputs,scursor,splayback,srecord,ssmartcard,susbredir, pid=14721, vmName=HostedEngine, devices=[Ljava.lang.Object;@6fec274b, nicModel=rtl8139,pv, username=Unknown, vmType=kvm, displayIp=0, display=vnc, displaySecurePort=-1, memSize=4096, displayPort=5900, cpuType=Haswell, guestIPs=, smp=2, pauseCode=NOERR, clientIp=}], log id: 122ab972 >2014-10-28 16:28:27,604 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-8) Received a console Device without an address when processing VM 8f884179-cff8-4583-a954-fce35bcc435d devices, skipping device: {alias=console0, specParams={}, deviceType=console, deviceId=5b37231c-715c-4c46-9041-501bed605143, device=console, type=console} >2014-10-28 16:28:27,605 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-8) Received a memballoon Device without an address when processing VM 8f884179-cff8-4583-a954-fce35bcc435d devices, skipping device: {device=memballoon, specParams={model=none}, deviceType=balloon, type=balloon, alias=balloon0} >2014-10-28 16:28:27,606 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-8) Received a vnc Device without an address when processing VM 8f884179-cff8-4583-a954-fce35bcc435d devices, skipping device: {device=vnc, specParams={spiceSecureChannels=smain,sdisplay,sinputs,scursor,splayback,srecord,ssmartcard,susbredir, displayIp=0}, deviceType=graphics, type=graphics, port=5900} >2014-10-28 16:28:27,607 ERROR [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-8) Empty or NULL values were passed for a VM 8f884179-cff8-4583-a954-fce35bcc435d device, Device is skipped >2014-10-28 16:31:09,314 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Loaded file "/usr/share/ovirt-engine/services/ovirt-engine/ovirt-engine.conf". >2014-10-28 16:31:09,322 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) The file "/etc/ovirt-engine/engine.conf" doesn't exist or isn't readable. Will return an empty set of properties. >2014-10-28 16:31:09,322 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Loaded file "/etc/ovirt-engine/engine.conf.d/10-setup-database.conf". >2014-10-28 16:31:09,323 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Loaded file "/etc/ovirt-engine/engine.conf.d/10-setup-jboss.conf". >2014-10-28 16:31:09,323 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Loaded file "/etc/ovirt-engine/engine.conf.d/10-setup-pki.conf". >2014-10-28 16:31:09,323 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Loaded file "/etc/ovirt-engine/engine.conf.d/10-setup-protocols.conf". >2014-10-28 16:31:09,324 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_AJP_ENABLED" is "true". >2014-10-28 16:31:09,324 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_AJP_PORT" is "8702". >2014-10-28 16:31:09,324 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_APPS" is "engine.ear restapi.war legacy_restapi.war". >2014-10-28 16:31:09,325 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_CACHE" is "/var/cache/ovirt-engine". >2014-10-28 16:31:09,325 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DB_CHECK_INTERVAL" is "1000". >2014-10-28 16:31:09,325 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DB_CONNECTION_TIMEOUT" is "300000". >2014-10-28 16:31:09,325 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DB_DATABASE" is "engine". >2014-10-28 16:31:09,326 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DB_DRIVER" is "org.postgresql.Driver". >2014-10-28 16:31:09,326 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DB_HOST" is "localhost". >2014-10-28 16:31:09,326 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DB_MAX_CONNECTIONS" is "100". >2014-10-28 16:31:09,326 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DB_MIN_CONNECTIONS" is "1". >2014-10-28 16:31:09,327 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DB_PASSWORD" is "***". >2014-10-28 16:31:09,327 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DB_PORT" is "5432". >2014-10-28 16:31:09,327 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DB_SECURED" is "False". >2014-10-28 16:31:09,327 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DB_SECURED_VALIDATION" is "False". >2014-10-28 16:31:09,327 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DB_URL" is "jdbc:postgresql://localhost:5432/engine?sslfactory=org.postgresql.ssl.NonValidatingFactory". >2014-10-28 16:31:09,328 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DB_USER" is "engine". >2014-10-28 16:31:09,328 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DEBUG_ADDRESS" is "". >2014-10-28 16:31:09,328 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_DOC" is "/usr/share/doc/ovirt-engine". >2014-10-28 16:31:09,328 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_ETC" is "/etc/ovirt-engine". >2014-10-28 16:31:09,331 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_EXTENSION_PATH" is "/usr/share/ovirt-engine/extensions.d:/etc/ovirt-engine/extensions.d". >2014-10-28 16:31:09,332 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_FQDN" is "c65eht.localdomain". >2014-10-28 16:31:09,332 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_GROUP" is "ovirt". >2014-10-28 16:31:09,332 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_HEAP_MAX" is "1g". >2014-10-28 16:31:09,332 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_HEAP_MIN" is "1g". >2014-10-28 16:31:09,333 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_HTTPS_ENABLED" is "false". >2014-10-28 16:31:09,333 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_HTTPS_PORT" is "None". >2014-10-28 16:31:09,333 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_HTTPS_PROTOCOLS" is "SSLv3,TLSv1,TLSv1.1,TLSv1.2". >2014-10-28 16:31:09,333 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_HTTP_ENABLED" is "false". >2014-10-28 16:31:09,333 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_HTTP_PORT" is "None". >2014-10-28 16:31:09,334 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_JAVA_MODULEPATH" is "/usr/share/ovirt-engine/modules". >2014-10-28 16:31:09,334 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_JVM_ARGS" is " -XX:+HeapDumpOnOutOfMemoryError -XX:HeapDumpPath="/var/log/ovirt-engine/dump"". >2014-10-28 16:31:09,334 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_LOG" is "/var/log/ovirt-engine". >2014-10-28 16:31:09,334 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_LOG_TO_CONSOLE" is "false". >2014-10-28 16:31:09,335 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_MANUAL" is "/usr/share/ovirt-engine/manual". >2014-10-28 16:31:09,335 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_PERM_MAX" is "256m". >2014-10-28 16:31:09,335 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_PERM_MIN" is "256m". >2014-10-28 16:31:09,335 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_PKI" is "/etc/pki/ovirt-engine". >2014-10-28 16:31:09,336 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_PKI_CA" is "/etc/pki/ovirt-engine/ca.pem". >2014-10-28 16:31:09,336 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_PKI_ENGINE_CERT" is "/etc/pki/ovirt-engine/certs/engine.cer". >2014-10-28 16:31:09,336 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_PKI_ENGINE_STORE" is "/etc/pki/ovirt-engine/keys/engine.p12". >2014-10-28 16:31:09,336 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_PKI_ENGINE_STORE_ALIAS" is "1". >2014-10-28 16:31:09,337 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_PKI_ENGINE_STORE_PASSWORD" is "***". >2014-10-28 16:31:09,337 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_PKI_TRUST_STORE" is "/etc/pki/ovirt-engine/.truststore". >2014-10-28 16:31:09,337 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_PKI_TRUST_STORE_PASSWORD" is "***". >2014-10-28 16:31:09,337 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_PROPERTIES" is " jsse.enableSNIExtension=false "java.security.krb5.conf=/etc/ovirt-engine/krb5.conf"". >2014-10-28 16:31:09,338 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_PROXY_ENABLED" is "true". >2014-10-28 16:31:09,338 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_PROXY_HTTPS_PORT" is "443". >2014-10-28 16:31:09,338 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_PROXY_HTTP_PORT" is "80". >2014-10-28 16:31:09,338 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_REPORTS_BASE_URL" is "". >2014-10-28 16:31:09,338 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_REPORTS_DASHBOARD_URL" is "/flow.html?viewAsDashboardFrame=true". >2014-10-28 16:31:09,339 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_REPORTS_PROXY_URL" is "/ovirt/reports-interface". >2014-10-28 16:31:09,339 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_REPORTS_READ_TIMEOUT" is "". >2014-10-28 16:31:09,339 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_REPORTS_RIGHTCLICK_URL" is "". >2014-10-28 16:31:09,339 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_REPORTS_VERIFY_CHAIN" is "true". >2014-10-28 16:31:09,340 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_REPORTS_VERIFY_HOST" is "true". >2014-10-28 16:31:09,340 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_STOP_INTERVAL" is "1". >2014-10-28 16:31:09,340 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_STOP_TIME" is "10". >2014-10-28 16:31:09,340 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_TMP" is "/var/tmp/ovirt-engine". >2014-10-28 16:31:09,341 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_UP_MARK" is "/var/lib/ovirt-engine/engine.up". >2014-10-28 16:31:09,341 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_URI" is "/ovirt-engine". >2014-10-28 16:31:09,341 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_USER" is "ovirt". >2014-10-28 16:31:09,344 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_USR" is "/usr/share/ovirt-engine". >2014-10-28 16:31:09,345 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_VAR" is "/var/lib/ovirt-engine". >2014-10-28 16:31:09,345 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "ENGINE_VERBOSE_GC" is "false". >2014-10-28 16:31:09,345 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "JBOSS_HOME" is "/usr/share/ovirt-engine-jboss-as". >2014-10-28 16:31:09,346 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "JBOSS_RUNTIME" is "/var/lib/ovirt-engine/jboss_runtime". >2014-10-28 16:31:09,346 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-4) Value of property "SENSITIVE_KEYS" is ",ENGINE_DB_PASSWORD,ENGINE_PKI_TRUST_STORE_PASSWORD,ENGINE_PKI_ENGINE_STORE_PASSWORD". >2014-10-28 16:31:09,855 INFO [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-3) Start initializing Backend >2014-10-28 16:31:10,135 INFO [org.ovirt.engine.core.utils.osinfo.OsInfoPreferencesLoader] (MSC service thread 1-3) Loaded file /etc/ovirt-engine/osinfo.conf.d/00-defaults.properties >2014-10-28 16:31:10,219 INFO [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-3) Running ovirt-engine 3.5.0.1-1.el6 >2014-10-28 16:31:10,220 INFO [org.ovirt.engine.core.bll.CpuFlagsManagerHandler] (MSC service thread 1-3) Start initializing dictionaries >2014-10-28 16:31:10,221 INFO [org.ovirt.engine.core.bll.CpuFlagsManagerHandler] (MSC service thread 1-3) Finished initializing dictionaries >2014-10-28 16:31:10,222 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-3) Start initializing AuditLogCleanupManager >2014-10-28 16:31:10,222 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-3) Setting audit cleanup manager to run at: 35 35 3 * * ? >2014-10-28 16:31:10,244 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-3) Finished initializing AuditLogCleanupManager >2014-10-28 16:31:10,244 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-3) Start initializing CommandEntityCleanupManager >2014-10-28 16:31:10,245 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-3) Setting command entity cleanup manager to run at: 35 35 3 * * ? >2014-10-28 16:31:10,246 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-3) Finished initializing CommandEntityCleanupManager >2014-10-28 16:31:10,248 INFO [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-3) Start initializing TagsDirector >2014-10-28 16:31:10,253 INFO [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-3) Tag root added to tree >2014-10-28 16:31:10,261 INFO [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-3) Finished initializing TagsDirector >2014-10-28 16:31:10,262 INFO [org.ovirt.engine.core.bll.IsoDomainListSyncronizer] (MSC service thread 1-3) Start initializing IsoDomainListSyncronizer >2014-10-28 16:31:10,267 INFO [org.ovirt.engine.core.bll.IsoDomainListSyncronizer] (MSC service thread 1-3) Finished initializing IsoDomainListSyncronizer >2014-10-28 16:31:10,326 INFO [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-3) Completed initializing handlers >2014-10-28 16:31:10,347 INFO [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-3) Start initializing ErrorTranslatorImpl >2014-10-28 16:31:10,353 WARN [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-3) Code MAC_ADDRESS_IS_IN_USE appears more than once in string table. >2014-10-28 16:31:10,354 INFO [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-3) Finished initializing ErrorTranslatorImpl >2014-10-28 16:31:10,355 INFO [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-3) Start initializing ErrorTranslatorImpl >2014-10-28 16:31:10,355 INFO [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-3) Finished initializing ErrorTranslatorImpl >2014-10-28 16:31:10,355 INFO [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-3) Mark incomplete jobs as UNKNOWN >2014-10-28 16:31:10,401 INFO [org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager] (MSC service thread 1-3) Start initializing JobRepositoryCleanupManager >2014-10-28 16:31:10,403 INFO [org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager] (MSC service thread 1-3) Finished initializing JobRepositoryCleanupManager >2014-10-28 16:31:10,403 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager] (MSC service thread 1-3) Start initializing AutoRecoveryManager >2014-10-28 16:31:10,404 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager] (MSC service thread 1-3) Finished initializing AutoRecoveryManager >2014-10-28 16:31:10,405 INFO [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (MSC service thread 1-3) Start initializing ExecutionMessageDirector >2014-10-28 16:31:10,406 INFO [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (MSC service thread 1-3) Finished initializing ExecutionMessageDirector >2014-10-28 16:31:10,455 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-3) Loading extension 'builtin-authn-internal' >2014-10-28 16:31:10,462 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-3) Extension 'builtin-authn-internal' loaded >2014-10-28 16:31:10,463 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-3) Loading extension 'internal' >2014-10-28 16:31:10,464 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-3) Extension 'internal' loaded >2014-10-28 16:31:10,467 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-3) Initializing extension 'builtin-authn-internal' >2014-10-28 16:31:10,467 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-3) Extension 'builtin-authn-internal' initialized >2014-10-28 16:31:10,468 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-3) Initializing extension 'internal' >2014-10-28 16:31:10,468 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-3) Extension 'internal' initialized >2014-10-28 16:31:10,468 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-3) Start of enabled extensions list >2014-10-28 16:31:10,475 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-3) Instance name: 'builtin-authn-internal', Extension name: 'Internal Authn (Built-in)', Version: 'N/A', Notes: '', License: 'ASL 2.0', Home: 'http://www.ovirt.org', Author 'The oVirt Project', Build interface Version: '0', File: 'N/A', Initialized: 'true' >2014-10-28 16:31:10,475 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-3) Instance name: 'internal', Extension name: 'Internal Authz (Built-in)', Version: 'N/A', Notes: '', License: 'ASL 2.0', Home: 'http://www.ovirt.org', Author 'The oVirt Project', Build interface Version: '0', File: 'N/A', Initialized: 'true' >2014-10-28 16:31:10,477 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-3) End of enabled extensions list >2014-10-28 16:31:10,570 INFO [org.ovirt.engine.core.bll.aaa.DbUserCacheManager] (MSC service thread 1-2) Start initializing DbUserCacheManager >2014-10-28 16:31:10,577 INFO [org.ovirt.engine.core.bll.aaa.DbUserCacheManager] (MSC service thread 1-2) Finished initializing DbUserCacheManager >2014-10-28 16:31:10,593 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (MSC service thread 1-2) Initialization of AsyncTaskManager completed successfully. >2014-10-28 16:31:10,595 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) Start initializing ResourceManager >2014-10-28 16:31:10,640 INFO [org.ovirt.engine.core.bll.aaa.SyncUsers] (DefaultQuartzScheduler_Worker-1) Principal admin::internal synchronized >2014-10-28 16:31:10,672 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Entered VdsManager constructor >2014-10-28 16:31:10,699 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Initialize vdsBroker (192.168.1.123,54,321) >2014-10-28 16:31:10,832 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) VDS 531933b6-31fc-487d-afd7-b6cb33ef2d38 was added to the Resource Manager >2014-10-28 16:31:10,848 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) Finished initializing ResourceManager >2014-10-28 16:31:10,852 INFO [org.ovirt.engine.core.bll.OvfDataUpdater] (MSC service thread 1-2) Initialization of OvfDataUpdater completed successfully. >2014-10-28 16:31:10,852 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-2) Start scheduling to enable vds load balancer >2014-10-28 16:31:10,852 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-2) Finished scheduling to enable vds load balancer >2014-10-28 16:31:10,853 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-2) Start HA Reservation check >2014-10-28 16:31:10,854 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-2) Finished HA Reservation check >2014-10-28 16:31:10,856 INFO [org.ovirt.engine.core.bll.network.MacPoolManagerRanges] (org.ovirt.thread.pool-8-thread-1) Start initializing MacPoolManagerRanges >2014-10-28 16:31:10,860 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-2) Init VM custom properties utilities >2014-10-28 16:31:10,861 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-2) Init device custom properties utilities >2014-10-28 16:31:10,863 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-2) Initializing Scheduling manager >2014-10-28 16:31:10,877 INFO [org.ovirt.engine.core.bll.network.MacPoolManagerRanges] (org.ovirt.thread.pool-8-thread-1) Finished initializing. Available MACs in pool: 256 >2014-10-28 16:31:10,893 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-2) External scheduler disabled, discovery skipped >2014-10-28 16:31:10,894 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-2) Initialized Scheduling manager >2014-10-28 16:31:10,894 INFO [org.ovirt.engine.core.bll.dwh.DwhHeartBeat] (MSC service thread 1-2) Initializing DWH Heart Beat >2014-10-28 16:31:10,895 INFO [org.ovirt.engine.core.bll.dwh.DwhHeartBeat] (MSC service thread 1-2) DWH Heart Beat initialized >2014-10-28 16:31:13,904 INFO [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to /192.168.1.123 >2014-10-28 16:31:14,444 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-6) START, GetHardwareInfoVDSCommand(HostName = hosted_engine_1, HostId = 531933b6-31fc-487d-afd7-b6cb33ef2d38, vds=Host[hosted_engine_1,531933b6-31fc-487d-afd7-b6cb33ef2d38]), log id: 3a29d189 >2014-10-28 16:31:14,450 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-6) FINISH, GetHardwareInfoVDSCommand, log id: 3a29d189 >2014-10-28 16:31:14,513 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-6) VM HostedEngine 8f884179-cff8-4583-a954-fce35bcc435d moved from Up --> PoweringUp >2014-10-28 16:31:14,591 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand] (DefaultQuartzScheduler_Worker-6) START, FullListVdsCommand(HostName = hosted_engine_1, HostId = 531933b6-31fc-487d-afd7-b6cb33ef2d38, vds=Host[hosted_engine_1,531933b6-31fc-487d-afd7-b6cb33ef2d38], vmIds=[8f884179-cff8-4583-a954-fce35bcc435d]), log id: 5192b2f2 >2014-10-28 16:31:14,606 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand] (DefaultQuartzScheduler_Worker-6) FINISH, FullListVdsCommand, return: [{status=Up, nicModel=rtl8139,pv, emulatedMachine=pc, vmId=8f884179-cff8-4583-a954-fce35bcc435d, pid=26054, vmName=HostedEngine, devices=[Ljava.lang.Object;@2db29529, smp=2, vmType=kvm, display=vnc, displaySecurePort=-1, memSize=4096, displayPort=5900, cpuType=Haswell, spiceSecureChannels=smain,sdisplay,sinputs,scursor,splayback,srecord,ssmartcard,susbredir, displayIp=0, clientIp=, pauseCode=NOERR}], log id: 5192b2f2 >2014-10-28 16:31:14,614 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-6) Received a console Device without an address when processing VM 8f884179-cff8-4583-a954-fce35bcc435d devices, skipping device: {alias=console0, specParams={}, deviceType=console, deviceId=5b37231c-715c-4c46-9041-501bed605143, device=console, type=console} >2014-10-28 16:31:14,614 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-6) Received a memballoon Device without an address when processing VM 8f884179-cff8-4583-a954-fce35bcc435d devices, skipping device: {device=memballoon, specParams={model=none}, deviceType=balloon, type=balloon, alias=balloon0} >2014-10-28 16:31:14,615 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-6) Received a vnc Device without an address when processing VM 8f884179-cff8-4583-a954-fce35bcc435d devices, skipping device: {device=vnc, specParams={spiceSecureChannels=smain,sdisplay,sinputs,scursor,splayback,srecord,ssmartcard,susbredir, displayIp=0}, deviceType=graphics, type=graphics, port=5900} >2014-10-28 16:31:14,615 ERROR [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-6) Empty or NULL values were passed for a VM 8f884179-cff8-4583-a954-fce35bcc435d device, Device is skipped >2014-10-28 16:31:14,745 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-6) Initializing Host: hosted_engine_1 >2014-10-28 16:31:14,840 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler_Worker-6) [9857d7c] Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: 531933b6-31fc-487d-afd7-b6cb33ef2d38 Type: VDS >2014-10-28 16:31:17,960 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-13) VM HostedEngine 8f884179-cff8-4583-a954-fce35bcc435d moved from PoweringUp --> Up >2014-10-28 16:31:24,405 INFO [org.ovirt.engine.core.utils.servlet.UnsupportedLocaleHelper] (ajp--127.0.0.1-8702-3) Invalid locale found in configuration: >2014-10-28 16:31:24,406 INFO [org.ovirt.engine.core.utils.servlet.UnsupportedLocaleHelper] (ajp--127.0.0.1-8702-3) Invalid locale found in configuration: >2014-10-28 16:31:27,412 INFO [org.ovirt.engine.core.utils.servlet.UnsupportedLocaleHelper] (ajp--127.0.0.1-8702-5) Invalid locale found in configuration: >2014-10-28 16:31:27,413 INFO [org.ovirt.engine.core.utils.servlet.UnsupportedLocaleHelper] (ajp--127.0.0.1-8702-5) Invalid locale found in configuration: >2014-10-28 16:31:34,364 INFO [org.ovirt.engine.core.bll.aaa.LoginAdminUserCommand] (ajp--127.0.0.1-8702-5) Running command: LoginAdminUserCommand internal: false. >2014-10-28 16:31:34,371 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: UNASSIGNED not exist in string table >2014-10-28 16:31:34,371 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: VDS_HIGH_NETWORK_USE not exist in string table >2014-10-28 16:31:34,371 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: USER_FAILED_REMOVE_VM not exist in string table >2014-10-28 16:31:34,372 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: USER_RUN_UNLOCK_ENTITY_SCRIPT not exist in string table >2014-10-28 16:31:34,372 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: VDS_NETWORK_MTU_DIFFER_FROM_LOGICAL_NETWORK not exist in string table >2014-10-28 16:31:34,372 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: STORAGE_ACTIVATE_ASYNC not exist in string table >2014-10-28 16:31:34,373 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: USER_ADDED_DISK_PROFILE not exist in string table >2014-10-28 16:31:34,373 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: USER_FAILED_TO_ADD_DISK_PROFILE not exist in string table >2014-10-28 16:31:34,373 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: USER_REMOVED_DISK_PROFILE not exist in string table >2014-10-28 16:31:34,373 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: USER_FAILED_TO_REMOVE_DISK_PROFILE not exist in string table >2014-10-28 16:31:34,374 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: USER_UPDATED_DISK_PROFILE not exist in string table >2014-10-28 16:31:34,374 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: USER_FAILED_TO_UPDATE_DISK_PROFILE not exist in string table >2014-10-28 16:31:34,374 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: USER_ADDED_CPU_PROFILE not exist in string table >2014-10-28 16:31:34,374 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: USER_FAILED_TO_ADD_CPU_PROFILE not exist in string table >2014-10-28 16:31:34,375 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: USER_REMOVED_CPU_PROFILE not exist in string table >2014-10-28 16:31:34,375 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: USER_FAILED_TO_REMOVE_CPU_PROFILE not exist in string table >2014-10-28 16:31:34,375 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: USER_UPDATED_CPU_PROFILE not exist in string table >2014-10-28 16:31:34,376 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) AuditLogType: USER_FAILED_TO_UPDATE_CPU_PROFILE not exist in string table >2014-10-28 16:31:34,514 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: User admin logged in. >2014-10-28 16:31:37,157 INFO [org.ovirt.engine.core.bll.aaa.LoginUserCommand] (ajp--127.0.0.1-8702-3) Running command: LoginUserCommand internal: false. >2014-10-28 16:31:51,923 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Refresh image list succeeded for domain(s): ovirt-image-repository (All file type) >2014-10-28 16:32:50,652 INFO [org.ovirt.engine.core.bll.network.dc.AddNetworkCommand] (ajp--127.0.0.1-8702-6) [25555fec] Lock Acquired to object EngineLock [exclusiveLocks= key: net2 value: NETWORK >, sharedLocks= ] >2014-10-28 16:32:50,663 INFO [org.ovirt.engine.core.bll.network.dc.AddNetworkCommand] (ajp--127.0.0.1-8702-6) [25555fec] Running command: AddNetworkCommand internal: false. Entities affected : ID: 00000002-0002-0002-0002-00000000029b Type: StoragePoolAction group CREATE_STORAGE_POOL_NETWORK with role type ADMIN >2014-10-28 16:32:50,680 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-6) [25555fec] Correlation ID: 25555fec, Call Stack: null, Custom Event ID: -1, Message: Network net2 was added to Data Center: Default >2014-10-28 16:32:50,681 INFO [org.ovirt.engine.core.bll.network.dc.AddNetworkCommand] (ajp--127.0.0.1-8702-6) [25555fec] Lock freed to object EngineLock [exclusiveLocks= key: net2 value: NETWORK >, sharedLocks= ] >2014-10-28 16:32:50,727 INFO [org.ovirt.engine.core.bll.network.vm.AddVnicProfileCommand] (ajp--127.0.0.1-8702-8) [54c2f234] Running command: AddVnicProfileCommand internal: false. Entities affected : ID: 0ee0e9bb-6d86-4644-ac15-f45fa4c4d967 Type: NetworkAction group CREATE_NETWORK_VNIC_PROFILE with role type ADMIN >2014-10-28 16:32:50,772 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-8) [54c2f234] Correlation ID: 54c2f234, Call Stack: null, Custom Event ID: -1, Message: VM network interface profile net2 was added to network net2 in Data Center: Default. (User: admin) >2014-10-28 16:32:50,795 INFO [org.ovirt.engine.core.bll.network.cluster.AttachNetworkToVdsGroupCommand] (org.ovirt.thread.pool-8-thread-38) [289e942] Running command: AttachNetworkToVdsGroupCommand internal: false. Entities affected : ID: 0ee0e9bb-6d86-4644-ac15-f45fa4c4d967 Type: NetworkAction group ASSIGN_CLUSTER_NETWORK with role type ADMIN >2014-10-28 16:32:50,885 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-38) Correlation ID: 289e942, Call Stack: null, Custom Event ID: -1, Message: Network net2 attached to Cluster Default >2014-10-28 16:33:17,334 INFO [org.ovirt.engine.core.bll.network.host.SetupNetworksCommand] (ajp--127.0.0.1-8702-6) [3f85eca] Running command: SetupNetworksCommand internal: false. Entities affected : ID: 531933b6-31fc-487d-afd7-b6cb33ef2d38 Type: VDSAction group CONFIGURE_HOST_NETWORK with role type ADMIN >2014-10-28 16:33:17,338 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetupNetworksVDSCommand] (ajp--127.0.0.1-8702-6) [3f85eca] START, SetupNetworksVDSCommand(HostName = hosted_engine_1, HostId = 531933b6-31fc-487d-afd7-b6cb33ef2d38, force=false, checkConnectivity=true, conectivityTimeout=120, > networks=[net2 {id=0ee0e9bb-6d86-4644-ac15-f45fa4c4d967, description=null, comment=null, subnet=null, gateway=null, type=null, vlanId=null, stp=false, dataCenterId=00000002-0002-0002-0002-00000000029b, mtu=0, vmNetwork=true, cluster=NetworkCluster {id={clusterId=null, networkId=null}, status=NON_OPERATIONAL, display=false, required=true, migration=false}, providedBy=null, label=null, qosId=null}], > bonds=[], > interfaces=[eth0 {id=c0e43a1b-5562-46bd-9b7d-29da8dcc137f, vdsId=531933b6-31fc-487d-afd7-b6cb33ef2d38, name=eth0, macAddress=00:1a:4a:4f:bd:04, networkName=ovirtmgmt, bondName=null, bootProtocol=DHCP, address=192.168.1.123, subnet=255.255.255.0, gateway=192.168.1.1, mtu=1500, bridged=true, speed=0, type=2, networkImplementationDetails={inSync=true, managed=true}}, > eth1 {id=f7a0887b-03d7-44ca-a6ca-2059024d8205, vdsId=531933b6-31fc-487d-afd7-b6cb33ef2d38, name=eth1, macAddress=00:1a:4a:4f:bd:05, networkName=net2, bondName=null, bootProtocol=NONE, address=, subnet=, gateway=null, mtu=0, bridged=true, speed=0, type=0, networkImplementationDetails=null}], > removedNetworks=[], > removedBonds=[]), log id: 4cae5310 >2014-10-28 16:33:17,343 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetupNetworksVDSCommand] (ajp--127.0.0.1-8702-6) [3f85eca] FINISH, SetupNetworksVDSCommand, log id: 4cae5310 >2014-10-28 16:33:17,346 INFO [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to /192.168.1.123 >2014-10-28 16:33:20,067 INFO [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to /192.168.1.123 >2014-10-28 16:33:20,442 INFO [org.ovirt.engine.core.bll.network.host.CommitNetworkChangesCommand] (ajp--127.0.0.1-8702-3) [2187aec7] Running command: CommitNetworkChangesCommand internal: false. Entities affected : ID: 531933b6-31fc-487d-afd7-b6cb33ef2d38 Type: VDSAction group CONFIGURE_HOST_NETWORK with role type ADMIN >2014-10-28 16:33:20,444 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetSafeNetworkConfigVDSCommand] (ajp--127.0.0.1-8702-3) [2187aec7] START, SetSafeNetworkConfigVDSCommand(HostName = hosted_engine_1, HostId = 531933b6-31fc-487d-afd7-b6cb33ef2d38), log id: c37e03b >2014-10-28 16:33:20,481 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetSafeNetworkConfigVDSCommand] (ajp--127.0.0.1-8702-3) [2187aec7] FINISH, SetSafeNetworkConfigVDSCommand, log id: c37e03b >2014-10-28 16:33:20,527 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) [2187aec7] Correlation ID: 2187aec7, Job ID: 36c66504-5cde-47ad-a50e-64ae02bb5e3e, Call Stack: null, Custom Event ID: -1, Message: Network changes were saved on host hosted_engine_1 >2014-10-28 16:37:24,296 INFO [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to /192.168.1.123 >2014-10-28 16:41:38,488 INFO [org.ovirt.engine.core.bll.aaa.LoginUserCommand] (ajp--127.0.0.1-8702-8) Running command: LoginUserCommand internal: false. >2014-10-28 16:41:38,501 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-8) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: User admin logged in. >2014-10-28 16:41:40,452 INFO [org.ovirt.engine.core.bll.AddVdsCommand] (ajp--127.0.0.1-8702-3) [57331f66] Running command: AddVdsCommand internal: false. Entities affected : ID: 00000001-0001-0001-0001-000000000384 Type: VdsGroupsAction group CREATE_HOST with role type ADMIN >2014-10-28 16:41:40,501 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (ajp--127.0.0.1-8702-3) [5bac315f] Running command: AddVdsSpmIdCommand internal: true. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDS >2014-10-28 16:41:40,513 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (ajp--127.0.0.1-8702-3) [5bac315f] Lock freed to object EngineLock [exclusiveLocks= key: 00000002-0002-0002-0002-00000000029b value: REGISTER_VDS >, sharedLocks= ] >2014-10-28 16:41:40,513 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (ajp--127.0.0.1-8702-3) [5bac315f] START, RemoveVdsVDSCommand(HostName = hosted_engine_2, HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff), log id: 6bb5bb8c >2014-10-28 16:41:40,513 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (ajp--127.0.0.1-8702-3) [5bac315f] FINISH, RemoveVdsVDSCommand, log id: 6bb5bb8c >2014-10-28 16:41:40,513 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-3) [5bac315f] START, AddVdsVDSCommand(HostName = hosted_engine_2, HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff), log id: 60a99dd1 >2014-10-28 16:41:40,513 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-3) [5bac315f] AddVds - entered , starting logic to add VDS a5eeed3e-6d56-4030-8dd8-f87422df89ff >2014-10-28 16:41:40,513 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-3) [5bac315f] AddVds - VDS a5eeed3e-6d56-4030-8dd8-f87422df89ff was added, will try to add it to the resource manager >2014-10-28 16:41:40,513 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (ajp--127.0.0.1-8702-3) [5bac315f] Entered VdsManager constructor >2014-10-28 16:41:40,534 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (ajp--127.0.0.1-8702-3) [5bac315f] Initialize vdsBroker (192.168.1.124,54,321) >2014-10-28 16:41:40,538 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--127.0.0.1-8702-3) [5bac315f] VDS a5eeed3e-6d56-4030-8dd8-f87422df89ff was added to the Resource Manager >2014-10-28 16:41:40,538 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-3) [5bac315f] FINISH, AddVdsVDSCommand, log id: 60a99dd1 >2014-10-28 16:41:40,543 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) [5bac315f] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Failed to verify Power Management configuration for Host hosted_engine_2. >2014-10-28 16:41:40,585 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-45) [78ae5a0d] Lock Acquired to object EngineLock [exclusiveLocks= key: a5eeed3e-6d56-4030-8dd8-f87422df89ff value: VDS >, sharedLocks= ] >2014-10-28 16:41:40,607 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) [5bac315f] Correlation ID: 57331f66, Job ID: 6a053752-de41-498e-a13c-4bf066f5de52, Call Stack: null, Custom Event ID: -1, Message: Host hosted_engine_2 was added by admin. >2014-10-28 16:41:40,634 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-45) [78ae5a0d] Running command: InstallVdsInternalCommand internal: true. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDS >2014-10-28 16:41:40,647 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-45) [78ae5a0d] Before Installation host a5eeed3e-6d56-4030-8dd8-f87422df89ff, hosted_engine_2 >2014-10-28 16:41:40,670 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-45) [78ae5a0d] START, SetVdsStatusVDSCommand(HostName = hosted_engine_2, HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff, status=Installing, nonOperationalReason=NONE, stopSpmFailureLogged=false), log id: 6f513b3c >2014-10-28 16:41:40,678 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-45) [78ae5a0d] FINISH, SetVdsStatusVDSCommand, log id: 6f513b3c >2014-10-28 16:41:40,798 INFO [org.ovirt.engine.core.bll.InstallerMessages] (org.ovirt.thread.pool-8-thread-45) [78ae5a0d] Installation 192.168.1.124: Connected to host 192.168.1.124 with SSH key fingerprint: 56:3c:7a:17:d2:cb:3b:6c:5d:a2:6c:96:83:5c:1e:b3 >2014-10-28 16:41:40,820 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-45) [78ae5a0d] Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Connected to host 192.168.1.124 with SSH key fingerprint: 56:3c:7a:17:d2:cb:3b:6c:5d:a2:6c:96:83:5c:1e:b3. >2014-10-28 16:41:40,918 INFO [org.ovirt.engine.core.bll.VdsDeploy] (org.ovirt.thread.pool-8-thread-45) [78ae5a0d] Installation of 192.168.1.124. Executing command via SSH umask 0077; MYTMP="$(TMPDIR="${OVIRT_TMPDIR}" mktemp -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; rm -fr "${MYTMP}" && mkdir "${MYTMP}" && tar --warning=no-timestamp -C "${MYTMP}" -x && "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True < /var/cache/ovirt-engine/ovirt-host-deploy.tar >2014-10-28 16:41:41,143 INFO [org.ovirt.engine.core.uutils.ssh.SSHDialog] (org.ovirt.thread.pool-8-thread-45) SSH execute root@192.168.1.124 'umask 0077; MYTMP="$(TMPDIR="${OVIRT_TMPDIR}" mktemp -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; rm -fr "${MYTMP}" && mkdir "${MYTMP}" && tar --warning=no-timestamp -C "${MYTMP}" -x && "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True' >2014-10-28 16:41:41,934 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Initializing >2014-10-28 16:41:41,943 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Initializing. >2014-10-28 16:41:41,960 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Environment setup >2014-10-28 16:41:41,970 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Environment setup. >2014-10-28 16:41:41,971 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Environment packages setup >2014-10-28 16:41:41,978 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Environment packages setup. >2014-10-28 16:41:43,540 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-93) Initializing Host: hosted_engine_2 >2014-10-28 16:41:55,452 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Programs detection >2014-10-28 16:41:55,459 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Programs detection. >2014-10-28 16:41:55,459 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Environment customization >2014-10-28 16:41:55,465 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Environment customization. >2014-10-28 16:41:58,773 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Kdump supported >2014-10-28 16:41:58,779 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Kdump supported. >2014-10-28 16:41:58,800 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Logs at host located at: '/tmp/ovirt-host-deploy-20141028114148-1ywnnf.log' >2014-10-28 16:41:58,803 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Logs at host located at: '/tmp/ovirt-host-deploy-20141028114148-1ywnnf.log'. >2014-10-28 16:41:58,833 INFO [org.ovirt.engine.core.bll.VdsDeploy] (VdsDeploy) Host 192.168.1.124 reports unique id B4CDFAC4-3FBC-4039-AE02-96F709368590 >2014-10-28 16:41:58,844 INFO [org.ovirt.engine.core.bll.VdsDeploy] (VdsDeploy) Assigning unique id B4CDFAC4-3FBC-4039-AE02-96F709368590 to Host 192.168.1.124 >2014-10-28 16:41:58,911 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Disabling Kdump integration >2014-10-28 16:41:58,916 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Disabling Kdump integration. >2014-10-28 16:41:58,930 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Setup validation >2014-10-28 16:41:58,934 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Setup validation. >2014-10-28 16:41:58,949 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Hardware supports virtualization >2014-10-28 16:41:58,954 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Hardware supports virtualization. >2014-10-28 16:41:59,102 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Transaction setup >2014-10-28 16:41:59,105 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Transaction setup. >2014-10-28 16:41:59,262 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Misc configuration >2014-10-28 16:41:59,267 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Misc configuration. >2014-10-28 16:41:59,267 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Package installation >2014-10-28 16:41:59,270 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Package installation. >2014-10-28 16:42:08,039 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Status: Downloading Packages >2014-10-28 16:42:08,043 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Status: Downloading Packages. >2014-10-28 16:42:08,568 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Download/Verify: 2:qemu-kvm-rhev-tools-0.12.1.2-2.415.el6_5.14.x86_64 >2014-10-28 16:42:08,572 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Download/Verify: 2:qemu-kvm-rhev-tools-0.12.1.2-2.415.el6_5.14.x86_64. >2014-10-28 16:42:08,573 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Status: Check Package Signatures >2014-10-28 16:42:08,579 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Status: Check Package Signatures. >2014-10-28 16:42:08,580 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Status: Running Test Transaction >2014-10-28 16:42:08,586 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Status: Running Test Transaction. >2014-10-28 16:42:08,634 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Status: Running Transaction >2014-10-28 16:42:08,637 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Status: Running Transaction. >2014-10-28 16:42:09,084 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum install: 1/1: 2:qemu-kvm-rhev-tools-0.12.1.2-2.415.el6_5.14.x86_64 >2014-10-28 16:42:09,087 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum install: 1/1: 2:qemu-kvm-rhev-tools-0.12.1.2-2.415.el6_5.14.x86_64. >2014-10-28 16:42:10,200 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Verify: 1/1: qemu-kvm-rhev-tools.x86_64 2:0.12.1.2-2.415.el6_5.14 - u >2014-10-28 16:42:10,204 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Verify: 1/1: qemu-kvm-rhev-tools.x86_64 2:0.12.1.2-2.415.el6_5.14 - u. >2014-10-28 16:42:10,919 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Misc configuration >2014-10-28 16:42:10,924 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Misc configuration. >2014-10-28 16:42:11,022 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Setting time >2014-10-28 16:42:11,026 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Setting time. >2014-10-28 16:42:13,679 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Enrolling certificate >2014-10-28 16:42:13,684 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Enrolling certificate. >2014-10-28 16:42:15,262 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Transaction commit >2014-10-28 16:42:15,267 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Transaction commit. >2014-10-28 16:42:16,149 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Closing up >2014-10-28 16:42:16,157 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Closing up. >2014-10-28 16:42:17,028 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stopping libvirtd >2014-10-28 16:42:17,040 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stopping libvirtd. >2014-10-28 16:42:17,094 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Starting vdsm >2014-10-28 16:42:17,097 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Starting vdsm. >2014-10-28 16:42:19,318 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Pre-termination >2014-10-28 16:42:19,324 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Pre-termination. >2014-10-28 16:42:19,335 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Retrieving installation logs to: '/var/log/ovirt-engine/host-deploy/ovirt-20141028164219-192.168.1.124-78ae5a0d.log' >2014-10-28 16:42:19,339 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Retrieving installation logs to: '/var/log/ovirt-engine/host-deploy/ovirt-20141028164219-192.168.1.124-78ae5a0d.log'. >2014-10-28 16:42:19,508 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Termination >2014-10-28 16:42:19,513 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 78ae5a0d, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Termination. >2014-10-28 16:42:19,689 INFO [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to /192.168.1.124 >2014-10-28 16:42:19,703 WARN [org.ovirt.vdsm.jsonrpc.client.utils.retry.Retryable] (SSL Stomp Reactor) Retry failed: java.net.ConnectException: Connection refused > at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method) [rt.jar:1.7.0_65] > at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:739) [rt.jar:1.7.0_65] > at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient$2.call(ReactorClient.java:111) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient$2.call(ReactorClient.java:97) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.utils.retry.Retryable.call(Retryable.java:26) [vdsm-jsonrpc-java-client.jar:] > at java.util.concurrent.FutureTask.run(FutureTask.java:262) [rt.jar:1.7.0_65] > at org.ovirt.vdsm.jsonrpc.client.utils.ReactorScheduler.performPendingOperations(ReactorScheduler.java:28) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.reactors.Reactor.run(Reactor.java:58) [vdsm-jsonrpc-java-client.jar:] > >2014-10-28 16:42:19,706 WARN [org.ovirt.vdsm.jsonrpc.client.utils.retry.Retryable] (SSL Stomp Reactor) Retry failed: java.net.ConnectException: Connection refused > at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method) [rt.jar:1.7.0_65] > at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:739) [rt.jar:1.7.0_65] > at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient$2.call(ReactorClient.java:111) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient$2.call(ReactorClient.java:97) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.utils.retry.Retryable.call(Retryable.java:26) [vdsm-jsonrpc-java-client.jar:] > at java.util.concurrent.FutureTask.run(FutureTask.java:262) [rt.jar:1.7.0_65] > at org.ovirt.vdsm.jsonrpc.client.utils.ReactorScheduler.performPendingOperations(ReactorScheduler.java:28) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.reactors.Reactor.run(Reactor.java:58) [vdsm-jsonrpc-java-client.jar:] > >2014-10-28 16:42:19,707 ERROR [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (org.ovirt.thread.pool-8-thread-9) Exception during connection: java.util.concurrent.ExecutionException: java.net.ConnectException: Connection refused > at java.util.concurrent.FutureTask.report(FutureTask.java:122) [rt.jar:1.7.0_65] > at java.util.concurrent.FutureTask.get(FutureTask.java:188) [rt.jar:1.7.0_65] > at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient.connect(ReactorClient.java:122) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.JsonRpcClient.getClient(JsonRpcClient.java:109) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.JsonRpcClient.call(JsonRpcClient.java:67) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.engine.core.vdsbroker.jsonrpc.FutureMap.<init>(FutureMap.java:60) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.jsonrpc.JsonRpcVdsServer$3.call(JsonRpcVdsServer.java:917) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.jsonrpc.JsonRpcVdsServer$3.call(JsonRpcVdsServer.java:913) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.jsonrpc.JsonRpcVdsServer$FutureCallable.call(JsonRpcVdsServer.java:405) [vdsbroker.jar:] > at org.ovirt.engine.core.vdsbroker.jsonrpc.JsonRpcVdsServer$FutureCallable.call(JsonRpcVdsServer.java:394) [vdsbroker.jar:] > at java.util.concurrent.FutureTask.run(FutureTask.java:262) [rt.jar:1.7.0_65] > at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) [rt.jar:1.7.0_65] > at java.util.concurrent.FutureTask.run(FutureTask.java:262) [rt.jar:1.7.0_65] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_65] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_65] > at java.lang.Thread.run(Thread.java:745) [rt.jar:1.7.0_65] >Caused by: java.net.ConnectException: Connection refused > at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method) [rt.jar:1.7.0_65] > at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:739) [rt.jar:1.7.0_65] > at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient$2.call(ReactorClient.java:111) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient$2.call(ReactorClient.java:97) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.utils.retry.Retryable.call(Retryable.java:26) [vdsm-jsonrpc-java-client.jar:] > at java.util.concurrent.FutureTask.run(FutureTask.java:262) [rt.jar:1.7.0_65] > at org.ovirt.vdsm.jsonrpc.client.utils.ReactorScheduler.performPendingOperations(ReactorScheduler.java:28) [vdsm-jsonrpc-java-client.jar:] > at org.ovirt.vdsm.jsonrpc.client.reactors.Reactor.run(Reactor.java:58) [vdsm-jsonrpc-java-client.jar:] > >2014-10-28 16:42:19,712 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (org.ovirt.thread.pool-8-thread-45) [78ae5a0d] java.util.concurrent.ExecutionException: org.ovirt.engine.core.vdsbroker.xmlrpc.XmlRpcRunTimeException: Connection issues during send request >2014-10-28 16:42:19,722 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.PollVDSCommand] (org.ovirt.thread.pool-8-thread-45) [78ae5a0d] Command PollVDSCommand(HostName = hosted_engine_2, HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff) execution failed. Exception: RuntimeException: java.util.concurrent.ExecutionException: org.ovirt.engine.core.vdsbroker.xmlrpc.XmlRpcRunTimeException: Connection issues during send request >2014-10-28 16:42:20,225 INFO [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to /192.168.1.124 >2014-10-28 16:42:20,350 INFO [org.ovirt.engine.core.bll.network.NetworkConfigurator] (org.ovirt.thread.pool-8-thread-45) [78ae5a0d] Engine managed to communicate with VDSM agent on host hosted_engine_2 >2014-10-28 16:42:20,665 INFO [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (org.ovirt.thread.pool-8-thread-45) [29efdc0d] Running command: SetNonOperationalVdsCommand internal: true. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDS >2014-10-28 16:42:20,670 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-45) [29efdc0d] START, SetVdsStatusVDSCommand(HostName = hosted_engine_2, HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff, status=NonOperational, nonOperationalReason=NETWORK_UNREACHABLE, stopSpmFailureLogged=false), log id: 516a772d >2014-10-28 16:42:20,674 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-45) [29efdc0d] FINISH, SetVdsStatusVDSCommand, log id: 516a772d >2014-10-28 16:42:20,684 ERROR [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (org.ovirt.thread.pool-8-thread-45) [29efdc0d] Host hosted_engine_2 is set to Non-Operational, it is missing the following networks: net2 >2014-10-28 16:42:20,706 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-45) [29efdc0d] Correlation ID: 29efdc0d, Job ID: 898cc218-9281-43b0-83e7-f7f1600c19f8, Call Stack: null, Custom Event ID: -1, Message: Host hosted_engine_2 does not comply with the cluster Default networks, the following networks are missing on host: 'net2' >2014-10-28 16:42:20,745 INFO [org.ovirt.engine.core.bll.network.host.SetupNetworksCommand] (org.ovirt.thread.pool-8-thread-45) [2d4eadc6] Running command: SetupNetworksCommand internal: true. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDSAction group CONFIGURE_HOST_NETWORK with role type ADMIN >2014-10-28 16:42:20,747 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetupNetworksVDSCommand] (org.ovirt.thread.pool-8-thread-45) [2d4eadc6] START, SetupNetworksVDSCommand(HostName = hosted_engine_2, HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff, force=false, checkConnectivity=true, conectivityTimeout=120, > networks=[ovirtmgmt {id=00000000-0000-0000-0000-000000000009, description=Management Network, comment=null, subnet=null, gateway=null, type=null, vlanId=null, stp=false, dataCenterId=00000002-0002-0002-0002-00000000029b, mtu=0, vmNetwork=true, cluster=NetworkCluster {id={clusterId=null, networkId=null}, status=OPERATIONAL, display=true, required=true, migration=true}, providedBy=null, label=null, qosId=null}], > bonds=[], > interfaces=[eth1 {id=c6dfb271-709c-4a90-92ad-73ae295709a3, vdsId=a5eeed3e-6d56-4030-8dd8-f87422df89ff, macAddress=00:1a:4a:4f:bd:07, networkName=null, baseInterface=null, vlanId=null, bonded=null, bondName=null, bondOptions=null, bootProtocol=NONE, address=, subnet=, gateway=null, mtu=1500, bridged=false, speed=0, type=0, networkImplementationDetails=null, qos=null qosOverridden=false, labels=null, customProperties=null}, > eth0 {id=15d2b6ab-6ba8-4df2-9154-c41b73124ccd, vdsId=a5eeed3e-6d56-4030-8dd8-f87422df89ff, macAddress=00:1a:4a:4f:bd:06, networkName=ovirtmgmt, baseInterface=null, vlanId=null, bonded=null, bondName=null, bondOptions=null, bootProtocol=DHCP, address=192.168.1.124, subnet=255.255.255.0, gateway=null, mtu=1500, bridged=false, speed=0, type=0, networkImplementationDetails=null, qos=null qosOverridden=false, labels=null, customProperties=null}], > removedNetworks=[], > removedBonds=[]), log id: 5fbcb61a >2014-10-28 16:42:20,751 INFO [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to /192.168.1.124 >2014-10-28 16:42:20,750 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetupNetworksVDSCommand] (org.ovirt.thread.pool-8-thread-45) [2d4eadc6] FINISH, SetupNetworksVDSCommand, log id: 5fbcb61a >2014-10-28 16:42:24,588 INFO [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to /192.168.1.124 >2014-10-28 16:42:24,824 INFO [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (org.ovirt.thread.pool-8-thread-45) [3c8c17c1] Running command: SetNonOperationalVdsCommand internal: true. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDS >2014-10-28 16:42:24,826 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-45) [3c8c17c1] START, SetVdsStatusVDSCommand(HostName = hosted_engine_2, HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff, status=NonOperational, nonOperationalReason=NETWORK_UNREACHABLE, stopSpmFailureLogged=false), log id: 30265cdc >2014-10-28 16:42:24,830 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-45) [3c8c17c1] FINISH, SetVdsStatusVDSCommand, log id: 30265cdc >2014-10-28 16:42:24,837 ERROR [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (org.ovirt.thread.pool-8-thread-45) [3c8c17c1] Host hosted_engine_2 is set to Non-Operational, it is missing the following networks: net2 >2014-10-28 16:42:24,864 INFO [org.ovirt.engine.core.bll.network.host.CommitNetworkChangesCommand] (org.ovirt.thread.pool-8-thread-45) [57d01cc4] Running command: CommitNetworkChangesCommand internal: true. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDSAction group CONFIGURE_HOST_NETWORK with role type ADMIN >2014-10-28 16:42:24,867 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetSafeNetworkConfigVDSCommand] (org.ovirt.thread.pool-8-thread-45) [57d01cc4] START, SetSafeNetworkConfigVDSCommand(HostName = hosted_engine_2, HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff), log id: 105869d2 >2014-10-28 16:42:24,894 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.SetSafeNetworkConfigVDSCommand] (org.ovirt.thread.pool-8-thread-45) [57d01cc4] FINISH, SetSafeNetworkConfigVDSCommand, log id: 105869d2 >2014-10-28 16:42:24,900 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-45) [57d01cc4] Correlation ID: 57d01cc4, Call Stack: null, Custom Event ID: -1, Message: Network changes were saved on host hosted_engine_2 >2014-10-28 16:42:24,902 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-45) [57d01cc4] START, SetVdsStatusVDSCommand(HostName = hosted_engine_2, HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff, status=Initializing, nonOperationalReason=NONE, stopSpmFailureLogged=false), log id: 4313f34a >2014-10-28 16:42:24,910 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-45) [57d01cc4] FINISH, SetVdsStatusVDSCommand, log id: 4313f34a >2014-10-28 16:42:24,910 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-45) [57d01cc4] After Installation host hosted_engine_2, VDS >2014-10-28 16:42:24,916 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-45) [57d01cc4] Correlation ID: 78ae5a0d, Job ID: 6a053752-de41-498e-a13c-4bf066f5de52, Call Stack: null, Custom Event ID: -1, Message: Host hosted_engine_2 installed >2014-10-28 16:42:24,920 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-45) [57d01cc4] Lock freed to object EngineLock [exclusiveLocks= key: a5eeed3e-6d56-4030-8dd8-f87422df89ff value: VDS >, sharedLocks= ] >2014-10-28 16:42:25,614 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-13) START, GetHardwareInfoVDSCommand(HostName = hosted_engine_2, HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff, vds=Host[hosted_engine_2,a5eeed3e-6d56-4030-8dd8-f87422df89ff]), log id: 4ca4972a >2014-10-28 16:42:25,658 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-13) FINISH, GetHardwareInfoVDSCommand, log id: 4ca4972a >2014-10-28 16:42:25,690 INFO [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (DefaultQuartzScheduler_Worker-13) [7386d8a3] Running command: SetNonOperationalVdsCommand internal: true. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDS >2014-10-28 16:42:25,693 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler_Worker-13) [7386d8a3] START, SetVdsStatusVDSCommand(HostName = hosted_engine_2, HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff, status=NonOperational, nonOperationalReason=NETWORK_UNREACHABLE, stopSpmFailureLogged=false), log id: 51cd7e15 >2014-10-28 16:42:25,705 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler_Worker-13) [7386d8a3] FINISH, SetVdsStatusVDSCommand, log id: 51cd7e15 >2014-10-28 16:42:25,708 ERROR [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (DefaultQuartzScheduler_Worker-13) [7386d8a3] Host hosted_engine_2 is set to Non-Operational, it is missing the following networks: net2 >2014-10-28 16:42:25,721 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler_Worker-13) [3cecff62] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDS >2014-10-28 16:42:25,760 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-13) [3cecff62] START, GetHardwareInfoVDSCommand(HostName = hosted_engine_2, HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff, vds=Host[hosted_engine_2,a5eeed3e-6d56-4030-8dd8-f87422df89ff]), log id: 5ba7365f >2014-10-28 16:42:25,766 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-13) [3cecff62] FINISH, GetHardwareInfoVDSCommand, log id: 5ba7365f >2014-10-28 16:42:25,798 INFO [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (DefaultQuartzScheduler_Worker-13) [7181825b] Running command: SetNonOperationalVdsCommand internal: true. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDS >2014-10-28 16:42:25,801 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler_Worker-13) [7181825b] START, SetVdsStatusVDSCommand(HostName = hosted_engine_2, HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff, status=NonOperational, nonOperationalReason=NETWORK_UNREACHABLE, stopSpmFailureLogged=false), log id: 400f08ac >2014-10-28 16:42:25,806 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler_Worker-13) [7181825b] FINISH, SetVdsStatusVDSCommand, log id: 400f08ac >2014-10-28 16:42:25,809 ERROR [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (DefaultQuartzScheduler_Worker-13) [7181825b] Host hosted_engine_2 is set to Non-Operational, it is missing the following networks: net2 >2014-10-28 16:42:25,816 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler_Worker-13) [4f9331d4] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDS >2014-10-28 16:42:25,820 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-13) [4f9331d4] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Status of host hosted_engine_2 was set to NonOperational. >2014-10-28 16:42:25,837 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler_Worker-13) [6f4e89e7] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDS >2014-10-28 16:42:25,840 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler_Worker-13) [1b8200a7] Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDS >2014-10-28 16:42:25,841 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-13) [1b8200a7] Host a5eeed3e-6d56-4030-8dd8-f87422df89ff : hosted_engine_2 is already in NonOperational status for reason NETWORK_UNREACHABLE. SetNonOperationalVds command is skipped. >2014-10-28 17:31:10,659 INFO [org.ovirt.engine.core.bll.aaa.SyncUsers] (DefaultQuartzScheduler_Worker-87) Principal admin::internal synchronized >2014-10-28 17:31:10,853 INFO [org.ovirt.engine.core.bll.OvfDataUpdater] (DefaultQuartzScheduler_Worker-90) Attempting to update VMs/Templates Ovf. >2014-10-28 17:35:20,749 INFO [org.ovirt.engine.core.bll.MaintenanceNumberOfVdssCommand] (org.ovirt.thread.pool-8-thread-19) [4f44aa6e] Running command: MaintenanceNumberOfVdssCommand internal: false. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDSAction group MANIPULATE_HOST with role type ADMIN >2014-10-28 17:35:20,755 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-19) [4f44aa6e] START, SetVdsStatusVDSCommand(HostName = hosted_engine_2, HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff, status=PreparingForMaintenance, nonOperationalReason=NONE, stopSpmFailureLogged=true), log id: 4cf3deea >2014-10-28 17:35:20,761 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-19) [4f44aa6e] FINISH, SetVdsStatusVDSCommand, log id: 4cf3deea >2014-10-28 17:35:20,886 INFO [org.ovirt.engine.core.bll.MaintenanceVdsCommand] (org.ovirt.thread.pool-8-thread-19) [4f44aa6e] Running command: MaintenanceVdsCommand internal: true. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDS >2014-10-28 17:35:20,898 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-19) [4f44aa6e] Correlation ID: 4f44aa6e, Job ID: 2ef06482-5db0-4e2c-8a8b-f8acc53f9f9d, Call Stack: null, Custom Event ID: -1, Message: Host hosted_engine_2 was switched to Maintenance mode by admin. >2014-10-28 17:35:23,030 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-38) Updated vds status from Preparing for Maintenance to Maintenance in database, vds = a5eeed3e-6d56-4030-8dd8-f87422df89ff : hosted_engine_2 >2014-10-28 17:35:23,058 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (org.ovirt.thread.pool-8-thread-22) Clearing cache of pool: 00000002-0002-0002-0002-00000000029b for problematic entities of VDS: hosted_engine_2. >2014-10-28 17:35:23,058 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (org.ovirt.thread.pool-8-thread-22) Removing vds [a5eeed3e-6d56-4030-8dd8-f87422df89ff] from the domain in maintenance cache >2014-10-28 17:35:23,059 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (org.ovirt.thread.pool-8-thread-22) Removing host(s) [a5eeed3e-6d56-4030-8dd8-f87422df89ff] from hosts unseen domain report cache >2014-10-28 17:35:28,347 INFO [org.ovirt.engine.core.bll.RemoveVdsCommand] (ajp--127.0.0.1-8702-1) [2ca6e8ed] Lock Acquired to object EngineLock [exclusiveLocks= key: a5eeed3e-6d56-4030-8dd8-f87422df89ff value: VDS >, sharedLocks= ] >2014-10-28 17:35:28,372 INFO [org.ovirt.engine.core.bll.RemoveVdsCommand] (org.ovirt.thread.pool-8-thread-25) [2ca6e8ed] Running command: RemoveVdsCommand internal: false. Entities affected : ID: a5eeed3e-6d56-4030-8dd8-f87422df89ff Type: VDSAction group DELETE_HOST with role type ADMIN >2014-10-28 17:35:28,412 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (org.ovirt.thread.pool-8-thread-25) [2ca6e8ed] START, RemoveVdsVDSCommand( HostId = a5eeed3e-6d56-4030-8dd8-f87422df89ff), log id: 588da596 >2014-10-28 17:35:28,418 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (org.ovirt.thread.pool-8-thread-25) [2ca6e8ed] vdsManager::disposing >2014-10-28 17:35:28,453 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (org.ovirt.thread.pool-8-thread-25) [2ca6e8ed] FINISH, RemoveVdsVDSCommand, log id: 588da596 >2014-10-28 17:35:28,460 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-25) [2ca6e8ed] Correlation ID: 2ca6e8ed, Call Stack: null, Custom Event ID: -1, Message: Host hosted_engine_2 was removed by admin. >2014-10-28 17:35:28,461 INFO [org.ovirt.engine.core.bll.RemoveVdsCommand] (org.ovirt.thread.pool-8-thread-25) [2ca6e8ed] Lock freed to object EngineLock [exclusiveLocks= key: a5eeed3e-6d56-4030-8dd8-f87422df89ff value: VDS >, sharedLocks= ] >2014-10-28 17:36:10,611 INFO [org.ovirt.engine.core.bll.AddVdsCommand] (ajp--127.0.0.1-8702-3) [48e548d9] Running command: AddVdsCommand internal: false. Entities affected : ID: 00000001-0001-0001-0001-000000000384 Type: VdsGroupsAction group CREATE_HOST with role type ADMIN >2014-10-28 17:36:10,621 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (ajp--127.0.0.1-8702-3) [28190c1f] Running command: AddVdsSpmIdCommand internal: true. Entities affected : ID: ade48c85-07d2-48f7-a3fe-ecf920b8dc95 Type: VDS >2014-10-28 17:36:10,626 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (ajp--127.0.0.1-8702-3) [28190c1f] Lock freed to object EngineLock [exclusiveLocks= key: 00000002-0002-0002-0002-00000000029b value: REGISTER_VDS >, sharedLocks= ] >2014-10-28 17:36:10,627 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (ajp--127.0.0.1-8702-3) [28190c1f] START, RemoveVdsVDSCommand(HostName = hosted_engine_2, HostId = ade48c85-07d2-48f7-a3fe-ecf920b8dc95), log id: 679d6b5f >2014-10-28 17:36:10,627 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (ajp--127.0.0.1-8702-3) [28190c1f] FINISH, RemoveVdsVDSCommand, log id: 679d6b5f >2014-10-28 17:36:10,628 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-3) [28190c1f] START, AddVdsVDSCommand(HostName = hosted_engine_2, HostId = ade48c85-07d2-48f7-a3fe-ecf920b8dc95), log id: 8cf4b0 >2014-10-28 17:36:10,628 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-3) [28190c1f] AddVds - entered , starting logic to add VDS ade48c85-07d2-48f7-a3fe-ecf920b8dc95 >2014-10-28 17:36:10,629 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-3) [28190c1f] AddVds - VDS ade48c85-07d2-48f7-a3fe-ecf920b8dc95 was added, will try to add it to the resource manager >2014-10-28 17:36:10,629 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (ajp--127.0.0.1-8702-3) [28190c1f] Entered VdsManager constructor >2014-10-28 17:36:10,641 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (ajp--127.0.0.1-8702-3) [28190c1f] Initialize vdsBroker (192.168.1.124,54,321) >2014-10-28 17:36:10,643 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--127.0.0.1-8702-3) [28190c1f] VDS ade48c85-07d2-48f7-a3fe-ecf920b8dc95 was added to the Resource Manager >2014-10-28 17:36:10,644 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--127.0.0.1-8702-3) [28190c1f] FINISH, AddVdsVDSCommand, log id: 8cf4b0 >2014-10-28 17:36:10,648 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) [28190c1f] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Failed to verify Power Management configuration for Host hosted_engine_2. >2014-10-28 17:36:10,664 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) [28190c1f] Correlation ID: 48e548d9, Job ID: a96dd74a-f703-41df-b684-f5cc7d6d3538, Call Stack: null, Custom Event ID: -1, Message: Host hosted_engine_2 was added by admin. >2014-10-28 17:36:10,667 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-40) [52a9afa0] Lock Acquired to object EngineLock [exclusiveLocks= key: ade48c85-07d2-48f7-a3fe-ecf920b8dc95 value: VDS >, sharedLocks= ] >2014-10-28 17:36:10,672 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-40) [52a9afa0] Running command: InstallVdsInternalCommand internal: true. Entities affected : ID: ade48c85-07d2-48f7-a3fe-ecf920b8dc95 Type: VDS >2014-10-28 17:36:10,672 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-40) [52a9afa0] Before Installation host ade48c85-07d2-48f7-a3fe-ecf920b8dc95, hosted_engine_2 >2014-10-28 17:36:10,674 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-40) [52a9afa0] START, SetVdsStatusVDSCommand(HostName = hosted_engine_2, HostId = ade48c85-07d2-48f7-a3fe-ecf920b8dc95, status=Installing, nonOperationalReason=NONE, stopSpmFailureLogged=false), log id: 25708e0e >2014-10-28 17:36:10,678 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-40) [52a9afa0] FINISH, SetVdsStatusVDSCommand, log id: 25708e0e >2014-10-28 17:36:10,722 INFO [org.ovirt.engine.core.bll.InstallerMessages] (org.ovirt.thread.pool-8-thread-40) [52a9afa0] Installation 192.168.1.124: Connected to host 192.168.1.124 with SSH key fingerprint: 56:3c:7a:17:d2:cb:3b:6c:5d:a2:6c:96:83:5c:1e:b3 >2014-10-28 17:36:10,736 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-40) [52a9afa0] Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Connected to host 192.168.1.124 with SSH key fingerprint: 56:3c:7a:17:d2:cb:3b:6c:5d:a2:6c:96:83:5c:1e:b3. >2014-10-28 17:36:10,804 INFO [org.ovirt.engine.core.bll.VdsDeploy] (org.ovirt.thread.pool-8-thread-40) [52a9afa0] Installation of 192.168.1.124. Executing command via SSH umask 0077; MYTMP="$(TMPDIR="${OVIRT_TMPDIR}" mktemp -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; rm -fr "${MYTMP}" && mkdir "${MYTMP}" && tar --warning=no-timestamp -C "${MYTMP}" -x && "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True < /var/cache/ovirt-engine/ovirt-host-deploy.tar >2014-10-28 17:36:10,810 INFO [org.ovirt.engine.core.uutils.ssh.SSHDialog] (org.ovirt.thread.pool-8-thread-40) SSH execute root@192.168.1.124 'umask 0077; MYTMP="$(TMPDIR="${OVIRT_TMPDIR}" mktemp -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; rm -fr "${MYTMP}" && mkdir "${MYTMP}" && tar --warning=no-timestamp -C "${MYTMP}" -x && "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True' >2014-10-28 17:36:11,439 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Initializing >2014-10-28 17:36:11,446 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Initializing. >2014-10-28 17:36:11,461 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Environment setup >2014-10-28 17:36:11,466 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Environment setup. >2014-10-28 17:36:11,483 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Environment packages setup >2014-10-28 17:36:11,498 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Environment packages setup. >2014-10-28 17:36:13,646 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-74) Initializing Host: hosted_engine_2 >2014-10-28 17:36:32,214 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Programs detection >2014-10-28 17:36:32,222 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Programs detection. >2014-10-28 17:36:32,222 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Environment customization >2014-10-28 17:36:32,226 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Environment customization. >2014-10-28 17:36:35,747 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Kdump supported >2014-10-28 17:36:35,751 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Kdump supported. >2014-10-28 17:36:35,759 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Logs at host located at: '/tmp/ovirt-host-deploy-20141028123713-k8yu6v.log' >2014-10-28 17:36:35,764 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Logs at host located at: '/tmp/ovirt-host-deploy-20141028123713-k8yu6v.log'. >2014-10-28 17:36:35,833 INFO [org.ovirt.engine.core.bll.VdsDeploy] (VdsDeploy) Host 192.168.1.124 reports unique id B4CDFAC4-3FBC-4039-AE02-96F709368590 >2014-10-28 17:36:35,849 INFO [org.ovirt.engine.core.bll.VdsDeploy] (VdsDeploy) Assigning unique id B4CDFAC4-3FBC-4039-AE02-96F709368590 to Host 192.168.1.124 >2014-10-28 17:36:35,907 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Disabling Kdump integration >2014-10-28 17:36:35,910 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Disabling Kdump integration. >2014-10-28 17:36:35,931 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Setup validation >2014-10-28 17:36:35,936 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Setup validation. >2014-10-28 17:36:35,962 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Hardware supports virtualization >2014-10-28 17:36:35,970 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Hardware supports virtualization. >2014-10-28 17:36:36,104 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Transaction setup >2014-10-28 17:36:36,108 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Transaction setup. >2014-10-28 17:36:36,139 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Misc configuration >2014-10-28 17:36:36,142 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Misc configuration. >2014-10-28 17:36:36,143 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Package installation >2014-10-28 17:36:36,148 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Package installation. >2014-10-28 17:36:44,834 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Status: Downloading Packages >2014-10-28 17:36:44,840 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Status: Downloading Packages. >2014-10-28 17:36:45,174 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Download/Verify: iptables-1.4.7-14.el6.x86_64 >2014-10-28 17:36:45,179 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Download/Verify: iptables-1.4.7-14.el6.x86_64. >2014-10-28 17:36:45,317 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Download/Verify: iptables-ipv6-1.4.7-14.el6.x86_64 >2014-10-28 17:36:45,322 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Download/Verify: iptables-ipv6-1.4.7-14.el6.x86_64. >2014-10-28 17:36:45,323 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Status: Check Package Signatures >2014-10-28 17:36:45,329 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Status: Check Package Signatures. >2014-10-28 17:36:45,330 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Status: Running Test Transaction >2014-10-28 17:36:45,336 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Status: Running Test Transaction. >2014-10-28 17:36:45,428 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Status: Running Transaction >2014-10-28 17:36:45,435 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Status: Running Transaction. >2014-10-28 17:36:46,036 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum update: 1/4: iptables-1.4.7-14.el6.x86_64 >2014-10-28 17:36:46,040 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum update: 1/4: iptables-1.4.7-14.el6.x86_64. >2014-10-28 17:36:47,812 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum update: 2/4: iptables-ipv6-1.4.7-14.el6.x86_64 >2014-10-28 17:36:47,838 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum update: 2/4: iptables-ipv6-1.4.7-14.el6.x86_64. >2014-10-28 17:36:48,729 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum updated: 3/4: iptables-ipv6 >2014-10-28 17:36:48,733 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum updated: 3/4: iptables-ipv6. >2014-10-28 17:36:49,237 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum updated: 4/4: iptables >2014-10-28 17:36:49,241 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum updated: 4/4: iptables. >2014-10-28 17:36:50,042 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Verify: 1/4: iptables.x86_64 0:1.4.7-14.el6 - u >2014-10-28 17:36:50,046 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Verify: 1/4: iptables.x86_64 0:1.4.7-14.el6 - u. >2014-10-28 17:36:50,240 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Verify: 2/4: iptables-ipv6.x86_64 0:1.4.7-14.el6 - u >2014-10-28 17:36:50,244 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Verify: 2/4: iptables-ipv6.x86_64 0:1.4.7-14.el6 - u. >2014-10-28 17:36:50,309 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Verify: 3/4: iptables.x86_64 0:1.4.7-11.el6 - ud >2014-10-28 17:36:50,312 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Verify: 3/4: iptables.x86_64 0:1.4.7-11.el6 - ud. >2014-10-28 17:36:50,312 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Yum Verify: 4/4: iptables-ipv6.x86_64 0:1.4.7-11.el6 - ud >2014-10-28 17:36:50,323 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Yum Verify: 4/4: iptables-ipv6.x86_64 0:1.4.7-11.el6 - ud. >2014-10-28 17:36:50,499 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Misc configuration >2014-10-28 17:36:50,502 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Misc configuration. >2014-10-28 17:36:50,524 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Setting time >2014-10-28 17:36:50,527 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Setting time. >2014-10-28 17:36:52,871 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Enrolling certificate >2014-10-28 17:36:52,876 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Enrolling certificate. >2014-10-28 17:36:54,281 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Transaction commit >2014-10-28 17:36:54,289 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Transaction commit. >2014-10-28 17:36:54,756 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Closing up >2014-10-28 17:36:54,761 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Closing up. >2014-10-28 17:37:01,116 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stopping libvirtd >2014-10-28 17:37:01,124 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stopping libvirtd. >2014-10-28 17:37:01,401 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Starting vdsm >2014-10-28 17:37:01,408 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Starting vdsm. >2014-10-28 17:37:02,066 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Pre-termination >2014-10-28 17:37:02,070 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Pre-termination. >2014-10-28 17:37:02,084 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Retrieving installation logs to: '/var/log/ovirt-engine/host-deploy/ovirt-20141028173702-192.168.1.124-52a9afa0.log' >2014-10-28 17:37:02,088 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Retrieving installation logs to: '/var/log/ovirt-engine/host-deploy/ovirt-20141028173702-192.168.1.124-52a9afa0.log'. >2014-10-28 17:37:02,240 INFO [org.ovirt.engine.core.bll.InstallerMessages] (VdsDeploy) Installation 192.168.1.124: Stage: Termination >2014-10-28 17:37:02,244 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) Correlation ID: 52a9afa0, Call Stack: null, Custom Event ID: -1, Message: Installing Host hosted_engine_2. Stage: Termination. >2014-10-28 17:37:02,473 INFO [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to /192.168.1.124 >2014-10-28 17:37:02,601 INFO [org.ovirt.engine.core.bll.network.NetworkConfigurator] (org.ovirt.thread.pool-8-thread-40) [52a9afa0] Engine managed to communicate with VDSM agent on host hosted_engine_2 >2014-10-28 17:37:02,706 INFO [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (org.ovirt.thread.pool-8-thread-40) [5e0795f0] Running command: SetNonOperationalVdsCommand internal: true. Entities affected : ID: ade48c85-07d2-48f7-a3fe-ecf920b8dc95 Type: VDS >2014-10-28 17:37:02,708 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-40) [5e0795f0] START, SetVdsStatusVDSCommand(HostName = hosted_engine_2, HostId = ade48c85-07d2-48f7-a3fe-ecf920b8dc95, status=NonOperational, nonOperationalReason=NETWORK_UNREACHABLE, stopSpmFailureLogged=false), log id: 25986468 >2014-10-28 17:37:02,716 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-40) [5e0795f0] FINISH, SetVdsStatusVDSCommand, log id: 25986468 >2014-10-28 17:37:02,720 ERROR [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (org.ovirt.thread.pool-8-thread-40) [5e0795f0] Host hosted_engine_2 is set to Non-Operational, it is missing the following networks: net2 >2014-10-28 17:37:02,732 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-40) [5e0795f0] Correlation ID: 5e0795f0, Job ID: f732042e-a0d2-4d09-a993-a8c49cbc6b6a, Call Stack: null, Custom Event ID: -1, Message: Host hosted_engine_2 does not comply with the cluster Default networks, the following networks are missing on host: 'net2' >2014-10-28 17:37:02,741 INFO [org.ovirt.engine.core.bll.network.NetworkConfigurator] (org.ovirt.thread.pool-8-thread-40) [5e0795f0] The management network ovirtmgmt is already configured on host hosted_engine_2 >2014-10-28 17:37:02,745 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-40) [5e0795f0] START, SetVdsStatusVDSCommand(HostName = hosted_engine_2, HostId = ade48c85-07d2-48f7-a3fe-ecf920b8dc95, status=Initializing, nonOperationalReason=NONE, stopSpmFailureLogged=false), log id: 7b471b54 >2014-10-28 17:37:02,751 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-40) [5e0795f0] FINISH, SetVdsStatusVDSCommand, log id: 7b471b54 >2014-10-28 17:37:02,751 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-40) [5e0795f0] After Installation host hosted_engine_2, VDS >2014-10-28 17:37:02,765 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-40) [5e0795f0] Correlation ID: 52a9afa0, Job ID: a96dd74a-f703-41df-b684-f5cc7d6d3538, Call Stack: null, Custom Event ID: -1, Message: Host hosted_engine_2 installed >2014-10-28 17:37:02,778 INFO [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-40) [5e0795f0] Lock freed to object EngineLock [exclusiveLocks= key: ade48c85-07d2-48f7-a3fe-ecf920b8dc95 value: VDS >, sharedLocks= ] >2014-10-28 17:37:04,715 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-96) START, GetHardwareInfoVDSCommand(HostName = hosted_engine_2, HostId = ade48c85-07d2-48f7-a3fe-ecf920b8dc95, vds=Host[hosted_engine_2,ade48c85-07d2-48f7-a3fe-ecf920b8dc95]), log id: 453ffac6 >2014-10-28 17:37:04,751 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-96) FINISH, GetHardwareInfoVDSCommand, log id: 453ffac6 >2014-10-28 17:37:04,787 INFO [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (DefaultQuartzScheduler_Worker-96) [5c74808d] Running command: SetNonOperationalVdsCommand internal: true. Entities affected : ID: ade48c85-07d2-48f7-a3fe-ecf920b8dc95 Type: VDS >2014-10-28 17:37:04,789 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler_Worker-96) [5c74808d] START, SetVdsStatusVDSCommand(HostName = hosted_engine_2, HostId = ade48c85-07d2-48f7-a3fe-ecf920b8dc95, status=NonOperational, nonOperationalReason=NETWORK_UNREACHABLE, stopSpmFailureLogged=false), log id: 12463727 >2014-10-28 17:37:04,793 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler_Worker-96) [5c74808d] FINISH, SetVdsStatusVDSCommand, log id: 12463727 >2014-10-28 17:37:04,796 ERROR [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (DefaultQuartzScheduler_Worker-96) [5c74808d] Host hosted_engine_2 is set to Non-Operational, it is missing the following networks: net2 >2014-10-28 17:37:04,808 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler_Worker-96) [7efbeba2] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: ade48c85-07d2-48f7-a3fe-ecf920b8dc95 Type: VDS >2014-10-28 17:37:04,845 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-96) [7efbeba2] START, GetHardwareInfoVDSCommand(HostName = hosted_engine_2, HostId = ade48c85-07d2-48f7-a3fe-ecf920b8dc95, vds=Host[hosted_engine_2,ade48c85-07d2-48f7-a3fe-ecf920b8dc95]), log id: 62c4b26e >2014-10-28 17:37:04,852 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-96) [7efbeba2] FINISH, GetHardwareInfoVDSCommand, log id: 62c4b26e >2014-10-28 17:37:04,881 INFO [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (DefaultQuartzScheduler_Worker-96) [1cbb0f27] Running command: SetNonOperationalVdsCommand internal: true. Entities affected : ID: ade48c85-07d2-48f7-a3fe-ecf920b8dc95 Type: VDS >2014-10-28 17:37:04,883 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler_Worker-96) [1cbb0f27] START, SetVdsStatusVDSCommand(HostName = hosted_engine_2, HostId = ade48c85-07d2-48f7-a3fe-ecf920b8dc95, status=NonOperational, nonOperationalReason=NETWORK_UNREACHABLE, stopSpmFailureLogged=false), log id: 10f7e0e4 >2014-10-28 17:37:04,887 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler_Worker-96) [1cbb0f27] FINISH, SetVdsStatusVDSCommand, log id: 10f7e0e4 >2014-10-28 17:37:04,891 ERROR [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (DefaultQuartzScheduler_Worker-96) [1cbb0f27] Host hosted_engine_2 is set to Non-Operational, it is missing the following networks: net2 >2014-10-28 17:37:04,899 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler_Worker-96) [2de4caf8] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: ade48c85-07d2-48f7-a3fe-ecf920b8dc95 Type: VDS >2014-10-28 17:37:04,908 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-96) [2de4caf8] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Status of host hosted_engine_2 was set to NonOperational. >2014-10-28 17:37:04,929 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler_Worker-96) [4e90a168] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: ade48c85-07d2-48f7-a3fe-ecf920b8dc95 Type: VDS >2014-10-28 17:37:04,934 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler_Worker-96) [1e4a10a4] Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: ade48c85-07d2-48f7-a3fe-ecf920b8dc95 Type: VDS >2014-10-28 17:37:04,936 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-96) [1e4a10a4] Host ade48c85-07d2-48f7-a3fe-ecf920b8dc95 : hosted_engine_2 is already in NonOperational status for reason NETWORK_UNREACHABLE. SetNonOperationalVds command is skipped.
<b>You cannot view the attachment while viewing its details because your browser does not support IFRAMEs. <a href="attachment.cgi?id=951454">View the attachment on a separate page</a>.</b>
View Attachment As Raw
Actions:
View
Attachments on
bug 1086032
:
951442
|
951444
|
951445
|
951447
|
951451
|
951453
| 951454