2018-03-13 22:36:57,928-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Loaded file '/home/engine/tchyp-engine/share/ovirt-engine/services/ovirt-engine/ovirt-engine.conf'. 2018-03-13 22:36:57,936-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] The file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf' doesn't exist or isn't readable. Will return an empty set of properties. 2018-03-13 22:36:57,936-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Loaded file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf.d/10-setup-database.conf'. 2018-03-13 22:36:57,936-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Loaded file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf.d/10-setup-java.conf'. 2018-03-13 22:36:57,936-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Loaded file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf.d/10-setup-jboss.conf'. 2018-03-13 22:36:57,937-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Loaded file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf.d/10-setup-pki.conf'. 2018-03-13 22:36:57,937-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Loaded file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf.d/10-setup-protocols.conf'. 2018-03-13 22:36:57,937-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Loaded file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf.d/11-setup-sso.conf'. 2018-03-13 22:36:57,937-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Loaded file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf.d/20-setup-jboss-overlay.conf'. 2018-03-13 22:36:57,932-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Loaded file '/home/engine/tchyp-engine/share/ovirt-engine/services/ovirt-engine/ovirt-engine.conf'. 2018-03-13 22:36:57,938-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] The file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf' doesn't exist or isn't readable. Will return an empty set of properties. 2018-03-13 22:36:57,938-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'AAA_JAAS_KEYTAB_FILE' is ''. 2018-03-13 22:36:57,938-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Loaded file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf.d/10-setup-database.conf'. 2018-03-13 22:36:57,938-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'AAA_JAAS_PRINCIPAL_NAME' is ''. 2018-03-13 22:36:57,938-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Loaded file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf.d/10-setup-java.conf'. 2018-03-13 22:36:57,938-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'AAA_JAAS_TICKET_CACHE_FILE' is ''. 2018-03-13 22:36:57,938-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Loaded file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf.d/10-setup-jboss.conf'. 2018-03-13 22:36:57,938-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'AAA_JAAS_USE_KEYTAB' is 'false'. 2018-03-13 22:36:57,939-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Loaded file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf.d/10-setup-pki.conf'. 2018-03-13 22:36:57,939-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'AAA_JAAS_USE_TICKET_CACHE' is 'false'. 2018-03-13 22:36:57,939-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'AAA_KRB5_CONF_FILE' is ''. 2018-03-13 22:36:57,939-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'COMMAND_COORDINATOR_THREAD_POOL_SIZE' is '10'. 2018-03-13 22:36:57,939-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'DASHBOARD_CACHE_UPDATE' is 'true'. 2018-03-13 22:36:57,939-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'DASHBOARD_INVENTORY_CACHE_UPDATE_INTERVAL' is '60'. 2018-03-13 22:36:57,939-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'DASHBOARD_UTILIZATION_CACHE_UPDATE_INTERVAL' is '300'. 2018-03-13 22:36:57,940-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'DWH_DB_DATABASE' is 'ovirt_engine_history'. 2018-03-13 22:36:57,940-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'DWH_DB_DRIVER' is 'org.postgresql.Driver'. 2018-03-13 22:36:57,940-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'DWH_DB_HOST' is 'localhost'. 2018-03-13 22:36:57,940-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'DWH_DB_PASSWORD' is '***'. 2018-03-13 22:36:57,940-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'DWH_DB_PORT' is '5432'. 2018-03-13 22:36:57,940-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'DWH_DB_SECURED' is 'False'. 2018-03-13 22:36:57,939-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Loaded file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf.d/10-setup-protocols.conf'. 2018-03-13 22:36:57,946-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'DWH_DB_SECURED_VALIDATION' is 'False'. 2018-03-13 22:36:57,948-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Loaded file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf.d/11-setup-sso.conf'. 2018-03-13 22:36:57,948-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Loaded file '/home/engine/tchyp-engine/etc/ovirt-engine/engine.conf.d/20-setup-jboss-overlay.conf'. 2018-03-13 22:36:57,948-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'DWH_DB_URL' is 'jdbc:postgresql://localhost:5432/ovirt_engine_history?sslfactory=org.postgresql.ssl.NonValidatingFactory'. 2018-03-13 22:36:57,948-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'AAA_JAAS_KEYTAB_FILE' is ''. 2018-03-13 22:36:57,948-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'DWH_DB_USER' is 'engine_history'. 2018-03-13 22:36:57,948-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'AAA_JAAS_PRINCIPAL_NAME' is ''. 2018-03-13 22:36:57,949-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENFORCE_ENGINE_HEAP_PARAMS' is 'false'. 2018-03-13 22:36:57,949-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'AAA_JAAS_TICKET_CACHE_FILE' is ''. 2018-03-13 22:36:57,949-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_AJP_ENABLED' is 'false'. 2018-03-13 22:36:57,949-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_AJP_PORT' is 'None'. 2018-03-13 22:36:57,949-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_API_DEFAULT_VERSION' is '4'. 2018-03-13 22:36:57,949-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_API_DEPRECATED_VERSIONS' is '3:4.0:4.3'. 2018-03-13 22:36:57,949-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_API_EXPLORER_DIRECTORY' is ''. 2018-03-13 22:36:57,949-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_API_FILTER_BY_DEFAULT' is 'true'. 2018-03-13 22:36:57,949-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_API_SUPPORTED_VERSIONS' is '3, 4'. 2018-03-13 22:36:57,950-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_APPS' is 'engine.ear restapi.war apidoc.war'. 2018-03-13 22:36:57,950-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_CACHE' is '/home/engine/tchyp-engine/var/cache/ovirt-engine'. 2018-03-13 22:36:57,950-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DB_CHECK_INTERVAL' is '1000'. 2018-03-13 22:36:57,950-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DB_CONNECTION_TIMEOUT' is '300000'. 2018-03-13 22:36:57,950-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DB_DATABASE' is 'engine'. 2018-03-13 22:36:57,950-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DB_DRIVER' is 'org.postgresql.Driver'. 2018-03-13 22:36:57,950-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DB_HOST' is 'localhost'. 2018-03-13 22:36:57,951-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DB_MAX_CONNECTIONS' is '100'. 2018-03-13 22:36:57,951-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DB_MIN_CONNECTIONS' is '1'. 2018-03-13 22:36:57,951-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DB_PASSWORD' is '***'. 2018-03-13 22:36:57,951-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DB_PORT' is '5432'. 2018-03-13 22:36:57,951-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DB_SECURED' is 'False'. 2018-03-13 22:36:57,951-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DB_SECURED_VALIDATION' is 'False'. 2018-03-13 22:36:57,951-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DB_URL' is 'jdbc:postgresql://localhost:5432/engine?sslfactory=org.postgresql.ssl.NonValidatingFactory'. 2018-03-13 22:36:57,951-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DB_USER' is 'engine'. 2018-03-13 22:36:57,952-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DEBUG_ADDRESS' is '127.0.0.1:8787'. 2018-03-13 22:36:57,952-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DEPLOYMENT_SCANNER' is 'true'. 2018-03-13 22:36:57,952-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_DOC' is '/home/engine/tchyp-engine/share/doc/ovirt-engine'. 2018-03-13 22:36:57,952-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_ETC' is '/home/engine/tchyp-engine/etc/ovirt-engine'. 2018-03-13 22:36:57,952-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_EXTENSIONS_IGNORED' is '.*?(Authz)'. 2018-03-13 22:36:57,952-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_EXTENSION_PATH' is '/home/engine/tchyp-engine/share/ovirt-engine/extensions.d:/home/engine/tchyp-engine/etc/ovirt-engine/extensions.d'. 2018-03-13 22:36:57,952-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_EXTERNAL_PROVIDERS_TRUST_STORE' is '/home/engine/tchyp-engine/var/lib/ovirt-engine/external_truststore'. 2018-03-13 22:36:57,953-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_EXTERNAL_PROVIDERS_TRUST_STORE_PASSWORD' is '***'. 2018-03-13 22:36:57,949-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'AAA_JAAS_USE_KEYTAB' is 'false'. 2018-03-13 22:36:57,957-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_EXTERNAL_PROVIDERS_TRUST_STORE_TYPE' is 'JKS'. 2018-03-13 22:36:57,957-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_FQDN' is 'ovirtdev.ecr.com'. 2018-03-13 22:36:57,957-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_GROUP' is 'ovirt'. 2018-03-13 22:36:57,958-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_HEAP_MAX' is '1955M'. 2018-03-13 22:36:57,958-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_HEAP_MIN' is '1955M'. 2018-03-13 22:36:57,958-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_HTTPS_ENABLED' is 'true'. 2018-03-13 22:36:57,958-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_HTTPS_PKI_TRUST_STORE' is '/home/engine/tchyp-engine/etc/pki/ovirt-engine/.truststore'. 2018-03-13 22:36:57,958-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_HTTPS_PKI_TRUST_STORE_PASSWORD' is '***'. 2018-03-13 22:36:57,958-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_HTTPS_PKI_TRUST_STORE_TYPE' is 'JKS'. 2018-03-13 22:36:57,958-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_HTTPS_PORT' is '8443'. 2018-03-13 22:36:57,958-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_HTTPS_PROTOCOLS' is 'SSLv3,TLSv1,TLSv1.1,TLSv1.2'. 2018-03-13 22:36:57,959-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_HTTP_ENABLED' is 'true'. 2018-03-13 22:36:57,959-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_HTTP_PORT' is '8080'. 2018-03-13 22:36:57,959-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_JAVA_MODULEPATH' is '/usr/share/ovirt-engine-wildfly-overlay/modules:/home/engine/tchyp-engine/share/ovirt-engine/modules/common'. 2018-03-13 22:36:57,959-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_JMX_INTERFACE' is 'loopback'. 2018-03-13 22:36:57,959-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_JVM_ARGS' is ' -XX:+HeapDumpOnOutOfMemoryError -XX:HeapDumpPath="/home/engine/tchyp-engine/var/log/ovirt-engine/dump"'. 2018-03-13 22:36:57,959-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_LOG' is '/home/engine/tchyp-engine/var/log/ovirt-engine'. 2018-03-13 22:36:57,959-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_LOG_TO_CONSOLE' is 'true'. 2018-03-13 22:36:57,959-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_MALLOC_ARENA_MAX' is '1'. 2018-03-13 22:36:57,959-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_MANUAL' is '/home/engine/tchyp-engine/share/ovirt-engine/manual'. 2018-03-13 22:36:57,960-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_NON_JTA_DB_MAX_CONNECTIONS' is '10'. 2018-03-13 22:36:57,960-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_NON_JTA_DB_MIN_CONNECTIONS' is '1'. 2018-03-13 22:36:57,960-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_PKI' is '/home/engine/tchyp-engine/etc/pki/ovirt-engine'. 2018-03-13 22:36:57,960-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_PKI_CA' is '/home/engine/tchyp-engine/etc/pki/ovirt-engine/ca.pem'. 2018-03-13 22:36:57,960-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_PKI_ENGINE_CERT' is '/home/engine/tchyp-engine/etc/pki/ovirt-engine/certs/engine.cer'. 2018-03-13 22:36:57,960-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_PKI_ENGINE_STORE' is '/home/engine/tchyp-engine/etc/pki/ovirt-engine/keys/engine.p12'. 2018-03-13 22:36:57,960-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_PKI_ENGINE_STORE_ALIAS' is '1'. 2018-03-13 22:36:57,960-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_PKI_ENGINE_STORE_PASSWORD' is '***'. 2018-03-13 22:36:57,960-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_PKI_ENGINE_STORE_TYPE' is 'PKCS12'. 2018-03-13 22:36:57,961-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_PKI_TRUST_STORE' is '/home/engine/tchyp-engine/etc/pki/ovirt-engine/.truststore'. 2018-03-13 22:36:57,961-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_PKI_TRUST_STORE_PASSWORD' is '***'. 2018-03-13 22:36:57,961-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_PKI_TRUST_STORE_TYPE' is 'JKS'. 2018-03-13 22:36:57,961-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_PROPERTIES' is ' java.awt.headless=true sun.rmi.dgc.client.gcInterval=3600000 sun.rmi.dgc.server.gcInterval=3600000 jsse.enableSNIExtension=false'. 2018-03-13 22:36:57,961-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_PROXY_ENABLED' is 'false'. 2018-03-13 22:36:57,961-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_PROXY_HTTPS_PORT' is '443'. 2018-03-13 22:36:57,961-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_PROXY_HTTP_PORT' is '80'. 2018-03-13 22:36:57,961-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_RESTAPI_NEGO' is 'true'. 2018-03-13 22:36:57,961-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SCHEDULED_THREAD_POOL_SIZE' is '100'. 2018-03-13 22:36:57,961-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SCHEDULER_POOL_CLASS' is 'org.ovirt.engine.core.utils.timer.SchedulerThreadPool'. 2018-03-13 22:36:57,962-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SCHEDULER_POOL_QUEUE_SIZE' is '350'. 2018-03-13 22:36:57,962-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SCHEDULER_POOL_REJECT_POLICY' is 'false'. 2018-03-13 22:36:57,962-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SCHEDULER_POOL_THREAD_SIZE' is '100'. 2018-03-13 22:36:57,962-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SSO_AUTH_SEQUENCE_webadmin' is '~'. 2018-03-13 22:36:57,962-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SSO_AUTH_SEQUENCE_welcome' is '~'. 2018-03-13 22:36:57,962-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SSO_AUTH_URL' is 'https://ovirtdev.ecr.com:8443/tchyp-engine/sso'. 2018-03-13 22:36:57,962-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SSO_CLIENT_ID' is 'ovirt-engine-core'. 2018-03-13 22:36:57,962-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SSO_CLIENT_SECRET' is '***'. 2018-03-13 22:36:57,962-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SSO_INSTALLED_ON_ENGINE_HOST' is 'true'. 2018-03-13 22:36:57,963-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SSO_SERVICE_CLIENT_POOL_SIZE' is '10'. 2018-03-13 22:36:57,963-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SSO_SERVICE_CONNECTION_RETRY_COUNT' is '3'. 2018-03-13 22:36:57,963-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SSO_SERVICE_CONNECTION_VALIDATE_AFTER_INACTIVITY' is '100'. 2018-03-13 22:36:57,963-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SSO_SERVICE_SSL_PROTOCOL' is 'TLS'. 2018-03-13 22:36:57,966-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SSO_SERVICE_SSL_VERIFY_CHAIN' is 'true'. 2018-03-13 22:36:57,967-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SSO_SERVICE_SSL_VERIFY_HOST' is 'false'. 2018-03-13 22:36:57,967-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SSO_SERVICE_URI' is '/tchyp-engine/sso'. 2018-03-13 22:36:57,967-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_SSO_SERVICE_URL' is 'https://ovirtdev.ecr.com:8443/tchyp-engine/sso'. 2018-03-13 22:36:57,967-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'AAA_JAAS_USE_TICKET_CACHE' is 'false'. 2018-03-13 22:36:57,967-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'AAA_KRB5_CONF_FILE' is ''. 2018-03-13 22:36:57,971-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'COMMAND_COORDINATOR_THREAD_POOL_SIZE' is '10'. 2018-03-13 22:36:57,971-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'DASHBOARD_CACHE_UPDATE' is 'true'. 2018-03-13 22:36:57,971-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'DASHBOARD_INVENTORY_CACHE_UPDATE_INTERVAL' is '60'. 2018-03-13 22:36:57,971-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'DASHBOARD_UTILIZATION_CACHE_UPDATE_INTERVAL' is '300'. 2018-03-13 22:36:57,971-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'DWH_DB_DATABASE' is 'ovirt_engine_history'. 2018-03-13 22:36:57,971-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'DWH_DB_DRIVER' is 'org.postgresql.Driver'. 2018-03-13 22:36:57,971-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'DWH_DB_HOST' is 'localhost'. 2018-03-13 22:36:57,971-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'DWH_DB_PASSWORD' is '***'. 2018-03-13 22:36:57,971-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'DWH_DB_PORT' is '5432'. 2018-03-13 22:36:57,972-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'DWH_DB_SECURED' is 'False'. 2018-03-13 22:36:57,972-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'DWH_DB_SECURED_VALIDATION' is 'False'. 2018-03-13 22:36:57,972-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'DWH_DB_URL' is 'jdbc:postgresql://localhost:5432/ovirt_engine_history?sslfactory=org.postgresql.ssl.NonValidatingFactory'. 2018-03-13 22:36:57,972-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'DWH_DB_USER' is 'engine_history'. 2018-03-13 22:36:57,972-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENFORCE_ENGINE_HEAP_PARAMS' is 'false'. 2018-03-13 22:36:57,972-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_AJP_ENABLED' is 'false'. 2018-03-13 22:36:57,972-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_AJP_PORT' is 'None'. 2018-03-13 22:36:57,972-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_API_DEFAULT_VERSION' is '4'. 2018-03-13 22:36:57,973-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_API_DEPRECATED_VERSIONS' is '3:4.0:4.3'. 2018-03-13 22:36:57,973-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_API_EXPLORER_DIRECTORY' is ''. 2018-03-13 22:36:57,973-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_API_FILTER_BY_DEFAULT' is 'true'. 2018-03-13 22:36:57,973-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_API_SUPPORTED_VERSIONS' is '3, 4'. 2018-03-13 22:36:57,973-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_APPS' is 'engine.ear restapi.war apidoc.war'. 2018-03-13 22:36:57,973-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_CACHE' is '/home/engine/tchyp-engine/var/cache/ovirt-engine'. 2018-03-13 22:36:57,973-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DB_CHECK_INTERVAL' is '1000'. 2018-03-13 22:36:57,973-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DB_CONNECTION_TIMEOUT' is '300000'. 2018-03-13 22:36:57,973-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DB_DATABASE' is 'engine'. 2018-03-13 22:36:57,973-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DB_DRIVER' is 'org.postgresql.Driver'. 2018-03-13 22:36:57,974-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DB_HOST' is 'localhost'. 2018-03-13 22:36:57,974-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DB_MAX_CONNECTIONS' is '100'. 2018-03-13 22:36:57,974-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DB_MIN_CONNECTIONS' is '1'. 2018-03-13 22:36:57,974-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DB_PASSWORD' is '***'. 2018-03-13 22:36:57,974-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DB_PORT' is '5432'. 2018-03-13 22:36:57,974-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DB_SECURED' is 'False'. 2018-03-13 22:36:57,974-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DB_SECURED_VALIDATION' is 'False'. 2018-03-13 22:36:57,974-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DB_URL' is 'jdbc:postgresql://localhost:5432/engine?sslfactory=org.postgresql.ssl.NonValidatingFactory'. 2018-03-13 22:36:57,974-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DB_USER' is 'engine'. 2018-03-13 22:36:57,975-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DEBUG_ADDRESS' is '127.0.0.1:8787'. 2018-03-13 22:36:57,975-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DEPLOYMENT_SCANNER' is 'true'. 2018-03-13 22:36:57,975-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_DOC' is '/home/engine/tchyp-engine/share/doc/ovirt-engine'. 2018-03-13 22:36:57,975-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_ETC' is '/home/engine/tchyp-engine/etc/ovirt-engine'. 2018-03-13 22:36:57,975-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_EXTENSIONS_IGNORED' is '.*?(Authz)'. 2018-03-13 22:36:57,975-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_EXTENSION_PATH' is '/home/engine/tchyp-engine/share/ovirt-engine/extensions.d:/home/engine/tchyp-engine/etc/ovirt-engine/extensions.d'. 2018-03-13 22:36:57,967-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_STOP_INTERVAL' is '1'. 2018-03-13 22:36:57,975-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_STOP_TIME' is '10'. 2018-03-13 22:36:57,976-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_THREAD_POOL_MAX_SIZE' is '500'. 2018-03-13 22:36:57,976-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_THREAD_POOL_MIN_SIZE' is '50'. 2018-03-13 22:36:57,976-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_THREAD_POOL_QUEUE_SIZE' is '100'. 2018-03-13 22:36:57,976-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_TMP' is '/home/engine/tchyp-engine/var/tmp/ovirt-engine'. 2018-03-13 22:36:57,976-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_UP_MARK' is '/home/engine/tchyp-engine/var/lib/ovirt-engine/engine.up'. 2018-03-13 22:36:57,976-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_URI' is '/tchyp-engine'. 2018-03-13 22:36:57,976-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_USER' is 'ovirt'. 2018-03-13 22:36:57,976-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_USR' is '/home/engine/tchyp-engine/share/ovirt-engine'. 2018-03-13 22:36:57,976-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_VAR' is '/home/engine/tchyp-engine/var/lib/ovirt-engine'. 2018-03-13 22:36:57,980-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'ENGINE_VERBOSE_GC' is 'false'. 2018-03-13 22:36:57,980-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'HOST_CHECK_FOR_UPDATES_THREAD_POOL_SIZE' is '5'. 2018-03-13 22:36:57,980-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'JBOSS_HOME' is '/usr/share/ovirt-engine-wildfly'. 2018-03-13 22:36:57,980-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'JBOSS_RUNTIME' is '/home/engine/tchyp-engine/var/lib/ovirt-engine/jboss_runtime'. 2018-03-13 22:36:57,975-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_EXTERNAL_PROVIDERS_TRUST_STORE' is '/home/engine/tchyp-engine/var/lib/ovirt-engine/external_truststore'. 2018-03-13 22:36:57,981-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_EXTERNAL_PROVIDERS_TRUST_STORE_PASSWORD' is '***'. 2018-03-13 22:36:57,981-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_EXTERNAL_PROVIDERS_TRUST_STORE_TYPE' is 'JKS'. 2018-03-13 22:36:57,981-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_FQDN' is 'ovirtdev.ecr.com'. 2018-03-13 22:36:57,981-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_GROUP' is 'ovirt'. 2018-03-13 22:36:57,981-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_HEAP_MAX' is '1955M'. 2018-03-13 22:36:57,981-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_HEAP_MIN' is '1955M'. 2018-03-13 22:36:57,982-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_HTTPS_ENABLED' is 'true'. 2018-03-13 22:36:57,982-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_HTTPS_PKI_TRUST_STORE' is '/home/engine/tchyp-engine/etc/pki/ovirt-engine/.truststore'. 2018-03-13 22:36:57,982-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_HTTPS_PKI_TRUST_STORE_PASSWORD' is '***'. 2018-03-13 22:36:57,982-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_HTTPS_PKI_TRUST_STORE_TYPE' is 'JKS'. 2018-03-13 22:36:57,982-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_HTTPS_PORT' is '8443'. 2018-03-13 22:36:57,982-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_HTTPS_PROTOCOLS' is 'SSLv3,TLSv1,TLSv1.1,TLSv1.2'. 2018-03-13 22:36:57,982-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_HTTP_ENABLED' is 'true'. 2018-03-13 22:36:57,982-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_HTTP_PORT' is '8080'. 2018-03-13 22:36:57,982-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_JAVA_MODULEPATH' is '/usr/share/ovirt-engine-wildfly-overlay/modules:/home/engine/tchyp-engine/share/ovirt-engine/modules/common'. 2018-03-13 22:36:57,982-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_JMX_INTERFACE' is 'loopback'. 2018-03-13 22:36:57,983-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_JVM_ARGS' is ' -XX:+HeapDumpOnOutOfMemoryError -XX:HeapDumpPath="/home/engine/tchyp-engine/var/log/ovirt-engine/dump"'. 2018-03-13 22:36:57,983-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_LOG' is '/home/engine/tchyp-engine/var/log/ovirt-engine'. 2018-03-13 22:36:57,983-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_LOG_TO_CONSOLE' is 'true'. 2018-03-13 22:36:57,983-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_MALLOC_ARENA_MAX' is '1'. 2018-03-13 22:36:57,983-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_MANUAL' is '/home/engine/tchyp-engine/share/ovirt-engine/manual'. 2018-03-13 22:36:57,983-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_NON_JTA_DB_MAX_CONNECTIONS' is '10'. 2018-03-13 22:36:57,983-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_NON_JTA_DB_MIN_CONNECTIONS' is '1'. 2018-03-13 22:36:57,984-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_PKI' is '/home/engine/tchyp-engine/etc/pki/ovirt-engine'. 2018-03-13 22:36:57,984-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_PKI_CA' is '/home/engine/tchyp-engine/etc/pki/ovirt-engine/ca.pem'. 2018-03-13 22:36:57,984-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_PKI_ENGINE_CERT' is '/home/engine/tchyp-engine/etc/pki/ovirt-engine/certs/engine.cer'. 2018-03-13 22:36:57,984-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_PKI_ENGINE_STORE' is '/home/engine/tchyp-engine/etc/pki/ovirt-engine/keys/engine.p12'. 2018-03-13 22:36:57,984-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_PKI_ENGINE_STORE_ALIAS' is '1'. 2018-03-13 22:36:57,984-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_PKI_ENGINE_STORE_PASSWORD' is '***'. 2018-03-13 22:36:57,984-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_PKI_ENGINE_STORE_TYPE' is 'PKCS12'. 2018-03-13 22:36:57,984-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_PKI_TRUST_STORE' is '/home/engine/tchyp-engine/etc/pki/ovirt-engine/.truststore'. 2018-03-13 22:36:57,984-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_PKI_TRUST_STORE_PASSWORD' is '***'. 2018-03-13 22:36:57,985-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_PKI_TRUST_STORE_TYPE' is 'JKS'. 2018-03-13 22:36:57,985-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_PROPERTIES' is ' java.awt.headless=true sun.rmi.dgc.client.gcInterval=3600000 sun.rmi.dgc.server.gcInterval=3600000 jsse.enableSNIExtension=false'. 2018-03-13 22:36:57,985-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_PROXY_ENABLED' is 'false'. 2018-03-13 22:36:57,985-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_PROXY_HTTPS_PORT' is '443'. 2018-03-13 22:36:57,985-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_PROXY_HTTP_PORT' is '80'. 2018-03-13 22:36:57,985-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_RESTAPI_NEGO' is 'true'. 2018-03-13 22:36:57,985-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SCHEDULED_THREAD_POOL_SIZE' is '100'. 2018-03-13 22:36:57,985-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SCHEDULER_POOL_CLASS' is 'org.ovirt.engine.core.utils.timer.SchedulerThreadPool'. 2018-03-13 22:36:57,985-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SCHEDULER_POOL_QUEUE_SIZE' is '350'. 2018-03-13 22:36:57,985-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SCHEDULER_POOL_REJECT_POLICY' is 'false'. 2018-03-13 22:36:57,985-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SCHEDULER_POOL_THREAD_SIZE' is '100'. 2018-03-13 22:36:57,986-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SSO_AUTH_SEQUENCE_webadmin' is '~'. 2018-03-13 22:36:57,986-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SSO_AUTH_SEQUENCE_welcome' is '~'. 2018-03-13 22:36:57,986-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SSO_AUTH_URL' is 'https://ovirtdev.ecr.com:8443/tchyp-engine/sso'. 2018-03-13 22:36:57,986-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SSO_CLIENT_ID' is 'ovirt-engine-core'. 2018-03-13 22:36:57,986-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SSO_CLIENT_SECRET' is '***'. 2018-03-13 22:36:57,986-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SSO_INSTALLED_ON_ENGINE_HOST' is 'true'. 2018-03-13 22:36:57,986-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SSO_SERVICE_CLIENT_POOL_SIZE' is '10'. 2018-03-13 22:36:57,986-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SSO_SERVICE_CONNECTION_RETRY_COUNT' is '3'. 2018-03-13 22:36:57,986-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SSO_SERVICE_CONNECTION_VALIDATE_AFTER_INACTIVITY' is '100'. 2018-03-13 22:36:57,986-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SSO_SERVICE_SSL_PROTOCOL' is 'TLS'. 2018-03-13 22:36:57,987-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SSO_SERVICE_SSL_VERIFY_CHAIN' is 'true'. 2018-03-13 22:36:57,987-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SSO_SERVICE_SSL_VERIFY_HOST' is 'false'. 2018-03-13 22:36:57,987-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SSO_SERVICE_URI' is '/tchyp-engine/sso'. 2018-03-13 22:36:57,987-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_SSO_SERVICE_URL' is 'https://ovirtdev.ecr.com:8443/tchyp-engine/sso'. 2018-03-13 22:36:57,987-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_STOP_INTERVAL' is '1'. 2018-03-13 22:36:57,987-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_STOP_TIME' is '10'. 2018-03-13 22:36:57,987-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_THREAD_POOL_MAX_SIZE' is '500'. 2018-03-13 22:36:57,987-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_THREAD_POOL_MIN_SIZE' is '50'. 2018-03-13 22:36:57,987-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_THREAD_POOL_QUEUE_SIZE' is '100'. 2018-03-13 22:36:57,987-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_TMP' is '/home/engine/tchyp-engine/var/tmp/ovirt-engine'. 2018-03-13 22:36:57,988-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_UP_MARK' is '/home/engine/tchyp-engine/var/lib/ovirt-engine/engine.up'. 2018-03-13 22:36:57,988-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_URI' is '/tchyp-engine'. 2018-03-13 22:36:57,988-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_USER' is 'ovirt'. 2018-03-13 22:36:57,988-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_USR' is '/home/engine/tchyp-engine/share/ovirt-engine'. 2018-03-13 22:36:57,988-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_VAR' is '/home/engine/tchyp-engine/var/lib/ovirt-engine'. 2018-03-13 22:36:57,988-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'ENGINE_VERBOSE_GC' is 'false'. 2018-03-13 22:36:57,988-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'HOST_CHECK_FOR_UPDATES_THREAD_POOL_SIZE' is '5'. 2018-03-13 22:36:57,988-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'JBOSS_HOME' is '/usr/share/ovirt-engine-wildfly'. 2018-03-13 22:36:57,988-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'JBOSS_RUNTIME' is '/home/engine/tchyp-engine/var/lib/ovirt-engine/jboss_runtime'. 2018-03-13 22:36:57,988-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'PACKAGE_DISPLAY_VERSION' is '4.2.0'. 2018-03-13 22:36:57,989-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'PACKAGE_NAME' is 'ovirt-engine'. 2018-03-13 22:36:57,989-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'PACKAGE_VERSION' is '4.2.0'. 2018-03-13 22:36:57,989-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'SENSITIVE_KEYS' is ',ENGINE_DB_PASSWORD,DWH_DB_PASSWORD,ENGINE_PKI_TRUST_STORE_PASSWORD,ENGINE_PKI_ENGINE_STORE_PASSWORD,ENGINE_EXTERNAL_PROVIDERS_TRUST_STORE_PASSWORD,ENGINE_HTTPS_PKI_TRUST_STORE_PASSWORD,ENGINE_SSO_CLIENT_SECRET'. 2018-03-13 22:36:57,989-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'SSO_ALTERNATE_ENGINE_FQDNS' is ''. 2018-03-13 22:36:57,989-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'SSO_AUTH_LOGIN_SEQUENCE' is 'NI'. 2018-03-13 22:36:57,989-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'SSO_CALLBACK_CLIENT_POOL_SIZE' is '10'. 2018-03-13 22:36:57,989-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'SSO_CALLBACK_CONNECTION_RETRY_COUNT' is '3'. 2018-03-13 22:36:57,989-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'SSO_CALLBACK_CONNECTION_VALIDATE_AFTER_INACTIVITY' is '100'. 2018-03-13 22:36:57,989-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'SSO_CALLBACK_CONNECT_TIMEOUT' is '0'. 2018-03-13 22:36:57,989-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'SSO_CALLBACK_PREFIX_CHECK' is 'false'. 2018-03-13 22:36:57,990-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'SSO_CALLBACK_READ_TIMEOUT' is '0'. 2018-03-13 22:36:57,990-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'SSO_ENGINE_URL' is 'http://ovirtdev.ecr.com:8080/tchyp-engine/'. 2018-03-13 22:36:57,990-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'SSO_HOUSE_KEEPING_INTERVAL' is '60'. 2018-03-13 22:36:57,990-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'PACKAGE_DISPLAY_VERSION' is '4.2.0'. 2018-03-13 22:36:57,990-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'SSO_TOKEN_HTTP_LOGIN_SEQUENCE' is 'Nb'. 2018-03-13 22:36:57,990-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'PACKAGE_NAME' is 'ovirt-engine'. 2018-03-13 22:36:57,990-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'SSO_TOKEN_TIMEOUT' is '360000'. 2018-03-13 22:36:57,990-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'PACKAGE_VERSION' is '4.2.0'. 2018-03-13 22:36:57,990-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 52) [] Value of property 'THREAD_POOL_MONITORING_INTERVAL_IN_SECONDS' is '600'. 2018-03-13 22:36:57,990-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'SENSITIVE_KEYS' is ',ENGINE_DB_PASSWORD,DWH_DB_PASSWORD,ENGINE_PKI_TRUST_STORE_PASSWORD,ENGINE_PKI_ENGINE_STORE_PASSWORD,ENGINE_EXTERNAL_PROVIDERS_TRUST_STORE_PASSWORD,ENGINE_HTTPS_PKI_TRUST_STORE_PASSWORD,ENGINE_SSO_CLIENT_SECRET'. 2018-03-13 22:36:57,990-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'SSO_ALTERNATE_ENGINE_FQDNS' is ''. 2018-03-13 22:36:57,990-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'SSO_AUTH_LOGIN_SEQUENCE' is 'NI'. 2018-03-13 22:36:57,991-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'SSO_CALLBACK_CLIENT_POOL_SIZE' is '10'. 2018-03-13 22:36:57,991-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'SSO_CALLBACK_CONNECTION_RETRY_COUNT' is '3'. 2018-03-13 22:36:57,991-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'SSO_CALLBACK_CONNECTION_VALIDATE_AFTER_INACTIVITY' is '100'. 2018-03-13 22:36:57,991-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'SSO_CALLBACK_CONNECT_TIMEOUT' is '0'. 2018-03-13 22:36:57,991-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'SSO_CALLBACK_PREFIX_CHECK' is 'false'. 2018-03-13 22:36:57,991-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'SSO_CALLBACK_READ_TIMEOUT' is '0'. 2018-03-13 22:36:57,991-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'SSO_ENGINE_URL' is 'http://ovirtdev.ecr.com:8080/tchyp-engine/'. 2018-03-13 22:36:57,991-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'SSO_HOUSE_KEEPING_INTERVAL' is '60'. 2018-03-13 22:36:57,991-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'SSO_TOKEN_HTTP_LOGIN_SEQUENCE' is 'Nb'. 2018-03-13 22:36:57,991-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'SSO_TOKEN_TIMEOUT' is '360000'. 2018-03-13 22:36:57,991-04 INFO [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (ServerService Thread Pool -- 54) [] Value of property 'THREAD_POOL_MONITORING_INTERVAL_IN_SECONDS' is '600'. 2018-03-13 22:36:57,998-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 52) [] Loading extension 'internal-authn' 2018-03-13 22:36:58,000-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 52) [] Extension 'internal-authn' loaded 2018-03-13 22:36:58,001-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 52) [] Loading extension 'internal-authz' 2018-03-13 22:36:58,003-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 52) [] Extension 'internal-authz' loaded 2018-03-13 22:36:58,003-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 52) [] Initializing extension 'internal-authn' 2018-03-13 22:36:58,003-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 52) [] Extension 'internal-authn' initialized 2018-03-13 22:36:58,006-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 52) [] Initializing extension 'internal-authz' 2018-03-13 22:36:58,006-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 52) [] Extension 'internal-authz' initialized 2018-03-13 22:36:58,006-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 52) [] Start of enabled extensions list 2018-03-13 22:36:58,012-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 52) [] Instance name: 'internal-authn', 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: '/home/engine/tchyp-engine/etc/ovirt-engine/extensions.d/internal-authn.properties', Initialized: 'true' 2018-03-13 22:36:58,013-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 52) [] Instance name: 'internal-authz', 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: '/home/engine/tchyp-engine/etc/ovirt-engine/extensions.d/internal-authz.properties', Initialized: 'true' 2018-03-13 22:36:58,013-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 52) [] End of enabled extensions list 2018-03-13 22:36:58,329-04 INFO [org.ovirt.engine.core.sso.utils.LocalizationUtils] (ServerService Thread Pool -- 52) [] Start initializing LocalizationUtils 2018-03-13 22:36:58,353-04 INFO [org.ovirt.engine.core.sso.utils.LocalizationUtils] (ServerService Thread Pool -- 52) [] Finished initializing LocalizationUtils 2018-03-13 22:36:58,423-04 INFO [org.ovirt.engine.core.dal.dbbroker.DbFacade] (ServerService Thread Pool -- 48) [] Initializing the DbFacade 2018-03-13 22:36:58,477-04 INFO [org.ovirt.engine.core.bll.TagsDirector] (ServerService Thread Pool -- 48) [] Start initializing TagsDirector 2018-03-13 22:36:58,488-04 INFO [org.ovirt.engine.core.bll.TagsDirector] (ServerService Thread Pool -- 48) [] Tag 'root' added to tree 2018-03-13 22:36:58,524-04 INFO [org.ovirt.engine.core.bll.TagsDirector] (ServerService Thread Pool -- 48) [] Finished initializing TagsDirector 2018-03-13 22:36:58,555-04 INFO [org.ovirt.engine.core.bll.Backend] (ServerService Thread Pool -- 48) [] Start initializing Backend 2018-03-13 22:36:58,566-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.common.utils.EngineThreadPools@28a4547e 2018-03-13 22:36:58,567-04 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (ServerService Thread Pool -- 48) [] Initializing Thread Monitoring Service 2018-03-13 22:36:58,588-04 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (ServerService Thread Pool -- 48) [] Thread Monitoring Service initialized 2018-03-13 22:36:58,588-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService@5fbbdd62 2018-03-13 22:36:58,629-04 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineScheduled' is using 0 threads out of 100 and 1 tasks are waiting in the queue. 2018-03-13 22:36:58,629-04 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineThreadMonitoring' is using 1 threads out of 1 and 0 tasks are waiting in the queue. 2018-03-13 22:36:58,670-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.hostedengine.PreviousHostedEngineHost@669cc390 2018-03-13 22:36:58,785-04 WARN [org.ovirt.engine.ui.frontend.server.dashboard.DashboardDataServlet] (ServerService Thread Pool -- 51) [] No valid DWH configurations were found, assuming DWH database isn't setup. 2018-03-13 22:36:58,785-04 INFO [org.ovirt.engine.ui.frontend.server.dashboard.DashboardDataServlet] (ServerService Thread Pool -- 51) [] Dashboard DB query cache has been disabled. 2018-03-13 22:36:58,901-04 INFO [org.ovirt.engine.core.bll.Backend] (ServerService Thread Pool -- 48) [] Started task scheduler org.ovirt.engine.core.utils.timer.DBSchedulerUtilQuartzImpl@6610e6b5 2018-03-13 22:36:58,925-04 INFO [org.ovirt.engine.core.bll.Backend] (ServerService Thread Pool -- 48) [] Started task scheduler org.ovirt.engine.core.utils.timer.SchedulerUtilQuartzImpl@3f460ad 2018-03-13 22:36:58,930-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.dal.utils.CacheManager@63ed3924 2018-03-13 22:36:59,013-04 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (ServerService Thread Pool -- 48) [] Could not find enum value for option: 'DbJustRestored' 2018-03-13 22:36:59,014-04 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (ServerService Thread Pool -- 48) [] Could not find enum value for option: 'ConfigDir' 2018-03-13 22:36:59,016-04 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (ServerService Thread Pool -- 48) [] Could not find enum value for option: 'DbJustRestored' 2018-03-13 22:36:59,016-04 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (ServerService Thread Pool -- 48) [] Could not find enum value for option: 'ConfigDir' 2018-03-13 22:36:59,079-04 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (ServerService Thread Pool -- 48) [] Could not find enum value for option: 'DbJustRestored' 2018-03-13 22:36:59,089-04 WARN [org.ovirt.engine.core.utils.ConfigUtilsBase] (ServerService Thread Pool -- 48) [] Could not find enum value for option: 'ConfigDir' 2018-03-13 22:36:59,090-04 INFO [org.ovirt.engine.core.utils.osinfo.OsInfoPreferencesLoader] (ServerService Thread Pool -- 48) [] Loading file '/home/engine/tchyp-engine/etc/ovirt-engine/osinfo.conf.d/00-defaults.properties' 2018-03-13 22:36:59,303-04 INFO [org.ovirt.engine.core.bll.CpuFlagsManagerHandler] (ServerService Thread Pool -- 48) [] Start initializing dictionaries 2018-03-13 22:36:59,306-04 INFO [org.ovirt.engine.core.bll.CpuFlagsManagerHandler] (ServerService Thread Pool -- 48) [] Finished initializing dictionaries 2018-03-13 22:36:59,415-04 INFO [org.ovirt.engine.core.bll.network.macpool.MacPoolUsingRanges] (ServerService Thread Pool -- 48) [] Initializing MacPoolUsingRanges:{id='58ca604b-017d-0374-0220-00000000014e'} 2018-03-13 22:36:59,418-04 INFO [org.ovirt.engine.core.bll.network.macpool.MacPoolUsingRanges] (ServerService Thread Pool -- 48) [] Finished initializing MacPoolUsingRanges:{id='58ca604b-017d-0374-0220-00000000014e'}. Available MACs in pool: 1024 2018-03-13 22:36:59,418-04 INFO [org.ovirt.engine.core.bll.network.macpool.MacPoolPerCluster] (ServerService Thread Pool -- 48) [] Successfully initialized 2018-03-13 22:36:59,428-04 INFO [org.ovirt.engine.core.bll.network.macpool.MacPoolPerCluster] (ServerService Thread Pool -- 48) [] Mac pool 58ca604b-017d-0374-0220-00000000014e has 1024 available free macs 2018-03-13 22:36:59,434-04 INFO [org.ovirt.engine.core.bll.Backend] (ServerService Thread Pool -- 48) [] Running ovirt-engine 4.2.0 2018-03-13 22:36:59,434-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.CpuFlagsManagerHandler@9e5985f 2018-03-13 22:36:59,435-04 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (ServerService Thread Pool -- 48) [] Start initializing AuditLogCleanupManager 2018-03-13 22:36:59,435-04 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (ServerService Thread Pool -- 48) [] Setting audit cleanup manager to run at '35 35 3 * * ?' 2018-03-13 22:36:59,453-04 INFO [org.ovirt.engine.core.bll.AuditLogCleanupManager] (ServerService Thread Pool -- 48) [] Finished initializing AuditLogCleanupManager 2018-03-13 22:36:59,453-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.AuditLogCleanupManager@5783e1a5 2018-03-13 22:36:59,453-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.TagsDirector@7028a0b7 2018-03-13 22:36:59,455-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.storage.domain.IsoDomainListSynchronizer@5d06949a 2018-03-13 22:36:59,489-04 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (ServerService Thread Pool -- 48) [] Initialization of AsyncTaskManager completed successfully. 2018-03-13 22:36:59,490-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.tasks.AsyncTaskManager@1d00c123 2018-03-13 22:36:59,490-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.tasks.CommandCoordinatorUtil@6261a919 2018-03-13 22:36:59,519-04 INFO [org.ovirt.engine.core.bll.tasks.CommandCallbacksPoller] (ServerService Thread Pool -- 48) [] Start initializing CommandCallbacksPoller 2018-03-13 22:36:59,527-04 INFO [org.ovirt.engine.core.bll.tasks.CommandCallbacksPoller] (ServerService Thread Pool -- 48) [] Finished initializing CommandCallbacksPoller 2018-03-13 22:36:59,527-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.tasks.CommandCallbacksPoller@499ae0bc 2018-03-13 22:36:59,527-04 INFO [org.ovirt.engine.core.bll.CommandEntityCleanupManager] (ServerService Thread Pool -- 48) [] Start initializing CommandEntityCleanupManager 2018-03-13 22:36:59,528-04 INFO [org.ovirt.engine.core.bll.CommandEntityCleanupManager] (ServerService Thread Pool -- 48) [] Setting command entity cleanup manager to run at: 35 35 3 * * ? 2018-03-13 22:36:59,529-04 INFO [org.ovirt.engine.core.bll.CommandEntityCleanupManager] (ServerService Thread Pool -- 48) [] Finished initializing CommandEntityCleanupManager 2018-03-13 22:36:59,529-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.CommandEntityCleanupManager@76698001 2018-03-13 22:36:59,675-04 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (ServerService Thread Pool -- 48) [] Start initializing ResourceManager$Proxy$_$$_WeldSubclass 2018-03-13 22:36:59,725-04 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (ServerService Thread Pool -- 48) [] Finished initializing ResourceManager$Proxy$_$$_WeldSubclass 2018-03-13 22:36:59,728-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.VmHandler@7d61405b 2018-03-13 22:36:59,729-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.VdsHandler@69b86865 2018-03-13 22:36:59,729-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.VmTemplateHandler@3b56951 2018-03-13 22:36:59,730-04 INFO [org.ovirt.engine.core.bll.Backend] (ServerService Thread Pool -- 48) [] Completed initializing handlers 2018-03-13 22:36:59,780-04 INFO [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (ServerService Thread Pool -- 48) [] Start initializing ErrorTranslatorImpl 2018-03-13 22:36:59,793-04 INFO [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (ServerService Thread Pool -- 48) [] Finished initializing ErrorTranslatorImpl 2018-03-13 22:36:59,793-04 INFO [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (ServerService Thread Pool -- 48) [] Start initializing ErrorTranslatorImpl 2018-03-13 22:36:59,793-04 INFO [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (ServerService Thread Pool -- 48) [] Finished initializing ErrorTranslatorImpl 2018-03-13 22:36:59,793-04 INFO [org.ovirt.engine.core.bll.Backend] (ServerService Thread Pool -- 48) [] Mark incomplete jobs as UNKNOWN 2018-03-13 22:36:59,808-04 INFO [org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager] (ServerService Thread Pool -- 48) [] Start initializing JobRepositoryCleanupManager 2018-03-13 22:36:59,809-04 INFO [org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager] (ServerService Thread Pool -- 48) [] Finished initializing JobRepositoryCleanupManager 2018-03-13 22:36:59,809-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager@1a3a81ce 2018-03-13 22:36:59,809-04 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager] (ServerService Thread Pool -- 48) [] Start initializing AutoRecoveryManager 2018-03-13 22:36:59,810-04 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager] (ServerService Thread Pool -- 48) [] Finished initializing AutoRecoveryManager 2018-03-13 22:36:59,811-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.AutoRecoveryManager@413b1590 2018-03-13 22:36:59,821-04 INFO [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (ServerService Thread Pool -- 48) [] Start initializing ExecutionMessageDirector 2018-03-13 22:36:59,823-04 INFO [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (ServerService Thread Pool -- 48) [] Finished initializing ExecutionMessageDirector 2018-03-13 22:36:59,825-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.VmPoolHandler@6c17a333 2018-03-13 22:36:59,826-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.VmPoolMonitor@1c9afd51 2018-03-13 22:36:59,840-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.HaAutoStartVmsRunner@5e47a583 2018-03-13 22:36:59,842-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.quota.QuotaManager@3fb6b1e3 2018-03-13 22:36:59,872-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.vdsbroker.monitoring.VmMigrationProgressMonitoring@3676815f 2018-03-13 22:37:00,031-04 WARN [org.ovirt.engine.core.bll.IconLoader] (ServerService Thread Pool -- 48) [] java.lang.RuntimeException: Icon for other_s390x was not found in /home/engine/tchyp-engine/share/ovirt-engine/icons/small 2018-03-13 22:37:00,031-04 WARN [org.ovirt.engine.core.bll.IconLoader] (ServerService Thread Pool -- 48) [] java.lang.RuntimeException: Icon for other_s390x was not found in /home/engine/tchyp-engine/share/ovirt-engine/icons/large 2018-03-13 22:37:00,032-04 WARN [org.ovirt.engine.core.bll.IconLoader] (ServerService Thread Pool -- 48) [] java.lang.RuntimeException: Icon for other_linux_s390x was not found in /home/engine/tchyp-engine/share/ovirt-engine/icons/small 2018-03-13 22:37:00,032-04 WARN [org.ovirt.engine.core.bll.IconLoader] (ServerService Thread Pool -- 48) [] java.lang.RuntimeException: Icon for other_linux_s390x was not found in /home/engine/tchyp-engine/share/ovirt-engine/icons/large 2018-03-13 22:37:00,032-04 WARN [org.ovirt.engine.core.bll.IconLoader] (ServerService Thread Pool -- 48) [] java.lang.RuntimeException: Icon for rhel_7_s390x was not found in /home/engine/tchyp-engine/share/ovirt-engine/icons/small 2018-03-13 22:37:00,032-04 WARN [org.ovirt.engine.core.bll.IconLoader] (ServerService Thread Pool -- 48) [] java.lang.RuntimeException: Icon for rhel_7_s390x was not found in /home/engine/tchyp-engine/share/ovirt-engine/icons/large 2018-03-13 22:37:00,032-04 WARN [org.ovirt.engine.core.bll.IconLoader] (ServerService Thread Pool -- 48) [] java.lang.RuntimeException: Icon for sles_12_s390x was not found in /home/engine/tchyp-engine/share/ovirt-engine/icons/small 2018-03-13 22:37:00,032-04 WARN [org.ovirt.engine.core.bll.IconLoader] (ServerService Thread Pool -- 48) [] java.lang.RuntimeException: Icon for sles_12_s390x was not found in /home/engine/tchyp-engine/share/ovirt-engine/icons/large 2018-03-13 22:37:00,032-04 WARN [org.ovirt.engine.core.bll.IconLoader] (ServerService Thread Pool -- 48) [] java.lang.RuntimeException: Icon for ubuntu_16_04_s390x was not found in /home/engine/tchyp-engine/share/ovirt-engine/icons/small 2018-03-13 22:37:00,032-04 WARN [org.ovirt.engine.core.bll.IconLoader] (ServerService Thread Pool -- 48) [] java.lang.RuntimeException: Icon for ubuntu_16_04_s390x was not found in /home/engine/tchyp-engine/share/ovirt-engine/icons/large 2018-03-13 22:37:00,078-04 WARN [org.ovirt.engine.core.bll.IconLoader] (ServerService Thread Pool -- 48) [] java.lang.RuntimeException: Icon for rhel_6_9_plus_ppc64 was not found in /home/engine/tchyp-engine/share/ovirt-engine/icons/small 2018-03-13 22:37:00,078-04 WARN [org.ovirt.engine.core.bll.IconLoader] (ServerService Thread Pool -- 48) [] java.lang.RuntimeException: Icon for rhel_6_9_plus_ppc64 was not found in /home/engine/tchyp-engine/share/ovirt-engine/icons/large 2018-03-13 22:37:00,257-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.IconLoader@72e73d11 2018-03-13 22:37:00,260-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 48) [] Loading extension 'internal-authn' 2018-03-13 22:37:00,260-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 48) [] Extension 'internal-authn' loaded 2018-03-13 22:37:00,261-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 48) [] Loading extension 'internal-authz' 2018-03-13 22:37:00,261-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 48) [] Extension 'internal-authz' loaded 2018-03-13 22:37:00,262-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 48) [] Initializing extension 'internal-authn' 2018-03-13 22:37:00,262-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 48) [] Extension 'internal-authn' initialized 2018-03-13 22:37:00,262-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 48) [] Start of enabled extensions list 2018-03-13 22:37:00,262-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 48) [] Instance name: 'internal-authn', 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: '/home/engine/tchyp-engine/etc/ovirt-engine/extensions.d/internal-authn.properties', Initialized: 'true' 2018-03-13 22:37:00,262-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 48) [] Instance name: 'internal-authz', 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: '/home/engine/tchyp-engine/etc/ovirt-engine/extensions.d/internal-authz.properties', Initialized: 'false' 2018-03-13 22:37:00,262-04 INFO [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (ServerService Thread Pool -- 48) [] End of enabled extensions list 2018-03-13 22:37:00,292-04 INFO [org.ovirt.engine.core.bll.pm.PmHealthCheckManager] (ServerService Thread Pool -- 48) [] Finished initializing PmHealthCheckManager 2018-03-13 22:37:00,293-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.pm.PmHealthCheckManager@47a3fcc7 2018-03-13 22:37:00,293-04 INFO [org.ovirt.engine.core.bll.EngineBackupAwarenessManager] (ServerService Thread Pool -- 48) [] Start initializing EngineBackupAwarenessManager 2018-03-13 22:37:00,294-04 INFO [org.ovirt.engine.core.bll.EngineBackupAwarenessManager] (ServerService Thread Pool -- 48) [] Finished initializing EngineBackupAwarenessManager 2018-03-13 22:37:00,294-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.EngineBackupAwarenessManager@541a45bd 2018-03-13 22:37:00,294-04 INFO [org.ovirt.engine.core.bll.DataCenterCompatibilityChecker] (ServerService Thread Pool -- 48) [] Start initializing DataCenterCompatibilityChecker 2018-03-13 22:37:00,295-04 INFO [org.ovirt.engine.core.bll.DataCenterCompatibilityChecker] (ServerService Thread Pool -- 48) [] Finished initializing DataCenterCompatibilityChecker 2018-03-13 22:37:00,295-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.DataCenterCompatibilityChecker@5fa58567 2018-03-13 22:37:00,295-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.vdsbroker.ResourceManager$Proxy$_$$_WeldSubclass@59941483 2018-03-13 22:37:00,295-04 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyManager] (ServerService Thread Pool -- 48) [] Start initializing IrsProxyManager 2018-03-13 22:37:00,356-04 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyManager] (ServerService Thread Pool -- 48) [] Start initializing IrsProxyManager 2018-03-13 22:37:00,357-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyManager@3e233ebb 2018-03-13 22:37:00,358-04 INFO [org.ovirt.engine.core.bll.storage.ovfstore.OvfDataUpdater] (ServerService Thread Pool -- 48) [] Initialization of OvfDataUpdater completed successfully. 2018-03-13 22:37:00,358-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.storage.ovfstore.OvfDataUpdater@a3aa09b 2018-03-13 22:37:00,477-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.gluster.GlusterJobsManager@6b3c9a1c 2018-03-13 22:37:00,477-04 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (ServerService Thread Pool -- 48) [] Init VM custom properties utilities 2018-03-13 22:37:00,478-04 INFO [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (ServerService Thread Pool -- 48) [] Init device custom properties utilities 2018-03-13 22:37:00,498-04 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (ServerService Thread Pool -- 48) [] Initializing Scheduling manager 2018-03-13 22:37:00,600-04 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (ServerService Thread Pool -- 48) [] External scheduler disabled, discovery skipped 2018-03-13 22:37:00,601-04 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (ServerService Thread Pool -- 48) [] Start scheduling to enable vds load balancer 2018-03-13 22:37:00,604-04 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (ServerService Thread Pool -- 48) [] Finished scheduling to enable vds load balancer 2018-03-13 22:37:00,604-04 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (ServerService Thread Pool -- 48) [] Start HA Reservation check 2018-03-13 22:37:00,606-04 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (ServerService Thread Pool -- 48) [] Finished HA Reservation check 2018-03-13 22:37:00,606-04 INFO [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (ServerService Thread Pool -- 48) [] Initialized Scheduling manager 2018-03-13 22:37:00,606-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.scheduling.SchedulingManager@2e7c2c2d 2018-03-13 22:37:00,623-04 INFO [org.ovirt.engine.core.bll.PrevalidatingMultipleActionsRunner] (ServerService Thread Pool -- 48) [] PrevalidatingMultipleActionsRunner of type 'RefreshHostDevices' invoked with no actions 2018-03-13 22:37:00,625-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.hostdev.HostDeviceManager@241526b4 2018-03-13 22:37:00,626-04 INFO [org.ovirt.engine.core.bll.dwh.DwhHeartBeat] (ServerService Thread Pool -- 48) [] Initializing DWH Heart Beat 2018-03-13 22:37:00,627-04 INFO [org.ovirt.engine.core.bll.dwh.DwhHeartBeat] (ServerService Thread Pool -- 48) [] DWH Heart Beat initialized 2018-03-13 22:37:00,627-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.dwh.DwhHeartBeat@4222983b 2018-03-13 22:37:00,655-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ServerService Thread Pool -- 48) [] EVENT_ID: AFFINITY_RULES_ENFORCEMENT_MANAGER_START(10,780), Affinity Rules Enforcement Manager started. 2018-03-13 22:37:00,660-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.scheduling.AffinityRulesEnforcementManager@3d02bde9 2018-03-13 22:37:00,662-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.CertificationValidityChecker@51f46c02 2018-03-13 22:37:00,664-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.hostdeploy.HostUpdatesCheckerService@1d1b8f25 2018-03-13 22:37:00,665-04 INFO [org.ovirt.engine.core.bll.IPTablesDeprecationNotifier] (ServerService Thread Pool -- 48) [] Start initializing IPTablesDeprecationNotifier 2018-03-13 22:37:00,666-04 INFO [org.ovirt.engine.core.bll.IPTablesDeprecationNotifier] (ServerService Thread Pool -- 48) [] Finished initializing IPTablesDeprecationNotifier 2018-03-13 22:37:00,667-04 INFO [org.ovirt.engine.core.bll.ServiceLoader] (ServerService Thread Pool -- 48) [] Start org.ovirt.engine.core.bll.IPTablesDeprecationNotifier@28bdeceb 2018-03-13 22:37:07,073-04 INFO [org.ovirt.engine.core.sso.utils.AuthenticationUtils] (default task-51) [] User admin@internal successfully logged in with scopes: ovirt-app-admin ovirt-app-api ovirt-app-portal ovirt-ext=auth:sequence-priority=~ ovirt-ext=revoke:revoke-all ovirt-ext=token-info:authz-search ovirt-ext=token-info:public-authz-search ovirt-ext=token-info:validate ovirt-ext=token:password-access 2018-03-13 22:37:07,221-04 INFO [org.ovirt.engine.core.bll.aaa.CreateUserSessionCommand] (default task-53) [602ee9cb] Running command: CreateUserSessionCommand internal: false. 2018-03-13 22:37:07,272-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-53) [602ee9cb] EVENT_ID: USER_VDC_LOGIN(30), User admin@internal-authz connecting from '192.168.122.1' using session '2LhEwHlOsl2eWPdUjwYI4bxHOhoRHuchKvCYLsmGkBMsmmrK4vhoQycsjij1LzFD1W+WGjMcFoEG4cQg1OAdxw==' logged in. 2018-03-13 22:38:18,308-04 INFO [org.ovirt.engine.core.bll.hostdeploy.AddVdsCommand] (default task-58) [330caeca-2d9e-48cb-9c0b-b692d54385ff] Running command: AddVdsCommand internal: false. Entities affected : ID: 5aa88a7c-0227-00fe-00a7-0000000003cc Type: ClusterAction group CREATE_HOST with role type ADMIN 2018-03-13 22:38:18,391-04 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (default task-58) [72e55d60] Before acquiring and wait lock 'EngineLock:{exclusiveLocks='[5aa88a7c-01a0-01d9-0376-00000000012e=REGISTER_VDS]', sharedLocks=''}' 2018-03-13 22:38:18,392-04 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (default task-58) [72e55d60] Lock-wait acquired to object 'EngineLock:{exclusiveLocks='[5aa88a7c-01a0-01d9-0376-00000000012e=REGISTER_VDS]', sharedLocks=''}' 2018-03-13 22:38:18,396-04 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (default task-58) [72e55d60] Running command: AddVdsSpmIdCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:38:18,410-04 INFO [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (default task-58) [72e55d60] Lock freed to object 'EngineLock:{exclusiveLocks='[5aa88a7c-01a0-01d9-0376-00000000012e=REGISTER_VDS]', sharedLocks=''}' 2018-03-13 22:38:18,435-04 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (default task-58) [72e55d60] START, RemoveVdsVDSCommand(HostName = 192.168.122.54, RemoveVdsVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9'}), log id: 4c930a80 2018-03-13 22:38:18,436-04 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (default task-58) [72e55d60] FINISH, RemoveVdsVDSCommand, log id: 4c930a80 2018-03-13 22:38:18,455-04 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (default task-58) [72e55d60] START, RemoveVdsVDSCommand(HostName = 192.168.122.54, RemoveVdsVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9'}), log id: 22b04f24 2018-03-13 22:38:18,455-04 INFO [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (default task-58) [72e55d60] FINISH, RemoveVdsVDSCommand, log id: 22b04f24 2018-03-13 22:38:18,476-04 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (default task-58) [72e55d60] START, AddVdsVDSCommand(HostName = 192.168.122.54, AddVdsVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9'}), log id: 1d7e6d5a 2018-03-13 22:38:18,476-04 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (default task-58) [72e55d60] AddVds - entered , starting logic to add VDS '015379e4-f77d-45cb-8488-904dc740d1e9' 2018-03-13 22:38:18,496-04 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (default task-58) [72e55d60] AddVds - VDS '015379e4-f77d-45cb-8488-904dc740d1e9' was added, will try to add it to the resource manager 2018-03-13 22:38:18,499-04 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (default task-58) [72e55d60] Entered VdsManager constructor 2018-03-13 22:38:18,514-04 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (default task-58) [72e55d60] Initialize vdsBroker '192.168.122.54:54321' 2018-03-13 22:38:18,568-04 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (default task-58) [72e55d60] VDS '015379e4-f77d-45cb-8488-904dc740d1e9' was added to the Resource Manager 2018-03-13 22:38:18,568-04 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (default task-58) [72e55d60] FINISH, AddVdsVDSCommand, log id: 1d7e6d5a 2018-03-13 22:38:18,589-04 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (default task-58) [72e55d60] START, AddVdsVDSCommand(HostName = 192.168.122.54, AddVdsVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9'}), log id: 11e03be1 2018-03-13 22:38:18,589-04 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (default task-58) [72e55d60] AddVds - entered , starting logic to add VDS '015379e4-f77d-45cb-8488-904dc740d1e9' 2018-03-13 22:38:18,591-04 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (default task-58) [72e55d60] AddVds - VDS '015379e4-f77d-45cb-8488-904dc740d1e9' was added, will try to add it to the resource manager 2018-03-13 22:38:18,591-04 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (default task-58) [72e55d60] Entered VdsManager constructor 2018-03-13 22:38:18,601-04 INFO [org.ovirt.engine.core.vdsbroker.VdsManager] (default task-58) [72e55d60] Initialize vdsBroker '192.168.122.54:54321' 2018-03-13 22:38:18,606-04 INFO [org.ovirt.engine.core.vdsbroker.ResourceManager] (default task-58) [72e55d60] VDS '015379e4-f77d-45cb-8488-904dc740d1e9' was added to the Resource Manager 2018-03-13 22:38:18,606-04 INFO [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (default task-58) [72e55d60] FINISH, AddVdsVDSCommand, log id: 11e03be1 2018-03-13 22:38:18,616-04 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-58) [72e55d60] EVENT_ID: VDS_ALERT_FENCE_IS_NOT_CONFIGURED(9,000), Failed to verify Power Management configuration for Host 192.168.122.54. 2018-03-13 22:38:18,643-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-58) [72e55d60] EVENT_ID: USER_ADD_VDS(42), Host 192.168.122.54 was added by admin@internal-authz. 2018-03-13 22:38:18,655-04 INFO [org.ovirt.engine.core.bll.hostdeploy.InstallVdsInternalCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] Lock Acquired to object 'EngineLock:{exclusiveLocks='[015379e4-f77d-45cb-8488-904dc740d1e9=VDS]', sharedLocks=''}' 2018-03-13 22:38:18,690-04 INFO [org.ovirt.engine.core.bll.hostdeploy.InstallVdsInternalCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] Running command: InstallVdsInternalCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:38:18,699-04 INFO [org.ovirt.engine.core.bll.hostdeploy.InstallVdsInternalCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] Before Installation host 015379e4-f77d-45cb-8488-904dc740d1e9, 192.168.122.54 2018-03-13 22:38:18,757-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='Installing', nonOperationalReason='NONE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 24f5d35e 2018-03-13 22:38:18,767-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] FINISH, SetVdsStatusVDSCommand, log id: 24f5d35e 2018-03-13 22:38:18,790-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='Installing', nonOperationalReason='NONE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: d26afb4 2018-03-13 22:38:18,809-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] FINISH, SetVdsStatusVDSCommand, log id: d26afb4 2018-03-13 22:38:18,984-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Connected to host 192.168.122.54 with SSH key fingerprint: SHA256:iKTihnaqAT6HEIzYg5sY2wJpqllaLbRzUTKqybyFqyg. 2018-03-13 22:38:19,110-04 INFO [org.ovirt.engine.core.bll.hostdeploy.VdsDeployBase] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] Installation of 192.168.122.54. Executing command via SSH umask 0077; MYTMP="$(TMPDIR="${OVIRT_TMPDIR}" mktemp -d -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; tar --warning=no-timestamp -C "${MYTMP}" -x && "${MYTMP}"/ovirt-host-deploy DIALOG/dialect=str:machine DIALOG/customization=bool:True < /home/engine/tchyp-engine/var/cache/ovirt-engine/ovirt-host-deploy.tar 2018-03-13 22:38:19,110-04 INFO [org.ovirt.engine.core.utils.archivers.tar.CachedTar] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] Tarball '/home/engine/tchyp-engine/var/cache/ovirt-engine/ovirt-host-deploy.tar' refresh 2018-03-13 22:38:19,213-04 INFO [org.ovirt.engine.core.uutils.ssh.SSHDialog] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] SSH execute 'root@192.168.122.54' 'umask 0077; MYTMP="$(TMPDIR="${OVIRT_TMPDIR}" mktemp -d -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; tar --warning=no-timestamp -C "${MYTMP}" -x && "${MYTMP}"/ovirt-host-deploy DIALOG/dialect=str:machine DIALOG/customization=bool:True' 2018-03-13 22:38:21,285-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Initializing. 2018-03-13 22:38:21,436-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Environment setup. 2018-03-13 22:38:21,515-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Environment packages setup. 2018-03-13 22:38:21,721-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Programs detection. 2018-03-13 22:38:21,862-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Environment customization. 2018-03-13 22:39:07,515-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Yum Downloading: base/7/x86_64 (0%). 2018-03-13 22:39:32,883-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Kdump supported. 2018-03-13 22:39:33,207-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Logs at host located at: '/tmp/ovirt-host-deploy-20180314103820-wjrcyu.log'. 2018-03-13 22:39:33,322-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Host is hypervisor. 2018-03-13 22:39:33,335-04 INFO [org.ovirt.engine.core.bll.hostdeploy.VdsDeployVdsmUnit] (VdsDeploy) [294d3f03] Host 192.168.122.54 reports unique id F136059B-05A1-48B9-87C0-6587524C86F7 2018-03-13 22:39:33,374-04 INFO [org.ovirt.engine.core.bll.hostdeploy.VdsDeployVdsmUnit] (VdsDeploy) [294d3f03] Assigning unique id F136059B-05A1-48B9-87C0-6587524C86F7 to Host 192.168.122.54 2018-03-13 22:39:33,506-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Disabling Kdump integration. 2018-03-13 22:39:33,729-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Setup validation. 2018-03-13 22:39:33,777-04 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS_WARNING(510), Host 192.168.122.54 installation in progress . Cannot validate host name settings, reason: resolved host does not match any of the local addresses. 2018-03-13 22:39:34,185-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Hardware supports virtualization. 2018-03-13 22:39:34,540-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Transaction setup. 2018-03-13 22:39:34,630-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Misc configuration. 2018-03-13 22:39:34,635-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Package installation. 2018-03-13 22:39:46,019-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Misc configuration. 2018-03-13 22:39:46,153-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Setting time. 2018-03-13 22:39:50,547-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Enrolling certificate. 2018-03-13 22:39:52,398-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Enrolling serial console certificate. 2018-03-13 22:39:54,549-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Transaction commit. 2018-03-13 22:39:54,811-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Setting kernel arguments. 2018-03-13 22:39:55,049-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Closing up. 2018-03-13 22:39:57,965-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Starting Cockpit. 2018-03-13 22:39:58,665-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Restarting libvirtd. 2018-03-13 22:39:59,154-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Starting vdsm. 2018-03-13 22:40:07,213-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Starting ovirt-vmconsole-host-sshd. 2018-03-13 22:40:07,744-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Clean up. 2018-03-13 22:40:07,751-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Pre-termination. 2018-03-13 22:40:07,800-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Retrieving installation logs to: '/home/engine/tchyp-engine/var/log/ovirt-engine/host-deploy/ovirt-host-deploy-20180313224007-192.168.122.54-294d3f03.log'. 2018-03-13 22:40:08,317-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (VdsDeploy) [294d3f03] EVENT_ID: VDS_INSTALL_IN_PROGRESS(509), Installing Host 192.168.122.54. Stage: Termination. 2018-03-13 22:40:08,483-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] EVENT_ID: VDS_ANSIBLE_INSTALL_STARTED(560), Ansible host-deploy playbook execution has started on host 192.168.122.54. 2018-03-13 22:40:08,493-04 INFO [org.ovirt.engine.core.common.utils.ansible.AnsibleExecutor] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] Executing Ansible command: /usr/bin/ansible-playbook --private-key=/home/engine/tchyp-engine/etc/pki/ovirt-engine/keys/engine_id_rsa --inventory=/tmp/ansible-inventory8977418904382983833 --extra-vars=host_deploy_cluster_version=4.2 --extra-vars=host_deploy_gluster_enabled=false --extra-vars=host_deploy_virt_enabled=true --extra-vars=host_deploy_vdsm_port=54321 --extra-vars=host_deploy_override_firewall=true --extra-vars=host_deploy_firewall_type=FIREWALLD --extra-vars=ansible_port=22 --extra-vars=host_deploy_post_tasks=/home/engine/tchyp-engine/etc/ovirt-engine/ansible/ovirt-host-deploy-post-tasks.yml --extra-vars=host_deploy_ovn_tunneling_interface=192.168.122.54 --extra-vars=host_deploy_ovn_central=192.168.122.134 /home/engine/tchyp-engine/share/ovirt-engine/playbooks/ovirt-host-deploy.yml 2018-03-13 22:41:54,248-04 INFO [org.ovirt.engine.core.common.utils.ansible.AnsibleExecutor] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] Ansible playbook command has exited with value: 0 2018-03-13 22:41:54,254-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] EVENT_ID: VDS_ANSIBLE_INSTALL_FINISHED(561), Ansible host-deploy playbook execution has successfully finished on host 192.168.122.54. 2018-03-13 22:41:54,297-04 INFO [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) [72e55d60] Connecting to /192.168.122.54 2018-03-13 22:41:54,454-04 INFO [org.ovirt.engine.core.bll.host.HostConnectivityChecker] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] Engine managed to communicate with VDSM agent on host '192.168.122.54' with address '192.168.122.54' ('015379e4-f77d-45cb-8488-904dc740d1e9') 2018-03-13 22:46:41,919-04 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetLldpVDSCommand] (default task-24) [6ab0f805-253c-4a20-b16c-b2fc88e87299] START, GetLldpVDSCommand(HostName = 192.168.122.54, GetLldpVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9'}), log id: 43511147 2018-03-13 22:46:44,123-04 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetLldpVDSCommand] (default task-24) [6ab0f805-253c-4a20-b16c-b2fc88e87299] FINISH, GetLldpVDSCommand, return: {eth0=LldpInfo:{enabled='false', tlvs='[]'}}, log id: 43511147 2018-03-13 22:46:44,129-04 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetLldpVDSCommand] (default task-24) [6ab0f805-253c-4a20-b16c-b2fc88e87299] START, GetLldpVDSCommand(HostName = 192.168.122.54, GetLldpVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9'}), log id: 44d1557e 2018-03-13 22:46:46,312-04 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetLldpVDSCommand] (default task-24) [6ab0f805-253c-4a20-b16c-b2fc88e87299] FINISH, GetLldpVDSCommand, return: {eth0=LldpInfo:{enabled='false', tlvs='[]'}}, log id: 44d1557e 2018-03-13 22:46:54,489-04 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CollectVdsNetworkDataAfterInstallationVDSCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] Command 'org.ovirt.engine.core.vdsbroker.vdsbroker.CollectVdsNetworkDataAfterInstallationVDSCommand' return value 'org.ovirt.engine.core.vdsbroker.vdsbroker.VDSInfoReturn@20747848' 2018-03-13 22:46:54,489-04 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CollectVdsNetworkDataAfterInstallationVDSCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] HostName = 192.168.122.54 2018-03-13 22:46:54,490-04 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.CollectVdsNetworkDataAfterInstallationVDSCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] Failed in 'CollectVdsNetworkDataAfterInstallationVDS' method, for vds: '192.168.122.54'; host: '192.168.122.54': Could not get JDBC Connection; nested exception is java.sql.SQLException: javax.resource.ResourceException: IJ000457: Unchecked throwable in managedConnectionReconnected() cl=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@5629b0eb[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@794a499c connection handles=0 lastReturned=1520995614467 lastValidated=1520995020646 lastCheckedOut=1520995316128 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.OnePool@35f9b31 mcp=SemaphoreConcurrentLinkedQueueManagedConnectionPool@6142eaf9[pool=ENGINEDataSource] xaResource=LocalXAResourceImpl@6735a071[connectionListener=5629b0eb connectionManager=4ef2225d warned=false currentXid=null productName=PostgreSQL productVersion=9.2.23 jndiName=java:/ENGINEDataSource] txSync=null] 2018-03-13 22:46:54,490-04 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.CollectVdsNetworkDataAfterInstallationVDSCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] Command 'CollectVdsNetworkDataAfterInstallationVDSCommand(HostName = 192.168.122.54, CollectHostNetworkDataVdsCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', vds='Host[192.168.122.54,015379e4-f77d-45cb-8488-904dc740d1e9]'})' execution failed: Could not get JDBC Connection; nested exception is java.sql.SQLException: javax.resource.ResourceException: IJ000457: Unchecked throwable in managedConnectionReconnected() cl=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@5629b0eb[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@794a499c connection handles=0 lastReturned=1520995614467 lastValidated=1520995020646 lastCheckedOut=1520995316128 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.OnePool@35f9b31 mcp=SemaphoreConcurrentLinkedQueueManagedConnectionPool@6142eaf9[pool=ENGINEDataSource] xaResource=LocalXAResourceImpl@6735a071[connectionListener=5629b0eb connectionManager=4ef2225d warned=false currentXid=null productName=PostgreSQL productVersion=9.2.23 jndiName=java:/ENGINEDataSource] txSync=null] 2018-03-13 22:46:54,491-04 INFO [org.ovirt.engine.core.utils.transaction.TransactionSupport] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] transaction rolled back 2018-03-13 22:46:54,492-04 ERROR [org.ovirt.engine.core.bll.hostdeploy.InstallVdsInternalCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] Exception: org.ovirt.engine.core.common.errors.EngineException: EngineException: org.springframework.jdbc.CannotGetJdbcConnectionException: Could not get JDBC Connection; nested exception is java.sql.SQLException: javax.resource.ResourceException: IJ000457: Unchecked throwable in managedConnectionReconnected() cl=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@5629b0eb[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@794a499c connection handles=0 lastReturned=1520995614467 lastValidated=1520995020646 lastCheckedOut=1520995316128 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.OnePool@35f9b31 mcp=SemaphoreConcurrentLinkedQueueManagedConnectionPool@6142eaf9[pool=ENGINEDataSource] xaResource=LocalXAResourceImpl@6735a071[connectionListener=5629b0eb connectionManager=4ef2225d warned=false currentXid=null productName=PostgreSQL productVersion=9.2.23 jndiName=java:/ENGINEDataSource] txSync=null] (Failed with error ENGINE and code 5001) at org.ovirt.engine.core.bll.VdsHandler.handleVdsResult(VdsHandler.java:118) [bll.jar:] at org.ovirt.engine.core.bll.VDSBrokerFrontendImpl.runVdsCommand(VDSBrokerFrontendImpl.java:38) [bll.jar:] at org.ovirt.engine.core.bll.network.NetworkConfigurator.lambda$refreshNetworkConfiguration$0(NetworkConfigurator.java:132) [bll.jar:] at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInNewTransaction(TransactionSupport.java:202) [utils.jar:] at org.ovirt.engine.core.bll.network.NetworkConfigurator.refreshNetworkConfiguration(NetworkConfigurator.java:131) [bll.jar:] at org.ovirt.engine.core.bll.hostdeploy.InstallVdsInternalCommand.configureManagementNetwork(InstallVdsInternalCommand.java:293) [bll.jar:] at org.ovirt.engine.core.bll.hostdeploy.InstallVdsInternalCommand.installHost(InstallVdsInternalCommand.java:215) [bll.jar:] at org.ovirt.engine.core.bll.hostdeploy.InstallVdsInternalCommand.executeCommand(InstallVdsInternalCommand.java:111) [bll.jar:] at org.ovirt.engine.core.bll.CommandBase.executeWithoutTransaction(CommandBase.java:1205) [bll.jar:] at org.ovirt.engine.core.bll.CommandBase.executeActionInTransactionScope(CommandBase.java:1345) [bll.jar:] at org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1987) [bll.jar:] at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInSuppressed(TransactionSupport.java:164) [utils.jar:] at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInScope(TransactionSupport.java:103) [utils.jar:] at org.ovirt.engine.core.bll.CommandBase.execute(CommandBase.java:1405) [bll.jar:] at org.ovirt.engine.core.bll.CommandBase.executeAction(CommandBase.java:412) [bll.jar:] at org.ovirt.engine.core.bll.executor.DefaultBackendActionExecutor.execute(DefaultBackendActionExecutor.java:13) [bll.jar:] at org.ovirt.engine.core.bll.Backend.runAction(Backend.java:509) [bll.jar:] at org.ovirt.engine.core.bll.Backend.runActionImpl(Backend.java:491) [bll.jar:] at org.ovirt.engine.core.bll.Backend.runInternalAction(Backend.java:697) [bll.jar:] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.8.0_161] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [rt.jar:1.8.0_161] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_161] at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_161] at org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.java:52) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:509) at org.jboss.as.weld.interceptors.Jsr299BindingsInterceptor.delegateInterception(Jsr299BindingsInterceptor.java:78) at org.jboss.as.weld.interceptors.Jsr299BindingsInterceptor.doMethodInterception(Jsr299BindingsInterceptor.java:88) at org.jboss.as.weld.interceptors.Jsr299BindingsInterceptor.processInvocation(Jsr299BindingsInterceptor.java:101) at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:63) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.as.ejb3.component.invocationmetrics.ExecutionTimeInterceptor.processInvocation(ExecutionTimeInterceptor.java:43) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.as.ee.concurrent.ConcurrentContextInterceptor.processInvocation(ConcurrentContextInterceptor.java:45) [wildfly-ee-11.0.0.Final.jar:11.0.0.Final] at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:40) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:53) at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:52) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.as.ejb3.component.singleton.SingletonComponentInstanceAssociationInterceptor.processInvocation(SingletonComponentInstanceAssociationInterceptor.java:53) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInNoTx(CMTTxInterceptor.java:264) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] at org.jboss.as.ejb3.tx.CMTTxInterceptor.supports(CMTTxInterceptor.java:379) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:244) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:509) at org.jboss.weld.ejb.AbstractEJBRequestScopeActivationInterceptor.aroundInvoke(AbstractEJBRequestScopeActivationInterceptor.java:73) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] at org.jboss.as.weld.ejb.EjbRequestScopeActivationInterceptor.processInvocation(EjbRequestScopeActivationInterceptor.java:89) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.as.ejb3.component.invocationmetrics.WaitTimeInterceptor.processInvocation(WaitTimeInterceptor.java:47) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.as.ejb3.security.SecurityContextInterceptor.processInvocation(SecurityContextInterceptor.java:100) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.as.ejb3.deployment.processors.StartupAwaitInterceptor.processInvocation(StartupAwaitInterceptor.java:22) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.as.ejb3.component.interceptors.ShutDownInterceptorFactory$1.processInvocation(ShutDownInterceptorFactory.java:64) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:67) [wildfly-ejb3-11.0.0.Final.jar:11.0.0.Final] at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.invocation.ContextClassLoaderInterceptor.processInvocation(ContextClassLoaderInterceptor.java:60) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.invocation.InterceptorContext.run(InterceptorContext.java:438) at org.wildfly.security.manager.WildFlySecurityManager.doChecked(WildFlySecurityManager.java:609) at org.jboss.invocation.AccessCheckingInterceptor.processInvocation(AccessCheckingInterceptor.java:57) at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:422) at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:53) at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:198) at org.jboss.as.ee.component.ViewDescription$1.processInvocation(ViewDescription.java:185) at org.jboss.as.ee.component.ProxyInvocationHandler.invoke(ProxyInvocationHandler.java:81) at org.ovirt.engine.core.bll.interfaces.BackendInternal$$$view2.runInternalAction(Unknown Source) [bll.jar:] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.8.0_161] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [rt.jar:1.8.0_161] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_161] at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_161] at org.jboss.weld.util.reflection.Reflections.invokeAndUnwrap(Reflections.java:433) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] at org.jboss.weld.bean.proxy.EnterpriseBeanProxyMethodHandler.invoke(EnterpriseBeanProxyMethodHandler.java:127) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] at org.jboss.weld.bean.proxy.EnterpriseTargetBeanInstance.invoke(EnterpriseTargetBeanInstance.java:56) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] at org.jboss.weld.bean.proxy.InjectionPointPropagatingEnterpriseTargetBeanInstance.invoke(InjectionPointPropagatingEnterpriseTargetBeanInstance.java:67) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] at org.jboss.weld.bean.proxy.ProxyMethodHandler.invoke(ProxyMethodHandler.java:100) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] at org.ovirt.engine.core.bll.BackendCommandObjectsHandler$BackendInternal$BackendLocal$2049259618$Proxy$_$$_Weld$EnterpriseProxy$.runInternalAction(Unknown Source) [bll.jar:] at org.ovirt.engine.core.bll.CommandBase.runInternalAction(CommandBase.java:2377) [bll.jar:] at org.ovirt.engine.core.bll.hostdeploy.AddVdsCommand.lambda$executeCommand$2(AddVdsCommand.java:217) [bll.jar:] at org.ovirt.engine.core.utils.threadpool.ThreadPoolUtil$InternalWrapperRunnable.run(ThreadPoolUtil.java:96) [utils.jar:] at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [rt.jar:1.8.0_161] at java.util.concurrent.FutureTask.run(FutureTask.java:266) [rt.jar:1.8.0_161] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [rt.jar:1.8.0_161] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [rt.jar:1.8.0_161] at java.lang.Thread.run(Thread.java:748) [rt.jar:1.8.0_161] at org.glassfish.enterprise.concurrent.ManagedThreadFactoryImpl$ManagedThread.run(ManagedThreadFactoryImpl.java:250) [javax.enterprise.concurrent-1.0.jar:] at org.jboss.as.ee.concurrent.service.ElytronManagedThreadFactory$ElytronManagedThread.run(ElytronManagedThreadFactory.java:78) Caused by: org.springframework.jdbc.CannotGetJdbcConnectionException: Could not get JDBC Connection; nested exception is java.sql.SQLException: javax.resource.ResourceException: IJ000457: Unchecked throwable in managedConnectionReconnected() cl=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@5629b0eb[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@794a499c connection handles=0 lastReturned=1520995614467 lastValidated=1520995020646 lastCheckedOut=1520995316128 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.OnePool@35f9b31 mcp=SemaphoreConcurrentLinkedQueueManagedConnectionPool@6142eaf9[pool=ENGINEDataSource] xaResource=LocalXAResourceImpl@6735a071[connectionListener=5629b0eb connectionManager=4ef2225d warned=false currentXid=null productName=PostgreSQL productVersion=9.2.23 jndiName=java:/ENGINEDataSource] txSync=null] at org.springframework.jdbc.datasource.DataSourceUtils.getConnection(DataSourceUtils.java:80) [spring-jdbc.jar:4.3.9.RELEASE] at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:619) [spring-jdbc.jar:4.3.9.RELEASE] at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:684) [spring-jdbc.jar:4.3.9.RELEASE] at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:716) [spring-jdbc.jar:4.3.9.RELEASE] at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:766) [spring-jdbc.jar:4.3.9.RELEASE] at org.ovirt.engine.core.dal.dbbroker.PostgresDbEngineDialect$PostgresSimpleJdbcCall.executeCallInternal(PostgresDbEngineDialect.java:152) [dal.jar:] at org.ovirt.engine.core.dal.dbbroker.PostgresDbEngineDialect$PostgresSimpleJdbcCall.doExecute(PostgresDbEngineDialect.java:118) [dal.jar:] at org.springframework.jdbc.core.simple.SimpleJdbcCall.execute(SimpleJdbcCall.java:198) [spring-jdbc.jar:4.3.9.RELEASE] at org.ovirt.engine.core.dal.dbbroker.SimpleJdbcCallsHandler.executeImpl(SimpleJdbcCallsHandler.java:135) [dal.jar:] at org.ovirt.engine.core.dal.dbbroker.SimpleJdbcCallsHandler.executeReadList(SimpleJdbcCallsHandler.java:105) [dal.jar:] at org.ovirt.engine.core.dao.network.InterfaceDaoImpl.getAllInterfacesForVds(InterfaceDaoImpl.java:195) [dal.jar:] at org.ovirt.engine.core.dao.network.InterfaceDaoImpl.getAllInterfacesForVds(InterfaceDaoImpl.java:158) [dal.jar:] at org.ovirt.engine.core.vdsbroker.vdsbroker.HostNetworkTopologyPersisterImpl.persistAndEnforceNetworkCompliance(HostNetworkTopologyPersisterImpl.java:92) [vdsbroker.jar:] at org.ovirt.engine.core.vdsbroker.vdsbroker.CollectVdsNetworkDataVDSCommand.persistCollectedData(CollectVdsNetworkDataVDSCommand.java:30) [vdsbroker.jar:] at org.ovirt.engine.core.vdsbroker.vdsbroker.CollectVdsNetworkDataAfterInstallationVDSCommand.persistCollectedData(CollectVdsNetworkDataAfterInstallationVDSCommand.java:24) [vdsbroker.jar:] at org.ovirt.engine.core.vdsbroker.vdsbroker.CollectVdsNetworkDataVDSCommand.executeVdsBrokerCommand(CollectVdsNetworkDataVDSCommand.java:23) [vdsbroker.jar:] at org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand.executeVDSCommand(VdsBrokerCommand.java:112) [vdsbroker.jar:] at org.ovirt.engine.core.vdsbroker.VDSCommandBase.executeCommand(VDSCommandBase.java:73) [vdsbroker.jar:] at org.ovirt.engine.core.dal.VdcCommandBase.execute(VdcCommandBase.java:33) [dal.jar:] at org.ovirt.engine.core.vdsbroker.vdsbroker.DefaultVdsCommandExecutor.execute(DefaultVdsCommandExecutor.java:14) [vdsbroker.jar:] at org.ovirt.engine.core.vdsbroker.ResourceManager.runVdsCommand(ResourceManager.java:387) [vdsbroker.jar:] at org.ovirt.engine.core.vdsbroker.ResourceManager$Proxy$_$$_WeldSubclass.runVdsCommand$$super(Unknown Source) [vdsbroker.jar:] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.8.0_161] at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [rt.jar:1.8.0_161] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_161] at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_161] at org.jboss.weld.interceptor.proxy.TerminalAroundInvokeInvocationContext.proceedInternal(TerminalAroundInvokeInvocationContext.java:49) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] at org.jboss.weld.interceptor.proxy.AroundInvokeInvocationContext.proceed(AroundInvokeInvocationContext.java:77) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] at org.ovirt.engine.core.common.di.interceptor.LoggingInterceptor.apply(LoggingInterceptor.java:12) [common.jar:] at sun.reflect.GeneratedMethodAccessor68.invoke(Unknown Source) [:1.8.0_161] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_161] at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_161] at org.jboss.weld.interceptor.reader.SimpleInterceptorInvocation$SimpleMethodInvocation.invoke(SimpleInterceptorInvocation.java:73) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.executeAroundInvoke(InterceptorMethodHandler.java:84) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.executeInterception(InterceptorMethodHandler.java:72) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] at org.jboss.weld.interceptor.proxy.InterceptorMethodHandler.invoke(InterceptorMethodHandler.java:56) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] at org.jboss.weld.bean.proxy.CombinedInterceptorAndDecoratorStackMethodHandler.invoke(CombinedInterceptorAndDecoratorStackMethodHandler.java:79) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] at org.jboss.weld.bean.proxy.CombinedInterceptorAndDecoratorStackMethodHandler.invoke(CombinedInterceptorAndDecoratorStackMethodHandler.java:68) [weld-core-impl-2.4.3.Final.jar:2.4.3.Final] at org.ovirt.engine.core.vdsbroker.ResourceManager$Proxy$_$$_WeldSubclass.runVdsCommand(Unknown Source) [vdsbroker.jar:] ... 94 more Caused by: java.sql.SQLException: javax.resource.ResourceException: IJ000457: Unchecked throwable in managedConnectionReconnected() cl=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@5629b0eb[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@794a499c connection handles=0 lastReturned=1520995614467 lastValidated=1520995020646 lastCheckedOut=1520995316128 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.OnePool@35f9b31 mcp=SemaphoreConcurrentLinkedQueueManagedConnectionPool@6142eaf9[pool=ENGINEDataSource] xaResource=LocalXAResourceImpl@6735a071[connectionListener=5629b0eb connectionManager=4ef2225d warned=false currentXid=null productName=PostgreSQL productVersion=9.2.23 jndiName=java:/ENGINEDataSource] txSync=null] at org.jboss.jca.adapters.jdbc.WrapperDataSource.getConnection(WrapperDataSource.java:146) at org.jboss.as.connector.subsystems.datasources.WildFlyDataSource.getConnection(WildFlyDataSource.java:64) at org.springframework.jdbc.datasource.DataSourceUtils.doGetConnection(DataSourceUtils.java:111) [spring-jdbc.jar:4.3.9.RELEASE] at org.springframework.jdbc.datasource.DataSourceUtils.getConnection(DataSourceUtils.java:77) [spring-jdbc.jar:4.3.9.RELEASE] ... 132 more Caused by: javax.resource.ResourceException: IJ000457: Unchecked throwable in managedConnectionReconnected() cl=org.jboss.jca.core.connectionmanager.listener.TxConnectionListener@5629b0eb[state=NORMAL managed connection=org.jboss.jca.adapters.jdbc.local.LocalManagedConnection@794a499c connection handles=0 lastReturned=1520995614467 lastValidated=1520995020646 lastCheckedOut=1520995316128 trackByTx=false pool=org.jboss.jca.core.connectionmanager.pool.strategy.OnePool@35f9b31 mcp=SemaphoreConcurrentLinkedQueueManagedConnectionPool@6142eaf9[pool=ENGINEDataSource] xaResource=LocalXAResourceImpl@6735a071[connectionListener=5629b0eb connectionManager=4ef2225d warned=false currentXid=null productName=PostgreSQL productVersion=9.2.23 jndiName=java:/ENGINEDataSource] txSync=null] at org.jboss.jca.core.connectionmanager.AbstractConnectionManager.reconnectManagedConnection(AbstractConnectionManager.java:975) at org.jboss.jca.core.connectionmanager.AbstractConnectionManager.allocateConnection(AbstractConnectionManager.java:792) at org.jboss.jca.adapters.jdbc.WrapperDataSource.getConnection(WrapperDataSource.java:138) ... 135 more Caused by: javax.resource.ResourceException: IJ000461: Could not enlist in transaction on entering meta-aware object at org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl.managedConnectionReconnected(TxConnectionManagerImpl.java:561) at org.jboss.jca.core.connectionmanager.AbstractConnectionManager.reconnectManagedConnection(AbstractConnectionManager.java:970) ... 137 more Caused by: java.lang.IllegalStateException: Transaction Local transaction (delegate=TransactionImple < ac, BasicAction: 0:ffffc0a87a86:-5959ac91:5aa88ac1:346 status: ActionStatus.ABORTED >, owner=Local transaction context for provider JBoss JTA transaction provider) is not active STATUS_ROLLEDBACK at org.jboss.jca.core.connectionmanager.listener.TxConnectionListener.enlist(TxConnectionListener.java:296) at org.jboss.jca.core.connectionmanager.tx.TxConnectionManagerImpl.managedConnectionReconnected(TxConnectionManagerImpl.java:554) ... 138 more 2018-03-13 22:46:54,524-04 ERROR [org.ovirt.engine.core.bll.hostdeploy.InstallVdsInternalCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] Host installation failed for host '015379e4-f77d-45cb-8488-904dc740d1e9', '192.168.122.54': Failed to configure management network on the host 2018-03-13 22:46:54,562-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='NonOperational', nonOperationalReason='NONE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 3841ba32 2018-03-13 22:46:54,570-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] FINISH, SetVdsStatusVDSCommand, log id: 3841ba32 2018-03-13 22:46:54,575-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='NonOperational', nonOperationalReason='NONE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 316b8ad6 2018-03-13 22:46:54,586-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] FINISH, SetVdsStatusVDSCommand, log id: 316b8ad6 2018-03-13 22:46:54,594-04 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] EVENT_ID: VDS_INSTALL_FAILED(505), Host 192.168.122.54 installation failed. Failed to configure management network on the host. 2018-03-13 22:46:54,613-04 INFO [org.ovirt.engine.core.bll.hostdeploy.InstallVdsInternalCommand] (EE-ManagedThreadFactory-engine-Thread-1) [294d3f03] Lock freed to object 'EngineLock:{exclusiveLocks='[015379e4-f77d-45cb-8488-904dc740d1e9=VDS]', sharedLocks=''}' 2018-03-13 22:46:56,266-04 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [] START, GetHardwareInfoVDSCommand(HostName = 192.168.122.54, VdsIdAndVdsVDSCommandParametersBase:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', vds='Host[192.168.122.54,015379e4-f77d-45cb-8488-904dc740d1e9]'}), log id: 698735ab 2018-03-13 22:46:56,340-04 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [] FINISH, GetHardwareInfoVDSCommand, log id: 698735ab 2018-03-13 22:46:56,423-04 INFO [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [19358996] Running command: SetNonOperationalVdsCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:46:56,427-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [19358996] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='NonOperational', nonOperationalReason='NETWORK_UNREACHABLE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 1a74937c 2018-03-13 22:46:56,431-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [19358996] FINISH, SetVdsStatusVDSCommand, log id: 1a74937c 2018-03-13 22:46:56,435-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [19358996] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='NonOperational', nonOperationalReason='NETWORK_UNREACHABLE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 57354b40 2018-03-13 22:46:56,439-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [19358996] FINISH, SetVdsStatusVDSCommand, log id: 57354b40 2018-03-13 22:46:56,479-04 ERROR [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [19358996] Host '192.168.122.54' is set to Non-Operational, it is missing the following networks: 'ovirtmgmt' 2018-03-13 22:46:56,513-04 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [19358996] EVENT_ID: VDS_SET_NONOPERATIONAL_NETWORK(519), Host 192.168.122.54 does not comply with the cluster Default networks, the following networks are missing on host: 'ovirtmgmt' 2018-03-13 22:46:56,541-04 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [1f74f1c] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:46:56,580-04 INFO [org.ovirt.engine.core.bll.UpdateClusterCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [bf56977] Lock Acquired to object 'EngineLock:{exclusiveLocks='[]', sharedLocks='[]'}' 2018-03-13 22:46:56,635-04 INFO [org.ovirt.engine.core.bll.UpdateClusterCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [bf56977] Running command: UpdateClusterCommand internal: true. Entities affected : ID: 5aa88a7c-0227-00fe-00a7-0000000003cc Type: ClusterAction group EDIT_CLUSTER_CONFIGURATION with role type ADMIN 2018-03-13 22:46:56,656-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [bf56977] EVENT_ID: SYSTEM_UPDATE_CLUSTER(835), Host cluster Default was updated by system 2018-03-13 22:46:56,656-04 INFO [org.ovirt.engine.core.bll.UpdateClusterCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [bf56977] Lock freed to object 'EngineLock:{exclusiveLocks='[]', sharedLocks='[]'}' 2018-03-13 22:46:56,667-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [bf56977] EVENT_ID: VDS_DETECTED(13), Status of host 192.168.122.54 was set to NonOperational. 2018-03-13 22:46:56,712-04 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [6649c727] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:46:56,725-04 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-97) [3cea0a0d] Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:46:58,632-04 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engine' is using 0 threads out of 500, 2 threads waiting for tasks and 0 tasks in queue. 2018-03-13 22:46:58,632-04 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineScheduled' is using 0 threads out of 100 and 100 tasks are waiting in the queue. 2018-03-13 22:46:58,632-04 INFO [org.ovirt.engine.core.bll.utils.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineThreadMonitoring' is using 1 threads out of 1 and 0 tasks are waiting in the queue. 2018-03-13 22:46:59,054-04 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [] START, GetHardwareInfoVDSCommand(HostName = 192.168.122.54, VdsIdAndVdsVDSCommandParametersBase:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', vds='Host[192.168.122.54,015379e4-f77d-45cb-8488-904dc740d1e9]'}), log id: 516de224 2018-03-13 22:46:59,068-04 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [] FINISH, GetHardwareInfoVDSCommand, log id: 516de224 2018-03-13 22:46:59,144-04 INFO [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [20a656fe] Running command: SetNonOperationalVdsCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:46:59,149-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [20a656fe] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='NonOperational', nonOperationalReason='NETWORK_UNREACHABLE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: fa5e3b 2018-03-13 22:46:59,153-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [20a656fe] FINISH, SetVdsStatusVDSCommand, log id: fa5e3b 2018-03-13 22:46:59,159-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [20a656fe] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='NonOperational', nonOperationalReason='NETWORK_UNREACHABLE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 20049594 2018-03-13 22:46:59,162-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [20a656fe] FINISH, SetVdsStatusVDSCommand, log id: 20049594 2018-03-13 22:46:59,192-04 ERROR [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [20a656fe] Host '192.168.122.54' is set to Non-Operational, it is missing the following networks: 'ovirtmgmt' 2018-03-13 22:46:59,215-04 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [37de7da2] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:46:59,220-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [37de7da2] EVENT_ID: VDS_DETECTED(13), Status of host 192.168.122.54 was set to NonOperational. 2018-03-13 22:46:59,247-04 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [23cea145] Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:47:03,780-04 INFO [org.ovirt.engine.core.vdsbroker.monitoring.VmsStatisticsFetcher] (EE-ManagedThreadFactory-engineScheduled-Thread-32) [] Fetched 0 VMs from VDS '015379e4-f77d-45cb-8488-904dc740d1e9' 2018-03-13 22:50:00,019-04 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager] (EE-ManagedThreadFactory-engineScheduled-Thread-6) [] Autorecovering 1 hosts 2018-03-13 22:50:00,019-04 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager] (EE-ManagedThreadFactory-engineScheduled-Thread-6) [] Autorecovering hosts id: 015379e4-f77d-45cb-8488-904dc740d1e9 , name : 192.168.122.54 2018-03-13 22:50:00,034-04 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-6) [1d82f3d9] Lock Acquired to object 'EngineLock:{exclusiveLocks='[015379e4-f77d-45cb-8488-904dc740d1e9=VDS]', sharedLocks=''}' 2018-03-13 22:50:00,043-04 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-6) [1d82f3d9] Running command: ActivateVdsCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDSAction group MANIPULATE_HOST with role type ADMIN 2018-03-13 22:50:00,044-04 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-6) [1d82f3d9] Before acquiring lock in order to prevent monitoring for host '192.168.122.54' from data-center 'Default' 2018-03-13 22:50:00,044-04 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-6) [1d82f3d9] Lock acquired, from now a monitoring of host will be skipped for host '192.168.122.54' from data-center 'Default' 2018-03-13 22:50:00,053-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-6) [1d82f3d9] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='Unassigned', nonOperationalReason='NONE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 183c8cb8 2018-03-13 22:50:00,059-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-6) [1d82f3d9] FINISH, SetVdsStatusVDSCommand, log id: 183c8cb8 2018-03-13 22:50:00,065-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-6) [1d82f3d9] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='Unassigned', nonOperationalReason='NONE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 7cd1969 2018-03-13 22:50:00,077-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-6) [1d82f3d9] FINISH, SetVdsStatusVDSCommand, log id: 7cd1969 2018-03-13 22:50:00,090-04 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-6) [1d82f3d9] Activate host finished. Lock released. Monitoring can run now for host '192.168.122.54' from data-center 'Default' 2018-03-13 22:50:00,106-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-6) [1d82f3d9] EVENT_ID: VDS_ACTIVATE_ASYNC(9,502), Host 192.168.122.54 was autorecovered. 2018-03-13 22:50:00,107-04 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-6) [1d82f3d9] Lock freed to object 'EngineLock:{exclusiveLocks='[015379e4-f77d-45cb-8488-904dc740d1e9=VDS]', sharedLocks=''}' 2018-03-13 22:50:00,957-04 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [] START, GetHardwareInfoVDSCommand(HostName = 192.168.122.54, VdsIdAndVdsVDSCommandParametersBase:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', vds='Host[192.168.122.54,015379e4-f77d-45cb-8488-904dc740d1e9]'}), log id: 1eda39d9 2018-03-13 22:50:00,966-04 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [] FINISH, GetHardwareInfoVDSCommand, log id: 1eda39d9 2018-03-13 22:50:01,020-04 INFO [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [2da6455f] Running command: SetNonOperationalVdsCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:50:01,027-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [2da6455f] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='NonOperational', nonOperationalReason='NETWORK_UNREACHABLE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 5b0d427d 2018-03-13 22:50:01,032-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [2da6455f] FINISH, SetVdsStatusVDSCommand, log id: 5b0d427d 2018-03-13 22:50:01,039-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [2da6455f] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='NonOperational', nonOperationalReason='NETWORK_UNREACHABLE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 6975cb57 2018-03-13 22:50:01,045-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [2da6455f] FINISH, SetVdsStatusVDSCommand, log id: 6975cb57 2018-03-13 22:50:01,088-04 ERROR [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [2da6455f] Host '192.168.122.54' is set to Non-Operational, it is missing the following networks: 'ovirtmgmt' 2018-03-13 22:50:01,115-04 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [2da6455f] EVENT_ID: VDS_SET_NONOPERATIONAL_NETWORK(519), Host 192.168.122.54 does not comply with the cluster Default networks, the following networks are missing on host: 'ovirtmgmt' 2018-03-13 22:50:01,150-04 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [74040e8d] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:50:01,157-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [74040e8d] EVENT_ID: VDS_DETECTED(13), Status of host 192.168.122.54 was set to NonOperational. 2018-03-13 22:50:01,180-04 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [1f72803a] Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:50:01,183-04 INFO [org.ovirt.engine.core.vdsbroker.monitoring.HostMonitoring] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [1f72803a] Host '192.168.122.54'(015379e4-f77d-45cb-8488-904dc740d1e9) is already in NonOperational status for reason 'NETWORK_UNREACHABLE'. SetNonOperationalVds command is skipped. 2018-03-13 22:52:00,712-04 INFO [org.ovirt.engine.core.common.utils.ansible.AnsibleExecutor] (EE-ManagedThreadFactory-hostUpdatesChecker-Thread-1) [] Executing Ansible command: /usr/bin/ansible-playbook --check --private-key=/home/engine/tchyp-engine/etc/pki/ovirt-engine/keys/engine_id_rsa --inventory=/tmp/ansible-inventory9053281511395114929 /home/engine/tchyp-engine/share/ovirt-engine/playbooks/ovirt-host-upgrade.yml 2018-03-13 22:53:18,826-04 INFO [org.ovirt.engine.core.common.utils.ansible.AnsibleExecutor] (EE-ManagedThreadFactory-hostUpdatesChecker-Thread-1) [] Ansible playbook command has exited with value: 0 2018-03-13 22:53:18,829-04 INFO [org.ovirt.engine.core.bll.host.HostUpgradeManager] (EE-ManagedThreadFactory-hostUpdatesChecker-Thread-1) [] There are available package updates (kbd-misc, fence-agents-hpblade, iputils, fence-agents-brocade, fence-agents-bladecenter, efivar-libs, rsyslog, abrt, centos-release, libibverbs, grub2, trousers, python-libguestfs, ruby-libs, python-setuptools, libdb-utils, gtk2, iwl2030-firmware, libseccomp, selinux-policy, NetworkManager-config-server, usbredir, iproute, device-mapper-persistent-data, fence-agents-apc-snmp, cryptsetup-libs, fence-agents-ipdu, ovirt-release-host-node, bind-libs, rng-tools, python-firewall, libreport-cli, virt-v2v, libosinfo, rubygem-cool.io, gawk, device-mapper-multipath, abrt-python, python-libipa_hbac, jansson, bind-utils, sssd-krb5, fence-agents-kdump, pulseaudio-libs, ioprocess, libnfsidmap, libsss_nss_idmap, iprutils, libXrandr, grub2-tools, libxcb, ovirt-imageio-daemon, mokutil, ovirt-hosted-engine-setup, libnetfilter_conntrack, perl, tzdata, iwl3160-firmware, vim-enhanced, libreport-filesystem, libICE, yum-plugin-fastestmirror, otopi, kernel-tools-libs, fence-agents-wti, sssd-ad, fence-agents-vmware-soap, tar, sudo, logrotate, socat, gsettings-desktop-schemas, fence-agents-ipmilan, alsa-lib, abrt-addon-vmcore, fence-agents-ilo2, abrt-libs, rubygem-msgpack, efibootmgr, openvswitch, yum-utils, ovirt-hosted-engine-ha, fcoe-utils, collectd-write_http, pciutils, openssh-clients, perl-libs, libX11, kbd, perl-hivex, abrt-retrace-client, dracut-config-rescue, policycoreutils, fence-agents-all, sssd, iwl3945-firmware, rubygem-psych, grubby, rubygem-yajl-ruby, cockpit-networkmanager, pango, dhclient, fence-agents-mpath, psmisc, net-snmp-libs, libsss_certmap, fence-agents-ilo-mp, augeas, cairo, vim-filesystem, iwl7260-firmware, libtomcrypt, sshpass, cockpit, fence-agents-cisco-mds, bash, openssh, ovirt-setup-lib, atk, fence-agents-ibmblade, pykickstart, iwl5000-firmware, yum, cryptsetup, iwl100-firmware, gssproxy, harfbuzz, iwl6000g2b-firmware, cryptsetup-python, libguestfs-winsupport, rubygem-io-console, vim-minimal, NetworkManager-libnm, microcode_ctl, NetworkManager, gdk-pixbuf2, fence-agents-scsi, authconfig, libunwind, unbound-libs, python-ovirt-engine-sdk4, libtalloc, abrt-addon-ccpp, grep, rubygem-rdoc, iwl1000-firmware, cronie-anacron, xfsprogs, firewalld-filesystem, python-pyudev, ruby-irb, libcroco, selinux-policy-targeted, librdmacm, ovirt-node-ng-image-update-placeholder, mesa-libgbm, net-snmp-utils, net-snmp, python-sss-murmur, dracut-network, libreport-centos, plymouth-scripts, libdb, rubygem-http_parser.rb, kmod-libs, gzip, perl-Pod-Escapes, cronie, sg3_utils, libreport, abrt-addon-python, libcacard, libsemanage-python, mesa-libGL, libtirpc, python-sssdconfig, libsss_idmap, gobject-introspection, perl-macros, fontconfig, iwl2000-firmware, python-blivet, gdeploy, iptables, freetype, ovirt-imageio-common, cpio, fence-agents-compute, NetworkManager-wifi, teamd, kernel, rpcbind, collectd, storaged-iscsi, sssd-ipa, libsss_autofs, mdadm, glib-networking, kmod, hwdata, libguestfs, libXtst, kpartx, fence-agents-common, irqbalance, sssd-client, python-urllib3, dhcp-libs, kernel-tools, sssd-ldap, boost-system, iptables-services, sysstat, device-mapper-multipath-libs, virt-what, fence-agents-eps, iwl135-firmware, binutils, biosdevname, gfs2-utils, fence-agents-apc, fence-agents-ilo-moonshot, net-snmp-agent-libs, dracut, libreport-plugin-ureport, procps-ng, plymouth-core-libs, fence-agents-intelmodular, nfs-utils, ruby, cockpit-system, abrt-addon-pstoreoops, ipset-libs, sssd-krb5-common, libstoraged, expat, fence-agents-cisco-ucs, ansible, fence-agents-emerson, fence-agents-eaton-snmp, iscsi-initiator-utils-iscsiuio, chkconfig, libreport-plugin-mantisbt, tboot, iscsi-initiator-utils, iwl6050-firmware, libsoup, cockpit-storaged, ovirt-node-ng-nodectl, fuse, augeas-libs, cockpit-ovirt-dashboard, iwl6000-firmware, ipmitool, cups-libs, ca-certificates, abrt-dbus, NetworkManager-team, libtevent, vim-common, libipa_hbac, gdb, collectd-disk, kbd-legacy, python-dmidecode, libguestfs-tools-c, policycoreutils-python, iwl6000g2a-firmware, rubygems, iwl7265-firmware, ipset, iwl4965-firmware, python-httplib2, libdrm, mom, rubygem-bigdecimal, fence-agents-rsb, iwl105-firmware, fence-agents-rsa, storaged-lvm2, python-netaddr, dnsmasq, libXfixes, shared-mime-info, python2-crypto, cockpit-bridge, jasper-libs, libXrender, json-glib, libsss_sudo, libssh, boost-thread, rsync, sssd-common, libreport-plugin-rhtsupport, fence-virt, btrfs-progs, libcgroup, linux-firmware, sssd-common-pac, fence-agents-drac5, fipscheck, mesa-libglapi, libX11-common, python-webob, libteam, libtommath, fence-agents-ilo-ssh, libreport-web, dhcp-common, dracut-fips, mariadb-libs, fluentd, cockpit-dashboard, wpa_supplicant, libstdc++, sos, sg3_utils-libs, libXcursor, iwl5150-firmware, libXxf86vm, fence-agents-ifmib, mesa-libEGL, python-perf, rubygem-fluent-plugin-viaq_data_model, tcpdump, bind-libs-lite, imgbased, pciutils-libs, libreport-python, collectd-virt, openssh-server, libXi, ovirt-host-deploy, firewalld, initscripts, plymouth, libsemanage, bind-license, mailx, lsscsi, abrt-addon-kerneloops, rubygem-json, storaged, fipscheck-lib, hivex, scrub, cockpit-ws, telnet, fence-agents-rhevm, collectd-netlink, abrt-tui, abrt-cli, NetworkManager-tui, chrony, abrt-addon-xorg, sssd-proxy) for host '192.168.122.54' 2018-03-13 22:53:18,835-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-hostUpdatesChecker-Thread-1) [] EVENT_ID: HOST_UPDATES_ARE_AVAILABLE_WITH_PACKAGES(843), Host 192.168.122.54 has available updates: kbd-misc, fence-agents-hpblade, iputils, fence-agents-brocade, fence-agents-bladecenter, efivar-libs, rsyslog, abrt, centos-release, libibverbs and 347 others. To see all packages check engine.log.. 2018-03-13 22:53:18,838-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-hostUpdatesChecker-Thread-1) [] EVENT_ID: HOST_AVAILABLE_UPDATES_FINISHED(885), Check for available updates on host 192.168.122.54 was completed successfully with message 'kbd-misc, fence-agents-hpblade, iputils, fence-agents-brocade, fence-agents-bladecenter, efivar-libs, rsyslog, abrt, centos-release, libibverbs and 347 others. To see all packages check engine.log.'. 2018-03-13 22:55:00,016-04 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager] (EE-ManagedThreadFactory-engineScheduled-Thread-74) [] Autorecovering 1 hosts 2018-03-13 22:55:00,016-04 INFO [org.ovirt.engine.core.bll.AutoRecoveryManager] (EE-ManagedThreadFactory-engineScheduled-Thread-74) [] Autorecovering hosts id: 015379e4-f77d-45cb-8488-904dc740d1e9 , name : 192.168.122.54 2018-03-13 22:55:00,027-04 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-74) [7b19fe7] Lock Acquired to object 'EngineLock:{exclusiveLocks='[015379e4-f77d-45cb-8488-904dc740d1e9=VDS]', sharedLocks=''}' 2018-03-13 22:55:00,036-04 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-74) [7b19fe7] Running command: ActivateVdsCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDSAction group MANIPULATE_HOST with role type ADMIN 2018-03-13 22:55:00,036-04 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-74) [7b19fe7] Before acquiring lock in order to prevent monitoring for host '192.168.122.54' from data-center 'Default' 2018-03-13 22:55:00,036-04 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-74) [7b19fe7] Lock acquired, from now a monitoring of host will be skipped for host '192.168.122.54' from data-center 'Default' 2018-03-13 22:55:00,046-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-74) [7b19fe7] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='Unassigned', nonOperationalReason='NONE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 65f4d7cd 2018-03-13 22:55:00,054-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-74) [7b19fe7] FINISH, SetVdsStatusVDSCommand, log id: 65f4d7cd 2018-03-13 22:55:00,060-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-74) [7b19fe7] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='Unassigned', nonOperationalReason='NONE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 2d6c15f1 2018-03-13 22:55:00,065-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-74) [7b19fe7] FINISH, SetVdsStatusVDSCommand, log id: 2d6c15f1 2018-03-13 22:55:00,071-04 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-74) [7b19fe7] Activate host finished. Lock released. Monitoring can run now for host '192.168.122.54' from data-center 'Default' 2018-03-13 22:55:00,076-04 INFO [org.ovirt.engine.core.bll.ActivateVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-74) [7b19fe7] Lock freed to object 'EngineLock:{exclusiveLocks='[015379e4-f77d-45cb-8488-904dc740d1e9=VDS]', sharedLocks=''}' 2018-03-13 22:55:01,199-04 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-39) [] START, GetHardwareInfoVDSCommand(HostName = 192.168.122.54, VdsIdAndVdsVDSCommandParametersBase:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', vds='Host[192.168.122.54,015379e4-f77d-45cb-8488-904dc740d1e9]'}), log id: 3850f183 2018-03-13 22:55:01,215-04 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-39) [] FINISH, GetHardwareInfoVDSCommand, log id: 3850f183 2018-03-13 22:55:01,259-04 INFO [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-39) [65941060] Running command: SetNonOperationalVdsCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:55:01,265-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-39) [65941060] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='NonOperational', nonOperationalReason='NETWORK_UNREACHABLE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 52c81ad7 2018-03-13 22:55:01,269-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-39) [65941060] FINISH, SetVdsStatusVDSCommand, log id: 52c81ad7 2018-03-13 22:55:01,275-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-39) [65941060] START, SetVdsStatusVDSCommand(HostName = 192.168.122.54, SetVdsStatusVDSCommandParameters:{hostId='015379e4-f77d-45cb-8488-904dc740d1e9', status='NonOperational', nonOperationalReason='NETWORK_UNREACHABLE', stopSpmFailureLogged='false', maintenanceReason='null'}), log id: 25965c22 2018-03-13 22:55:01,280-04 INFO [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-39) [65941060] FINISH, SetVdsStatusVDSCommand, log id: 25965c22 2018-03-13 22:55:01,326-04 ERROR [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-39) [65941060] Host '192.168.122.54' is set to Non-Operational, it is missing the following networks: 'ovirtmgmt' 2018-03-13 22:55:01,349-04 WARN [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-39) [65941060] EVENT_ID: VDS_SET_NONOPERATIONAL_NETWORK(519), Host 192.168.122.54 does not comply with the cluster Default networks, the following networks are missing on host: 'ovirtmgmt' 2018-03-13 22:55:01,361-04 INFO [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-39) [4f3fdd35] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:55:01,366-04 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-39) [4f3fdd35] EVENT_ID: VDS_DETECTED(13), Status of host 192.168.122.54 was set to NonOperational. 2018-03-13 22:55:01,385-04 INFO [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-39) [551f3046] Running command: HandleVdsVersionCommand internal: true. Entities affected : ID: 015379e4-f77d-45cb-8488-904dc740d1e9 Type: VDS 2018-03-13 22:55:01,388-04 INFO [org.ovirt.engine.core.vdsbroker.monitoring.HostMonitoring] (EE-ManagedThreadFactory-engineScheduled-Thread-39) [551f3046] Host '192.168.122.54'(015379e4-f77d-45cb-8488-904dc740d1e9) is already in NonOperational status for reason 'NETWORK_UNREACHABLE'. SetNonOperationalVds command is skipped.