Attachment 944065 Details for Bug 1149517 – engine log when using jsonrpc

engine log when using jsonrpc

engine-jsonrpc.log (text/plain), 146.62 KB, created by Nir Soffer on 2014-10-05 18:52:26 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Nir Soffer

Created: 2014-10-05 18:52:26 UTC

Size: 146.62 KB

patch

obsolete

>2014-10-05 21:15:52,657 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Loaded file "/usr/share/ovirt-engine/services/ovirt-engine/ovirt-engine.conf".
>2014-10-05 21:15:52,658 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) The file "/etc/ovirt-engine/engine.conf" doesn't exist or isn't readable. Will return an empty set of properties.
>2014-10-05 21:15:52,659 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Loaded file "/etc/ovirt-engine/engine.conf.d/10-setup-database.conf".
>2014-10-05 21:15:52,659 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Loaded file "/etc/ovirt-engine/engine.conf.d/10-setup-jboss.conf".
>2014-10-05 21:15:52,664 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Loaded file "/etc/ovirt-engine/engine.conf.d/10-setup-pki.conf".
>2014-10-05 21:15:52,665 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Loaded file "/etc/ovirt-engine/engine.conf.d/10-setup-protocols.conf".
>2014-10-05 21:15:52,666 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_AJP_ENABLED" is "true".
>2014-10-05 21:15:52,666 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_AJP_PORT" is "8702".
>2014-10-05 21:15:52,666 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-10-05 21:15:52,667 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_CACHE" is "/var/cache/ovirt-engine".
>2014-10-05 21:15:52,667 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_CHECK_INTERVAL" is "1000".
>2014-10-05 21:15:52,668 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_CONNECTION_TIMEOUT" is "300000".
>2014-10-05 21:15:52,668 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_DATABASE" is "engine".
>2014-10-05 21:15:52,669 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_DRIVER" is "org.postgresql.Driver".
>2014-10-05 21:15:52,669 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_HOST" is "localhost".
>2014-10-05 21:15:52,669 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_MAX_CONNECTIONS" is "100".
>2014-10-05 21:15:52,670 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_MIN_CONNECTIONS" is "1".
>2014-10-05 21:15:52,671 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_PASSWORD" is "***".
>2014-10-05 21:15:52,671 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_PORT" is "5432".
>2014-10-05 21:15:52,672 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_SECURED" is "False".
>2014-10-05 21:15:52,672 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_SECURED_VALIDATION" is "False".
>2014-10-05 21:15:52,672 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-10-05 21:15:52,672 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DB_USER" is "engine".
>2014-10-05 21:15:52,673 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DEBUG_ADDRESS" is "".
>2014-10-05 21:15:52,673 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_DOC" is "/usr/share/doc/ovirt-engine".
>2014-10-05 21:15:52,673 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_ETC" is "/etc/ovirt-engine".
>2014-10-05 21:15:52,673 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_EXTENSION_PATH" is "/usr/share/ovirt-engine/extensions.d:/etc/ovirt-engine/extensions.d".
>2014-10-05 21:15:52,674 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_FQDN" is "localhost".
>2014-10-05 21:15:52,674 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_GROUP" is "ovirt".
>2014-10-05 21:15:52,674 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_HEAP_MAX" is "1g".
>2014-10-05 21:15:52,674 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_HEAP_MIN" is "1g".
>2014-10-05 21:15:52,675 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_HTTPS_ENABLED" is "false".
>2014-10-05 21:15:52,675 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_HTTPS_PORT" is "None".
>2014-10-05 21:15:52,676 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-10-05 21:15:52,676 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_HTTP_ENABLED" is "false".
>2014-10-05 21:15:52,676 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_HTTP_PORT" is "None".
>2014-10-05 21:15:52,677 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_JAVA_MODULEPATH" is "/usr/share/ovirt-engine/modules".
>2014-10-05 21:15:52,677 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_JVM_ARGS" is " -XX:+HeapDumpOnOutOfMemoryError -XX:HeapDumpPath="/var/log/ovirt-engine/dump"".
>2014-10-05 21:15:52,678 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_LOG" is "/var/log/ovirt-engine".
>2014-10-05 21:15:52,678 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_LOG_TO_CONSOLE" is "false".
>2014-10-05 21:15:52,679 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_MANUAL" is "/usr/share/ovirt-engine/manual".
>2014-10-05 21:15:52,679 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PERM_MAX" is "256m".
>2014-10-05 21:15:52,679 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PERM_MIN" is "256m".
>2014-10-05 21:15:52,680 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI" is "/etc/pki/ovirt-engine".
>2014-10-05 21:15:52,680 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_CA" is "/etc/pki/ovirt-engine/ca.pem".
>2014-10-05 21:15:52,681 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_ENGINE_CERT" is "/etc/pki/ovirt-engine/certs/engine.cer".
>2014-10-05 21:15:52,681 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_ENGINE_STORE" is "/etc/pki/ovirt-engine/keys/engine.p12".
>2014-10-05 21:15:52,682 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_ENGINE_STORE_ALIAS" is "1".
>2014-10-05 21:15:52,682 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_ENGINE_STORE_PASSWORD" is "***".
>2014-10-05 21:15:52,683 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_TRUST_STORE" is "/etc/pki/ovirt-engine/.truststore".
>2014-10-05 21:15:52,683 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PKI_TRUST_STORE_PASSWORD" is "***".
>2014-10-05 21:15:52,683 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=/etc/ovirt-engine/krb5.conf"".
>2014-10-05 21:15:52,684 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PROXY_ENABLED" is "true".
>2014-10-05 21:15:52,684 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PROXY_HTTPS_PORT" is "443".
>2014-10-05 21:15:52,685 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_PROXY_HTTP_PORT" is "80".
>2014-10-05 21:15:52,685 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_REPORTS_BASE_URL" is "".
>2014-10-05 21:15:52,685 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_REPORTS_DASHBOARD_URL" is "/flow.html?viewAsDashboardFrame=true".
>2014-10-05 21:15:52,686 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_REPORTS_PROXY_URL" is "/ovirt/reports-interface".
>2014-10-05 21:15:52,686 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_REPORTS_READ_TIMEOUT" is "".
>2014-10-05 21:15:52,687 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_REPORTS_RIGHTCLICK_URL" is "".
>2014-10-05 21:15:52,687 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_REPORTS_VERIFY_CHAIN" is "true".
>2014-10-05 21:15:52,688 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_REPORTS_VERIFY_HOST" is "true".
>2014-10-05 21:15:52,688 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_STOP_INTERVAL" is "1".
>2014-10-05 21:15:52,688 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_STOP_TIME" is "10".
>2014-10-05 21:15:52,689 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_TMP" is "/var/tmp/ovirt-engine".
>2014-10-05 21:15:52,689 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_UP_MARK" is "/var/lib/ovirt-engine/engine.up".
>2014-10-05 21:15:52,689 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_URI" is "/ovirt-engine".
>2014-10-05 21:15:52,695 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_USER" is "ovirt".
>2014-10-05 21:15:52,695 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_USR" is "/usr/share/ovirt-engine".
>2014-10-05 21:15:52,695 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_VAR" is "/var/lib/ovirt-engine".
>2014-10-05 21:15:52,695 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "ENGINE_VERBOSE_GC" is "false".
>2014-10-05 21:15:52,696 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "JBOSS_HOME" is "/usr/share/ovirt-engine-jboss-as".
>2014-10-05 21:15:52,696 INFO  [org.ovirt.engine.core.uutils.config.ShellLikeConfd] (MSC service thread 1-7) Value of property "JBOSS_RUNTIME" is "/var/lib/ovirt-engine/jboss_runtime".
>2014-10-05 21:15:52,696 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-10-05 21:15:52,968 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-4) Start initializing Backend
>2014-10-05 21:15:53,178 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-4) Failed to decrypt value for property LocalAdminPassword will be used encrypted value: javax.crypto.BadPaddingException: Decryption error
>	at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:380) [rt.jar:1.7.0_65]
>	at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:291) [rt.jar:1.7.0_65]
>	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_65]
>	at org.ovirt.engine.core.utils.crypt.EngineEncryptionUtils.decrypt(EngineEncryptionUtils.java:159) [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_65]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_65]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_65]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_65]
>	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_65]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_65]
>	at java.lang.Thread.run(Thread.java:745) [rt.jar:1.7.0_65]
>
>2014-10-05 21:15:53,245 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-4) Could not parse option AutoRecoveryAllowedTypes value.
>2014-10-05 21:15:53,266 ERROR [org.ovirt.engine.core.dal.dbbroker.generic.DBConfigUtils] (MSC service thread 1-4) Failed to decrypt value for property AdminPassword will be used encrypted value: javax.crypto.BadPaddingException: Decryption error
>	at sun.security.rsa.RSAPadding.unpadV15(RSAPadding.java:380) [rt.jar:1.7.0_65]
>	at sun.security.rsa.RSAPadding.unpad(RSAPadding.java:291) [rt.jar:1.7.0_65]
>	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_65]
>	at org.ovirt.engine.core.utils.crypt.EngineEncryptionUtils.decrypt(EngineEncryptionUtils.java:159) [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_65]
>	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_65]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_65]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_65]
>	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_65]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_65]
>	at java.lang.Thread.run(Thread.java:745) [rt.jar:1.7.0_65]
>
>2014-10-05 21:15:53,287 INFO  [org.ovirt.engine.core.utils.osinfo.OsInfoPreferencesLoader] (MSC service thread 1-4) Loaded file /etc/ovirt-engine/osinfo.conf.d/00-defaults.properties
>2014-10-05 21:15:53,425 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-4) Running ovirt-engine 3.5.0-0.0.master.20141001234938.git65deb9d.fc20
>2014-10-05 21:15:53,425 INFO  [org.ovirt.engine.core.bll.CpuFlagsManagerHandler] (MSC service thread 1-4) Start initializing dictionaries
>2014-10-05 21:15:53,427 INFO  [org.ovirt.engine.core.bll.CpuFlagsManagerHandler] (MSC service thread 1-4) Finished initializing dictionaries
>2014-10-05 21:15:53,428 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-4) Start initializing AuditLogCleanupManager
>2014-10-05 21:15:53,428 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-4) Setting audit cleanup manager to run at: 35 35 3 * * ?
>2014-10-05 21:15:53,441 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-4) Finished initializing AuditLogCleanupManager
>2014-10-05 21:15:53,442 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-4) Start initializing CommandEntityCleanupManager
>2014-10-05 21:15:53,442 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-4) Setting command entity cleanup manager to run at: 35 35 3 * * ?
>2014-10-05 21:15:53,443 INFO  [org.ovirt.engine.core.bll.AuditLogCleanupManager] (MSC service thread 1-4) Finished initializing CommandEntityCleanupManager
>2014-10-05 21:15:53,445 INFO  [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-4) Start initializing TagsDirector
>2014-10-05 21:15:53,451 INFO  [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-4) Tag root added to tree
>2014-10-05 21:15:53,458 INFO  [org.ovirt.engine.core.bll.TagsDirector] (MSC service thread 1-4) Finished initializing TagsDirector
>2014-10-05 21:15:53,458 INFO  [org.ovirt.engine.core.bll.IsoDomainListSyncronizer] (MSC service thread 1-4) Start initializing IsoDomainListSyncronizer
>2014-10-05 21:15:53,464 INFO  [org.ovirt.engine.core.bll.IsoDomainListSyncronizer] (MSC service thread 1-4) Finished initializing IsoDomainListSyncronizer
>2014-10-05 21:15:53,515 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-4) Completed initializing handlers
>2014-10-05 21:15:53,534 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-4) Start initializing ErrorTranslatorImpl
>2014-10-05 21:15:53,543 WARN  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-4) Code MAC_ADDRESS_IS_IN_USE appears more than once in string table.
>2014-10-05 21:15:53,544 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-4) Finished initializing ErrorTranslatorImpl
>2014-10-05 21:15:53,545 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-4) Start initializing ErrorTranslatorImpl
>2014-10-05 21:15:53,545 INFO  [org.ovirt.engine.core.utils.ErrorTranslatorImpl] (MSC service thread 1-4) Finished initializing ErrorTranslatorImpl
>2014-10-05 21:15:53,546 INFO  [org.ovirt.engine.core.bll.Backend] (MSC service thread 1-4) Mark incomplete jobs as UNKNOWN
>2014-10-05 21:15:53,573 INFO  [org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager] (MSC service thread 1-4) Start initializing JobRepositoryCleanupManager
>2014-10-05 21:15:53,574 INFO  [org.ovirt.engine.core.bll.job.JobRepositoryCleanupManager] (MSC service thread 1-4) Finished initializing JobRepositoryCleanupManager
>2014-10-05 21:15:53,574 INFO  [org.ovirt.engine.core.bll.AutoRecoveryManager] (MSC service thread 1-4) Start initializing AutoRecoveryManager
>2014-10-05 21:15:53,575 INFO  [org.ovirt.engine.core.bll.AutoRecoveryManager] (MSC service thread 1-4) Finished initializing AutoRecoveryManager
>2014-10-05 21:15:53,576 INFO  [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (MSC service thread 1-4) Start initializing ExecutionMessageDirector
>2014-10-05 21:15:53,578 INFO  [org.ovirt.engine.core.dal.job.ExecutionMessageDirector] (MSC service thread 1-4) Finished initializing ExecutionMessageDirector
>2014-10-05 21:15:53,608 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-4) Loading extension 'builtin-authn-internal'
>2014-10-05 21:15:53,609 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-4) Extension 'builtin-authn-internal' loaded
>2014-10-05 21:15:53,610 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-4) Loading extension 'internal'
>2014-10-05 21:15:53,612 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-4) Extension 'internal' loaded
>2014-10-05 21:15:53,613 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-4) Initializing extension 'builtin-authn-internal'
>2014-10-05 21:15:53,614 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-4) Extension 'builtin-authn-internal' initialized
>2014-10-05 21:15:53,615 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-4) Initializing extension 'internal'
>2014-10-05 21:15:53,616 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-4) Extension 'internal' initialized
>2014-10-05 21:15:53,616 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-4) Start of enabled extensions list
>2014-10-05 21:15:53,617 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-4) Instance name: 'builtin-authn-internal', Extension name: 'Internal Authn (Built-in)', Version: 'N/A', Notes: '', License: 'ASL 2.0', Home: 'http://www.ovirt.org', Author 'The oVirt Project', Build interface Version: '0',  File: 'N/A', Initialized: 'true'
>2014-10-05 21:15:53,618 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-4) Instance name: 'internal', Extension name: 'Internal Authz (Built-in)', Version: 'N/A', Notes: '', License: 'ASL 2.0', Home: 'http://www.ovirt.org', Author 'The oVirt Project', Build interface Version: '0',  File: 'N/A', Initialized: 'true'
>2014-10-05 21:15:53,618 INFO  [org.ovirt.engine.core.extensions.mgr.ExtensionsManager] (MSC service thread 1-4) End of enabled extensions list
>2014-10-05 21:15:53,675 INFO  [org.ovirt.engine.core.bll.aaa.DbUserCacheManager] (MSC service thread 1-2) Start initializing DbUserCacheManager
>2014-10-05 21:15:53,684 INFO  [org.ovirt.engine.core.bll.aaa.DbUserCacheManager] (MSC service thread 1-2) Finished initializing DbUserCacheManager
>2014-10-05 21:15:53,701 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (MSC service thread 1-2) Initialization of AsyncTaskManager completed successfully.
>2014-10-05 21:15:53,703 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) Start initializing ResourceManager
>2014-10-05 21:15:53,771 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Entered VdsManager constructor
>2014-10-05 21:15:53,793 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Initialize vdsBroker (voodoo1.tlv.redhat.com,54,321)
>2014-10-05 21:15:53,899 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) VDS 114c2cc6-5123-45bc-8900-5c875b0543c4 was added to the Resource Manager
>2014-10-05 21:15:53,900 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Entered VdsManager constructor
>2014-10-05 21:15:53,910 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Initialize vdsBroker (voodoo6.tlv.redhat.com,54,321)
>2014-10-05 21:15:53,916 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) VDS 45462850-a02c-4eeb-8527-292e15e5cb54 was added to the Resource Manager
>2014-10-05 21:15:53,917 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Entered VdsManager constructor
>2014-10-05 21:15:53,924 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Initialize vdsBroker (voodoo3.tlv.redhat.com,54,321)
>2014-10-05 21:15:53,930 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) VDS 54ecf14b-3ec8-4af6-91ef-fa294ad0bb77 was added to the Resource Manager
>2014-10-05 21:15:53,931 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Entered VdsManager constructor
>2014-10-05 21:15:53,941 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Initialize vdsBroker (voodoo4.tlv.redhat.com,54,321)
>2014-10-05 21:15:53,946 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) VDS e6cc924b-39b8-462b-b2e7-69033f9fa050 was added to the Resource Manager
>2014-10-05 21:15:53,946 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Entered VdsManager constructor
>2014-10-05 21:15:53,957 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Initialize vdsBroker (voodoo5.tlv.redhat.com,54,321)
>2014-10-05 21:15:53,961 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) VDS 057db593-8f30-49fa-8ed2-1f205523878d was added to the Resource Manager
>2014-10-05 21:15:53,962 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Entered VdsManager constructor
>2014-10-05 21:15:53,975 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Initialize vdsBroker (voodoo2.tlv.redhat.com,54,321)
>2014-10-05 21:15:53,981 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) VDS 180d9ed7-fb9e-457a-b780-234bdb9d5a53 was added to the Resource Manager
>2014-10-05 21:15:53,981 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Entered VdsManager constructor
>2014-10-05 21:15:53,991 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (MSC service thread 1-2) Initialize vdsBroker (voodoo7.tlv.redhat.com,54,321)
>2014-10-05 21:15:53,994 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) VDS 00e5e0fa-aab2-4e4e-a75a-1757950b01b4 was added to the Resource Manager
>2014-10-05 21:15:54,012 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (MSC service thread 1-2) Finished initializing ResourceManager
>2014-10-05 21:15:54,017 INFO  [org.ovirt.engine.core.bll.OvfDataUpdater] (MSC service thread 1-2) Initialization of OvfDataUpdater completed successfully.
>2014-10-05 21:15:54,017 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-2) Start scheduling to enable vds load balancer
>2014-10-05 21:15:54,018 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-2) Finished scheduling to enable vds load balancer
>2014-10-05 21:15:54,019 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-2) Start HA Reservation check
>2014-10-05 21:15:54,019 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-2) Finished HA Reservation check
>2014-10-05 21:15:54,023 INFO  [org.ovirt.engine.core.bll.network.MacPoolManagerRanges] (org.ovirt.thread.pool-8-thread-1) Start initializing MacPoolManagerRanges
>2014-10-05 21:15:54,032 INFO  [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-2) Init VM custom properties utilities
>2014-10-05 21:15:54,033 INFO  [org.ovirt.engine.core.bll.InitBackendServicesOnStartupBean] (MSC service thread 1-2) Init device custom properties utilities
>2014-10-05 21:15:54,037 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-2) Initializing Scheduling manager
>2014-10-05 21:15:54,043 INFO  [org.ovirt.engine.core.bll.network.MacPoolManagerRanges] (org.ovirt.thread.pool-8-thread-1) Finished initializing. Available MACs in pool: 248
>2014-10-05 21:15:54,061 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-2) External scheduler disabled, discovery skipped
>2014-10-05 21:15:54,061 INFO  [org.ovirt.engine.core.bll.scheduling.SchedulingManager] (MSC service thread 1-2) Initialized Scheduling manager
>2014-10-05 21:15:54,062 INFO  [org.ovirt.engine.core.bll.dwh.DwhHeartBeat] (MSC service thread 1-2) Initializing DWH Heart Beat
>2014-10-05 21:15:54,063 INFO  [org.ovirt.engine.core.bll.dwh.DwhHeartBeat] (MSC service thread 1-2) DWH Heart Beat initialized
>2014-10-05 21:15:56,959 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-8) Initializing Host: voodoo3
>2014-10-05 21:15:56,980 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-10) Initializing Host: voodoo5
>2014-10-05 21:15:56,980 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-9) Initializing Host: voodoo4
>2014-10-05 21:15:56,988 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-6) Initializing Host: voodoo1
>2014-10-05 21:15:57,005 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-11) Initializing Host: voodoo2
>2014-10-05 21:15:57,009 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-12) Initializing Host: voodoo7
>2014-10-05 21:15:57,111 INFO  [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to voodoo6.tlv.redhat.com/10.35.0.110
>2014-10-05 21:15:58,105 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-7) START, GetHardwareInfoVDSCommand(HostName = voodoo6, HostId = 45462850-a02c-4eeb-8527-292e15e5cb54, vds=Host[voodoo6,45462850-a02c-4eeb-8527-292e15e5cb54]), log id: 1d2c7d5
>2014-10-05 21:15:58,191 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-7) FINISH, GetHardwareInfoVDSCommand, log id: 1d2c7d5
>2014-10-05 21:15:58,490 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-7) Initializing Host: voodoo6
>2014-10-05 21:15:58,566 INFO  [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler_Worker-7) [6c961db0] Running command: HandleVdsVersionCommand internal: true. Entities affected :  ID: 45462850-a02c-4eeb-8527-292e15e5cb54 Type: VDS
>2014-10-05 21:16:04,104 INFO  [org.ovirt.engine.core.bll.storage.SetStoragePoolStatusCommand] (DefaultQuartzScheduler_Worker-37) [3e57601] Running command: SetStoragePoolStatusCommand internal: true. Entities affected :  ID: b86b687a-d073-497a-ac8a-249025419a3e Type: StoragePool
>2014-10-05 21:16:04,153 INFO  [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (DefaultQuartzScheduler_Worker-37) [3e57601] Storage Pool b86b687a-d073-497a-ac8a-249025419a3e - Updating Storage Domain ff559f46-c495-4f6b-901c-2a624042a050 status from Active to Unknown, reason : null
>2014-10-05 21:16:04,167 INFO  [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (DefaultQuartzScheduler_Worker-37) [3e57601] Storage Pool b86b687a-d073-497a-ac8a-249025419a3e - Updating Storage Domain c73a3ced-4b41-4b4e-93f7-494d63e7e7ae status from Active to Unknown, reason : null
>2014-10-05 21:16:04,235 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: UNASSIGNED not exist in string table
>2014-10-05 21:16:04,236 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: VDS_HIGH_NETWORK_USE not exist in string table
>2014-10-05 21:16:04,236 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: USER_FAILED_REMOVE_VM not exist in string table
>2014-10-05 21:16:04,237 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: USER_RUN_UNLOCK_ENTITY_SCRIPT not exist in string table
>2014-10-05 21:16:04,238 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: VDS_NETWORK_MTU_DIFFER_FROM_LOGICAL_NETWORK not exist in string table
>2014-10-05 21:16:04,239 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: STORAGE_ACTIVATE_ASYNC not exist in string table
>2014-10-05 21:16:04,240 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: USER_ADDED_DISK_PROFILE not exist in string table
>2014-10-05 21:16:04,240 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: USER_FAILED_TO_ADD_DISK_PROFILE not exist in string table
>2014-10-05 21:16:04,241 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: USER_REMOVED_DISK_PROFILE not exist in string table
>2014-10-05 21:16:04,241 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: USER_FAILED_TO_REMOVE_DISK_PROFILE not exist in string table
>2014-10-05 21:16:04,242 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: USER_UPDATED_DISK_PROFILE not exist in string table
>2014-10-05 21:16:04,242 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: USER_FAILED_TO_UPDATE_DISK_PROFILE not exist in string table
>2014-10-05 21:16:04,243 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: USER_ADDED_CPU_PROFILE not exist in string table
>2014-10-05 21:16:04,243 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: USER_FAILED_TO_ADD_CPU_PROFILE not exist in string table
>2014-10-05 21:16:04,244 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: USER_REMOVED_CPU_PROFILE not exist in string table
>2014-10-05 21:16:04,244 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: USER_FAILED_TO_REMOVE_CPU_PROFILE not exist in string table
>2014-10-05 21:16:04,245 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: USER_UPDATED_CPU_PROFILE not exist in string table
>2014-10-05 21:16:04,245 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] AuditLogType: USER_FAILED_TO_UPDATE_CPU_PROFILE not exist in string table
>2014-10-05 21:16:04,432 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] Correlation ID: 3e57601, Call Stack: null, Custom Event ID: -1, Message: Invalid status on Data Center iscsi-el7. Setting status to Non Responsive.
>2014-10-05 21:16:04,543 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (DefaultQuartzScheduler_Worker-37) [3e57601] hostFromVds::selectedVds - voodoo6, spmStatus SPM, storage pool iscsi-el7
>2014-10-05 21:16:04,556 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (DefaultQuartzScheduler_Worker-37) [3e57601] Initialize Irs proxy from vds: voodoo6.tlv.redhat.com
>2014-10-05 21:16:04,581 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-37) [3e57601] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Storage Pool Manager runs on Host voodoo6 (Address: voodoo6.tlv.redhat.com).
>2014-10-05 21:16:04,583 INFO  [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to voodoo6.tlv.redhat.com/10.35.0.110
>2014-10-05 21:16:04,590 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-6) [3e57601] START, SPMGetAllTasksInfoVDSCommand( storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, ignoreFailoverLimit = false), log id: b81a33b
>2014-10-05 21:16:05,290 INFO  [org.ovirt.engine.core.bll.storage.SyncLunsInfoForBlockStorageDomainCommand] (org.ovirt.thread.pool-8-thread-8) [2d107cea] Running command: SyncLunsInfoForBlockStorageDomainCommand internal: true. Entities affected :  ID: c73a3ced-4b41-4b4e-93f7-494d63e7e7ae Type: Storage
>2014-10-05 21:16:05,305 INFO  [org.ovirt.engine.core.bll.storage.SyncLunsInfoForBlockStorageDomainCommand] (org.ovirt.thread.pool-8-thread-9) [1fb96d57] Running command: SyncLunsInfoForBlockStorageDomainCommand internal: true. Entities affected :  ID: ff559f46-c495-4f6b-901c-2a624042a050 Type: Storage
>2014-10-05 21:16:05,310 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-6) [3e57601] -- executeIrsBrokerCommand: Attempting on storage pool b86b687a-d073-497a-ac8a-249025419a3e
>2014-10-05 21:16:05,318 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-6) [3e57601] START, HSMGetAllTasksInfoVDSCommand(HostName = voodoo6, HostId = 45462850-a02c-4eeb-8527-292e15e5cb54), log id: 16776d38
>2014-10-05 21:16:05,337 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVGInfoVDSCommand] (org.ovirt.thread.pool-8-thread-9) [1fb96d57] START, GetVGInfoVDSCommand(HostName = voodoo6, HostId = 45462850-a02c-4eeb-8527-292e15e5cb54, VGID=1B1oT5-JcGj-Ru1I-v3Ni-yden-Du9b-I9fSu8), log id: 19b33657
>2014-10-05 21:16:05,340 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVGInfoVDSCommand] (org.ovirt.thread.pool-8-thread-8) [2d107cea] START, GetVGInfoVDSCommand(HostName = voodoo6, HostId = 45462850-a02c-4eeb-8527-292e15e5cb54, VGID=pF71zc-KPBX-BMKm-7KHK-KihY-ysp4-6DZTpA), log id: 7ff31e2e
>2014-10-05 21:16:05,405 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-6) [3e57601] FINISH, HSMGetAllTasksInfoVDSCommand, return: [], log id: 16776d38
>2014-10-05 21:16:05,405 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-6) [3e57601] FINISH, SPMGetAllTasksInfoVDSCommand, return: [], log id: b81a33b
>2014-10-05 21:16:05,405 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (org.ovirt.thread.pool-8-thread-6) [3e57601] Discovered no tasks on Storage Pool iscsi-el7
>2014-10-05 21:16:05,529 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVGInfoVDSCommand] (org.ovirt.thread.pool-8-thread-9) [1fb96d57] FINISH, GetVGInfoVDSCommand, return: [LUNs [id=1IET_00060007, physicalVolumeId=QfuzQ5-Ml7u-kFUc-gdmr-rfmS-Aefp-3HODNb, volumeGroupId=1B1oT5-JcGj-Ru1I-v3Ni-yden-Du9b-I9fSu8, serial=SRed_Cat_VIRTUAL-DISK, lunMapping=7, vendorId=Red Cat, productId=VIRTUAL-DISK, _lunConnections=[{ id: null, connection: 10.35.0.98, iqn: iqn.1994-05.com.redhat:target6, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };], deviceSize=20, vendorName=Red Cat, pathsDictionary={sdv=true}, lunType=ISCSI, status=null, diskId=null, diskAlias=null, storageDomainId=ff559f46-c495-4f6b-901c-2a624042a050, storageDomainName=null], LUNs [id=1IET_00060009, physicalVolumeId=pGRciD-wcLp-X1ME-MijE-P1B9-7XWo-ycTXdG, volumeGroupId=1B1oT5-JcGj-Ru1I-v3Ni-yden-Du9b-I9fSu8, serial=SRed_Cat_VIRTUAL-DISK, lunMapping=9, vendorId=Red Cat, productId=VIRTUAL-DISK, _lunConnections=[{ id: null, connection: 10.35.0.98, iqn: iqn.1994-05.com.redhat:target6, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };], deviceSize=20, vendorName=Red Cat, pathsDictionary={sdx=true}, lunType=ISCSI, status=null, diskId=null, diskAlias=null, storageDomainId=ff559f46-c495-4f6b-901c-2a624042a050, storageDomainName=null]], log id: 19b33657
>2014-10-05 21:16:05,607 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVGInfoVDSCommand] (org.ovirt.thread.pool-8-thread-8) [2d107cea] FINISH, GetVGInfoVDSCommand, return: [LUNs [id=3600144f09dbd0500000053a85076000a, physicalVolumeId=Ka3ewV-ddPQ-boL6-sDJT-xcFb-YBkc-9HeKFq, volumeGroupId=pF71zc-KPBX-BMKm-7KHK-KihY-ysp4-6DZTpA, serial=SNEXENTA_COMSTAR_5H49HFEFE, lunMapping=11, vendorId=NEXENTA, productId=COMSTAR, _lunConnections=[{ id: null, connection: 10.35.16.25, iqn: iqn.1994-05.com.redhat:nsoffer-target1, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };], deviceSize=10, vendorName=NEXENTA, pathsDictionary={sdl=true}, lunType=ISCSI, status=null, diskId=null, diskAlias=null, storageDomainId=c73a3ced-4b41-4b4e-93f7-494d63e7e7ae, storageDomainName=null], LUNs [id=3600144f09dbd0500000053a84e730003, physicalVolumeId=5zWyZx-cpAZ-tMON-3wa5-s6pN-Xj7N-b3fPs5, volumeGroupId=pF71zc-KPBX-BMKm-7KHK-KihY-ysp4-6DZTpA, serial=SNEXENTA_COMSTAR_5H49HFEFE, lunMapping=77, vendorId=NEXENTA, productId=COMSTAR, _lunConnections=[{ id: null, connection: 10.35.16.25, iqn: iqn.1994-05.com.redhat:nsoffer-target1, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };], deviceSize=10, vendorName=NEXENTA, pathsDictionary={sdo=true}, lunType=ISCSI, status=null, diskId=null, diskAlias=null, storageDomainId=c73a3ced-4b41-4b4e-93f7-494d63e7e7ae, storageDomainName=null], LUNs [id=3600144f09dbd0500000053a853ed000c, physicalVolumeId=c2LMVb-PXdj-XpTE-4f06-2rrh-TdAG-zzehcn, volumeGroupId=pF71zc-KPBX-BMKm-7KHK-KihY-ysp4-6DZTpA, serial=SNEXENTA_COMSTAR_5H49HFEFE, lunMapping=5, vendorId=NEXENTA, productId=COMSTAR, _lunConnections=[{ id: null, connection: 10.35.16.25, iqn: iqn.1994-05.com.redhat:nsoffer-target2, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };], deviceSize=10, vendorName=NEXENTA, pathsDictionary={sdae=true}, lunType=ISCSI, status=null, diskId=null, diskAlias=null, storageDomainId=c73a3ced-4b41-4b4e-93f7-494d63e7e7ae, storageDomainName=null], LUNs [id=3600144f09dbd0500000053a85401000d, physicalVolumeId=1kMage-eAId-qy7G-oIqH-tfbH-ScLD-gqv7JM, volumeGroupId=pF71zc-KPBX-BMKm-7KHK-KihY-ysp4-6DZTpA, serial=SNEXENTA_COMSTAR_5H49HFEFE, lunMapping=6, vendorId=NEXENTA, productId=COMSTAR, _lunConnections=[{ id: null, connection: 10.35.16.25, iqn: iqn.1994-05.com.redhat:nsoffer-target2, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };], deviceSize=10, vendorName=NEXENTA, pathsDictionary={sdaf=true}, lunType=ISCSI, status=null, diskId=null, diskAlias=null, storageDomainId=c73a3ced-4b41-4b4e-93f7-494d63e7e7ae, storageDomainName=null]], log id: 7ff31e2e
>2014-10-05 21:16:09,186 INFO  [org.ovirt.engine.core.bll.aaa.LoginUserCommand] (ajp--127.0.0.1-8702-1) Running command: LoginUserCommand internal: false.
>2014-10-05 21:16:09,203 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-1) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: User admin logged in.
>2014-10-05 21:16:09,988 INFO  [org.ovirt.engine.core.bll.aaa.LogoutUserCommand] (ajp--127.0.0.1-8702-2) [5306c748] Running command: LogoutUserCommand internal: false.
>2014-10-05 21:16:09,996 INFO  [org.ovirt.engine.core.bll.aaa.LogoutUserCommand] (ajp--127.0.0.1-8702-6) [30f4111f] Running command: LogoutUserCommand internal: false.
>2014-10-05 21:16:09,984 INFO  [org.ovirt.engine.core.bll.aaa.LogoutUserCommand] (ajp--127.0.0.1-8702-4) [7d61e46a] Running command: LogoutUserCommand internal: false.
>2014-10-05 21:16:10,000 INFO  [org.ovirt.engine.core.bll.aaa.LogoutUserCommand] (ajp--127.0.0.1-8702-5) [71318773] Running command: LogoutUserCommand internal: false.
>2014-10-05 21:16:10,056 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-5) [71318773] Correlation ID: 71318773, Call Stack: null, Custom Event ID: -1, Message: User admin logged out.
>2014-10-05 21:16:10,064 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-4) [7d61e46a] Correlation ID: 7d61e46a, Call Stack: null, Custom Event ID: -1, Message: User admin logged out.
>2014-10-05 21:16:10,065 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-2) [5306c748] Correlation ID: 5306c748, Call Stack: null, Custom Event ID: -1, Message: User admin logged out.
>2014-10-05 21:16:10,064 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-6) [30f4111f] Correlation ID: 30f4111f, Call Stack: null, Custom Event ID: -1, Message: User admin logged out.
>2014-10-05 21:16:10,067 INFO  [org.ovirt.engine.core.bll.aaa.LogoutUserCommand] (ajp--127.0.0.1-8702-7) [10a2c2f4] Running command: LogoutUserCommand internal: false.
>2014-10-05 21:16:10,139 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-7) [10a2c2f4] Correlation ID: 10a2c2f4, Call Stack: null, Custom Event ID: -1, Message: User admin logged out.
>2014-10-05 21:16:10,229 INFO  [org.ovirt.engine.core.utils.servlet.UnsupportedLocaleHelper] (ajp--127.0.0.1-8702-9) Invalid locale found in configuration: 
>2014-10-05 21:16:10,230 INFO  [org.ovirt.engine.core.utils.servlet.UnsupportedLocaleHelper] (ajp--127.0.0.1-8702-9) Invalid locale found in configuration: 
>2014-10-05 21:16:10,230 INFO  [org.ovirt.engine.core.utils.servlet.UnsupportedLocaleHelper] (ajp--127.0.0.1-8702-5) Invalid locale found in configuration: 
>2014-10-05 21:16:10,230 INFO  [org.ovirt.engine.core.utils.servlet.UnsupportedLocaleHelper] (ajp--127.0.0.1-8702-5) Invalid locale found in configuration: 
>2014-10-05 21:16:10,233 INFO  [org.ovirt.engine.core.utils.servlet.UnsupportedLocaleHelper] (ajp--127.0.0.1-8702-8) Invalid locale found in configuration: 
>2014-10-05 21:16:10,233 INFO  [org.ovirt.engine.core.utils.servlet.UnsupportedLocaleHelper] (ajp--127.0.0.1-8702-8) Invalid locale found in configuration: 
>2014-10-05 21:16:20,006 INFO  [org.ovirt.engine.core.bll.aaa.LoginAdminUserCommand] (ajp--127.0.0.1-8702-3) Running command: LoginAdminUserCommand internal: false.
>2014-10-05 21:16:20,019 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-3) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: User admin logged in.
>2014-10-05 21:16:58,230 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (ajp--127.0.0.1-8702-9) [738f76c] Lock Acquired to object EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS
>, sharedLocks= ]
>2014-10-05 21:16:58,342 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (org.ovirt.thread.pool-8-thread-34) [738f76c] Running command: ActivateVdsCommand internal: false. Entities affected :  ID: 114c2cc6-5123-45bc-8900-5c875b0543c4 Type: VDSAction group MANIPULATE_HOST with role type ADMIN
>2014-10-05 21:16:58,343 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (org.ovirt.thread.pool-8-thread-34) [738f76c] Before acquiring lock in order to prevent monitoring for host voodoo1 from data-center iscsi-el7
>2014-10-05 21:16:58,343 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (org.ovirt.thread.pool-8-thread-34) [738f76c] Lock acquired, from now a monitoring of host will be skipped for host voodoo1 from data-center iscsi-el7
>2014-10-05 21:16:58,370 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-34) [738f76c] START, SetVdsStatusVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, status=Unassigned, nonOperationalReason=NONE, stopSpmFailureLogged=false), log id: 64e4d3c2
>2014-10-05 21:16:58,383 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-34) [738f76c] FINISH, SetVdsStatusVDSCommand, log id: 64e4d3c2
>2014-10-05 21:16:58,424 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (org.ovirt.thread.pool-8-thread-34) Activate finished. Lock released. Monitoring can run now for host voodoo1 from data-center iscsi-el7
>2014-10-05 21:16:58,433 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-34) Correlation ID: 738f76c, Job ID: c951de22-c108-41f1-96c7-5270f8e73d1b, Call Stack: null, Custom Event ID: -1, Message: Host voodoo1 was activated by admin.
>2014-10-05 21:16:58,449 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (org.ovirt.thread.pool-8-thread-34) Lock freed to object EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS
>, sharedLocks= ]
>2014-10-05 21:17:00,194 INFO  [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to voodoo1.tlv.redhat.com/10.35.0.100
>2014-10-05 21:17:01,089 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-39) START, GetHardwareInfoVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, vds=Host[voodoo1,114c2cc6-5123-45bc-8900-5c875b0543c4]), log id: 17b4fec1
>2014-10-05 21:17:01,182 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-39) FINISH, GetHardwareInfoVDSCommand, log id: 17b4fec1
>2014-10-05 21:17:01,243 INFO  [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler_Worker-39) [38713b3a] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected :  ID: 114c2cc6-5123-45bc-8900-5c875b0543c4 Type: VDS
>2014-10-05 21:17:01,363 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-39) [38713b3a] START, GetHardwareInfoVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, vds=Host[voodoo1,114c2cc6-5123-45bc-8900-5c875b0543c4]), log id: 12bd816d
>2014-10-05 21:17:01,452 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-39) [38713b3a] FINISH, GetHardwareInfoVDSCommand, log id: 12bd816d
>2014-10-05 21:17:01,574 INFO  [org.ovirt.engine.core.bll.InitVdsOnUpCommand] (DefaultQuartzScheduler_Worker-39) [44b522f2] Running command: InitVdsOnUpCommand internal: true. Entities affected :  ID: b86b687a-d073-497a-ac8a-249025419a3e Type: StoragePool
>2014-10-05 21:17:01,593 INFO  [org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServersCommand] (DefaultQuartzScheduler_Worker-39) [1ebc1751] Running command: ConnectHostToStoragePoolServersCommand internal: true. Entities affected :  ID: b86b687a-d073-497a-ac8a-249025419a3e Type: StoragePool
>2014-10-05 21:17:01,623 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (DefaultQuartzScheduler_Worker-39) [1ebc1751] START, ConnectStorageServerVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, storageType = ISCSI, connectionList = [{ id: af150e8e-4d74-4810-b8bf-0c6a19637dbf, connection: 10.35.16.25, iqn: iqn.1994-05.com.redhat:nsoffer-target1, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };{ id: e8d58651-6414-4fc2-b281-2141cc97829b, connection: 10.35.0.98, iqn: iqn.1994-05.com.redhat:target6, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };{ id: 8f399b5f-1237-479e-82e6-eedb202b66fd, connection: 10.35.16.25, iqn: iqn.1994-05.com.redhat:nsoffer-target2, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 7ca49a03
>2014-10-05 21:17:04,473 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (DefaultQuartzScheduler_Worker-39) [1ebc1751] FINISH, ConnectStorageServerVDSCommand, return: {e8d58651-6414-4fc2-b281-2141cc97829b=0, af150e8e-4d74-4810-b8bf-0c6a19637dbf=0, 8f399b5f-1237-479e-82e6-eedb202b66fd=0}, log id: 7ca49a03
>2014-10-05 21:17:04,475 INFO  [org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServersCommand] (DefaultQuartzScheduler_Worker-39) [1ebc1751] Host voodoo1 storage connection was succeeded 
>2014-10-05 21:17:04,485 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (org.ovirt.thread.pool-8-thread-40) START, ConnectStoragePoolVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, vdsId = 114c2cc6-5123-45bc-8900-5c875b0543c4, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, masterVersion = 5), log id: 55a18894
>2014-10-05 21:17:05,704 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (org.ovirt.thread.pool-8-thread-40) FINISH, ConnectStoragePoolVDSCommand, log id: 55a18894
>2014-10-05 21:17:05,802 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SetMOMPolicyParametersVDSCommand] (DefaultQuartzScheduler_Worker-39) [1ebc1751] START, SetMOMPolicyParametersVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4), log id: 6e964817
>2014-10-05 21:17:05,950 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SetMOMPolicyParametersVDSCommand] (DefaultQuartzScheduler_Worker-39) [1ebc1751] FINISH, SetMOMPolicyParametersVDSCommand, log id: 6e964817
>2014-10-05 21:17:05,969 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-39) [1ebc1751] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Status of host voodoo1 was set to Up.
>2014-10-05 21:17:05,979 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-39) [1ebc1751] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Failed to verify Power Management configuration for Host voodoo1.
>2014-10-05 21:17:06,011 INFO  [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler_Worker-39) [60fb6f18] Running command: HandleVdsVersionCommand internal: true. Entities affected :  ID: 114c2cc6-5123-45bc-8900-5c875b0543c4 Type: VDS
>2014-10-05 21:17:53,390 ERROR [org.ovirt.vdsm.jsonrpc.client.reactors.Reactor] (SSL Stomp Reactor) Unable to process messages: java.io.IOException: Connection reset by peer
>	at sun.nio.ch.FileDispatcherImpl.write0(Native Method) [rt.jar:1.7.0_65]
>	at sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:47) [rt.jar:1.7.0_65]
>	at sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:93) [rt.jar:1.7.0_65]
>	at sun.nio.ch.IOUtil.write(IOUtil.java:65) [rt.jar:1.7.0_65]
>	at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:487) [rt.jar:1.7.0_65]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.SSLEngineNioHelper.write(SSLEngineNioHelper.java:95) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.SSLClient.write(SSLClient.java:90) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient.processOutgoing(ReactorClient.java:199) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient.process(ReactorClient.java:170) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.SSLClient.process(SSLClient.java:115) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.Reactor.processChannels(Reactor.java:86) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.Reactor.run(Reactor.java:62) [vdsm-jsonrpc-java-client.jar:]
>
>2014-10-05 21:19:20,552 INFO  [org.ovirt.engine.core.bll.RefreshHostCapabilitiesCommand] (ajp--127.0.0.1-8702-8) [2a273f0a] Lock Acquired to object EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS
>, sharedLocks= ]
>2014-10-05 21:19:20,556 INFO  [org.ovirt.engine.core.bll.RefreshHostCapabilitiesCommand] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Running command: RefreshHostCapabilitiesCommand internal: false. Entities affected :  ID: 114c2cc6-5123-45bc-8900-5c875b0543c4 Type: VDSAction group MANIPULATE_HOST with role type ADMIN
>2014-10-05 21:19:20,560 INFO  [org.ovirt.engine.core.bll.RefreshHostCapabilitiesCommand] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Before acquiring lock in order to prevent monitoring for host voodoo1 from data-center iscsi-el7
>2014-10-05 21:19:20,561 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:21,059 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:21,179 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:21,188 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:21,195 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:21,218 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:24,181 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:24,190 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:24,196 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:24,220 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:24,332 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:27,182 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:27,192 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:27,198 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:27,223 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:27,439 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:30,186 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:30,195 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:30,200 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:30,225 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:30,536 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:33,187 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:33,197 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:33,202 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:33,227 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:33,628 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:36,190 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:36,200 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:36,205 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:36,230 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:36,724 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:39,193 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:39,203 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:39,205 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:39,232 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:40,017 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:42,195 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:42,204 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:42,234 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:43,107 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:45,196 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:45,206 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:45,236 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:46,204 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:48,198 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:48,208 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:48,238 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:49,291 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:51,199 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:51,209 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:51,240 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:52,382 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:54,202 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:54,212 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:54,242 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:55,659 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:57,204 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:57,204 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:57,214 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:57,245 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:19:58,750 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:00,206 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:00,218 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:00,248 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:01,901 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:03,209 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:03,220 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:03,255 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:05,075 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:06,211 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:06,222 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:06,252 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:08,245 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:09,212 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:09,224 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:09,254 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:11,518 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:12,215 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:12,226 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:12,227 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:12,256 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:14,614 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:15,216 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:15,228 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:15,257 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:17,703 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:18,219 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:18,230 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:18,259 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:20,792 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:21,220 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:21,232 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:21,260 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:23,893 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:24,221 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:24,222 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:24,233 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:24,262 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:27,157 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:27,222 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:27,234 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:27,245 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:27,263 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:30,224 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:30,236 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:30,247 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:30,258 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:30,264 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:33,226 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:33,238 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:33,249 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:33,267 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:33,348 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:36,227 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:36,240 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:36,250 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:36,269 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:36,433 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:39,228 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:39,229 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:39,242 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:39,252 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:39,270 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:39,522 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:42,229 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:42,244 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:42,253 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:42,272 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:42,756 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:45,230 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:45,247 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:45,254 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:45,274 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:45,847 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:48,233 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:48,249 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:48,255 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:48,276 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:48,937 INFO  [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Failed to acquire lock and wait lock EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS_INIT
>, sharedLocks= ]
>2014-10-05 21:20:49,987 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.GetStatsVDSCommand] (DefaultQuartzScheduler_Worker-19) Command GetStatsVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, vds=Host[voodoo1,114c2cc6-5123-45bc-8900-5c875b0543c4]) execution failed. Exception: VDSNetworkException: VDSGenericException: VDSNetworkException: Message timeout which can be caused by communication issues'
>2014-10-05 21:20:49,990 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-19) Host voodoo1 is not responding. It will stay in Connecting state for a grace period of 60 seconds and after that an attempt to fence the host will be issued.
>2014-10-05 21:20:50,023 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-19) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Host voodoo1 is not responding. It will stay in Connecting state for a grace period of 60 seconds and after that an attempt to fence the host will be issued.
>2014-10-05 21:20:50,025 ERROR [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-19) vds::refreshVdsStats Failed getVdsStats,  vds = 114c2cc6-5123-45bc-8900-5c875b0543c4 : voodoo1, error = VDSNetworkException: VDSGenericException: VDSNetworkException: Message timeout which can be caused by communication issues'
>2014-10-05 21:20:50,026 ERROR [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-19) Failure to refresh Vds runtime info: org.ovirt.engine.core.vdsbroker.vdsbroker.VDSNetworkException: VDSGenericException: VDSNetworkException: Message timeout which can be caused by communication issues'
>	at org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase.proceedProxyReturnValue(BrokerCommandBase.java:183) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.vdsbroker.GetStatsVDSCommand.executeVdsBrokerCommand(GetStatsVDSCommand.java:24) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand.executeVDSCommand(VdsBrokerCommand.java:96) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VDSCommandBase.executeCommand(VDSCommandBase.java:56) [vdsbroker.jar:]
>	at org.ovirt.engine.core.dal.VdcCommandBase.execute(VdcCommandBase.java:31) [dal.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.refreshVdsStats(VdsUpdateRunTimeInfo.java:698) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.refreshVdsRunTimeInfo(VdsUpdateRunTimeInfo.java:652) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.refresh(VdsUpdateRunTimeInfo.java:504) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsManager.onTimer(VdsManager.java:236) [vdsbroker.jar:]
>	at sun.reflect.GeneratedMethodAccessor7.invoke(Unknown Source) [:1.7.0_65]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_65]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_65]
>	at org.ovirt.engine.core.utils.timer.JobWrapper.execute(JobWrapper.java:60) [scheduler.jar:]
>	at org.quartz.core.JobRunShell.run(JobRunShell.java:213) [quartz.jar:]
>	at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557) [quartz.jar:]
>
>2014-10-05 21:20:50,041 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-19) Failed to refresh VDS , vds = 114c2cc6-5123-45bc-8900-5c875b0543c4 : voodoo1, VDS Network Error, continuing.
>VDSGenericException: VDSNetworkException: Message timeout which can be caused by communication issues'
>2014-10-05 21:20:50,043 INFO  [org.ovirt.engine.core.bll.RefreshHostCapabilitiesCommand] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] Lock acquired, from now a monitoring of host will be skipped for host voodoo1 from data-center iscsi-el7
>2014-10-05 21:20:50,126 INFO  [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to voodoo1.tlv.redhat.com/10.35.0.100
>2014-10-05 21:20:50,997 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] START, GetHardwareInfoVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, vds=Host[voodoo1,114c2cc6-5123-45bc-8900-5c875b0543c4]), log id: 38ebab06
>2014-10-05 21:20:51,117 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (org.ovirt.thread.pool-8-thread-20) [2a273f0a] FINISH, GetHardwareInfoVDSCommand, log id: 38ebab06
>2014-10-05 21:20:51,294 INFO  [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (org.ovirt.thread.pool-8-thread-20) [c63324d] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected :  ID: 114c2cc6-5123-45bc-8900-5c875b0543c4 Type: VDS
>2014-10-05 21:20:51,300 INFO  [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (org.ovirt.thread.pool-8-thread-20) [2c7a6da1] Running command: HandleVdsVersionCommand internal: true. Entities affected :  ID: 114c2cc6-5123-45bc-8900-5c875b0543c4 Type: VDS
>2014-10-05 21:20:51,302 INFO  [org.ovirt.engine.core.bll.RefreshHostCapabilitiesCommand] (org.ovirt.thread.pool-8-thread-20) [2c7a6da1] Refresh host capabilities finished. Lock released. Monitoring can run now for host voodoo1 from data-center iscsi-el7
>2014-10-05 21:20:51,357 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-20) [2c7a6da1] Correlation ID: 2a273f0a, Call Stack: null, Custom Event ID: -1, Message: Successfully refreshed the capabilities of host voodoo1.
>2014-10-05 21:20:51,358 INFO  [org.ovirt.engine.core.bll.RefreshHostCapabilitiesCommand] (org.ovirt.thread.pool-8-thread-20) [2c7a6da1] Lock freed to object EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS
>, sharedLocks= ]
>2014-10-05 21:21:05,732 WARN  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (org.ovirt.thread.pool-8-thread-28) domain c73a3ced-4b41-4b4e-93f7-494d63e7e7ae:sasha-el7 in problem. vds: voodoo1
>2014-10-05 21:21:05,734 WARN  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (org.ovirt.thread.pool-8-thread-28) domain ff559f46-c495-4f6b-901c-2a624042a050:jumbo-el7 in problem. vds: voodoo1
>2014-10-05 21:23:53,500 ERROR [org.ovirt.vdsm.jsonrpc.client.reactors.Reactor] (SSL Stomp Reactor) Unable to process messages: java.io.IOException: Connection reset by peer
>	at sun.nio.ch.FileDispatcherImpl.write0(Native Method) [rt.jar:1.7.0_65]
>	at sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:47) [rt.jar:1.7.0_65]
>	at sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:93) [rt.jar:1.7.0_65]
>	at sun.nio.ch.IOUtil.write(IOUtil.java:65) [rt.jar:1.7.0_65]
>	at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:487) [rt.jar:1.7.0_65]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.SSLEngineNioHelper.write(SSLEngineNioHelper.java:95) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.SSLClient.write(SSLClient.java:90) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient.processOutgoing(ReactorClient.java:199) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient.process(ReactorClient.java:170) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.SSLClient.process(SSLClient.java:115) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.Reactor.processChannels(Reactor.java:86) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.Reactor.run(Reactor.java:62) [vdsm-jsonrpc-java-client.jar:]
>
>2014-10-05 21:25:45,999 INFO  [org.ovirt.engine.core.bll.ForceSelectSPMCommand] (ajp--127.0.0.1-8702-1) [1fed0e03] Running command: ForceSelectSPMCommand internal: false. Entities affected :  ID: 114c2cc6-5123-45bc-8900-5c875b0543c4 Type: VDSAction group MANIPULATE_HOST with role type ADMIN
>2014-10-05 21:25:46,001 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SpmStopOnIrsVDSCommand] (ajp--127.0.0.1-8702-1) [1fed0e03] START, SpmStopOnIrsVDSCommand( storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, ignoreFailoverLimit = false), log id: 5a2511e4
>2014-10-05 21:25:46,002 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.ResetIrsVDSCommand] (ajp--127.0.0.1-8702-1) [1fed0e03] START, ResetIrsVDSCommand( storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, ignoreFailoverLimit = false, vdsId = 45462850-a02c-4eeb-8527-292e15e5cb54, ignoreStopFailed = false), log id: 36a4b65a
>2014-10-05 21:25:46,005 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand] (ajp--127.0.0.1-8702-1) [1fed0e03] START, SpmStopVDSCommand(HostName = voodoo6, HostId = 45462850-a02c-4eeb-8527-292e15e5cb54, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e), log id: d040a0a
>2014-10-05 21:25:46,099 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand] (ajp--127.0.0.1-8702-1) [1fed0e03] SpmStopVDSCommand::Stopping SPM on vds voodoo6, pool id b86b687a-d073-497a-ac8a-249025419a3e
>2014-10-05 21:25:46,325 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStopVDSCommand] (ajp--127.0.0.1-8702-1) [1fed0e03] FINISH, SpmStopVDSCommand, log id: d040a0a
>2014-10-05 21:25:46,339 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.ResetIrsVDSCommand] (ajp--127.0.0.1-8702-1) [1fed0e03] FINISH, ResetIrsVDSCommand, log id: 36a4b65a
>2014-10-05 21:25:46,340 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SpmStopOnIrsVDSCommand] (ajp--127.0.0.1-8702-1) [1fed0e03] FINISH, SpmStopOnIrsVDSCommand, log id: 5a2511e4
>2014-10-05 21:25:46,355 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-1) [1fed0e03] Correlation ID: 1fed0e03, Job ID: a37e4531-392e-441f-a0a3-5eb8c84f3c59, Call Stack: null, Custom Event ID: -1, Message: Host voodoo1 was force selected by admin
>2014-10-05 21:25:50,507 INFO  [org.ovirt.engine.core.bll.storage.SetStoragePoolStatusCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] Running command: SetStoragePoolStatusCommand internal: true. Entities affected :  ID: b86b687a-d073-497a-ac8a-249025419a3e Type: StoragePool
>2014-10-05 21:25:50,512 INFO  [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (DefaultQuartzScheduler_Worker-41) [3167f8d9] Storage Pool b86b687a-d073-497a-ac8a-249025419a3e - Updating Storage Domain ff559f46-c495-4f6b-901c-2a624042a050 status from Active to Unknown, reason : null
>2014-10-05 21:25:50,516 INFO  [org.ovirt.engine.core.vdsbroker.storage.StoragePoolDomainHelper] (DefaultQuartzScheduler_Worker-41) [3167f8d9] Storage Pool b86b687a-d073-497a-ac8a-249025419a3e - Updating Storage Domain c73a3ced-4b41-4b4e-93f7-494d63e7e7ae status from Active to Unknown, reason : null
>2014-10-05 21:25:50,564 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-41) [3167f8d9] Correlation ID: 3167f8d9, Call Stack: null, Custom Event ID: -1, Message: Invalid status on Data Center iscsi-el7. Setting status to Non Responsive.
>2014-10-05 21:25:50,654 INFO  [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to voodoo1.tlv.redhat.com/10.35.0.100
>2014-10-05 21:25:51,300 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (DefaultQuartzScheduler_Worker-41) [3167f8d9] hostFromVds::selectedVds - voodoo1, spmStatus Unknown_Pool, storage pool iscsi-el7
>2014-10-05 21:25:51,307 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] START, ConnectStoragePoolVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, vdsId = 114c2cc6-5123-45bc-8900-5c875b0543c4, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, masterVersion = 5), log id: 76a7712c
>2014-10-05 21:25:51,518 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] Command org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand return value 
> StatusOnlyReturnForXmlRpc [mStatus=StatusForXmlRpc [mCode=304, mMessage=Cannot find master domain: u'spUUID=b86b687a-d073-497a-ac8a-249025419a3e, msdUUID=ff559f46-c495-4f6b-901c-2a624042a050']]
>2014-10-05 21:25:51,520 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] HostName = voodoo1
>2014-10-05 21:25:51,520 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] Command ConnectStoragePoolVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, vdsId = 114c2cc6-5123-45bc-8900-5c875b0543c4, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, masterVersion = 5) execution failed. Exception: IRSNoMasterDomainException: IRSGenericException: IRSErrorException: IRSNoMasterDomainException: Cannot find master domain: u'spUUID=b86b687a-d073-497a-ac8a-249025419a3e, msdUUID=ff559f46-c495-4f6b-901c-2a624042a050'
>2014-10-05 21:25:51,522 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] FINISH, ConnectStoragePoolVDSCommand, log id: 76a7712c
>2014-10-05 21:25:51,522 ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] IrsBroker::Failed::GetStoragePoolInfoVDS
>2014-10-05 21:25:51,523 ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] Exception: IRSGenericException: IRSErrorException: IRSNoMasterDomainException: Cannot find master domain: u'spUUID=b86b687a-d073-497a-ac8a-249025419a3e, msdUUID=ff559f46-c495-4f6b-901c-2a624042a050'
>2014-10-05 21:25:51,611 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (DefaultQuartzScheduler_Worker-41) [3167f8d9] Irs placed on server 114c2cc6-5123-45bc-8900-5c875b0543c4 failed. Proceed Failover
>2014-10-05 21:25:51,712 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (DefaultQuartzScheduler_Worker-41) [3167f8d9] hostFromVds::selectedVds - voodoo6, spmStatus Free, storage pool iscsi-el7
>2014-10-05 21:25:51,732 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (DefaultQuartzScheduler_Worker-41) [3167f8d9] starting spm on vds voodoo6, storage pool iscsi-el7, prevId -1, LVER -1
>2014-10-05 21:25:51,735 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] START, SpmStartVDSCommand(HostName = voodoo6, HostId = 45462850-a02c-4eeb-8527-292e15e5cb54, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, prevId=-1, prevLVER=-1, storagePoolFormatType=V3, recoveryMode=Manual, SCSIFencing=false), log id: 5bd9454
>2014-10-05 21:25:51,828 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] spmStart polling started: taskId = eee267e7-bb06-482b-bba9-df77835d1109
>2014-10-05 21:25:52,917 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] spmStart polling ended: taskId = eee267e7-bb06-482b-bba9-df77835d1109 task status = finished
>2014-10-05 21:25:53,095 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] spmStart polling ended, spm status: SPM
>2014-10-05 21:25:53,097 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] START, HSMClearTaskVDSCommand(HostName = voodoo6, HostId = 45462850-a02c-4eeb-8527-292e15e5cb54, taskId=eee267e7-bb06-482b-bba9-df77835d1109), log id: 585653e1
>2014-10-05 21:25:53,191 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] FINISH, HSMClearTaskVDSCommand, log id: 585653e1
>2014-10-05 21:25:53,191 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SpmStartVDSCommand] (DefaultQuartzScheduler_Worker-41) [3167f8d9] FINISH, SpmStartVDSCommand, return: org.ovirt.engine.core.common.businessentities.SpmStatusResult@2d7cbf2a, log id: 5bd9454
>2014-10-05 21:25:53,239 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (DefaultQuartzScheduler_Worker-41) [3167f8d9] Initialize Irs proxy from vds: voodoo6.tlv.redhat.com
>2014-10-05 21:25:53,247 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-41) [3167f8d9] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Storage Pool Manager runs on Host voodoo6 (Address: voodoo6.tlv.redhat.com).
>2014-10-05 21:25:53,251 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-30) [3167f8d9] START, SPMGetAllTasksInfoVDSCommand( storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, ignoreFailoverLimit = false), log id: 273cfe73
>2014-10-05 21:25:53,330 INFO  [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to voodoo6.tlv.redhat.com/10.35.0.110
>2014-10-05 21:25:54,020 INFO  [org.ovirt.engine.core.bll.storage.SyncLunsInfoForBlockStorageDomainCommand] (org.ovirt.thread.pool-8-thread-29) [115aab4d] Running command: SyncLunsInfoForBlockStorageDomainCommand internal: true. Entities affected :  ID: c73a3ced-4b41-4b4e-93f7-494d63e7e7ae Type: Storage
>2014-10-05 21:25:54,032 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVGInfoVDSCommand] (org.ovirt.thread.pool-8-thread-29) [115aab4d] START, GetVGInfoVDSCommand(HostName = voodoo6, HostId = 45462850-a02c-4eeb-8527-292e15e5cb54, VGID=pF71zc-KPBX-BMKm-7KHK-KihY-ysp4-6DZTpA), log id: 905cc5c
>2014-10-05 21:25:54,045 INFO  [org.ovirt.engine.core.bll.storage.SyncLunsInfoForBlockStorageDomainCommand] (org.ovirt.thread.pool-8-thread-35) [7c25c69b] Running command: SyncLunsInfoForBlockStorageDomainCommand internal: true. Entities affected :  ID: ff559f46-c495-4f6b-901c-2a624042a050 Type: Storage
>2014-10-05 21:25:54,059 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-30) [3167f8d9] -- executeIrsBrokerCommand: Attempting on storage pool b86b687a-d073-497a-ac8a-249025419a3e
>2014-10-05 21:25:54,061 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-30) [3167f8d9] START, HSMGetAllTasksInfoVDSCommand(HostName = voodoo6, HostId = 45462850-a02c-4eeb-8527-292e15e5cb54), log id: 58cfae8f
>2014-10-05 21:25:54,066 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVGInfoVDSCommand] (org.ovirt.thread.pool-8-thread-35) [7c25c69b] START, GetVGInfoVDSCommand(HostName = voodoo6, HostId = 45462850-a02c-4eeb-8527-292e15e5cb54, VGID=1B1oT5-JcGj-Ru1I-v3Ni-yden-Du9b-I9fSu8), log id: 5767aca7
>2014-10-05 21:25:54,171 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVGInfoVDSCommand] (org.ovirt.thread.pool-8-thread-29) [115aab4d] FINISH, GetVGInfoVDSCommand, return: [LUNs [id=3600144f09dbd0500000053a85076000a, physicalVolumeId=Ka3ewV-ddPQ-boL6-sDJT-xcFb-YBkc-9HeKFq, volumeGroupId=pF71zc-KPBX-BMKm-7KHK-KihY-ysp4-6DZTpA, serial=SNEXENTA_COMSTAR_5H49HFEFE, lunMapping=11, vendorId=NEXENTA, productId=COMSTAR, _lunConnections=[{ id: null, connection: 10.35.16.25, iqn: iqn.1994-05.com.redhat:nsoffer-target1, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };], deviceSize=10, vendorName=NEXENTA, pathsDictionary={sdl=true}, lunType=ISCSI, status=null, diskId=null, diskAlias=null, storageDomainId=c73a3ced-4b41-4b4e-93f7-494d63e7e7ae, storageDomainName=null], LUNs [id=3600144f09dbd0500000053a84e730003, physicalVolumeId=5zWyZx-cpAZ-tMON-3wa5-s6pN-Xj7N-b3fPs5, volumeGroupId=pF71zc-KPBX-BMKm-7KHK-KihY-ysp4-6DZTpA, serial=SNEXENTA_COMSTAR_5H49HFEFE, lunMapping=77, vendorId=NEXENTA, productId=COMSTAR, _lunConnections=[{ id: null, connection: 10.35.16.25, iqn: iqn.1994-05.com.redhat:nsoffer-target1, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };], deviceSize=10, vendorName=NEXENTA, pathsDictionary={sdo=true}, lunType=ISCSI, status=null, diskId=null, diskAlias=null, storageDomainId=c73a3ced-4b41-4b4e-93f7-494d63e7e7ae, storageDomainName=null], LUNs [id=3600144f09dbd0500000053a853ed000c, physicalVolumeId=c2LMVb-PXdj-XpTE-4f06-2rrh-TdAG-zzehcn, volumeGroupId=pF71zc-KPBX-BMKm-7KHK-KihY-ysp4-6DZTpA, serial=SNEXENTA_COMSTAR_5H49HFEFE, lunMapping=5, vendorId=NEXENTA, productId=COMSTAR, _lunConnections=[{ id: null, connection: 10.35.16.25, iqn: iqn.1994-05.com.redhat:nsoffer-target2, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };], deviceSize=10, vendorName=NEXENTA, pathsDictionary={sdae=true}, lunType=ISCSI, status=null, diskId=null, diskAlias=null, storageDomainId=c73a3ced-4b41-4b4e-93f7-494d63e7e7ae, storageDomainName=null], LUNs [id=3600144f09dbd0500000053a85401000d, physicalVolumeId=1kMage-eAId-qy7G-oIqH-tfbH-ScLD-gqv7JM, volumeGroupId=pF71zc-KPBX-BMKm-7KHK-KihY-ysp4-6DZTpA, serial=SNEXENTA_COMSTAR_5H49HFEFE, lunMapping=6, vendorId=NEXENTA, productId=COMSTAR, _lunConnections=[{ id: null, connection: 10.35.16.25, iqn: iqn.1994-05.com.redhat:nsoffer-target2, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };], deviceSize=10, vendorName=NEXENTA, pathsDictionary={sdaf=true}, lunType=ISCSI, status=null, diskId=null, diskAlias=null, storageDomainId=c73a3ced-4b41-4b4e-93f7-494d63e7e7ae, storageDomainName=null]], log id: 905cc5c
>2014-10-05 21:25:54,253 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-30) [3167f8d9] FINISH, HSMGetAllTasksInfoVDSCommand, return: [], log id: 58cfae8f
>2014-10-05 21:25:54,253 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.SPMGetAllTasksInfoVDSCommand] (org.ovirt.thread.pool-8-thread-30) [3167f8d9] FINISH, SPMGetAllTasksInfoVDSCommand, return: [], log id: 273cfe73
>2014-10-05 21:25:54,254 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (org.ovirt.thread.pool-8-thread-30) [3167f8d9] Discovered no tasks on Storage Pool iscsi-el7
>2014-10-05 21:25:54,333 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVGInfoVDSCommand] (org.ovirt.thread.pool-8-thread-35) [7c25c69b] FINISH, GetVGInfoVDSCommand, return: [LUNs [id=1IET_00060007, physicalVolumeId=QfuzQ5-Ml7u-kFUc-gdmr-rfmS-Aefp-3HODNb, volumeGroupId=1B1oT5-JcGj-Ru1I-v3Ni-yden-Du9b-I9fSu8, serial=SRed_Cat_VIRTUAL-DISK, lunMapping=7, vendorId=Red Cat, productId=VIRTUAL-DISK, _lunConnections=[{ id: null, connection: 10.35.0.98, iqn: iqn.1994-05.com.redhat:target6, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };], deviceSize=20, vendorName=Red Cat, pathsDictionary={sdv=true}, lunType=ISCSI, status=null, diskId=null, diskAlias=null, storageDomainId=ff559f46-c495-4f6b-901c-2a624042a050, storageDomainName=null], LUNs [id=1IET_00060009, physicalVolumeId=pGRciD-wcLp-X1ME-MijE-P1B9-7XWo-ycTXdG, volumeGroupId=1B1oT5-JcGj-Ru1I-v3Ni-yden-Du9b-I9fSu8, serial=SRed_Cat_VIRTUAL-DISK, lunMapping=9, vendorId=Red Cat, productId=VIRTUAL-DISK, _lunConnections=[{ id: null, connection: 10.35.0.98, iqn: iqn.1994-05.com.redhat:target6, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };], deviceSize=20, vendorName=Red Cat, pathsDictionary={sdx=true}, lunType=ISCSI, status=null, diskId=null, diskAlias=null, storageDomainId=ff559f46-c495-4f6b-901c-2a624042a050, storageDomainName=null]], log id: 5767aca7
>2014-10-05 21:26:05,734 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (org.ovirt.thread.pool-8-thread-37) starting processDomainRecovery for domain c73a3ced-4b41-4b4e-93f7-494d63e7e7ae:sasha-el7
>2014-10-05 21:26:05,751 WARN  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (org.ovirt.thread.pool-8-thread-37) vds voodoo1 reported domain c73a3ced-4b41-4b4e-93f7-494d63e7e7ae:sasha-el7 as in problem, attempting to move the vds to status NonOperational
>2014-10-05 21:26:05,753 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (org.ovirt.thread.pool-8-thread-37) Domain ff559f46-c495-4f6b-901c-2a624042a050:jumbo-el7 has recovered from problem. No active host in the DC is reporting it as poblematic, so clearing the domain recovery timer.
>2014-10-05 21:26:05,753 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (org.ovirt.thread.pool-8-thread-37) Removing vds [114c2cc6-5123-45bc-8900-5c875b0543c4] from the domain in maintenance cache
>2014-10-05 21:26:05,754 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.IrsProxyData] (org.ovirt.thread.pool-8-thread-37) Removing host(s) [114c2cc6-5123-45bc-8900-5c875b0543c4] from hosts unseen domain report cache
>2014-10-05 21:26:05,837 INFO  [org.ovirt.engine.core.bll.SetNonOperationalVdsCommand] (org.ovirt.thread.pool-8-thread-41) [7611ec62] Running command: SetNonOperationalVdsCommand internal: true. Entities affected :  ID: 114c2cc6-5123-45bc-8900-5c875b0543c4 Type: VDS
>2014-10-05 21:26:05,839 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-41) [7611ec62] START, SetVdsStatusVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, status=NonOperational, nonOperationalReason=STORAGE_DOMAIN_UNREACHABLE, stopSpmFailureLogged=false), log id: 790214f3
>2014-10-05 21:26:52,055 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.ListVDSCommand] (DefaultQuartzScheduler_Worker-4) Command ListVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, vds=Host[voodoo1,114c2cc6-5123-45bc-8900-5c875b0543c4]) execution failed. Exception: VDSNetworkException: VDSGenericException: VDSNetworkException: Message timeout which can be caused by communication issues'
>2014-10-05 21:26:52,056 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-4) Host voodoo1 is not responding. It will stay in Connecting state for a grace period of 60 seconds and after that an attempt to fence the host will be issued.
>2014-10-05 21:26:52,116 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-4) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Host voodoo1 is not responding. It will stay in Connecting state for a grace period of 60 seconds and after that an attempt to fence the host will be issued.
>2014-10-05 21:26:52,117 ERROR [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-4) Failure to refresh Vds runtime info: org.ovirt.engine.core.vdsbroker.vdsbroker.VDSNetworkException: VDSGenericException: VDSNetworkException: Message timeout which can be caused by communication issues'
>	at org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase.proceedProxyReturnValue(BrokerCommandBase.java:183) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.vdsbroker.ListVDSCommand.executeVdsBrokerCommand(ListVDSCommand.java:24) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand.executeVDSCommand(VdsBrokerCommand.java:96) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VDSCommandBase.executeCommand(VDSCommandBase.java:56) [vdsbroker.jar:]
>	at org.ovirt.engine.core.dal.VdcCommandBase.execute(VdcCommandBase.java:31) [dal.jar:]
>	at org.ovirt.engine.core.vdsbroker.ResourceManager.runVdsCommand(ResourceManager.java:418) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.fetchRunningVms(VdsUpdateRunTimeInfo.java:1000) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.refreshVmStats(VdsUpdateRunTimeInfo.java:949) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.refreshVdsRunTimeInfo(VdsUpdateRunTimeInfo.java:667) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.refresh(VdsUpdateRunTimeInfo.java:504) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsManager.onTimer(VdsManager.java:236) [vdsbroker.jar:]
>	at sun.reflect.GeneratedMethodAccessor7.invoke(Unknown Source) [:1.7.0_65]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_65]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_65]
>	at org.ovirt.engine.core.utils.timer.JobWrapper.execute(JobWrapper.java:60) [scheduler.jar:]
>	at org.quartz.core.JobRunShell.run(JobRunShell.java:213) [quartz.jar:]
>	at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557) [quartz.jar:]
>
>2014-10-05 21:26:52,133 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-4) Failed to refresh VDS , vds = 114c2cc6-5123-45bc-8900-5c875b0543c4 : voodoo1, VDS Network Error, continuing.
>VDSGenericException: VDSNetworkException: Message timeout which can be caused by communication issues'
>2014-10-05 21:26:52,141 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (org.ovirt.thread.pool-8-thread-41) [7611ec62] FINISH, SetVdsStatusVDSCommand, log id: 790214f3
>2014-10-05 21:26:52,157 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-41) [7611ec62] Correlation ID: 7611ec62, Job ID: 03528685-1b91-49d9-a0c4-21628a4b2f0b, Call Stack: null, Custom Event ID: -1, Message: Host voodoo1 cannot access the Storage Domain(s) sasha-el7 attached to the Data Center iscsi-el7. Setting Host state to Non-Operational.
>2014-10-05 21:30:00,021 INFO  [org.ovirt.engine.core.bll.AutoRecoveryManager] (DefaultQuartzScheduler_Worker-23) Autorecovering 1 hosts
>2014-10-05 21:30:00,021 INFO  [org.ovirt.engine.core.bll.AutoRecoveryManager] (DefaultQuartzScheduler_Worker-23) Autorecovering hosts id: 114c2cc6-5123-45bc-8900-5c875b0543c4, name : voodoo1
>2014-10-05 21:30:00,024 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (DefaultQuartzScheduler_Worker-23) [74f9b72] Lock Acquired to object EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS
>, sharedLocks= ]
>2014-10-05 21:30:00,025 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (DefaultQuartzScheduler_Worker-23) [74f9b72] Running command: ActivateVdsCommand internal: true. Entities affected :  ID: 114c2cc6-5123-45bc-8900-5c875b0543c4 Type: VDSAction group MANIPULATE_HOST with role type ADMIN
>2014-10-05 21:30:00,025 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (DefaultQuartzScheduler_Worker-23) [74f9b72] Before acquiring lock in order to prevent monitoring for host voodoo1 from data-center iscsi-el7
>2014-10-05 21:30:00,026 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (DefaultQuartzScheduler_Worker-23) [74f9b72] Lock acquired, from now a monitoring of host will be skipped for host voodoo1 from data-center iscsi-el7
>2014-10-05 21:30:00,029 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler_Worker-23) [74f9b72] START, SetVdsStatusVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, status=Unassigned, nonOperationalReason=NONE, stopSpmFailureLogged=false), log id: 75a2fea2
>2014-10-05 21:30:00,043 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (DefaultQuartzScheduler_Worker-23) [74f9b72] FINISH, SetVdsStatusVDSCommand, log id: 75a2fea2
>2014-10-05 21:30:00,068 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (DefaultQuartzScheduler_Worker-23) Activate finished. Lock released. Monitoring can run now for host voodoo1 from data-center iscsi-el7
>2014-10-05 21:30:00,077 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-23) Correlation ID: 74f9b72, Call Stack: null, Custom Event ID: -1, Message: Host voodoo1 was autorecovered.
>2014-10-05 21:30:00,077 INFO  [org.ovirt.engine.core.bll.ActivateVdsCommand] (DefaultQuartzScheduler_Worker-23) Lock freed to object EngineLock [exclusiveLocks= key: 114c2cc6-5123-45bc-8900-5c875b0543c4 value: VDS
>, sharedLocks= ]
>2014-10-05 21:30:01,332 INFO  [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to voodoo1.tlv.redhat.com/10.35.0.100
>2014-10-05 21:30:03,030 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-61) START, GetHardwareInfoVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, vds=Host[voodoo1,114c2cc6-5123-45bc-8900-5c875b0543c4]), log id: 3520f3ca
>2014-10-05 21:30:03,220 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-61) FINISH, GetHardwareInfoVDSCommand, log id: 3520f3ca
>2014-10-05 21:30:03,283 INFO  [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler_Worker-61) [62893be3] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected :  ID: 114c2cc6-5123-45bc-8900-5c875b0543c4 Type: VDS
>2014-10-05 21:30:03,426 INFO  [org.ovirt.engine.core.bll.InitVdsOnUpCommand] (DefaultQuartzScheduler_Worker-61) [419a8902] Running command: InitVdsOnUpCommand internal: true. Entities affected :  ID: b86b687a-d073-497a-ac8a-249025419a3e Type: StoragePool
>2014-10-05 21:30:03,441 INFO  [org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServersCommand] (DefaultQuartzScheduler_Worker-61) [e62be57] Running command: ConnectHostToStoragePoolServersCommand internal: true. Entities affected :  ID: b86b687a-d073-497a-ac8a-249025419a3e Type: StoragePool
>2014-10-05 21:30:03,461 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (DefaultQuartzScheduler_Worker-61) [e62be57] START, ConnectStorageServerVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, storageType = ISCSI, connectionList = [{ id: af150e8e-4d74-4810-b8bf-0c6a19637dbf, connection: 10.35.16.25, iqn: iqn.1994-05.com.redhat:nsoffer-target1, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };{ id: e8d58651-6414-4fc2-b281-2141cc97829b, connection: 10.35.0.98, iqn: iqn.1994-05.com.redhat:target6, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };{ id: 8f399b5f-1237-479e-82e6-eedb202b66fd, connection: 10.35.16.25, iqn: iqn.1994-05.com.redhat:nsoffer-target2, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 6f17108
>2014-10-05 21:30:06,195 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (DefaultQuartzScheduler_Worker-61) [e62be57] FINISH, ConnectStorageServerVDSCommand, return: {e8d58651-6414-4fc2-b281-2141cc97829b=0, af150e8e-4d74-4810-b8bf-0c6a19637dbf=0, 8f399b5f-1237-479e-82e6-eedb202b66fd=0}, log id: 6f17108
>2014-10-05 21:30:06,196 INFO  [org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServersCommand] (DefaultQuartzScheduler_Worker-61) [e62be57] Host voodoo1 storage connection was succeeded 
>2014-10-05 21:30:06,208 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (org.ovirt.thread.pool-8-thread-1) START, ConnectStoragePoolVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, vdsId = 114c2cc6-5123-45bc-8900-5c875b0543c4, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, masterVersion = 5), log id: 67762409
>2014-10-05 21:30:08,311 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (org.ovirt.thread.pool-8-thread-1) FINISH, ConnectStoragePoolVDSCommand, log id: 67762409
>2014-10-05 21:30:08,405 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SetMOMPolicyParametersVDSCommand] (DefaultQuartzScheduler_Worker-61) [e62be57] START, SetMOMPolicyParametersVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4), log id: 6c5c1dd9
>2014-10-05 21:30:08,534 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SetMOMPolicyParametersVDSCommand] (DefaultQuartzScheduler_Worker-61) [e62be57] FINISH, SetMOMPolicyParametersVDSCommand, log id: 6c5c1dd9
>2014-10-05 21:30:08,567 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-61) [e62be57] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Status of host voodoo1 was set to Up.
>2014-10-05 21:30:08,571 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-61) [e62be57] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Failed to verify Power Management configuration for Host voodoo1.
>2014-10-05 21:30:08,596 INFO  [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler_Worker-61) [13ffc39b] Running command: HandleVdsVersionCommand internal: true. Entities affected :  ID: 114c2cc6-5123-45bc-8900-5c875b0543c4 Type: VDS
>2014-10-05 21:30:43,877 ERROR [org.ovirt.vdsm.jsonrpc.client.reactors.Reactor] (SSL Stomp Reactor) Unable to process messages: java.io.IOException: Connection reset by peer
>	at sun.nio.ch.FileDispatcherImpl.write0(Native Method) [rt.jar:1.7.0_65]
>	at sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:47) [rt.jar:1.7.0_65]
>	at sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:93) [rt.jar:1.7.0_65]
>	at sun.nio.ch.IOUtil.write(IOUtil.java:65) [rt.jar:1.7.0_65]
>	at sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:487) [rt.jar:1.7.0_65]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.SSLEngineNioHelper.write(SSLEngineNioHelper.java:95) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.SSLClient.write(SSLClient.java:90) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient.processOutgoing(ReactorClient.java:199) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient.process(ReactorClient.java:170) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.SSLClient.process(SSLClient.java:115) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.Reactor.processChannels(Reactor.java:86) [vdsm-jsonrpc-java-client.jar:]
>	at org.ovirt.vdsm.jsonrpc.client.reactors.Reactor.run(Reactor.java:62) [vdsm-jsonrpc-java-client.jar:]
>
>2014-10-05 21:33:36,637 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.GetStatsVDSCommand] (DefaultQuartzScheduler_Worker-55) Command GetStatsVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, vds=Host[voodoo1,114c2cc6-5123-45bc-8900-5c875b0543c4]) execution failed. Exception: VDSNetworkException: VDSGenericException: VDSNetworkException: Message timeout which can be caused by communication issues'
>2014-10-05 21:33:36,640 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-55) Host voodoo1 is not responding. It will stay in Connecting state for a grace period of 60 seconds and after that an attempt to fence the host will be issued.
>2014-10-05 21:33:36,654 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-55) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Host voodoo1 is not responding. It will stay in Connecting state for a grace period of 60 seconds and after that an attempt to fence the host will be issued.
>2014-10-05 21:33:36,655 ERROR [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-55) vds::refreshVdsStats Failed getVdsStats,  vds = 114c2cc6-5123-45bc-8900-5c875b0543c4 : voodoo1, error = VDSNetworkException: VDSGenericException: VDSNetworkException: Message timeout which can be caused by communication issues'
>2014-10-05 21:33:36,656 ERROR [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-55) Failure to refresh Vds runtime info: org.ovirt.engine.core.vdsbroker.vdsbroker.VDSNetworkException: VDSGenericException: VDSNetworkException: Message timeout which can be caused by communication issues'
>	at org.ovirt.engine.core.vdsbroker.vdsbroker.BrokerCommandBase.proceedProxyReturnValue(BrokerCommandBase.java:183) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.vdsbroker.GetStatsVDSCommand.executeVdsBrokerCommand(GetStatsVDSCommand.java:24) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand.executeVDSCommand(VdsBrokerCommand.java:96) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VDSCommandBase.executeCommand(VDSCommandBase.java:56) [vdsbroker.jar:]
>	at org.ovirt.engine.core.dal.VdcCommandBase.execute(VdcCommandBase.java:31) [dal.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.refreshVdsStats(VdsUpdateRunTimeInfo.java:698) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.refreshVdsRunTimeInfo(VdsUpdateRunTimeInfo.java:652) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo.refresh(VdsUpdateRunTimeInfo.java:504) [vdsbroker.jar:]
>	at org.ovirt.engine.core.vdsbroker.VdsManager.onTimer(VdsManager.java:236) [vdsbroker.jar:]
>	at sun.reflect.GeneratedMethodAccessor7.invoke(Unknown Source) [:1.7.0_65]
>	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_65]
>	at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_65]
>	at org.ovirt.engine.core.utils.timer.JobWrapper.execute(JobWrapper.java:60) [scheduler.jar:]
>	at org.quartz.core.JobRunShell.run(JobRunShell.java:213) [quartz.jar:]
>	at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557) [quartz.jar:]
>
>2014-10-05 21:33:36,672 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (DefaultQuartzScheduler_Worker-55) Failed to refresh VDS , vds = 114c2cc6-5123-45bc-8900-5c875b0543c4 : voodoo1, VDS Network Error, continuing.
>VDSGenericException: VDSNetworkException: Message timeout which can be caused by communication issues'
>2014-10-05 21:33:39,759 INFO  [org.ovirt.vdsm.jsonrpc.client.reactors.ReactorClient] (SSL Stomp Reactor) Connecting to voodoo1.tlv.redhat.com/10.35.0.100
>2014-10-05 21:33:40,659 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-22) START, GetHardwareInfoVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, vds=Host[voodoo1,114c2cc6-5123-45bc-8900-5c875b0543c4]), log id: 7b387dfe
>2014-10-05 21:33:40,793 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.GetHardwareInfoVDSCommand] (DefaultQuartzScheduler_Worker-22) FINISH, GetHardwareInfoVDSCommand, log id: 7b387dfe
>2014-10-05 21:33:40,824 INFO  [org.ovirt.engine.core.bll.HandleVdsCpuFlagsOrClusterChangedCommand] (DefaultQuartzScheduler_Worker-22) [426be2a9] Running command: HandleVdsCpuFlagsOrClusterChangedCommand internal: true. Entities affected :  ID: 114c2cc6-5123-45bc-8900-5c875b0543c4 Type: VDS
>2014-10-05 21:33:40,911 INFO  [org.ovirt.engine.core.bll.InitVdsOnUpCommand] (DefaultQuartzScheduler_Worker-22) [2fe523de] Running command: InitVdsOnUpCommand internal: true. Entities affected :  ID: b86b687a-d073-497a-ac8a-249025419a3e Type: StoragePool
>2014-10-05 21:33:40,921 INFO  [org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServersCommand] (DefaultQuartzScheduler_Worker-22) [694878b7] Running command: ConnectHostToStoragePoolServersCommand internal: true. Entities affected :  ID: b86b687a-d073-497a-ac8a-249025419a3e Type: StoragePool
>2014-10-05 21:33:40,937 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (DefaultQuartzScheduler_Worker-22) [694878b7] START, ConnectStorageServerVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, storageType = ISCSI, connectionList = [{ id: af150e8e-4d74-4810-b8bf-0c6a19637dbf, connection: 10.35.16.25, iqn: iqn.1994-05.com.redhat:nsoffer-target1, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };{ id: e8d58651-6414-4fc2-b281-2141cc97829b, connection: 10.35.0.98, iqn: iqn.1994-05.com.redhat:target6, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };{ id: 8f399b5f-1237-479e-82e6-eedb202b66fd, connection: 10.35.16.25, iqn: iqn.1994-05.com.redhat:nsoffer-target2, vfsType: null, mountOptions: null, nfsVersion: null, nfsRetrans: null, nfsTimeo: null };]), log id: 3e16ec55
>2014-10-05 21:33:43,829 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStorageServerVDSCommand] (DefaultQuartzScheduler_Worker-22) [694878b7] FINISH, ConnectStorageServerVDSCommand, return: {e8d58651-6414-4fc2-b281-2141cc97829b=0, af150e8e-4d74-4810-b8bf-0c6a19637dbf=0, 8f399b5f-1237-479e-82e6-eedb202b66fd=0}, log id: 3e16ec55
>2014-10-05 21:33:43,830 INFO  [org.ovirt.engine.core.bll.storage.ConnectHostToStoragePoolServersCommand] (DefaultQuartzScheduler_Worker-22) [694878b7] Host voodoo1 storage connection was succeeded 
>2014-10-05 21:33:43,837 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (org.ovirt.thread.pool-8-thread-41) START, ConnectStoragePoolVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4, vdsId = 114c2cc6-5123-45bc-8900-5c875b0543c4, storagePoolId = b86b687a-d073-497a-ac8a-249025419a3e, masterVersion = 5), log id: 30623742
>2014-10-05 21:33:45,516 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.ConnectStoragePoolVDSCommand] (org.ovirt.thread.pool-8-thread-41) FINISH, ConnectStoragePoolVDSCommand, log id: 30623742
>2014-10-05 21:33:45,614 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SetMOMPolicyParametersVDSCommand] (DefaultQuartzScheduler_Worker-22) [694878b7] START, SetMOMPolicyParametersVDSCommand(HostName = voodoo1, HostId = 114c2cc6-5123-45bc-8900-5c875b0543c4), log id: 1a43164e
>2014-10-05 21:33:45,744 INFO  [org.ovirt.engine.core.vdsbroker.vdsbroker.SetMOMPolicyParametersVDSCommand] (DefaultQuartzScheduler_Worker-22) [694878b7] FINISH, SetMOMPolicyParametersVDSCommand, log id: 1a43164e
>2014-10-05 21:33:45,799 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-22) [694878b7] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Status of host voodoo1 was set to Up.
>2014-10-05 21:33:45,803 WARN  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (DefaultQuartzScheduler_Worker-22) [694878b7] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Failed to verify Power Management configuration for Host voodoo1.
>2014-10-05 21:33:45,826 INFO  [org.ovirt.engine.core.bll.HandleVdsVersionCommand] (DefaultQuartzScheduler_Worker-22) [7c946112] Running command: HandleVdsVersionCommand internal: true. Entities affected :  ID: 114c2cc6-5123-45bc-8900-5c875b0543c4 Type: VDS

Actions: View

Attachments on bug 1149517: 944065 | 944066 | 944067 | 944068