Please note that there is a NPE in the engine log for trying to update the task status which I think is something that should be addressed.however, I could not find a failure in the vdsm which would be related to this issue.The issue is actually with engine loosing connection to host and assuming there was a failure.Link and headline of suspected patches:
Patch repoted as the failed: https://gerrit.ovirt.org/#/c/8
6198/2 Patch reported as root cause: https://gerrit.ovirt.org/#/c/8
4883/11 Link to Job:
http://jenkins.ovirt.org/job/ovirt-master_change-queue-teste r/4829/ Link to all logs:
http://jenkins.ovirt.org/job/ovirt-master_change-queue- tester/4829/artifact/ (Relevant) error snippet from the log:
<error>
2018-01-14 21:24:16,881-05 ERROR [org.ovirt.vdsm.jsonrpc.client.JsonRpcClient] (ResponseWorker) [] Not able to update response for "6bae83f1-184c-475a-96e7- 240e58ead94c"
2018-01-14 21:25:34,824-05 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (default task-6) [ae77e2a8-1473-487d-949b- e6f525dcb38f] Adding task '388ef299-f83e-4af1-93a6- 07781caf275f' (Parent Command 'AddImageFromScratch', Paramete
rs Type 'org.ovirt.engine.core.common.asynctasks. AsyncTaskParameters'), polling hasn't started yet..
2018-01-14 21:25:34,866-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (default task-6) [ae77e2a8-1473-487d-949b- e6f525dcb38f] BaseAsyncTask:: startPollingTask: Starting to poll task '388ef299-f83e-4af1-93a6- 07781caf275f'.
2018-01-14 21:25:34,900-05 ERROR [org.ovirt.engine.core.bll.storage.disk.AddDiskCommand] (default task-6) [ae77e2a8-1473-487d-949b- e6f525dcb38f] Command 'org.ovirt.engine.core.bll. storage.disk.AddDiskCommand' failed: null
2018-01-14 21:25:34,900-05 ERROR [org.ovirt.engine.core.bll.storage.disk.AddDiskCommand] (default task-6) [ae77e2a8-1473-487d-949b- e6f525dcb38f] Exception: java.lang.NullPointerException
at org.ovirt.engine.core.bll.VmCommand.executeCommand( VmCommand.java:163) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase. executeWithoutTransaction( CommandBase.java:1140) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase. executeActionInTransactionScop e(CommandBase.java:1282) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase.runInTransaction( CommandBase.java:1931) [bll.jar:]
at org.ovirt.engine.core.utils.transaction. TransactionSupport. executeInSuppressed( TransactionSupport.java:164) [utils.jar:]
at org.ovirt.engine.core.utils.transaction. TransactionSupport. executeInScope( TransactionSupport.java:103) [utils.jar:]
at org.ovirt.engine.core.bll.CommandBase.execute( CommandBase.java:1342) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase.executeAction( CommandBase.java:407) [bll.jar:]
at org.ovirt.engine.core.bll.executor. DefaultBackendActionExecutor. execute( DefaultBackendActionExecutor. java:13) [bll.jar:]
at org.ovirt.engine.core.bll.Backend.runAction(Backend. java:468) [bll.jar:]
at org.ovirt.engine.core.bll.Backend.runActionImpl(Backend. java:450) [bll.jar:]
at org.ovirt.engine.core.bll.Backend.runInternalAction( Backend.java:656) [bll.jar:]
at sun.reflect.NativeMethodAccessorImpl. invoke0(Native Method) [rt.jar:1.8.0_151]
at sun.reflect.NativeMethodAccessorImpl. invoke( NativeMethodAccessorImpl.java: 62) [rt.jar:1.8.0_151]
at sun.reflect.DelegatingMethodAccessorImpl. invoke( DelegatingMethodAccessorImpl. java:43) [rt.jar:1.8.0_151]
at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_151]
at org.jboss.as.ee.component.ManagedReferenceMethodIntercep tor.processInvocation( ManagedReferenceMethodIntercep tor.java:52)
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.invocation.InterceptorContext$Invocation. proceed(InterceptorContext. java:509)
at org.jboss.as.weld.interceptors. Jsr299BindingsInterceptor. delegateInterception( Jsr299BindingsInterceptor. java:78)
at org.jboss.as.weld.interceptors. Jsr299BindingsInterceptor. doMethodInterception( Jsr299BindingsInterceptor. java:88)
at org.jboss.as.weld.interceptors. Jsr299BindingsInterceptor. processInvocation( Jsr299BindingsInterceptor. java:101)
at org.jboss.as.ee.component.interceptors. UserInterceptorFactory$1. processInvocation( UserInterceptorFactory.java: 63)
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.as.ejb3.component.invocationmetrics. ExecutionTimeInterceptor. processInvocation( ExecutionTimeInterceptor.java: 43) [wildfly-ejb3-11.0.0.Final. jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.as.ee.concurrent.ConcurrentContextInterceptor. processInvocation( ConcurrentContextInterceptor. java:45) [wildfly-ee-11.0.0.Final.jar: 11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.invocation.InitialInterceptor. processInvocation( InitialInterceptor.java:40)
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.invocation.ChainedInterceptor. processInvocation( ChainedInterceptor.java:53)
at org.jboss.as.ee.component.interceptors. ComponentDispatcherInterceptor .processInvocation( ComponentDispatcherInterceptor .java:52)
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.as.ejb3.component.singleton. SingletonComponentInstanceAsso ciationInterceptor. processInvocation( SingletonComponentInstanceAsso ciationInterceptor.java:53) [wildfly-ejb3-11.0.0.Final. jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.as.ejb3.tx.CMTTxInterceptor. invokeInCallerTx( CMTTxInterceptor.java:255) [wildfly-ejb3-11.0.0.Final. jar:11.0.0.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor.supports( CMTTxInterceptor.java:381) [wildfly-ejb3-11.0.0.Final. jar:11.0.0.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor. processInvocation( CMTTxInterceptor.java:244) [wildfly-ejb3-11.0.0.Final. jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.invocation.InterceptorContext$Invocation. proceed(InterceptorContext. java:509)
at org.jboss.weld.ejb.AbstractEJBRequestScopeActivat ionInterceptor.aroundInvoke( AbstractEJBRequestScopeActivat ionInterceptor.java:64) [weld-core-impl-2.4.3.Final. jar:2.4.3.Final]
at org.jboss.as.weld.ejb.EjbRequestScopeActivationInter ceptor.processInvocation( EjbRequestScopeActivationInter ceptor.java:89)
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.as.ejb3.component.interceptors. CurrentInvocationContextInterc eptor.processInvocation( CurrentInvocationContextInterc eptor.java:41) [wildfly-ejb3-11.0.0.Final. jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.as.ejb3.component.invocationmetrics. WaitTimeInterceptor. processInvocation( WaitTimeInterceptor.java:47) [wildfly-ejb3-11.0.0.Final. jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.as.ejb3.security.SecurityContextInterceptor. processInvocation( SecurityContextInterceptor. java:100) [wildfly-ejb3-11.0.0.Final. jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.as.ejb3.deployment.processors. StartupAwaitInterceptor. processInvocation( StartupAwaitInterceptor.java: 22) [wildfly-ejb3-11.0.0.Final. jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
at org.jboss.as.ejb3.component.interceptors. ShutDownInterceptorFactory$1. processInvocation( ShutDownInterceptorFactory. java:64) [wildfly-ejb3-11.0.0.Final. jar:11.0.0.Final]
at org.jboss.invocation.InterceptorContext.proceed( InterceptorContext.java:422)
:</error>