Attachment 925487 Details for Bug 1128417 – engine.log

engine.log

engine.log (text/x-log), 172.93 KB, created by Vered Volansky on 2014-08-10 11:01:34 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Vered Volansky

Created: 2014-08-10 11:01:34 UTC

Size: 172.93 KB

patch

obsolete

>2014-08-10 13:14:38,262 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Loaded file "/home/vvolansk/ovirt-engine/share/ovirt-engine/services/ovirt-engine/ovirt-engine.conf".
>2014-08-10 13:14:38,263 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) The file "/home/vvolansk/ovirt-engine/etc/ovirt-engine/engine.conf" doesn't exist or isn't readable. Will return an empty set of properties.
>2014-08-10 13:14:38,264 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Loaded file "/home/vvolansk/ovirt-engine/etc/ovirt-engine/engine.conf.d/10-setup-database.conf".
>2014-08-10 13:14:38,265 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Loaded file "/home/vvolansk/ovirt-engine/etc/ovirt-engine/engine.conf.d/10-setup-jboss.conf".
>2014-08-10 13:14:38,266 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Loaded file "/home/vvolansk/ovirt-engine/etc/ovirt-engine/engine.conf.d/10-setup-pki.conf".
>2014-08-10 13:14:38,267 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Loaded file "/home/vvolansk/ovirt-engine/etc/ovirt-engine/engine.conf.d/10-setup-protocols.conf".
>2014-08-10 13:14:38,268 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_AJP_ENABLED" is "false".
>2014-08-10 13:14:38,269 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_AJP_PORT" is "None".
>2014-08-10 13:14:38,269 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_APPS" is "engine.ear restapi.war legacy_restapi.war".
>2014-08-10 13:14:38,270 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_CACHE" is "/home/vvolansk/ovirt-engine/var/cache/ovirt-engine".
>2014-08-10 13:14:38,270 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_CHECK_INTERVAL" is "1000".
>2014-08-10 13:14:38,271 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_CONNECTION_TIMEOUT" is "300000".
>2014-08-10 13:14:38,272 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_DATABASE" is "engine".
>2014-08-10 13:14:38,272 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_DRIVER" is "org.postgresql.Driver".
>2014-08-10 13:14:38,273 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_HOST" is "localhost".
>2014-08-10 13:14:38,273 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_MAX_CONNECTIONS" is "100".
>2014-08-10 13:14:38,274 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_MIN_CONNECTIONS" is "1".
>2014-08-10 13:14:38,274 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_PASSWORD" is "***".
>2014-08-10 13:14:38,275 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_PORT" is "5432".
>2014-08-10 13:14:38,275 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_SECURED" is "False".
>2014-08-10 13:14:38,276 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_SECURED_VALIDATION" is "False".
>2014-08-10 13:14:38,276 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_URL" is "jdbc:postgresql://localhost:5432/engine?sslfactory=org.postgresql.ssl.NonValidatingFactory".
>2014-08-10 13:14:38,277 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_USER" is "engine".
>2014-08-10 13:14:38,278 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DEBUG_ADDRESS" is "127.0.0.1:8787".
>2014-08-10 13:14:38,278 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DOC" is "/home/vvolansk/ovirt-engine/share/doc/ovirt-engine".
>2014-08-10 13:14:38,279 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_ETC" is "/home/vvolansk/ovirt-engine/etc/ovirt-engine".
>2014-08-10 13:14:38,280 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_EXTENSION_PATH" is "/home/vvolansk/ovirt-engine/share/ovirt-engine/extensions.d:/home/vvolansk/ovirt-engine/etc/ovirt-engine/extensions.d".
>2014-08-10 13:14:38,281 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_FQDN" is "vered.laptop.tlv.redhat.com".
>2014-08-10 13:14:38,281 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_GROUP" is "ovirt".
>2014-08-10 13:14:38,282 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_HEAP_MAX" is "1g".
>2014-08-10 13:14:38,282 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_HEAP_MIN" is "1g".
>2014-08-10 13:14:38,283 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_HTTPS_ENABLED" is "true".
>2014-08-10 13:14:38,283 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_HTTPS_PORT" is "8443".
>2014-08-10 13:14:38,284 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_HTTPS_PROTOCOLS" is "SSLv3,TLSv1,TLSv1.1,TLSv1.2".
>2014-08-10 13:14:38,284 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_HTTP_ENABLED" is "true".
>2014-08-10 13:14:38,285 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_HTTP_PORT" is "8080".
>2014-08-10 13:14:38,285 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_JAVA_MODULEPATH" is "/home/vvolansk/ovirt-engine/share/ovirt-engine/modules".
>2014-08-10 13:14:38,289 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_JVM_ARGS" is " -XX:+HeapDumpOnOutOfMemoryError -XX:HeapDumpPath="/home/vvolansk/ovirt-engine/var/log/ovirt-engine/dump"".
>2014-08-10 13:14:38,290 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_LOG" is "/home/vvolansk/ovirt-engine/var/log/ovirt-engine".
>2014-08-10 13:14:38,291 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_LOG_TO_CONSOLE" is "true".
>2014-08-10 13:14:38,291 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_MANUAL" is "/home/vvolansk/ovirt-engine/share/ovirt-engine/manual".
>2014-08-10 13:14:38,292 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PERM_MAX" is "256m".
>2014-08-10 13:14:38,292 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PERM_MIN" is "256m".
>2014-08-10 13:14:38,293 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI" is "/home/vvolansk/ovirt-engine/etc/pki/ovirt-engine".
>2014-08-10 13:14:38,293 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_CA" is "/home/vvolansk/ovirt-engine/etc/pki/ovirt-engine/ca.pem".
>2014-08-10 13:14:38,295 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_ENGINE_CERT" is "/home/vvolansk/ovirt-engine/etc/pki/ovirt-engine/certs/engine.cer".
>2014-08-10 13:14:38,296 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_ENGINE_STORE" is "/home/vvolansk/ovirt-engine/etc/pki/ovirt-engine/keys/engine.p12".
>2014-08-10 13:14:38,297 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_ENGINE_STORE_ALIAS" is "1".
>2014-08-10 13:14:38,301 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_ENGINE_STORE_PASSWORD" is "***".
>2014-08-10 13:14:38,302 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_ENGINE_STORE_TYPE" is "PKCS12".
>2014-08-10 13:14:38,302 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_TRUST_STORE" is "/home/vvolansk/ovirt-engine/etc/pki/ovirt-engine/.truststore".
>2014-08-10 13:14:38,303 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_TRUST_STORE_PASSWORD" is "***".
>2014-08-10 13:14:38,303 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_TRUST_STORE_TYPE" is "JKS".
>2014-08-10 13:14:38,304 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PROPERTIES" is " jsse.enableSNIExtension=false "java.security.krb5.conf=/home/vvolansk/ovirt-engine/etc/ovirt-engine/krb5.conf"".
>2014-08-10 13:14:38,311 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PROXY_ENABLED" is "false".
>2014-08-10 13:14:38,312 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PROXY_HTTPS_PORT" is "443".
>2014-08-10 13:14:38,312 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PROXY_HTTP_PORT" is "80".
>2014-08-10 13:14:38,313 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_REPORTS_UI" is "/home/vvolansk/ovirt-engine/var/lib/ovirt-engine/reports.xml".
>2014-08-10 13:14:38,313 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_STOP_INTERVAL" is "1".
>2014-08-10 13:14:38,314 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_STOP_TIME" is "10".
>2014-08-10 13:14:38,314 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_TMP" is "/home/vvolansk/ovirt-engine/var/tmp/ovirt-engine".
>2014-08-10 13:14:38,315 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_UP_MARK" is "/home/vvolansk/ovirt-engine/var/lib/ovirt-engine/engine.up".
>2014-08-10 13:14:38,316 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_URI" is "/ovirt-engine".
>2014-08-10 13:14:38,316 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_USER" is "ovirt".
>2014-08-10 13:14:38,316 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_USR" is "/home/vvolansk/ovirt-engine/share/ovirt-engine".
>2014-08-10 13:14:38,317 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_VAR" is "/home/vvolansk/ovirt-engine/var/lib/ovirt-engine".
>2014-08-10 13:14:38,318 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_VERBOSE_GC" is "false".
>2014-08-10 13:14:38,318 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "JBOSS_HOME" is "/usr/share/jboss-as".
>2014-08-10 13:14:38,318 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "JBOSS_RUNTIME" is "/home/vvolansk/ovirt-engine/var/lib/ovirt-engine/jboss_runtime".
>2014-08-10 13:14:38,319 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "SENSITIVE_KEYS" is ",ENGINE_DB_PASSWORD,ENGINE_PKI_TRUST_STORE_PASSWORD,ENGINE_PKI_ENGINE_STORE_PASSWORD".
>2014-08-10 13:14:38,654 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-1) Start initializing Backend
>2014-08-10 13:14:38,751 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-1) Failed to decrypt value for property AdminPassword will be used encrypted value: javax.crypto.BadPaddingException: Data must start with zero
>	at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:325) [rt.jar:1.7.0_25]
>	at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:272) [rt.jar:1.7.0_25]
>	at com.sun.crypto.provider.RSACipher.doFinal(RSACipher.java:356)
>	at com.sun.crypto.provider.RSACipher.engineDoFinal(RSACipher.java:382)
>	at javax.crypto.Cipher.doFinal(Cipher.java:1922) [jce.jar:1.7.0_25]
>	at org.ovirt.engine.core.utils.crypt.EngineEncryptionUtils.decrypt(EngineEncryptionUtils.java:163) [utils.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.getValue(DBConfigUtils.java:112) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.updateOption(DBConfigUtils.java:263) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.refreshVdcOptionCache(DBConfigUtils.java:38) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.<init>(DBConfigUtils.java:171) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.<init>(DBConfigUtils.java:157) [dal.jar:]
>	at org.ovirt.engine.core.bll.Backend.initialize(Backend.java:187) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.create(Backend.java:138) [bll.jar:]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_25]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_25]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_25]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_25]
>	at org.jboss.as.ee.component.ManagedReferenceLifecycleMethodInterceptorFactory$ManagedReferenceLifecycleMethodInterceptor.processInvocation(ManagedReferenceLifecycleMethodInterceptorFactory.java:130) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.injection.WeldInjectionInterceptor.processInvocation(WeldInjectionInterceptor.java:73) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ManagedReferenceInterceptorFactory$ManagedReferenceInterceptor.processInvocation(ManagedReferenceInterceptorFactory.java:95) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ManagedReferenceInterceptorFactory$ManagedReferenceInterceptor.processInvocation(ManagedReferenceInterceptorFactory.java:95) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInOurTx(CMTTxInterceptor.java:228) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.requiresNew(CMTTxInterceptor.java:333) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.SingletonLifecycleCMTTxInterceptor.processInvocation(SingletonLifecycleCMTTxInterceptor.java:56) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.BasicComponent.constructComponentInstance(BasicComponent.java:161) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.BasicComponent.createInstance(BasicComponent.java:85) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.component.singleton.SingletonComponent.getComponentInstance(SingletonComponent.java:116) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.component.singleton.SingletonComponent.start(SingletonComponent.java:130) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.ComponentStartService.start(ComponentStartService.java:44) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1811)
>	at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1746)
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_25]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:14:38,828 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-1) Failed to decrypt value for property LocalAdminPassword will be used encrypted value: javax.crypto.BadPaddingException: Data must start with zero
>	at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:325) [rt.jar:1.7.0_25]
>	at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:272) [rt.jar:1.7.0_25]
>	at com.sun.crypto.provider.RSACipher.doFinal(RSACipher.java:356)
>	at com.sun.crypto.provider.RSACipher.engineDoFinal(RSACipher.java:382)
>	at javax.crypto.Cipher.doFinal(Cipher.java:1922) [jce.jar:1.7.0_25]
>	at org.ovirt.engine.core.utils.crypt.EngineEncryptionUtils.decrypt(EngineEncryptionUtils.java:163) [utils.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.getValue(DBConfigUtils.java:112) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.updateOption(DBConfigUtils.java:263) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.refreshVdcOptionCache(DBConfigUtils.java:38) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.<init>(DBConfigUtils.java:171) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.<init>(DBConfigUtils.java:157) [dal.jar:]
>	at org.ovirt.engine.core.bll.Backend.initialize(Backend.java:187) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.create(Backend.java:138) [bll.jar:]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_25]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_25]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_25]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_25]
>	at org.jboss.as.ee.component.ManagedReferenceLifecycleMethodInterceptorFactory$ManagedReferenceLifecycleMethodInterceptor.processInvocation(ManagedReferenceLifecycleMethodInterceptorFactory.java:130) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.injection.WeldInjectionInterceptor.processInvocation(WeldInjectionInterceptor.java:73) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ManagedReferenceInterceptorFactory$ManagedReferenceInterceptor.processInvocation(ManagedReferenceInterceptorFactory.java:95) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ManagedReferenceInterceptorFactory$ManagedReferenceInterceptor.processInvocation(ManagedReferenceInterceptorFactory.java:95) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInOurTx(CMTTxInterceptor.java:228) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.requiresNew(CMTTxInterceptor.java:333) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.SingletonLifecycleCMTTxInterceptor.processInvocation(SingletonLifecycleCMTTxInterceptor.java:56) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.BasicComponent.constructComponentInstance(BasicComponent.java:161) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.BasicComponent.createInstance(BasicComponent.java:85) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.component.singleton.SingletonComponent.getComponentInstance(SingletonComponent.java:116) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.component.singleton.SingletonComponent.start(SingletonComponent.java:130) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.ComponentStartService.start(ComponentStartService.java:44) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1811)
>	at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1746)
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_25]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:14:38,859 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-1) Could not parse option AutoRecoveryAllowedTypes value.
>2014-08-10 13:14:38,869 INFO  [org.ovirt.engine.core.utils.osinfo.OsInfoPreferencesLoader] (MSC service thread 1-1) Loaded file /home/vvolansk/ovirt-engine/etc/ovirt-engine/osinfo.conf.d/00-defaults.properties
>2014-08-10 13:14:39,000 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-1) Running ovirt-engine 3.5.0.0
>2014-08-10 13:14:39,001 INFO  [org.ovirt.engine.core.bll.CpuFlagsManagerHandler] (MSC service thread 1-1) Start initializing dictionaries
>2014-08-10 13:14:39,004 INFO  [org.ovirt.engine.core.bll.CpuFlagsManagerHandler] (MSC service thread 1-1) Finished initializing dictionaries
>2014-08-10 13:14:39,004 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-1) Start initializing AuditLogCleanupManager
>2014-08-10 13:14:39,005 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-1) Setting audit cleanup manager to run at: 35 35 3 * * ?
>2014-08-10 13:14:39,021 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-1) Finished initializing AuditLogCleanupManager
>2014-08-10 13:14:39,021 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-1) Start initializing CommandEntityCleanupManager
>2014-08-10 13:14:39,022 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-1) Setting command entity cleanup manager to run at: 35 35 3 * * ?
>2014-08-10 13:14:39,023 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-1) Finished initializing CommandEntityCleanupManager
>2014-08-10 13:14:39,025 INFO  [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-1) Start initializing TagsDirector
>2014-08-10 13:14:39,036 INFO  [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-1) Tag root added to tree
>2014-08-10 13:14:39,045 INFO  [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-1) Finished initializing TagsDirector
>2014-08-10 13:14:39,046 INFO  [org.ovirt.engine.core.bll.IsoDomainListSyncronizer] (MSC service thread 1-1) Start initializing IsoDomainListSyncronizer
>2014-08-10 13:14:39,053 INFO  [org.ovirt.engine.core.bll.IsoDomainListSyncronizer] (MSC service thread 1-1) Finished initializing IsoDomainListSyncronizer
>2014-08-10 13:14:39,112 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-1) Completed initializing handlers
>2014-08-10 13:14:39,132 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-1) Start initializing ErrorTranslatorImpl
>2014-08-10 13:14:39,141 WARN  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-1) Code MAC_ADDRESS_IS_IN_USE appears more than once in string table.
>2014-08-10 13:14:39,143 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-1) Finished initializing ErrorTranslatorImpl
>2014-08-10 13:14:39,143 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-1) Start initializing ErrorTranslatorImpl
>2014-08-10 13:14:39,144 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-1) Finished initializing ErrorTranslatorImpl
>2014-08-10 13:14:39,145 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-1) Mark incomplete jobs as UNKNOWN
>2014-08-10 13:14:39,192 INFO  [org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager] (MSC service thread 1-1) Start initializing JobRepositoryCleanupManager
>2014-08-10 13:14:39,193 INFO  [org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager] (MSC service thread 1-1) Finished initializing JobRepositoryCleanupManager
>2014-08-10 13:14:39,193 INFO  [org.ovirt.engine.core.bll.AutoRecoveryManager] (MSC service thread 1-1) Start initializing AutoRecoveryManager
>2014-08-10 13:14:39,196 INFO  [org.ovirt.engine.core.bll.AutoRecoveryManager] (MSC service thread 1-1) Finished initializing AutoRecoveryManager
>2014-08-10 13:14:39,198 INFO  [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (MSC service thread 1-1) Start initializing ExecutionMessageDirector
>2014-08-10 13:14:39,202 INFO  [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (MSC service thread 1-1) Finished initializing ExecutionMessageDirector
>2014-08-10 13:14:39,251 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) Start of enabled extensions list
>2014-08-10 13:14:39,251 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) Instance name: 'builtin-authn-internal', Extension name: 'Internal Authn (Built-in)', Version: 'N/A', Notes: '', License: 'ASL 2.0', Home: 'http://www.ovirt.org', Author 'The oVirt Project', Build interface Version: '0',  File: 'N/A', Initialized: 'true'
>2014-08-10 13:14:39,252 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) Instance name: 'internal', Extension name: 'Internal Authz (Built-in)', Version: 'N/A', Notes: '', License: 'ASL 2.0', Home: 'http://www.ovirt.org', Author 'The oVirt Project', Build interface Version: '0',  File: 'N/A', Initialized: 'true'
>2014-08-10 13:14:39,253 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-1) End of enabled extensions list
>2014-08-10 13:14:39,322 INFO  [org.ovirt.engine.core.bll.aaa.DbUserCacheManager] (MSC service thread 1-8) Start initializing DbUserCacheManager
>2014-08-10 13:14:39,324 INFO  [org.ovirt.engine.core.bll.aaa.DbUserCacheManager] (MSC service thread 1-8) Finished initializing DbUserCacheManager
>2014-08-10 13:14:39,332 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (MSC service thread 1-8) Initialization of AsyncTaskManager completed successfully.
>2014-08-10 13:14:39,334 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-8) Start initializing ResourceManager
>2014-08-10 13:14:39,415 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-8) Entered VdsManager constructor
>2014-08-10 13:14:39,441 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-8) Initialize vdsBroker (battlestar.tlv.redhat.com,54,321)
>2014-08-10 13:14:39,583 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-8) VDS 9c67d903-8424-4cda-8bb1-3d8652b92d77 was added to the Resource Manager
>2014-08-10 13:14:39,604 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-8) Finished initializing ResourceManager
>2014-08-10 13:14:39,608 INFO  [org.ovirt.engine.core.bll.OvfDataUpdater] (MSC service thread 1-8) Initialization of OvfDataUpdater completed successfully.
>2014-08-10 13:14:39,609 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-8) Start scheduling to enable vds load balancer
>2014-08-10 13:14:39,612 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-8) Finished scheduling to enable vds load balancer
>2014-08-10 13:14:39,612 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-8) Start HA Reservation check
>2014-08-10 13:14:39,614 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-8) Finished HA Reservation check
>2014-08-10 13:14:39,630 INFO  [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-8) Init VM custom properties utilities
>2014-08-10 13:14:39,635 INFO  [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-8) Init device custom properties utilities
>2014-08-10 13:14:39,639 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-8) Initializing Scheduling manager
>2014-08-10 13:14:39,689 INFO  [org.ovirt.engine.core.bll.network.macpoolmanager.MacPoolManagerRanges] (org.ovirt.thread.pool-8-thread-1) Start initializing MacPoolManagerRanges
>2014-08-10 13:14:39,696 INFO  [org.ovirt.engine.core.bll.network.macpoolmanager.MacPoolManagerRanges] (org.ovirt.thread.pool-8-thread-1) Finished initializing. Available MACs in pool: 150
>2014-08-10 13:14:39,697 INFO  [org.ovirt.engine.core.bll.network.macpoolmanager.MacPoolPerDc] (org.ovirt.thread.pool-8-thread-1) successfully initialized
>2014-08-10 13:14:39,705 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-8) External scheduler disabled, discovery skipped
>2014-08-10 13:14:39,706 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-8) Initialized Scheduling manager
>2014-08-10 13:14:39,706 INFO  [org.ovirt.engine.core.bll.dwh.DwhHeartBeat] (MSC service thread 1-8) Initializing DWH Heart Beat
>2014-08-10 13:14:39,710 INFO  [org.ovirt.engine.core.bll.dwh.DwhHeartBeat] (MSC service thread 1-8) DWH Heart Beat initialized
>2014-08-10 13:14:39,768 INFO  [org.ovirt.engine.core.bll.aaa.SyncUsers] (DefaultQuartzScheduler_Worker-1) Principal admin::internal synchronized
>2014-08-10 13:14:43,324 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-6) START, GetHardwareInfoVDSCommand(HostName = h1, HostId = 9c67d903-8424-4cda-8bb1-3d8652b92d77, vds=Host[h1,9c67d903-8424-4cda-8bb1-3d8652b92d77]), log id: 73dea836
>2014-08-10 13:14:43,331 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-6) FINISH, GetHardwareInfoVDSCommand, log id: 73dea836
>2014-08-10 13:14:43,348 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) Cannot convert the string Host ${VdsName} is not responding. It will stay in Connecting state for a grace period of ${Seconds} seconds and after that an attempt to fence the host will be issued. to AuditLogType, the key does not exist in the AuditLogType declared types
>2014-08-10 13:14:43,357 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: UNASSIGNED not exist in string table
>2014-08-10 13:14:43,357 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: VDS_AUTO_FENCE_STATUS not exist in string table
>2014-08-10 13:14:43,358 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: VDS_AUTO_FENCE_STATUS_FAILED not exist in string table
>2014-08-10 13:14:43,359 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: VDS_AUTO_FENCE_FAILED_CALL_FENCE_SPM not exist in string table
>2014-08-10 13:14:43,359 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: VDS_HIGH_NETWORK_USE not exist in string table
>2014-08-10 13:14:43,361 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: VDS_NOT_RESTARTED_DUE_TO_POLICY not exist in string table
>2014-08-10 13:14:43,361 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: USER_FAILED_REMOVE_VM not exist in string table
>2014-08-10 13:14:43,362 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: USER_RUN_UNLOCK_ENTITY_SCRIPT not exist in string table
>2014-08-10 13:14:43,363 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: VDS_NETWORK_MTU_DIFFER_FROM_LOGICAL_NETWORK not exist in string table
>2014-08-10 13:14:43,368 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: VDS_HOST_IN_CONNECTING_STATE not exist in string table
>2014-08-10 13:14:43,369 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: STORAGE_ACTIVATE_ASYNC not exist in string table
>2014-08-10 13:14:43,370 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: DWH_STOPPED not exist in string table
>2014-08-10 13:14:43,371 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: DWH_STARTED not exist in string table
>2014-08-10 13:14:43,371 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: DWH_ERROR not exist in string table
>2014-08-10 13:14:43,380 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: USER_REMOVE_AUDIT_LOG not exist in string table
>2014-08-10 13:14:43,380 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: USER_REMOVE_AUDIT_LOG_FAILED not exist in string table
>2014-08-10 13:14:43,381 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: USER_CLEAR_ALL_DISMISSED_AUDIT_LOG not exist in string table
>2014-08-10 13:14:43,381 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: USER_CLEAR_ALL_DISMISSED_AUDIT_LOG_FAILED not exist in string table
>2014-08-10 13:14:43,548 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Host h1 does not enforce SELinux.
>2014-08-10 13:14:43,549 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-6) Host h1 is running with disabled SELinux.
>2014-08-10 13:14:43,823 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-6) Initializing Host: h1
>2014-08-10 13:14:43,898 INFO  [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler_Worker-6) [5c4b5f39] Running command: HandleVdsVersionCommand internal: true. Entities affected :  ID: 9c67d903-8424-4cda-8bb1-3d8652b92d77 Type: VDS
>2014-08-10 13:14:49,652 INFO  [org.ovirt.engine.core.bll.storage.SetStoragePoolStatusCommand] (DefaultQuartzScheduler_Worker-20) [6efa8e9f] Running command: SetStoragePoolStatusCommand internal: true. Entities affected :  ID: 00000002-0002-0002-0002-00000000037f Type: StoragePool
>2014-08-10 13:14:49,668 INFO  [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (DefaultQuartzScheduler_Worker-20) [6efa8e9f] Storage Pool 00000002-0002-0002-0002-00000000037f - Updating Storage Domain d54e6e6c-81f2-41f2-90ab-7e3c2457938a status from Active to Unknown, reason : null
>2014-08-10 13:14:49,676 INFO  [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (DefaultQuartzScheduler_Worker-20) [6efa8e9f] Storage Pool 00000002-0002-0002-0002-00000000037f - Updating Storage Domain 7158eae9-4886-4af7-af0b-d668ecee9e4f status from Active to Unknown, reason : null
>2014-08-10 13:14:49,743 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-20) [6efa8e9f] Correlation ID: 6efa8e9f, Call Stack: null, Custom Event ID: -1, Message: Invalid status on Data Center Default. Setting status to Non Responsive.
>2014-08-10 13:14:49,809 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (DefaultQuartzScheduler_Worker-20) [6efa8e9f] hostFromVds::selectedVds - h1, spmStatus SPM, storage pool Default
>2014-08-10 13:14:49,818 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (DefaultQuartzScheduler_Worker-20) [6efa8e9f] Initialize Irs proxy from vds: battlestar.tlv.redhat.com
>2014-08-10 13:14:49,842 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-20) [6efa8e9f] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Storage Pool Manager runs on Host h1 (Address: battlestar.tlv.redhat.com).
>2014-08-10 13:14:49,859 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-13) [6efa8e9f] START, SPMGetAllTasksInfoVDSCommand( storagePoolId = 00000002-0002-0002-0002-00000000037f, ignoreFailoverLimit = false), log id: 2dfc93ef
>2014-08-10 13:14:49,933 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-20) [6efa8e9f] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Warning, Low disk space.sd_35 domain has 49 GB of free space
>2014-08-10 13:14:49,958 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-20) [6efa8e9f] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Warning, Low disk space.sd35_1 domain has 49 GB of free space
>2014-08-10 13:14:49,959 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-13) [6efa8e9f] -- executeIrsBrokerCommand: Attempting on storage pool 00000002-0002-0002-0002-00000000037f
>2014-08-10 13:14:49,967 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-13) [6efa8e9f] START, HSMGetAllTasksInfoVDSCommand(HostName = h1, HostId = 9c67d903-8424-4cda-8bb1-3d8652b92d77), log id: 2af1e871
>2014-08-10 13:14:49,974 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-13) [6efa8e9f] FINISH, HSMGetAllTasksInfoVDSCommand, return: [], log id: 2af1e871
>2014-08-10 13:14:49,974 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-13) [6efa8e9f] FINISH, SPMGetAllTasksInfoVDSCommand, return: [], log id: 2dfc93ef
>2014-08-10 13:14:49,975 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (org.ovirt.thread.pool-8-thread-13) [6efa8e9f] Discovered no tasks on Storage Pool Default
>2014-08-10 13:15:39,641 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Loaded file "/home/vvolansk/ovirt-engine/share/ovirt-engine/services/ovirt-engine/ovirt-engine.conf".
>2014-08-10 13:15:39,643 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) The file "/home/vvolansk/ovirt-engine/etc/ovirt-engine/engine.conf" doesn't exist or isn't readable. Will return an empty set of properties.
>2014-08-10 13:15:39,644 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Loaded file "/home/vvolansk/ovirt-engine/etc/ovirt-engine/engine.conf.d/10-setup-database.conf".
>2014-08-10 13:15:39,645 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Loaded file "/home/vvolansk/ovirt-engine/etc/ovirt-engine/engine.conf.d/10-setup-jboss.conf".
>2014-08-10 13:15:39,646 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Loaded file "/home/vvolansk/ovirt-engine/etc/ovirt-engine/engine.conf.d/10-setup-pki.conf".
>2014-08-10 13:15:39,647 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Loaded file "/home/vvolansk/ovirt-engine/etc/ovirt-engine/engine.conf.d/10-setup-protocols.conf".
>2014-08-10 13:15:39,648 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_AJP_ENABLED" is "false".
>2014-08-10 13:15:39,649 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_AJP_PORT" is "None".
>2014-08-10 13:15:39,649 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_APPS" is "engine.ear restapi.war legacy_restapi.war".
>2014-08-10 13:15:39,650 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_CACHE" is "/home/vvolansk/ovirt-engine/var/cache/ovirt-engine".
>2014-08-10 13:15:39,650 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DB_CHECK_INTERVAL" is "1000".
>2014-08-10 13:15:39,651 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DB_CONNECTION_TIMEOUT" is "300000".
>2014-08-10 13:15:39,651 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DB_DATABASE" is "engine".
>2014-08-10 13:15:39,652 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DB_DRIVER" is "org.postgresql.Driver".
>2014-08-10 13:15:39,653 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DB_HOST" is "localhost".
>2014-08-10 13:15:39,653 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DB_MAX_CONNECTIONS" is "100".
>2014-08-10 13:15:39,654 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DB_MIN_CONNECTIONS" is "1".
>2014-08-10 13:15:39,654 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DB_PASSWORD" is "***".
>2014-08-10 13:15:39,655 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DB_PORT" is "5432".
>2014-08-10 13:15:39,655 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DB_SECURED" is "False".
>2014-08-10 13:15:39,656 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DB_SECURED_VALIDATION" is "False".
>2014-08-10 13:15:39,656 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DB_URL" is "jdbc:postgresql://localhost:5432/engine?sslfactory=org.postgresql.ssl.NonValidatingFactory".
>2014-08-10 13:15:39,657 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DB_USER" is "engine".
>2014-08-10 13:15:39,657 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DEBUG_ADDRESS" is "127.0.0.1:8787".
>2014-08-10 13:15:39,658 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_DOC" is "/home/vvolansk/ovirt-engine/share/doc/ovirt-engine".
>2014-08-10 13:15:39,659 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_ETC" is "/home/vvolansk/ovirt-engine/etc/ovirt-engine".
>2014-08-10 13:15:39,659 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_EXTENSION_PATH" is "/home/vvolansk/ovirt-engine/share/ovirt-engine/extensions.d:/home/vvolansk/ovirt-engine/etc/ovirt-engine/extensions.d".
>2014-08-10 13:15:39,660 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_FQDN" is "vered.laptop.tlv.redhat.com".
>2014-08-10 13:15:39,661 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_GROUP" is "ovirt".
>2014-08-10 13:15:39,662 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_HEAP_MAX" is "1g".
>2014-08-10 13:15:39,662 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_HEAP_MIN" is "1g".
>2014-08-10 13:15:39,663 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_HTTPS_ENABLED" is "true".
>2014-08-10 13:15:39,663 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_HTTPS_PORT" is "8443".
>2014-08-10 13:15:39,664 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_HTTPS_PROTOCOLS" is "SSLv3,TLSv1,TLSv1.1,TLSv1.2".
>2014-08-10 13:15:39,664 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_HTTP_ENABLED" is "true".
>2014-08-10 13:15:39,665 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_HTTP_PORT" is "8080".
>2014-08-10 13:15:39,665 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_JAVA_MODULEPATH" is "/home/vvolansk/ovirt-engine/share/ovirt-engine/modules".
>2014-08-10 13:15:39,666 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_JVM_ARGS" is " -XX:+HeapDumpOnOutOfMemoryError -XX:HeapDumpPath="/home/vvolansk/ovirt-engine/var/log/ovirt-engine/dump"".
>2014-08-10 13:15:39,667 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_LOG" is "/home/vvolansk/ovirt-engine/var/log/ovirt-engine".
>2014-08-10 13:15:39,667 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_LOG_TO_CONSOLE" is "true".
>2014-08-10 13:15:39,668 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_MANUAL" is "/home/vvolansk/ovirt-engine/share/ovirt-engine/manual".
>2014-08-10 13:15:39,668 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PERM_MAX" is "256m".
>2014-08-10 13:15:39,669 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PERM_MIN" is "256m".
>2014-08-10 13:15:39,669 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PKI" is "/home/vvolansk/ovirt-engine/etc/pki/ovirt-engine".
>2014-08-10 13:15:39,670 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PKI_CA" is "/home/vvolansk/ovirt-engine/etc/pki/ovirt-engine/ca.pem".
>2014-08-10 13:15:39,670 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PKI_ENGINE_CERT" is "/home/vvolansk/ovirt-engine/etc/pki/ovirt-engine/certs/engine.cer".
>2014-08-10 13:15:39,671 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PKI_ENGINE_STORE" is "/home/vvolansk/ovirt-engine/etc/pki/ovirt-engine/keys/engine.p12".
>2014-08-10 13:15:39,671 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PKI_ENGINE_STORE_ALIAS" is "1".
>2014-08-10 13:15:39,672 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PKI_ENGINE_STORE_PASSWORD" is "***".
>2014-08-10 13:15:39,672 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PKI_ENGINE_STORE_TYPE" is "PKCS12".
>2014-08-10 13:15:39,673 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PKI_TRUST_STORE" is "/home/vvolansk/ovirt-engine/etc/pki/ovirt-engine/.truststore".
>2014-08-10 13:15:39,674 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PKI_TRUST_STORE_PASSWORD" is "***".
>2014-08-10 13:15:39,674 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PKI_TRUST_STORE_TYPE" is "JKS".
>2014-08-10 13:15:39,675 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PROPERTIES" is " jsse.enableSNIExtension=false "java.security.krb5.conf=/home/vvolansk/ovirt-engine/etc/ovirt-engine/krb5.conf"".
>2014-08-10 13:15:39,675 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PROXY_ENABLED" is "false".
>2014-08-10 13:15:39,676 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PROXY_HTTPS_PORT" is "443".
>2014-08-10 13:15:39,676 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_PROXY_HTTP_PORT" is "80".
>2014-08-10 13:15:39,677 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_REPORTS_UI" is "/home/vvolansk/ovirt-engine/var/lib/ovirt-engine/reports.xml".
>2014-08-10 13:15:39,678 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_STOP_INTERVAL" is "1".
>2014-08-10 13:15:39,678 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_STOP_TIME" is "10".
>2014-08-10 13:15:39,678 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_TMP" is "/home/vvolansk/ovirt-engine/var/tmp/ovirt-engine".
>2014-08-10 13:15:39,679 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_UP_MARK" is "/home/vvolansk/ovirt-engine/var/lib/ovirt-engine/engine.up".
>2014-08-10 13:15:39,680 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_URI" is "/ovirt-engine".
>2014-08-10 13:15:39,680 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_USER" is "ovirt".
>2014-08-10 13:15:39,681 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_USR" is "/home/vvolansk/ovirt-engine/share/ovirt-engine".
>2014-08-10 13:15:39,681 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_VAR" is "/home/vvolansk/ovirt-engine/var/lib/ovirt-engine".
>2014-08-10 13:15:39,683 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "ENGINE_VERBOSE_GC" is "false".
>2014-08-10 13:15:39,686 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "JBOSS_HOME" is "/usr/share/jboss-as".
>2014-08-10 13:15:39,686 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "JBOSS_RUNTIME" is "/home/vvolansk/ovirt-engine/var/lib/ovirt-engine/jboss_runtime".
>2014-08-10 13:15:39,687 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-3) Value of property "SENSITIVE_KEYS" is ",ENGINE_DB_PASSWORD,ENGINE_PKI_TRUST_STORE_PASSWORD,ENGINE_PKI_ENGINE_STORE_PASSWORD".
>2014-08-10 13:15:40,058 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-8) Start initializing Backend
>2014-08-10 13:15:40,184 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-8) Failed to decrypt value for property AdminPassword will be used encrypted value: javax.crypto.BadPaddingException: Data must start with zero
>	at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:325) [rt.jar:1.7.0_25]
>	at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:272) [rt.jar:1.7.0_25]
>	at com.sun.crypto.provider.RSACipher.doFinal(RSACipher.java:356)
>	at com.sun.crypto.provider.RSACipher.engineDoFinal(RSACipher.java:382)
>	at javax.crypto.Cipher.doFinal(Cipher.java:1922) [jce.jar:1.7.0_25]
>	at org.ovirt.engine.core.utils.crypt.EngineEncryptionUtils.decrypt(EngineEncryptionUtils.java:163) [utils.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.getValue(DBConfigUtils.java:112) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.updateOption(DBConfigUtils.java:263) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.refreshVdcOptionCache(DBConfigUtils.java:38) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.<init>(DBConfigUtils.java:171) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.<init>(DBConfigUtils.java:157) [dal.jar:]
>	at org.ovirt.engine.core.bll.Backend.initialize(Backend.java:187) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.create(Backend.java:138) [bll.jar:]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_25]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_25]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_25]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_25]
>	at org.jboss.as.ee.component.ManagedReferenceLifecycleMethodInterceptorFactory$ManagedReferenceLifecycleMethodInterceptor.processInvocation(ManagedReferenceLifecycleMethodInterceptorFactory.java:130) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.injection.WeldInjectionInterceptor.processInvocation(WeldInjectionInterceptor.java:73) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ManagedReferenceInterceptorFactory$ManagedReferenceInterceptor.processInvocation(ManagedReferenceInterceptorFactory.java:95) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ManagedReferenceInterceptorFactory$ManagedReferenceInterceptor.processInvocation(ManagedReferenceInterceptorFactory.java:95) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInOurTx(CMTTxInterceptor.java:228) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.requiresNew(CMTTxInterceptor.java:333) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.SingletonLifecycleCMTTxInterceptor.processInvocation(SingletonLifecycleCMTTxInterceptor.java:56) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.BasicComponent.constructComponentInstance(BasicComponent.java:161) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.BasicComponent.createInstance(BasicComponent.java:85) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.component.singleton.SingletonComponent.getComponentInstance(SingletonComponent.java:116) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.component.singleton.SingletonComponent.start(SingletonComponent.java:130) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.ComponentStartService.start(ComponentStartService.java:44) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1811)
>	at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1746)
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_25]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:15:40,296 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-8) Failed to decrypt value for property LocalAdminPassword will be used encrypted value: javax.crypto.BadPaddingException: Data must start with zero
>	at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:325) [rt.jar:1.7.0_25]
>	at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:272) [rt.jar:1.7.0_25]
>	at com.sun.crypto.provider.RSACipher.doFinal(RSACipher.java:356)
>	at com.sun.crypto.provider.RSACipher.engineDoFinal(RSACipher.java:382)
>	at javax.crypto.Cipher.doFinal(Cipher.java:1922) [jce.jar:1.7.0_25]
>	at org.ovirt.engine.core.utils.crypt.EngineEncryptionUtils.decrypt(EngineEncryptionUtils.java:163) [utils.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.getValue(DBConfigUtils.java:112) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.updateOption(DBConfigUtils.java:263) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.refreshVdcOptionCache(DBConfigUtils.java:38) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.<init>(DBConfigUtils.java:171) [dal.jar:]
>	at org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils.<init>(DBConfigUtils.java:157) [dal.jar:]
>	at org.ovirt.engine.core.bll.Backend.initialize(Backend.java:187) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.create(Backend.java:138) [bll.jar:]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_25]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_25]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_25]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_25]
>	at org.jboss.as.ee.component.ManagedReferenceLifecycleMethodInterceptorFactory$ManagedReferenceLifecycleMethodInterceptor.processInvocation(ManagedReferenceLifecycleMethodInterceptorFactory.java:130) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.injection.WeldInjectionInterceptor.processInvocation(WeldInjectionInterceptor.java:73) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ManagedReferenceInterceptorFactory$ManagedReferenceInterceptor.processInvocation(ManagedReferenceInterceptorFactory.java:95) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ManagedReferenceInterceptorFactory$ManagedReferenceInterceptor.processInvocation(ManagedReferenceInterceptorFactory.java:95) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInOurTx(CMTTxInterceptor.java:228) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.requiresNew(CMTTxInterceptor.java:333) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.SingletonLifecycleCMTTxInterceptor.processInvocation(SingletonLifecycleCMTTxInterceptor.java:56) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.BasicComponent.constructComponentInstance(BasicComponent.java:161) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.BasicComponent.createInstance(BasicComponent.java:85) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.component.singleton.SingletonComponent.getComponentInstance(SingletonComponent.java:116) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.component.singleton.SingletonComponent.start(SingletonComponent.java:130) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.ComponentStartService.start(ComponentStartService.java:44) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1811)
>	at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1746)
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_25]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:15:40,337 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-8) Could not parse option AutoRecoveryAllowedTypes value.
>2014-08-10 13:15:40,350 INFO  [org.ovirt.engine.core.utils.osinfo.OsInfoPreferencesLoader] (MSC service thread 1-8) Loaded file /home/vvolansk/ovirt-engine/etc/ovirt-engine/osinfo.conf.d/00-defaults.properties
>2014-08-10 13:15:40,493 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-8) Running ovirt-engine 3.5.0.0
>2014-08-10 13:15:40,494 INFO  [org.ovirt.engine.core.bll.CpuFlagsManagerHandler] (MSC service thread 1-8) Start initializing dictionaries
>2014-08-10 13:15:40,497 INFO  [org.ovirt.engine.core.bll.CpuFlagsManagerHandler] (MSC service thread 1-8) Finished initializing dictionaries
>2014-08-10 13:15:40,498 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-8) Start initializing AuditLogCleanupManager
>2014-08-10 13:15:40,499 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-8) Setting audit cleanup manager to run at: 35 35 3 * * ?
>2014-08-10 13:15:40,518 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-8) Finished initializing AuditLogCleanupManager
>2014-08-10 13:15:40,518 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-8) Start initializing CommandEntityCleanupManager
>2014-08-10 13:15:40,519 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-8) Setting command entity cleanup manager to run at: 35 35 3 * * ?
>2014-08-10 13:15:40,520 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-8) Finished initializing CommandEntityCleanupManager
>2014-08-10 13:15:40,525 INFO  [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-8) Start initializing TagsDirector
>2014-08-10 13:15:40,536 INFO  [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-8) Tag root added to tree
>2014-08-10 13:15:40,544 INFO  [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-8) Finished initializing TagsDirector
>2014-08-10 13:15:40,545 INFO  [org.ovirt.engine.core.bll.IsoDomainListSyncronizer] (MSC service thread 1-8) Start initializing IsoDomainListSyncronizer
>2014-08-10 13:15:40,553 INFO  [org.ovirt.engine.core.bll.IsoDomainListSyncronizer] (MSC service thread 1-8) Finished initializing IsoDomainListSyncronizer
>2014-08-10 13:15:40,621 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-8) Completed initializing handlers
>2014-08-10 13:15:40,641 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-8) Start initializing ErrorTranslatorImpl
>2014-08-10 13:15:40,653 WARN  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-8) Code MAC_ADDRESS_IS_IN_USE appears more than once in string table.
>2014-08-10 13:15:40,655 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-8) Finished initializing ErrorTranslatorImpl
>2014-08-10 13:15:40,655 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-8) Start initializing ErrorTranslatorImpl
>2014-08-10 13:15:40,656 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-8) Finished initializing ErrorTranslatorImpl
>2014-08-10 13:15:40,657 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-8) Mark incomplete jobs as UNKNOWN
>2014-08-10 13:15:40,682 INFO  [org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager] (MSC service thread 1-8) Start initializing JobRepositoryCleanupManager
>2014-08-10 13:15:40,683 INFO  [org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager] (MSC service thread 1-8) Finished initializing JobRepositoryCleanupManager
>2014-08-10 13:15:40,683 INFO  [org.ovirt.engine.core.bll.AutoRecoveryManager] (MSC service thread 1-8) Start initializing AutoRecoveryManager
>2014-08-10 13:15:40,685 INFO  [org.ovirt.engine.core.bll.AutoRecoveryManager] (MSC service thread 1-8) Finished initializing AutoRecoveryManager
>2014-08-10 13:15:40,686 INFO  [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (MSC service thread 1-8) Start initializing ExecutionMessageDirector
>2014-08-10 13:15:40,688 INFO  [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (MSC service thread 1-8) Finished initializing ExecutionMessageDirector
>2014-08-10 13:15:40,734 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-8) Start of enabled extensions list
>2014-08-10 13:15:40,735 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-8) Instance name: 'builtin-authn-internal', Extension name: 'Internal Authn (Built-in)', Version: 'N/A', Notes: '', License: 'ASL 2.0', Home: 'http://www.ovirt.org', Author 'The oVirt Project', Build interface Version: '0',  File: 'N/A', Initialized: 'true'
>2014-08-10 13:15:40,736 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-8) Instance name: 'internal', Extension name: 'Internal Authz (Built-in)', Version: 'N/A', Notes: '', License: 'ASL 2.0', Home: 'http://www.ovirt.org', Author 'The oVirt Project', Build interface Version: '0',  File: 'N/A', Initialized: 'true'
>2014-08-10 13:15:40,737 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-8) End of enabled extensions list
>2014-08-10 13:15:40,794 INFO  [org.ovirt.engine.core.bll.aaa.DbUserCacheManager] (MSC service thread 1-7) Start initializing DbUserCacheManager
>2014-08-10 13:15:40,795 INFO  [org.ovirt.engine.core.bll.aaa.DbUserCacheManager] (MSC service thread 1-7) Finished initializing DbUserCacheManager
>2014-08-10 13:15:40,805 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (MSC service thread 1-7) Initialization of AsyncTaskManager completed successfully.
>2014-08-10 13:15:40,808 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-7) Start initializing ResourceManager
>2014-08-10 13:15:40,824 INFO  [org.ovirt.engine.core.bll.aaa.SyncUsers] (DefaultQuartzScheduler_Worker-1) Principal admin::internal synchronized
>2014-08-10 13:15:40,888 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-7) Entered VdsManager constructor
>2014-08-10 13:15:40,907 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-7) Initialize vdsBroker (battlestar.tlv.redhat.com,54,321)
>2014-08-10 13:15:40,983 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-7) VDS 9c67d903-8424-4cda-8bb1-3d8652b92d77 was added to the Resource Manager
>2014-08-10 13:15:40,996 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-7) Finished initializing ResourceManager
>2014-08-10 13:15:41,000 INFO  [org.ovirt.engine.core.bll.OvfDataUpdater] (MSC service thread 1-7) Initialization of OvfDataUpdater completed successfully.
>2014-08-10 13:15:41,000 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-7) Start scheduling to enable vds load balancer
>2014-08-10 13:15:41,001 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-7) Finished scheduling to enable vds load balancer
>2014-08-10 13:15:41,001 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-7) Start HA Reservation check
>2014-08-10 13:15:41,002 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-7) Finished HA Reservation check
>2014-08-10 13:15:41,008 INFO  [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-7) Init VM custom properties utilities
>2014-08-10 13:15:41,009 INFO  [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-7) Init device custom properties utilities
>2014-08-10 13:15:41,014 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-7) Initializing Scheduling manager
>2014-08-10 13:15:41,042 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-7) External scheduler disabled, discovery skipped
>2014-08-10 13:15:41,042 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-7) Initialized Scheduling manager
>2014-08-10 13:15:41,043 INFO  [org.ovirt.engine.core.bll.dwh.DwhHeartBeat] (MSC service thread 1-7) Initializing DWH Heart Beat
>2014-08-10 13:15:41,044 INFO  [org.ovirt.engine.core.bll.dwh.DwhHeartBeat] (MSC service thread 1-7) DWH Heart Beat initialized
>2014-08-10 13:15:41,048 INFO  [org.ovirt.engine.core.bll.network.macpoolmanager.MacPoolManagerRanges] (org.ovirt.thread.pool-8-thread-1) Start initializing MacPoolManagerRanges
>2014-08-10 13:15:41,050 INFO  [org.ovirt.engine.core.bll.network.macpoolmanager.MacPoolManagerRanges] (org.ovirt.thread.pool-8-thread-1) Finished initializing. Available MACs in pool: 150
>2014-08-10 13:15:41,050 INFO  [org.ovirt.engine.core.bll.network.macpoolmanager.MacPoolPerDc] (org.ovirt.thread.pool-8-thread-1) successfully initialized
>2014-08-10 13:15:44,623 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-6) START, GetHardwareInfoVDSCommand(HostName = h1, HostId = 9c67d903-8424-4cda-8bb1-3d8652b92d77, vds=Host[h1,9c67d903-8424-4cda-8bb1-3d8652b92d77]), log id: 21eeb0f
>2014-08-10 13:15:44,633 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-6) FINISH, GetHardwareInfoVDSCommand, log id: 21eeb0f
>2014-08-10 13:15:44,645 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) Cannot convert the string Host ${VdsName} is not responding. It will stay in Connecting state for a grace period of ${Seconds} seconds and after that an attempt to fence the host will be issued. to AuditLogType, the key does not exist in the AuditLogType declared types
>2014-08-10 13:15:44,651 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: UNASSIGNED not exist in string table
>2014-08-10 13:15:44,652 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: VDS_AUTO_FENCE_STATUS not exist in string table
>2014-08-10 13:15:44,652 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: VDS_AUTO_FENCE_STATUS_FAILED not exist in string table
>2014-08-10 13:15:44,653 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: VDS_AUTO_FENCE_FAILED_CALL_FENCE_SPM not exist in string table
>2014-08-10 13:15:44,653 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: VDS_HIGH_NETWORK_USE not exist in string table
>2014-08-10 13:15:44,654 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: VDS_NOT_RESTARTED_DUE_TO_POLICY not exist in string table
>2014-08-10 13:15:44,655 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: USER_FAILED_REMOVE_VM not exist in string table
>2014-08-10 13:15:44,656 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: USER_RUN_UNLOCK_ENTITY_SCRIPT not exist in string table
>2014-08-10 13:15:44,657 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: VDS_NETWORK_MTU_DIFFER_FROM_LOGICAL_NETWORK not exist in string table
>2014-08-10 13:15:44,658 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: VDS_HOST_IN_CONNECTING_STATE not exist in string table
>2014-08-10 13:15:44,659 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: STORAGE_ACTIVATE_ASYNC not exist in string table
>2014-08-10 13:15:44,659 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: DWH_STOPPED not exist in string table
>2014-08-10 13:15:44,660 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: DWH_STARTED not exist in string table
>2014-08-10 13:15:44,661 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: DWH_ERROR not exist in string table
>2014-08-10 13:15:44,661 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: USER_REMOVE_AUDIT_LOG not exist in string table
>2014-08-10 13:15:44,662 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: USER_REMOVE_AUDIT_LOG_FAILED not exist in string table
>2014-08-10 13:15:44,662 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: USER_CLEAR_ALL_DISMISSED_AUDIT_LOG not exist in string table
>2014-08-10 13:15:44,663 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) AuditLogType: USER_CLEAR_ALL_DISMISSED_AUDIT_LOG_FAILED not exist in string table
>2014-08-10 13:15:44,811 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-6) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Host h1 does not enforce SELinux.
>2014-08-10 13:15:44,812 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-6) Host h1 is running with disabled SELinux.
>2014-08-10 13:15:45,198 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-6) Initializing Host: h1
>2014-08-10 13:15:45,293 INFO  [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler_Worker-6) [5569b6c0] Running command: HandleVdsVersionCommand internal: true. Entities affected :  ID: 9c67d903-8424-4cda-8bb1-3d8652b92d77 Type: VDS
>2014-08-10 13:15:51,039 INFO  [org.ovirt.engine.core.bll.storage.SetStoragePoolStatusCommand] (DefaultQuartzScheduler_Worker-19) [288657e1] Running command: SetStoragePoolStatusCommand internal: true. Entities affected :  ID: 00000002-0002-0002-0002-00000000037f Type: StoragePool
>2014-08-10 13:15:51,048 INFO  [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (DefaultQuartzScheduler_Worker-19) [288657e1] Storage Pool 00000002-0002-0002-0002-00000000037f - Updating Storage Domain d54e6e6c-81f2-41f2-90ab-7e3c2457938a status from Active to Unknown, reason : null
>2014-08-10 13:15:51,053 INFO  [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (DefaultQuartzScheduler_Worker-19) [288657e1] Storage Pool 00000002-0002-0002-0002-00000000037f - Updating Storage Domain 7158eae9-4886-4af7-af0b-d668ecee9e4f status from Active to Unknown, reason : null
>2014-08-10 13:15:51,114 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-19) [288657e1] Correlation ID: 288657e1, Call Stack: null, Custom Event ID: -1, Message: Invalid status on Data Center Default. Setting status to Non Responsive.
>2014-08-10 13:15:51,166 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (DefaultQuartzScheduler_Worker-19) [288657e1] hostFromVds::selectedVds - h1, spmStatus SPM, storage pool Default
>2014-08-10 13:15:51,213 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (DefaultQuartzScheduler_Worker-19) [288657e1] Initialize Irs proxy from vds: battlestar.tlv.redhat.com
>2014-08-10 13:15:51,304 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-19) [288657e1] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Storage Pool Manager runs on Host h1 (Address: battlestar.tlv.redhat.com).
>2014-08-10 13:15:51,324 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-13) [288657e1] START, SPMGetAllTasksInfoVDSCommand( storagePoolId = 00000002-0002-0002-0002-00000000037f, ignoreFailoverLimit = false), log id: 32947053
>2014-08-10 13:15:51,420 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-19) [288657e1] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Warning, Low disk space.sd_35 domain has 49 GB of free space
>2014-08-10 13:15:51,445 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-19) [288657e1] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Warning, Low disk space.sd35_1 domain has 49 GB of free space
>2014-08-10 13:15:51,446 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-13) [288657e1] -- executeIrsBrokerCommand: Attempting on storage pool 00000002-0002-0002-0002-00000000037f
>2014-08-10 13:15:51,456 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-13) [288657e1] START, HSMGetAllTasksInfoVDSCommand(HostName = h1, HostId = 9c67d903-8424-4cda-8bb1-3d8652b92d77), log id: 31d1e747
>2014-08-10 13:15:51,464 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-13) [288657e1] FINISH, HSMGetAllTasksInfoVDSCommand, return: [], log id: 31d1e747
>2014-08-10 13:15:51,465 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-13) [288657e1] FINISH, SPMGetAllTasksInfoVDSCommand, return: [], log id: 32947053
>2014-08-10 13:15:51,466 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (org.ovirt.thread.pool-8-thread-13) [288657e1] Discovered no tasks on Storage Pool Default
>2014-08-10 13:15:52,441 INFO  [org.ovirt.engine.core.bll.aaa.LoginAdminUserCommand] (http--0.0.0.0-8080-1) Running command: LoginAdminUserCommand internal: false.
>2014-08-10 13:15:52,472 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (http--0.0.0.0-8080-1) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: User admin logged in.
>2014-08-10 13:15:55,937 INFO  [org.ovirt.engine.core.bll.aaa.LoginUserCommand] (http--0.0.0.0-8080-4) Running command: LoginUserCommand internal: false.
>2014-08-10 13:16:02,125 INFO  [org.ovirt.engine.core.bll.HibernateVmCommand] (http--0.0.0.0-8080-1) [3b5aec92] Lock Acquired to object EngineLock [exclusiveLocks= key: de580b19-e975-426f-80de-6c7daf1f24ab value: VM
>, sharedLocks= ]
>2014-08-10 13:16:02,410 INFO  [org.ovirt.engine.core.bll.HibernateVmCommand] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] Running command: HibernateVmCommand internal: false. Entities affected :  ID: de580b19-e975-426f-80de-6c7daf1f24ab Type: VMAction group VM_BASIC_OPERATIONS with role type USER
>2014-08-10 13:16:02,460 INFO  [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] START, UpdateVmDynamicDataVDSCommand(HostName = h1, HostId = 9c67d903-8424-4cda-8bb1-3d8652b92d77, vmDynamic=org.ovirt.engine.core.common.businessentities.VmDynamic@afbeab9b), log id: 73d013e9
>2014-08-10 13:16:02,463 INFO  [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] FINISH, UpdateVmDynamicDataVDSCommand, log id: 73d013e9
>2014-08-10 13:16:02,478 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] START, CreateImageVDSCommand( storagePoolId = 00000002-0002-0002-0002-00000000037f, ignoreFailoverLimit = false, storageDomainId = 7158eae9-4886-4af7-af0b-d668ecee9e4f, imageGroupId = ef7c8ef2-cf66-4f60-a752-f1a79235e2d6, imageSizeInBytes = 1350565888, volumeFormat = RAW, newImageId = 952565e4-a91d-4876-a3b1-ccd5dfe2a8b0, newImageDescription = ), log id: 7278a6e9
>2014-08-10 13:16:02,490 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] -- executeIrsBrokerCommand: calling 'createVolume' with two new parameters: description and UUID
>2014-08-10 13:16:02,937 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] FINISH, CreateImageVDSCommand, return: 952565e4-a91d-4876-a3b1-ccd5dfe2a8b0, log id: 7278a6e9
>2014-08-10 13:16:02,969 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command 8ae74d40-2c2e-4226-9dd4-08ed57a8d4ad
>2014-08-10 13:16:02,970 INFO  [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] CommandMultiAsyncTasks::AttachTask: Attaching task 6af997dd-7966-4fa6-8a79-5e5e278f0ef4 to command 8ae74d40-2c2e-4226-9dd4-08ed57a8d4ad.
>2014-08-10 13:16:02,990 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] Adding task 6af997dd-7966-4fa6-8a79-5e5e278f0ef4 (Parent Command HibernateVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters), polling hasn't started yet..
>2014-08-10 13:16:03,016 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] START, CreateImageVDSCommand( storagePoolId = 00000002-0002-0002-0002-00000000037f, ignoreFailoverLimit = false, storageDomainId = 7158eae9-4886-4af7-af0b-d668ecee9e4f, imageGroupId = 4bd8a1f0-e234-40d6-a71c-9a93818794e4, imageSizeInBytes = 10240, volumeFormat = COW, newImageId = bb223e58-a6b3-449a-a77a-344b4863850b, newImageDescription = ), log id: 3d7d67fa
>2014-08-10 13:16:03,018 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] -- executeIrsBrokerCommand: calling 'createVolume' with two new parameters: description and UUID
>2014-08-10 13:16:03,730 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.CreateImageVDSCommand] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] FINISH, CreateImageVDSCommand, return: bb223e58-a6b3-449a-a77a-344b4863850b, log id: 3d7d67fa
>2014-08-10 13:16:03,839 INFO  [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] CommandMultiAsyncTasks::AttachTask: Attaching task 5812d8ec-cc9a-412f-8005-99c507282276 to command 8ae74d40-2c2e-4226-9dd4-08ed57a8d4ad.
>2014-08-10 13:16:03,869 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] Adding task 5812d8ec-cc9a-412f-8005-99c507282276 (Parent Command HibernateVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters), polling hasn't started yet..
>2014-08-10 13:16:03,886 INFO  [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] START, UpdateVmDynamicDataVDSCommand(HostName = h1, HostId = 9c67d903-8424-4cda-8bb1-3d8652b92d77, vmDynamic=org.ovirt.engine.core.common.businessentities.VmDynamic@b6e8248c), log id: 420e3434
>2014-08-10 13:16:03,934 INFO  [org.ovirt.engine.core.vdsbroker.UpdateVmDynamicDataVDSCommand] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] FINISH, UpdateVmDynamicDataVDSCommand, log id: 420e3434
>2014-08-10 13:16:04,017 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] Correlation ID: 3b5aec92, Job ID: ca864131-793a-4525-8d09-42afef54ed7d, Call Stack: null, Custom Event ID: -1, Message: Suspending VM vm4 was initiated by User admin (Host: h1).
>2014-08-10 13:16:04,018 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] BaseAsyncTask::startPollingTask: Starting to poll task 6af997dd-7966-4fa6-8a79-5e5e278f0ef4.
>2014-08-10 13:16:04,019 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] BaseAsyncTask::startPollingTask: Starting to poll task 5812d8ec-cc9a-412f-8005-99c507282276.
>2014-08-10 13:16:04,020 INFO  [org.ovirt.engine.core.bll.HibernateVmCommand] (org.ovirt.thread.pool-8-thread-31) [3b5aec92] Lock freed to object EngineLock [exclusiveLocks= key: de580b19-e975-426f-80de-6c7daf1f24ab value: VM
>, sharedLocks= ]
>2014-08-10 13:16:10,797 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (DefaultQuartzScheduler_Worker-60) Polling and updating Async Tasks: 2 tasks, 2 tasks to poll now
>2014-08-10 13:16:10,844 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler_Worker-60) SPMAsyncTask::PollTask: Polling task 5812d8ec-cc9a-412f-8005-99c507282276 (Parent Command HibernateVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) returned status finished, result 'success'.
>2014-08-10 13:16:10,882 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler_Worker-60) BaseAsyncTask::onTaskEndSuccess: Task 5812d8ec-cc9a-412f-8005-99c507282276 (Parent Command HibernateVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) ended successfully.
>2014-08-10 13:16:10,884 INFO  [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (DefaultQuartzScheduler_Worker-60) Task with DB Task ID 8cae746b-1044-4f73-92af-21405dd2e93b and VDSM Task ID 6af997dd-7966-4fa6-8a79-5e5e278f0ef4 is in state Polling. End action for command 8ae74d40-2c2e-4226-9dd4-08ed57a8d4ad will proceed when all the entitys tasks are completed.
>2014-08-10 13:16:10,885 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler_Worker-60) SPMAsyncTask::PollTask: Polling task 6af997dd-7966-4fa6-8a79-5e5e278f0ef4 (Parent Command HibernateVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) returned status finished, result 'success'.
>2014-08-10 13:16:10,899 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler_Worker-60) BaseAsyncTask::onTaskEndSuccess: Task 6af997dd-7966-4fa6-8a79-5e5e278f0ef4 (Parent Command HibernateVm, Parameters Type org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters) ended successfully.
>2014-08-10 13:16:10,900 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (DefaultQuartzScheduler_Worker-60) CommandAsyncTask::endActionIfNecessary: All tasks of command 8ae74d40-2c2e-4226-9dd4-08ed57a8d4ad has ended -> executing endAction
>2014-08-10 13:16:10,901 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (DefaultQuartzScheduler_Worker-60) CommandAsyncTask::endAction: Ending action for 2 tasks (command ID: 8ae74d40-2c2e-4226-9dd4-08ed57a8d4ad): calling endAction .
>2014-08-10 13:16:10,902 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-41) CommandAsyncTask::endCommandAction [within thread] context: Attempting to endAction HibernateVm, executionIndex: 0
>2014-08-10 13:16:10,965 INFO  [org.ovirt.engine.core.bll.HibernateVmCommand] (org.ovirt.thread.pool-8-thread-41) Ending command successfully: org.ovirt.engine.core.bll.HibernateVmCommand
>2014-08-10 13:16:10,982 INFO  [org.ovirt.engine.core.vdsbroker.HibernateVDSCommand] (org.ovirt.thread.pool-8-thread-41) START, HibernateVDSCommand(HostName = h1, HostId = 9c67d903-8424-4cda-8bb1-3d8652b92d77, vmId=de580b19-e975-426f-80de-6c7daf1f24ab, hibernationVolHandle=7158eae9-4886-4af7-af0b-d668ecee9e4f,00000002-0002-0002-0002-00000000037f,ef7c8ef2-cf66-4f60-a752-f1a79235e2d6,952565e4-a91d-4876-a3b1-ccd5dfe2a8b0,4bd8a1f0-e234-40d6-a71c-9a93818794e4,bb223e58-a6b3-449a-a77a-344b4863850b), log id: 497b0b5d
>2014-08-10 13:16:10,984 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HibernateBrokerVDSCommand] (org.ovirt.thread.pool-8-thread-41) START, HibernateBrokerVDSCommand(HostName = h1, HostId = 9c67d903-8424-4cda-8bb1-3d8652b92d77, vmId=de580b19-e975-426f-80de-6c7daf1f24ab, hibernationVolHandle=7158eae9-4886-4af7-af0b-d668ecee9e4f,00000002-0002-0002-0002-00000000037f,ef7c8ef2-cf66-4f60-a752-f1a79235e2d6,952565e4-a91d-4876-a3b1-ccd5dfe2a8b0,4bd8a1f0-e234-40d6-a71c-9a93818794e4,bb223e58-a6b3-449a-a77a-344b4863850b), log id: 12fa0a51
>2014-08-10 13:16:11,000 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HibernateBrokerVDSCommand] (org.ovirt.thread.pool-8-thread-41) FINISH, HibernateBrokerVDSCommand, log id: 12fa0a51
>2014-08-10 13:16:11,015 INFO  [org.ovirt.engine.core.vdsbroker.HibernateVDSCommand] (org.ovirt.thread.pool-8-thread-41) FINISH, HibernateVDSCommand, log id: 497b0b5d
>2014-08-10 13:16:11,016 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-41) CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type HibernateVm completed, handling the result.
>2014-08-10 13:16:11,017 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-41) CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type HibernateVm succeeded, clearing tasks.
>2014-08-10 13:16:11,031 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-8-thread-41) SPMAsyncTask::ClearAsyncTask: Attempting to clear task 5812d8ec-cc9a-412f-8005-99c507282276
>2014-08-10 13:16:11,035 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-41) START, SPMClearTaskVDSCommand( storagePoolId = 00000002-0002-0002-0002-00000000037f, ignoreFailoverLimit = false, taskId = 5812d8ec-cc9a-412f-8005-99c507282276), log id: 4e9ca165
>2014-08-10 13:16:11,037 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-41) START, HSMClearTaskVDSCommand(HostName = h1, HostId = 9c67d903-8424-4cda-8bb1-3d8652b92d77, taskId=5812d8ec-cc9a-412f-8005-99c507282276), log id: 36053c15
>2014-08-10 13:16:11,130 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-41) FINISH, HSMClearTaskVDSCommand, log id: 36053c15
>2014-08-10 13:16:11,130 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-41) FINISH, SPMClearTaskVDSCommand, log id: 4e9ca165
>2014-08-10 13:16:11,147 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-8-thread-41) BaseAsyncTask::removeTaskFromDB: Removed task 5812d8ec-cc9a-412f-8005-99c507282276 from DataBase
>2014-08-10 13:16:11,148 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-8-thread-41) SPMAsyncTask::ClearAsyncTask: Attempting to clear task 6af997dd-7966-4fa6-8a79-5e5e278f0ef4
>2014-08-10 13:16:11,148 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-41) START, SPMClearTaskVDSCommand( storagePoolId = 00000002-0002-0002-0002-00000000037f, ignoreFailoverLimit = false, taskId = 6af997dd-7966-4fa6-8a79-5e5e278f0ef4), log id: 615680be
>2014-08-10 13:16:11,150 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-41) START, HSMClearTaskVDSCommand(HostName = h1, HostId = 9c67d903-8424-4cda-8bb1-3d8652b92d77, taskId=6af997dd-7966-4fa6-8a79-5e5e278f0ef4), log id: 761e6bde
>2014-08-10 13:16:11,223 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-41) FINISH, HSMClearTaskVDSCommand, log id: 761e6bde
>2014-08-10 13:16:11,223 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (org.ovirt.thread.pool-8-thread-41) FINISH, SPMClearTaskVDSCommand, log id: 615680be
>2014-08-10 13:16:11,230 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (org.ovirt.thread.pool-8-thread-41) BaseAsyncTask::removeTaskFromDB: Removed task 6af997dd-7966-4fa6-8a79-5e5e278f0ef4 from DataBase
>2014-08-10 13:16:11,230 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-41) CommandAsyncTask::HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks object for entity 8ae74d40-2c2e-4226-9dd4-08ed57a8d4ad
>2014-08-10 13:16:12,998 INFO  [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-72) VM vm4 de580b19-e975-426f-80de-6c7daf1f24ab moved from SavingState --> Up
>2014-08-10 13:17:40,799 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (DefaultQuartzScheduler_Worker-79) Setting new tasks map. The map contains now 0 tasks
>2014-08-10 13:17:40,800 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (DefaultQuartzScheduler_Worker-79) Cleared all tasks of pool 00000002-0002-0002-0002-00000000037f.
>2014-08-10 13:41:43,696 WARN  [org.ovirt.engine.core.bll.AddVdsCommand] (http--0.0.0.0-8080-1) [5bcaa26f] Failed to initiate vdsm-id request on host with message Command returned failure code 127 during SSH session 'root@galactica.tlv.redhat.com'
>2014-08-10 13:41:43,718 INFO  [org.ovirt.engine.core.bll.AddVdsCommand] (http--0.0.0.0-8080-1) [5bcaa26f] Running command: AddVdsCommand internal: false. Entities affected :  ID: 00000001-0001-0001-0001-00000000039f Type: VdsGroupsAction group CREATE_HOST with role type ADMIN
>2014-08-10 13:41:43,753 INFO  [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (http--0.0.0.0-8080-1) [e68096c] Running command: AddVdsSpmIdCommand internal: true. Entities affected :  ID: 0472f9c2-dacf-4393-9fc3-5840ef369e1f Type: VDS
>2014-08-10 13:41:43,785 INFO  [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (http--0.0.0.0-8080-1) [e68096c] Lock freed to object EngineLock [exclusiveLocks= key: 00000002-0002-0002-0002-00000000037f value: REGISTER_VDS
>, sharedLocks= ]
>2014-08-10 13:41:43,788 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (http--0.0.0.0-8080-1) [e68096c] START, RemoveVdsVDSCommand(HostName = h2, HostId = 0472f9c2-dacf-4393-9fc3-5840ef369e1f), log id: 66fa7005
>2014-08-10 13:41:43,789 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (http--0.0.0.0-8080-1) [e68096c] FINISH, RemoveVdsVDSCommand, log id: 66fa7005
>2014-08-10 13:41:43,790 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (http--0.0.0.0-8080-1) [e68096c] START, AddVdsVDSCommand(HostName = h2, HostId = 0472f9c2-dacf-4393-9fc3-5840ef369e1f), log id: 1d94d886
>2014-08-10 13:41:43,791 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (http--0.0.0.0-8080-1) [e68096c] AddVds - entered , starting logic to add VDS 0472f9c2-dacf-4393-9fc3-5840ef369e1f
>2014-08-10 13:41:43,792 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (http--0.0.0.0-8080-1) [e68096c] AddVds - VDS 0472f9c2-dacf-4393-9fc3-5840ef369e1f was added, will try to add it to the resource manager
>2014-08-10 13:41:43,793 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (http--0.0.0.0-8080-1) [e68096c] Entered VdsManager constructor
>2014-08-10 13:41:43,804 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (http--0.0.0.0-8080-1) [e68096c] Initialize vdsBroker (galactica.tlv.redhat.com,54,321)
>2014-08-10 13:41:43,835 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (http--0.0.0.0-8080-1) [e68096c] VDS 0472f9c2-dacf-4393-9fc3-5840ef369e1f was added to the Resource Manager
>2014-08-10 13:41:43,836 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (http--0.0.0.0-8080-1) [e68096c] FINISH, AddVdsVDSCommand, log id: 1d94d886
>2014-08-10 13:41:43,840 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (http--0.0.0.0-8080-1) [e68096c] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Failed to verify Power Management configuration for Host h2.
>2014-08-10 13:41:43,870 INFO  [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] Lock Acquired to object EngineLock [exclusiveLocks= key: 0472f9c2-dacf-4393-9fc3-5840ef369e1f value: VDS
>, sharedLocks= ]
>2014-08-10 13:41:43,876 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (http--0.0.0.0-8080-1) [e68096c] Correlation ID: 5bcaa26f, Job ID: 883a39a1-f2d4-4989-a14f-c5224f128730, Call Stack: null, Custom Event ID: -1, Message: Host h2 was added by admin.
>2014-08-10 13:41:43,901 INFO  [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] Running command: InstallVdsInternalCommand internal: true. Entities affected :  ID: 0472f9c2-dacf-4393-9fc3-5840ef369e1f Type: VDS
>2014-08-10 13:41:43,906 INFO  [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] Before Installation host 0472f9c2-dacf-4393-9fc3-5840ef369e1f, h2
>2014-08-10 13:41:43,910 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] START, SetVdsStatusVDSCommand(HostName = h2, HostId = 0472f9c2-dacf-4393-9fc3-5840ef369e1f, status=Installing, nonOperationalReason=NONE, stopSpmFailureLogged=false), log id: 5aa57f9d
>2014-08-10 13:41:43,917 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] FINISH, SetVdsStatusVDSCommand, log id: 5aa57f9d
>2014-08-10 13:41:43,955 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] Installation galactica.tlv.redhat.com: Connected to host galactica.tlv.redhat.com with SSH key fingerprint: af:6b:19:0c:de:1c:76:eb:a5:97:b3:fa:05:62:84:04
>2014-08-10 13:41:43,975 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] Correlation ID: 450fbc5c, Call Stack: null, Custom Event ID: -1, Message: Installing Host h2. Connected to host galactica.tlv.redhat.com with SSH key fingerprint: af:6b:19:0c:de:1c:76:eb:a5:97:b3:fa:05:62:84:04.
>2014-08-10 13:41:44,035 INFO  [org.ovirt.engine.core.bll.VdsDeploy] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] Installation of galactica.tlv.redhat.com. Executing command via SSH umask 0077; MYTMP="$(TMPDIR="${OVIRT_TMPDIR}" mktemp -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; rm -fr "${MYTMP}" && mkdir "${MYTMP}" && tar --warning=no-timestamp -C "${MYTMP}" -x &&  "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True < /home/vvolansk/ovirt-engine/var/cache/ovirt-engine/ovirt-host-deploy.tar
>2014-08-10 13:41:44,183 INFO  [org.ovirt.engine.core.utils.archivers.tar.CachedTar] (org.ovirt.thread.pool-8-thread-1) Tarball '/home/vvolansk/ovirt-engine/var/cache/ovirt-engine/ovirt-host-deploy.tar' is out of date, re-creating
>2014-08-10 13:41:45,118 INFO  [org.ovirt.engine.core.uutils.ssh.SSHDialog] (org.ovirt.thread.pool-8-thread-1) SSH execute root@galactica.tlv.redhat.com 'umask 0077; MYTMP="$(TMPDIR="${OVIRT_TMPDIR}" mktemp -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; rm -fr "${MYTMP}" && mkdir "${MYTMP}" && tar --warning=no-timestamp -C "${MYTMP}" -x &&  "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True'
>2014-08-10 13:41:45,143 ERROR [org.ovirt.engine.core.bll.VdsDeploy] (VdsDeploy) Error during deploy dialog: java.io.IOException: Unexpected connection termination
>	at org.ovirt.otopi.dialog.MachineDialogParser.nextEvent(MachineDialogParser.java:388) [otopi.jar:]
>	at org.ovirt.otopi.dialog.MachineDialogParser.nextEvent(MachineDialogParser.java:405) [otopi.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy._threadMain(VdsDeploy.java:818) [bll.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy.access$2000(VdsDeploy.java:83) [bll.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy$51.run(VdsDeploy.java:966) [bll.jar:]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:41:45,144 ERROR [org.ovirt.engine.core.uutils.ssh.SSHDialog] (org.ovirt.thread.pool-8-thread-1) Swallowing exception as preferring stderr: java.io.IOException: Command returned failure code 127 during SSH session 'root@galactica.tlv.redhat.com'
>	at org.ovirt.engine.core.uutils.ssh.SSHClient.executeCommand(SSHClient.java:527) [uutils.jar:]
>	at org.ovirt.engine.core.uutils.ssh.SSHDialog.executeCommand(SSHDialog.java:318) [uutils.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy.execute(VdsDeploy.java:1115) [bll.jar:]
>	at org.ovirt.engine.core.bll.InstallVdsInternalCommand.installHost(InstallVdsInternalCommand.java:151) [bll.jar:]
>	at org.ovirt.engine.core.bll.InstallVdsInternalCommand.executeCommand(InstallVdsInternalCommand.java:78) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeWithoutTransaction(CommandBase.java:1163) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeActionInTransactionScope(CommandBase.java:1290) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1910) [bll.jar:]
>	at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInSuppressed(TransactionSupport.java:174) [utils.jar:]
>	at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInScope(TransactionSupport.java:116) [utils.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.execute(CommandBase.java:1311) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeAction(CommandBase.java:347) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runAction(Backend.java:430) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runActionImpl(Backend.java:411) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runInternalAction(Backend.java:616) [bll.jar:]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_25]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_25]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_25]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_25]
>	at org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:374) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.delegateInterception(Jsr299BindingsInterceptor.java:114) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.doMethodInterception(Jsr299BindingsInterceptor.java:125) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.processInvocation(Jsr299BindingsInterceptor.java:135) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.ejb.EjbRequestScopeActivationInterceptor.processInvocation(EjbRequestScopeActivationInterceptor.java:82) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.singleton.SingletonComponentInstanceAssociationInterceptor.processInvocation(SingletonComponentInstanceAssociationInterceptor.java:53) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInNoTx(CMTTxInterceptor.java:211) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.supports(CMTTxInterceptor.java:363) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:194) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:59) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.ViewDescription$1.processInvocation(ViewDescription.java:173) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ProxyInvocationHandler.invoke(ProxyInvocationHandler.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.ovirt.engine.core.bll.interfaces.BackendInternal$$$view7.runInternalAction(Unknown Source) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.runInternalAction(CommandBase.java:2239) [bll.jar:]
>	at org.ovirt.engine.core.bll.AddVdsCommand$3.run(AddVdsCommand.java:195) [bll.jar:]
>	at org.ovirt.engine.core.utils.threadpool.ThreadPoolUtil$InternalWrapperRunnable.run(ThreadPoolUtil.java:90) [utils.jar:]
>	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) [rt.jar:1.7.0_25]
>	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334) [rt.jar:1.7.0_25]
>	at java.util.concurrent.FutureTask.run(FutureTask.java:166) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_25]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:41:45,184 ERROR [org.ovirt.engine.core.uutils.ssh.SSHDialog] (org.ovirt.thread.pool-8-thread-1) SSH error running command root@galactica.tlv.redhat.com:'umask 0077; MYTMP="$(TMPDIR="${OVIRT_TMPDIR}" mktemp -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; rm -fr "${MYTMP}" && mkdir "${MYTMP}" && tar --warning=no-timestamp -C "${MYTMP}" -x &&  "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True': java.lang.RuntimeException: Unexpected error during execution: bash: tar: command not found
>
>	at org.ovirt.engine.core.uutils.ssh.SSHDialog.executeCommand(SSHDialog.java:337) [uutils.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy.execute(VdsDeploy.java:1115) [bll.jar:]
>	at org.ovirt.engine.core.bll.InstallVdsInternalCommand.installHost(InstallVdsInternalCommand.java:151) [bll.jar:]
>	at org.ovirt.engine.core.bll.InstallVdsInternalCommand.executeCommand(InstallVdsInternalCommand.java:78) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeWithoutTransaction(CommandBase.java:1163) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeActionInTransactionScope(CommandBase.java:1290) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1910) [bll.jar:]
>	at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInSuppressed(TransactionSupport.java:174) [utils.jar:]
>	at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInScope(TransactionSupport.java:116) [utils.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.execute(CommandBase.java:1311) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeAction(CommandBase.java:347) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runAction(Backend.java:430) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runActionImpl(Backend.java:411) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runInternalAction(Backend.java:616) [bll.jar:]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_25]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_25]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_25]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_25]
>	at org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:374) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.delegateInterception(Jsr299BindingsInterceptor.java:114) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.doMethodInterception(Jsr299BindingsInterceptor.java:125) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.processInvocation(Jsr299BindingsInterceptor.java:135) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.ejb.EjbRequestScopeActivationInterceptor.processInvocation(EjbRequestScopeActivationInterceptor.java:82) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.singleton.SingletonComponentInstanceAssociationInterceptor.processInvocation(SingletonComponentInstanceAssociationInterceptor.java:53) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInNoTx(CMTTxInterceptor.java:211) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.supports(CMTTxInterceptor.java:363) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:194) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:59) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.ViewDescription$1.processInvocation(ViewDescription.java:173) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ProxyInvocationHandler.invoke(ProxyInvocationHandler.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.ovirt.engine.core.bll.interfaces.BackendInternal$$$view7.runInternalAction(Unknown Source) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.runInternalAction(CommandBase.java:2239) [bll.jar:]
>	at org.ovirt.engine.core.bll.AddVdsCommand$3.run(AddVdsCommand.java:195) [bll.jar:]
>	at org.ovirt.engine.core.utils.threadpool.ThreadPoolUtil$InternalWrapperRunnable.run(ThreadPoolUtil.java:90) [utils.jar:]
>	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) [rt.jar:1.7.0_25]
>	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334) [rt.jar:1.7.0_25]
>	at java.util.concurrent.FutureTask.run(FutureTask.java:166) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_25]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:41:45,204 ERROR [org.ovirt.engine.core.bll.VdsDeploy] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] Error during host galactica.tlv.redhat.com install: java.lang.RuntimeException: Unexpected error during execution: bash: tar: command not found
>
>	at org.ovirt.engine.core.uutils.ssh.SSHDialog.executeCommand(SSHDialog.java:337) [uutils.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy.execute(VdsDeploy.java:1115) [bll.jar:]
>	at org.ovirt.engine.core.bll.InstallVdsInternalCommand.installHost(InstallVdsInternalCommand.java:151) [bll.jar:]
>	at org.ovirt.engine.core.bll.InstallVdsInternalCommand.executeCommand(InstallVdsInternalCommand.java:78) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeWithoutTransaction(CommandBase.java:1163) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeActionInTransactionScope(CommandBase.java:1290) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1910) [bll.jar:]
>	at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInSuppressed(TransactionSupport.java:174) [utils.jar:]
>	at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInScope(TransactionSupport.java:116) [utils.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.execute(CommandBase.java:1311) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeAction(CommandBase.java:347) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runAction(Backend.java:430) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runActionImpl(Backend.java:411) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runInternalAction(Backend.java:616) [bll.jar:]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_25]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_25]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_25]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_25]
>	at org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:374) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.delegateInterception(Jsr299BindingsInterceptor.java:114) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.doMethodInterception(Jsr299BindingsInterceptor.java:125) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.processInvocation(Jsr299BindingsInterceptor.java:135) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.ejb.EjbRequestScopeActivationInterceptor.processInvocation(EjbRequestScopeActivationInterceptor.java:82) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.singleton.SingletonComponentInstanceAssociationInterceptor.processInvocation(SingletonComponentInstanceAssociationInterceptor.java:53) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInNoTx(CMTTxInterceptor.java:211) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.supports(CMTTxInterceptor.java:363) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:194) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:59) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.ViewDescription$1.processInvocation(ViewDescription.java:173) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ProxyInvocationHandler.invoke(ProxyInvocationHandler.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.ovirt.engine.core.bll.interfaces.BackendInternal$$$view7.runInternalAction(Unknown Source) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.runInternalAction(CommandBase.java:2239) [bll.jar:]
>	at org.ovirt.engine.core.bll.AddVdsCommand$3.run(AddVdsCommand.java:195) [bll.jar:]
>	at org.ovirt.engine.core.utils.threadpool.ThreadPoolUtil$InternalWrapperRunnable.run(ThreadPoolUtil.java:90) [utils.jar:]
>	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) [rt.jar:1.7.0_25]
>	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334) [rt.jar:1.7.0_25]
>	at java.util.concurrent.FutureTask.run(FutureTask.java:166) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_25]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:41:45,219 ERROR [org.ovirt.engine.core.bll.InstallerMessages] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] Installation galactica.tlv.redhat.com: Unexpected error during execution: bash: tar: command not found
>
>2014-08-10 13:41:45,242 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] Correlation ID: 450fbc5c, Call Stack: null, Custom Event ID: -1, Message: Failed to install Host h2. Unexpected error during execution: bash: tar: command not found
>.
>2014-08-10 13:41:45,243 ERROR [org.ovirt.engine.core.bll.VdsDeploy] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] Error during host galactica.tlv.redhat.com install, prefering first exception: java.io.IOException: Unexpected connection termination
>	at org.ovirt.otopi.dialog.MachineDialogParser.nextEvent(MachineDialogParser.java:388) [otopi.jar:]
>	at org.ovirt.otopi.dialog.MachineDialogParser.nextEvent(MachineDialogParser.java:405) [otopi.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy._threadMain(VdsDeploy.java:818) [bll.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy.access$2000(VdsDeploy.java:83) [bll.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy$51.run(VdsDeploy.java:966) [bll.jar:]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:41:45,244 ERROR [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] Host installation failed for host 0472f9c2-dacf-4393-9fc3-5840ef369e1f, h2.: java.io.IOException: Unexpected connection termination
>	at org.ovirt.otopi.dialog.MachineDialogParser.nextEvent(MachineDialogParser.java:388) [otopi.jar:]
>	at org.ovirt.otopi.dialog.MachineDialogParser.nextEvent(MachineDialogParser.java:405) [otopi.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy._threadMain(VdsDeploy.java:818) [bll.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy.access$2000(VdsDeploy.java:83) [bll.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy$51.run(VdsDeploy.java:966) [bll.jar:]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:41:45,247 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] START, SetVdsStatusVDSCommand(HostName = h2, HostId = 0472f9c2-dacf-4393-9fc3-5840ef369e1f, status=InstallFailed, nonOperationalReason=NONE, stopSpmFailureLogged=false), log id: 24a545a1
>2014-08-10 13:41:45,259 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] FINISH, SetVdsStatusVDSCommand, log id: 24a545a1
>2014-08-10 13:41:45,275 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] Correlation ID: 450fbc5c, Job ID: 883a39a1-f2d4-4989-a14f-c5224f128730, Call Stack: null, Custom Event ID: -1, Message: Host h2 installation failed. Unexpected connection termination.
>2014-08-10 13:41:45,284 INFO  [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-1) [450fbc5c] Lock freed to object EngineLock [exclusiveLocks= key: 0472f9c2-dacf-4393-9fc3-5840ef369e1f value: VDS
>, sharedLocks= ]
>2014-08-10 13:41:46,836 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-40) Initializing Host: h2
>2014-08-10 13:42:00,698 WARN  [org.ovirt.engine.core.bll.MaintenanceNumberOfVdssCommand] (http--0.0.0.0-8080-1) [4c70eca8] CanDoAction of action MaintenanceNumberOfVdss failed. Reasons:VAR__TYPE__HOST,VAR__ACTION__MAINTENANCE,VDS_CANNOT_MAINTENANCE_VDS_IS_NOT_OPERATIONAL
>2014-08-10 13:42:08,678 INFO  [org.ovirt.engine.core.bll.RemoveVdsCommand] (http--0.0.0.0-8080-1) [3404c93e] Lock Acquired to object EngineLock [exclusiveLocks= key: 0472f9c2-dacf-4393-9fc3-5840ef369e1f value: VDS
>, sharedLocks= ]
>2014-08-10 13:42:08,686 INFO  [org.ovirt.engine.core.bll.RemoveVdsCommand] (org.ovirt.thread.pool-8-thread-38) [3404c93e] Running command: RemoveVdsCommand internal: false. Entities affected :  ID: 0472f9c2-dacf-4393-9fc3-5840ef369e1f Type: VDSAction group DELETE_HOST with role type ADMIN
>2014-08-10 13:42:08,815 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (org.ovirt.thread.pool-8-thread-38) [3404c93e] START, RemoveVdsVDSCommand( HostId = 0472f9c2-dacf-4393-9fc3-5840ef369e1f), log id: 20169f4c
>2014-08-10 13:42:08,815 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (org.ovirt.thread.pool-8-thread-38) [3404c93e] vdsManager::disposing
>2014-08-10 13:42:08,821 INFO  [org.ovirt.vdsm.jsonrpc.client.reactors.stomp.StompCommonClient] (org.ovirt.thread.pool-8-thread-38) Message sent: UNSUBSCRIBE
>id:null
>
>
>2014-08-10 13:42:08,821 INFO  [org.ovirt.vdsm.jsonrpc.client.reactors.stomp.StompCommonClient] (org.ovirt.thread.pool-8-thread-38) Message sent: DISCONNECT
>receipt:cbb14eb7-69da-4b45-a872-d91ea2f59a68
>
>
>2014-08-10 13:42:08,822 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (org.ovirt.thread.pool-8-thread-38) [3404c93e] FINISH, RemoveVdsVDSCommand, log id: 20169f4c
>2014-08-10 13:42:08,830 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-38) [3404c93e] Correlation ID: 3404c93e, Call Stack: null, Custom Event ID: -1, Message: Host h2 was removed by admin.
>2014-08-10 13:42:08,831 INFO  [org.ovirt.engine.core.bll.RemoveVdsCommand] (org.ovirt.thread.pool-8-thread-38) [3404c93e] Lock freed to object EngineLock [exclusiveLocks= key: 0472f9c2-dacf-4393-9fc3-5840ef369e1f value: VDS
>, sharedLocks= ]
>2014-08-10 13:45:13,237 WARN  [org.ovirt.engine.core.bll.AddVdsCommand] (http--0.0.0.0-8080-1) [65960527] Failed to initiate vdsm-id request on host with message Command returned failure code 127 during SSH session 'root@galactica.tlv.redhat.com'
>2014-08-10 13:45:13,264 INFO  [org.ovirt.engine.core.bll.AddVdsCommand] (http--0.0.0.0-8080-1) [65960527] Running command: AddVdsCommand internal: false. Entities affected :  ID: 8fc43cd8-abe9-4ee7-834b-6416aed91c63 Type: VdsGroupsAction group CREATE_HOST with role type ADMIN
>2014-08-10 13:45:13,282 INFO  [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (http--0.0.0.0-8080-1) [2c3ef0fd] Running command: AddVdsSpmIdCommand internal: true. Entities affected :  ID: 7140a009-99a5-4aa6-b769-4299ed51b873 Type: VDS
>2014-08-10 13:45:13,289 INFO  [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (http--0.0.0.0-8080-1) [2c3ef0fd] Lock freed to object EngineLock [exclusiveLocks= key: 76bcbfe3-3419-4fdb-9b89-d147b7fdef99 value: REGISTER_VDS
>, sharedLocks= ]
>2014-08-10 13:45:13,291 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (http--0.0.0.0-8080-1) [2c3ef0fd] START, RemoveVdsVDSCommand(HostName = h2, HostId = 7140a009-99a5-4aa6-b769-4299ed51b873), log id: 14441339
>2014-08-10 13:45:13,291 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (http--0.0.0.0-8080-1) [2c3ef0fd] FINISH, RemoveVdsVDSCommand, log id: 14441339
>2014-08-10 13:45:13,292 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (http--0.0.0.0-8080-1) [2c3ef0fd] START, AddVdsVDSCommand(HostName = h2, HostId = 7140a009-99a5-4aa6-b769-4299ed51b873), log id: eaa5640
>2014-08-10 13:45:13,293 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (http--0.0.0.0-8080-1) [2c3ef0fd] AddVds - entered , starting logic to add VDS 7140a009-99a5-4aa6-b769-4299ed51b873
>2014-08-10 13:45:13,294 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (http--0.0.0.0-8080-1) [2c3ef0fd] AddVds - VDS 7140a009-99a5-4aa6-b769-4299ed51b873 was added, will try to add it to the resource manager
>2014-08-10 13:45:13,295 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (http--0.0.0.0-8080-1) [2c3ef0fd] Entered VdsManager constructor
>2014-08-10 13:45:13,301 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (http--0.0.0.0-8080-1) [2c3ef0fd] Initialize vdsBroker (galactica.tlv.redhat.com,54,321)
>2014-08-10 13:45:13,301 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (http--0.0.0.0-8080-1) [2c3ef0fd] VDS 7140a009-99a5-4aa6-b769-4299ed51b873 was added to the Resource Manager
>2014-08-10 13:45:13,302 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (http--0.0.0.0-8080-1) [2c3ef0fd] FINISH, AddVdsVDSCommand, log id: eaa5640
>2014-08-10 13:45:13,304 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (http--0.0.0.0-8080-1) [2c3ef0fd] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Failed to verify Power Management configuration for Host h2.
>2014-08-10 13:45:13,330 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (http--0.0.0.0-8080-1) [2c3ef0fd] Correlation ID: 65960527, Job ID: 44baca53-7555-49cf-ae02-d16d1719d1cb, Call Stack: null, Custom Event ID: -1, Message: Host h2 was added by admin.
>2014-08-10 13:45:13,339 INFO  [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-22) [73e3795a] Lock Acquired to object EngineLock [exclusiveLocks= key: 7140a009-99a5-4aa6-b769-4299ed51b873 value: VDS
>, sharedLocks= ]
>2014-08-10 13:45:13,355 INFO  [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-22) [73e3795a] Running command: InstallVdsInternalCommand internal: true. Entities affected :  ID: 7140a009-99a5-4aa6-b769-4299ed51b873 Type: VDS
>2014-08-10 13:45:13,356 INFO  [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-22) [73e3795a] Before Installation host 7140a009-99a5-4aa6-b769-4299ed51b873, h2
>2014-08-10 13:45:13,359 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-22) [73e3795a] START, SetVdsStatusVDSCommand(HostName = h2, HostId = 7140a009-99a5-4aa6-b769-4299ed51b873, status=Installing, nonOperationalReason=NONE, stopSpmFailureLogged=false), log id: 212e6117
>2014-08-10 13:45:13,372 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-22) [73e3795a] FINISH, SetVdsStatusVDSCommand, log id: 212e6117
>2014-08-10 13:45:13,402 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (org.ovirt.thread.pool-8-thread-22) [73e3795a] Installation galactica.tlv.redhat.com: Connected to host galactica.tlv.redhat.com with SSH key fingerprint: af:6b:19:0c:de:1c:76:eb:a5:97:b3:fa:05:62:84:04
>2014-08-10 13:45:13,430 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-22) [73e3795a] Correlation ID: 73e3795a, Call Stack: null, Custom Event ID: -1, Message: Installing Host h2. Connected to host galactica.tlv.redhat.com with SSH key fingerprint: af:6b:19:0c:de:1c:76:eb:a5:97:b3:fa:05:62:84:04.
>2014-08-10 13:45:13,482 INFO  [org.ovirt.engine.core.bll.VdsDeploy] (org.ovirt.thread.pool-8-thread-22) [73e3795a] Installation of galactica.tlv.redhat.com. Executing command via SSH umask 0077; MYTMP="$(TMPDIR="${OVIRT_TMPDIR}" mktemp -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; rm -fr "${MYTMP}" && mkdir "${MYTMP}" && tar --warning=no-timestamp -C "${MYTMP}" -x &&  "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True < /home/vvolansk/ovirt-engine/var/cache/ovirt-engine/ovirt-host-deploy.tar
>2014-08-10 13:45:13,488 INFO  [org.ovirt.engine.core.uutils.ssh.SSHDialog] (org.ovirt.thread.pool-8-thread-22) SSH execute root@galactica.tlv.redhat.com 'umask 0077; MYTMP="$(TMPDIR="${OVIRT_TMPDIR}" mktemp -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; rm -fr "${MYTMP}" && mkdir "${MYTMP}" && tar --warning=no-timestamp -C "${MYTMP}" -x &&  "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True'
>2014-08-10 13:45:13,510 ERROR [org.ovirt.engine.core.bll.VdsDeploy] (VdsDeploy) Error during deploy dialog: java.io.IOException: Unexpected connection termination
>	at org.ovirt.otopi.dialog.MachineDialogParser.nextEvent(MachineDialogParser.java:388) [otopi.jar:]
>	at org.ovirt.otopi.dialog.MachineDialogParser.nextEvent(MachineDialogParser.java:405) [otopi.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy._threadMain(VdsDeploy.java:818) [bll.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy.access$2000(VdsDeploy.java:83) [bll.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy$51.run(VdsDeploy.java:966) [bll.jar:]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:45:13,512 ERROR [org.ovirt.engine.core.uutils.ssh.SSHDialog] (org.ovirt.thread.pool-8-thread-22) Swallowing exception as preferring stderr: java.io.IOException: Command returned failure code 127 during SSH session 'root@galactica.tlv.redhat.com'
>	at org.ovirt.engine.core.uutils.ssh.SSHClient.executeCommand(SSHClient.java:527) [uutils.jar:]
>	at org.ovirt.engine.core.uutils.ssh.SSHDialog.executeCommand(SSHDialog.java:318) [uutils.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy.execute(VdsDeploy.java:1115) [bll.jar:]
>	at org.ovirt.engine.core.bll.InstallVdsInternalCommand.installHost(InstallVdsInternalCommand.java:151) [bll.jar:]
>	at org.ovirt.engine.core.bll.InstallVdsInternalCommand.executeCommand(InstallVdsInternalCommand.java:78) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeWithoutTransaction(CommandBase.java:1163) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeActionInTransactionScope(CommandBase.java:1290) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1910) [bll.jar:]
>	at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInSuppressed(TransactionSupport.java:174) [utils.jar:]
>	at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInScope(TransactionSupport.java:116) [utils.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.execute(CommandBase.java:1311) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeAction(CommandBase.java:347) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runAction(Backend.java:430) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runActionImpl(Backend.java:411) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runInternalAction(Backend.java:616) [bll.jar:]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_25]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_25]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_25]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_25]
>	at org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:374) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.delegateInterception(Jsr299BindingsInterceptor.java:114) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.doMethodInterception(Jsr299BindingsInterceptor.java:125) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.processInvocation(Jsr299BindingsInterceptor.java:135) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.ejb.EjbRequestScopeActivationInterceptor.processInvocation(EjbRequestScopeActivationInterceptor.java:82) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.singleton.SingletonComponentInstanceAssociationInterceptor.processInvocation(SingletonComponentInstanceAssociationInterceptor.java:53) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInNoTx(CMTTxInterceptor.java:211) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.supports(CMTTxInterceptor.java:363) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:194) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:59) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.ViewDescription$1.processInvocation(ViewDescription.java:173) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ProxyInvocationHandler.invoke(ProxyInvocationHandler.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.ovirt.engine.core.bll.interfaces.BackendInternal$$$view7.runInternalAction(Unknown Source) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.runInternalAction(CommandBase.java:2239) [bll.jar:]
>	at org.ovirt.engine.core.bll.AddVdsCommand$3.run(AddVdsCommand.java:195) [bll.jar:]
>	at org.ovirt.engine.core.utils.threadpool.ThreadPoolUtil$InternalWrapperRunnable.run(ThreadPoolUtil.java:90) [utils.jar:]
>	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) [rt.jar:1.7.0_25]
>	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334) [rt.jar:1.7.0_25]
>	at java.util.concurrent.FutureTask.run(FutureTask.java:166) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_25]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:45:13,530 ERROR [org.ovirt.engine.core.uutils.ssh.SSHDialog] (org.ovirt.thread.pool-8-thread-22) SSH error running command root@galactica.tlv.redhat.com:'umask 0077; MYTMP="$(TMPDIR="${OVIRT_TMPDIR}" mktemp -t ovirt-XXXXXXXXXX)"; trap "chmod -R u+rwX \"${MYTMP}\" > /dev/null 2>&1; rm -fr \"${MYTMP}\" > /dev/null 2>&1" 0; rm -fr "${MYTMP}" && mkdir "${MYTMP}" && tar --warning=no-timestamp -C "${MYTMP}" -x &&  "${MYTMP}"/setup DIALOG/dialect=str:machine DIALOG/customization=bool:True': java.lang.RuntimeException: Unexpected error during execution: bash: tar: command not found
>
>	at org.ovirt.engine.core.uutils.ssh.SSHDialog.executeCommand(SSHDialog.java:337) [uutils.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy.execute(VdsDeploy.java:1115) [bll.jar:]
>	at org.ovirt.engine.core.bll.InstallVdsInternalCommand.installHost(InstallVdsInternalCommand.java:151) [bll.jar:]
>	at org.ovirt.engine.core.bll.InstallVdsInternalCommand.executeCommand(InstallVdsInternalCommand.java:78) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeWithoutTransaction(CommandBase.java:1163) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeActionInTransactionScope(CommandBase.java:1290) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1910) [bll.jar:]
>	at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInSuppressed(TransactionSupport.java:174) [utils.jar:]
>	at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInScope(TransactionSupport.java:116) [utils.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.execute(CommandBase.java:1311) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeAction(CommandBase.java:347) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runAction(Backend.java:430) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runActionImpl(Backend.java:411) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runInternalAction(Backend.java:616) [bll.jar:]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_25]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_25]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_25]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_25]
>	at org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:374) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.delegateInterception(Jsr299BindingsInterceptor.java:114) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.doMethodInterception(Jsr299BindingsInterceptor.java:125) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.processInvocation(Jsr299BindingsInterceptor.java:135) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.ejb.EjbRequestScopeActivationInterceptor.processInvocation(EjbRequestScopeActivationInterceptor.java:82) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.singleton.SingletonComponentInstanceAssociationInterceptor.processInvocation(SingletonComponentInstanceAssociationInterceptor.java:53) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInNoTx(CMTTxInterceptor.java:211) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.supports(CMTTxInterceptor.java:363) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:194) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:59) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.ViewDescription$1.processInvocation(ViewDescription.java:173) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ProxyInvocationHandler.invoke(ProxyInvocationHandler.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.ovirt.engine.core.bll.interfaces.BackendInternal$$$view7.runInternalAction(Unknown Source) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.runInternalAction(CommandBase.java:2239) [bll.jar:]
>	at org.ovirt.engine.core.bll.AddVdsCommand$3.run(AddVdsCommand.java:195) [bll.jar:]
>	at org.ovirt.engine.core.utils.threadpool.ThreadPoolUtil$InternalWrapperRunnable.run(ThreadPoolUtil.java:90) [utils.jar:]
>	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) [rt.jar:1.7.0_25]
>	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334) [rt.jar:1.7.0_25]
>	at java.util.concurrent.FutureTask.run(FutureTask.java:166) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_25]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:45:13,549 ERROR [org.ovirt.engine.core.bll.VdsDeploy] (org.ovirt.thread.pool-8-thread-22) [73e3795a] Error during host galactica.tlv.redhat.com install: java.lang.RuntimeException: Unexpected error during execution: bash: tar: command not found
>
>	at org.ovirt.engine.core.uutils.ssh.SSHDialog.executeCommand(SSHDialog.java:337) [uutils.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy.execute(VdsDeploy.java:1115) [bll.jar:]
>	at org.ovirt.engine.core.bll.InstallVdsInternalCommand.installHost(InstallVdsInternalCommand.java:151) [bll.jar:]
>	at org.ovirt.engine.core.bll.InstallVdsInternalCommand.executeCommand(InstallVdsInternalCommand.java:78) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeWithoutTransaction(CommandBase.java:1163) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeActionInTransactionScope(CommandBase.java:1290) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1910) [bll.jar:]
>	at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInSuppressed(TransactionSupport.java:174) [utils.jar:]
>	at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInScope(TransactionSupport.java:116) [utils.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.execute(CommandBase.java:1311) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.executeAction(CommandBase.java:347) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runAction(Backend.java:430) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runActionImpl(Backend.java:411) [bll.jar:]
>	at org.ovirt.engine.core.bll.Backend.runInternalAction(Backend.java:616) [bll.jar:]
>	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_25]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_25]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_25]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_25]
>	at org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:374) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.delegateInterception(Jsr299BindingsInterceptor.java:114) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.doMethodInterception(Jsr299BindingsInterceptor.java:125) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.processInvocation(Jsr299BindingsInterceptor.java:135) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.weld.ejb.EjbRequestScopeActivationInterceptor.processInvocation(EjbRequestScopeActivationInterceptor.java:82) [jboss-as-weld-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.singleton.SingletonComponentInstanceAssociationInterceptor.processInvocation(SingletonComponentInstanceAssociationInterceptor.java:53) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInNoTx(CMTTxInterceptor.java:211) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.supports(CMTTxInterceptor.java:363) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:194) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:59) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.as.ee.component.ViewDescription$1.processInvocation(ViewDescription.java:173) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
>	at org.jboss.as.ee.component.ProxyInvocationHandler.invoke(ProxyInvocationHandler.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
>	at org.ovirt.engine.core.bll.interfaces.BackendInternal$$$view7.runInternalAction(Unknown Source) [bll.jar:]
>	at org.ovirt.engine.core.bll.CommandBase.runInternalAction(CommandBase.java:2239) [bll.jar:]
>	at org.ovirt.engine.core.bll.AddVdsCommand$3.run(AddVdsCommand.java:195) [bll.jar:]
>	at org.ovirt.engine.core.utils.threadpool.ThreadPoolUtil$InternalWrapperRunnable.run(ThreadPoolUtil.java:90) [utils.jar:]
>	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) [rt.jar:1.7.0_25]
>	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334) [rt.jar:1.7.0_25]
>	at java.util.concurrent.FutureTask.run(FutureTask.java:166) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_25]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_25]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:45:13,567 ERROR [org.ovirt.engine.core.bll.InstallerMessages] (org.ovirt.thread.pool-8-thread-22) [73e3795a] Installation galactica.tlv.redhat.com: Unexpected error during execution: bash: tar: command not found
>
>2014-08-10 13:45:13,579 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-22) [73e3795a] Correlation ID: 73e3795a, Call Stack: null, Custom Event ID: -1, Message: Failed to install Host h2. Unexpected error during execution: bash: tar: command not found
>.
>2014-08-10 13:45:13,579 ERROR [org.ovirt.engine.core.bll.VdsDeploy] (org.ovirt.thread.pool-8-thread-22) [73e3795a] Error during host galactica.tlv.redhat.com install, prefering first exception: java.io.IOException: Unexpected connection termination
>	at org.ovirt.otopi.dialog.MachineDialogParser.nextEvent(MachineDialogParser.java:388) [otopi.jar:]
>	at org.ovirt.otopi.dialog.MachineDialogParser.nextEvent(MachineDialogParser.java:405) [otopi.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy._threadMain(VdsDeploy.java:818) [bll.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy.access$2000(VdsDeploy.java:83) [bll.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy$51.run(VdsDeploy.java:966) [bll.jar:]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:45:13,581 ERROR [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-22) [73e3795a] Host installation failed for host 7140a009-99a5-4aa6-b769-4299ed51b873, h2.: java.io.IOException: Unexpected connection termination
>	at org.ovirt.otopi.dialog.MachineDialogParser.nextEvent(MachineDialogParser.java:388) [otopi.jar:]
>	at org.ovirt.otopi.dialog.MachineDialogParser.nextEvent(MachineDialogParser.java:405) [otopi.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy._threadMain(VdsDeploy.java:818) [bll.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy.access$2000(VdsDeploy.java:83) [bll.jar:]
>	at org.ovirt.engine.core.bll.VdsDeploy$51.run(VdsDeploy.java:966) [bll.jar:]
>	at java.lang.Thread.run(Thread.java:724) [rt.jar:1.7.0_25]
>
>2014-08-10 13:45:13,583 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-22) [73e3795a] START, SetVdsStatusVDSCommand(HostName = h2, HostId = 7140a009-99a5-4aa6-b769-4299ed51b873, status=InstallFailed, nonOperationalReason=NONE, stopSpmFailureLogged=false), log id: 1ab334c1
>2014-08-10 13:45:13,595 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-22) [73e3795a] FINISH, SetVdsStatusVDSCommand, log id: 1ab334c1
>2014-08-10 13:45:13,603 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-22) [73e3795a] Correlation ID: 73e3795a, Job ID: 44baca53-7555-49cf-ae02-d16d1719d1cb, Call Stack: null, Custom Event ID: -1, Message: Host h2 installation failed. Unexpected connection termination.
>2014-08-10 13:45:13,612 INFO  [org.ovirt.engine.core.bll.InstallVdsInternalCommand] (org.ovirt.thread.pool-8-thread-22) [73e3795a] Lock freed to object EngineLock [exclusiveLocks= key: 7140a009-99a5-4aa6-b769-4299ed51b873 value: VDS
>, sharedLocks= ]
>2014-08-10 13:45:16,303 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-66) Initializing Host: h2
>2014-08-10 13:46:04,876 INFO  [org.ovirt.engine.core.bll.RemoveVdsCommand] (http--0.0.0.0-8080-1) [11b8aae7] Lock Acquired to object EngineLock [exclusiveLocks= key: 7140a009-99a5-4aa6-b769-4299ed51b873 value: VDS
>, sharedLocks= ]
>2014-08-10 13:46:04,881 INFO  [org.ovirt.engine.core.bll.RemoveVdsCommand] (org.ovirt.thread.pool-8-thread-34) [11b8aae7] Running command: RemoveVdsCommand internal: false. Entities affected :  ID: 7140a009-99a5-4aa6-b769-4299ed51b873 Type: VDSAction group DELETE_HOST with role type ADMIN
>2014-08-10 13:46:04,993 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (org.ovirt.thread.pool-8-thread-34) [11b8aae7] START, RemoveVdsVDSCommand( HostId = 7140a009-99a5-4aa6-b769-4299ed51b873), log id: 3ad35eef
>2014-08-10 13:46:04,993 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (org.ovirt.thread.pool-8-thread-34) [11b8aae7] vdsManager::disposing
>2014-08-10 13:46:04,994 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (org.ovirt.thread.pool-8-thread-34) [11b8aae7] FINISH, RemoveVdsVDSCommand, log id: 3ad35eef
>2014-08-10 13:46:05,000 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-34) [11b8aae7] Correlation ID: 11b8aae7, Call Stack: null, Custom Event ID: -1, Message: Host h2 was removed by admin.
>2014-08-10 13:46:05,001 INFO  [org.ovirt.engine.core.bll.RemoveVdsCommand] (org.ovirt.thread.pool-8-thread-34) [11b8aae7] Lock freed to object EngineLock [exclusiveLocks= key: 7140a009-99a5-4aa6-b769-4299ed51b873 value: VDS
>, sharedLocks= ]

Actions: View

Attachments on bug 1128417: 925486 | 925487 | 925636 | 925824 | 925836 | 925837 | 925838 | 925969 | 925970 | 925973 | 925974 | 925975