[teiid-issues] [JBoss JIRA] (TEIID-4336) Errors in logs during server shutdown

Ramesh Reddy (JIRA) issues at jboss.org
Thu Jul 14 10:03:00 EDT 2016


    [ https://issues.jboss.org/browse/TEIID-4336?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13265735#comment-13265735 ] 

Ramesh Reddy commented on TEIID-4336:
-------------------------------------

[~shawkins] If service dependencies are correctly specified the engine will shut them down in their reverse dependency. In this particular case "resultset-cache-enable" is defined as "false" (default is true) in the configuration, in which case the dependency is marked as "optional", thus it can be shutdown earlier than the dependent service does. Thus the issue.

> Errors in logs during server shutdown
> -------------------------------------
>
>                 Key: TEIID-4336
>                 URL: https://issues.jboss.org/browse/TEIID-4336
>             Project: Teiid
>          Issue Type: Quality Risk
>          Components: Query Engine
>    Affects Versions: 8.12.5
>            Reporter: Jan Stastny
>            Assignee: Steven Hawkins
>         Attachments: server.log
>
>
> When using materialization and user shuts down the server without disabling the vdb with materialized view defined a few exceptions appear in the server logs.
> I attached full server.log to this issue.
> {code:plain}
> 08:05:50,764 ERROR [org.teiid.CONNECTOR] (Worker3_QueryProcessorQueue626) Connector worker process failed for atomic-request=RsQyJH143A1D.0.0.953: java.lang.NullPointerException
> 	at org.teiid.translator.jdbc.JDBCBaseExecution.getPreparedStatement(JDBCBaseExecution.java:196) [translator-jdbc-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.translator.jdbc.JDBCQueryExecution.execute(JDBCQueryExecution.java:121) [translator-jdbc-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.dqp.internal.datamgr.ConnectorWorkItem.execute(ConnectorWorkItem.java:364)
> 	at sun.reflect.GeneratedMethodAccessor135.invoke(Unknown Source) [:1.8.0_92]
> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_92]
> 	at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_92]
> 	at org.teiid.dqp.internal.datamgr.ConnectorManager$1.invoke(ConnectorManager.java:211)
> 	at com.sun.proxy.$Proxy45.execute(Unknown Source)
> 	at org.teiid.dqp.internal.process.DataTierTupleSource.getResults(DataTierTupleSource.java:306)
> 	at org.teiid.dqp.internal.process.DataTierTupleSource.nextTuple(DataTierTupleSource.java:142)
> 	at org.teiid.query.processor.relational.AccessNode.nextBatchDirect(AccessNode.java:391)
> 	at org.teiid.query.processor.relational.RelationalNode.nextBatch(RelationalNode.java:282)
> 	at org.teiid.query.processor.relational.RelationalPlan.nextBatch(RelationalPlan.java:145)
> 	at org.teiid.query.processor.QueryProcessor.nextBatchDirect(QueryProcessor.java:151)
> 	at org.teiid.query.processor.QueryProcessor.nextBatch(QueryProcessor.java:114)
> 	at org.teiid.query.processor.BatchIterator.finalRow(BatchIterator.java:69)
> 	at org.teiid.common.buffer.AbstractTupleSource.getCurrentTuple(AbstractTupleSource.java:70)
> 	at org.teiid.query.processor.BatchIterator.getCurrentTuple(BatchIterator.java:84)
> 	at org.teiid.common.buffer.AbstractTupleSource.hasNext(AbstractTupleSource.java:92)
> 	at org.teiid.query.processor.proc.ProcedurePlan.executePlan(ProcedurePlan.java:608)
> 	at org.teiid.query.processor.proc.LoopInstruction.testCondition(LoopInstruction.java:108)
> 	at org.teiid.query.processor.proc.ProcedurePlan.processProcedure(ProcedurePlan.java:379)
> 	at org.teiid.query.processor.proc.ProcedurePlan.nextBatchDirect(ProcedurePlan.java:298)
> 	at org.teiid.query.processor.proc.ProcedurePlan.nextBatch(ProcedurePlan.java:270)
> 	at org.teiid.query.processor.QueryProcessor.nextBatchDirect(QueryProcessor.java:151)
> 	at org.teiid.query.processor.QueryProcessor.nextBatch(QueryProcessor.java:114)
> 	at org.teiid.query.processor.BatchCollector.collectTuples(BatchCollector.java:164)
> 	at org.teiid.query.processor.BatchCollector.collectTuples(BatchCollector.java:146)
> 	at org.teiid.dqp.internal.process.RequestWorkItem.processMore(RequestWorkItem.java:472)
> 	at org.teiid.dqp.internal.process.RequestWorkItem.process(RequestWorkItem.java:348)
> 	at org.teiid.dqp.internal.process.AbstractWorkItem.run(AbstractWorkItem.java:51)
> 	at org.teiid.dqp.internal.process.RequestWorkItem.run(RequestWorkItem.java:274)
> 	at org.teiid.dqp.internal.process.DQPWorkContext.runInContext(DQPWorkContext.java:276)
> 	at org.teiid.dqp.internal.process.ThreadReuseExecutor$RunnableWrapper.run(ThreadReuseExecutor.java:119)
> 	at org.teiid.dqp.internal.process.ThreadReuseExecutor$3.run(ThreadReuseExecutor.java:210)
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [rt.jar:1.8.0_92]
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [rt.jar:1.8.0_92]
> 	at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_92]
> {code}
> and 
> {code:plain}
> 8:05:50,797 WARN  [org.teiid.PROCESSOR.MATVIEWS] (MSC service thread 1-2) org.teiid.core.TeiidException: java.sql.SQLException: org.teiid.core.TeiidException
> 	at org.teiid.runtime.MaterializationManager.executeQuery(MaterializationManager.java:349) [teiid-runtime-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.runtime.MaterializationManager$1.process(MaterializationManager.java:101) [teiid-runtime-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.runtime.MaterializationManager.doMaterializationActions(MaterializationManager.java:199) [teiid-runtime-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.runtime.MaterializationManager.beforeRemove(MaterializationManager.java:90) [teiid-runtime-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.deployers.VDBRepository.notifyBeforeRemove(VDBRepository.java:394) [teiid-runtime-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.deployers.VDBRepository.removeVDB(VDBRepository.java:264) [teiid-runtime-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.deployers.VDBRepository.removeVDB(VDBRepository.java:260) [teiid-runtime-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.jboss.VDBService.cleanup(VDBService.java:264) [teiid-jboss-integration-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.jboss.VDBService.stop(VDBService.java:276) [teiid-jboss-integration-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.jboss.msc.service.ServiceControllerImpl$StopTask.stopService(ServiceControllerImpl.java:2088) [jboss-msc-1.1.5.Final-redhat-1.jar:1.1.5.Final-redhat-1]
> 	at org.jboss.msc.service.ServiceControllerImpl$StopTask.run(ServiceControllerImpl.java:2049) [jboss-msc-1.1.5.Final-redhat-1.jar:1.1.5.Final-redhat-1]
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [rt.jar:1.8.0_92]
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [rt.jar:1.8.0_92]
> 	at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_92]
> Caused by: org.teiid.core.TeiidException
> 	at org.teiid.client.ResultsMessage.setException(ResultsMessage.java:196) [teiid-client-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.dqp.internal.process.RequestWorkItem.sendError(RequestWorkItem.java:1088) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.dqp.internal.process.RequestWorkItem.close(RequestWorkItem.java:578) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.dqp.internal.process.RequestWorkItem.process(RequestWorkItem.java:374) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.dqp.internal.process.AbstractWorkItem.run(AbstractWorkItem.java:51) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.dqp.internal.process.RequestWorkItem.run(RequestWorkItem.java:274) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.dqp.internal.process.DQPWorkContext.runInContext(DQPWorkContext.java:276) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.dqp.internal.process.ThreadReuseExecutor$RunnableWrapper.run(ThreadReuseExecutor.java:119) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.dqp.internal.process.ThreadReuseExecutor$3.run(ThreadReuseExecutor.java:210) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	... 3 more
> Caused by: java.lang.NullPointerException
> 	at org.teiid.translator.jdbc.JDBCBaseExecution.getPreparedStatement(JDBCBaseExecution.java:196)
> 	at org.teiid.translator.jdbc.JDBCQueryExecution.execute(JDBCQueryExecution.java:121)
> 	at org.teiid.dqp.internal.datamgr.ConnectorWorkItem.execute(ConnectorWorkItem.java:364) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at sun.reflect.GeneratedMethodAccessor135.invoke(Unknown Source) [:1.8.0_92]
> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.8.0_92]
> 	at java.lang.reflect.Method.invoke(Method.java:498) [rt.jar:1.8.0_92]
> 	at org.teiid.dqp.internal.datamgr.ConnectorManager$1.invoke(ConnectorManager.java:211) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at com.sun.proxy.$Proxy45.execute(Unknown Source)
> 	at org.teiid.dqp.internal.process.DataTierTupleSource.getResults(DataTierTupleSource.java:306) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.dqp.internal.process.DataTierTupleSource.nextTuple(DataTierTupleSource.java:142) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.relational.AccessNode.nextBatchDirect(AccessNode.java:391) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.relational.RelationalNode.nextBatch(RelationalNode.java:282) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.relational.RelationalPlan.nextBatch(RelationalPlan.java:145) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.QueryProcessor.nextBatchDirect(QueryProcessor.java:151) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.QueryProcessor.nextBatch(QueryProcessor.java:114) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.BatchIterator.finalRow(BatchIterator.java:69) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.common.buffer.AbstractTupleSource.getCurrentTuple(AbstractTupleSource.java:70) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.BatchIterator.getCurrentTuple(BatchIterator.java:84) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.common.buffer.AbstractTupleSource.hasNext(AbstractTupleSource.java:92) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.proc.ProcedurePlan.executePlan(ProcedurePlan.java:608) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.proc.LoopInstruction.testCondition(LoopInstruction.java:108) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.proc.ProcedurePlan.processProcedure(ProcedurePlan.java:379) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.proc.ProcedurePlan.nextBatchDirect(ProcedurePlan.java:298) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.proc.ProcedurePlan.nextBatch(ProcedurePlan.java:270) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.QueryProcessor.nextBatchDirect(QueryProcessor.java:151) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.QueryProcessor.nextBatch(QueryProcessor.java:114) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.BatchCollector.collectTuples(BatchCollector.java:164) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.query.processor.BatchCollector.collectTuples(BatchCollector.java:146) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.dqp.internal.process.RequestWorkItem.processMore(RequestWorkItem.java:472) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	at org.teiid.dqp.internal.process.RequestWorkItem.process(RequestWorkItem.java:348) [teiid-engine-8.12.5.redhat-7.jar:8.12.5.redhat-7]
> 	... 8 more
> {code}
> and in the end:
> {code:plain}
> 08:05:50,818 WARN  [org.jboss.msc.service.fail] (MSC service thread 1-2) MSC000004: Failure during stop of service jboss.teiid.vdb.saphana.1: java.lang.IllegalStateException
> 	at org.jboss.msc.value.InjectedValue.getValue(InjectedValue.java:47) [jboss-msc-1.1.5.Final-redhat-1.jar:1.1.5.Final-redhat-1]
> 	at org.teiid.jboss.DQPCoreService$1.removed(DQPCoreService.java:117)
> 	at org.teiid.deployers.VDBRepository.notifyRemove(VDBRepository.java:387)
> 	at org.teiid.deployers.VDBRepository.removeVDB(VDBRepository.java:271)
> 	at org.teiid.deployers.VDBRepository.removeVDB(VDBRepository.java:260)
> 	at org.teiid.jboss.VDBService.cleanup(VDBService.java:264)
> 	at org.teiid.jboss.VDBService.stop(VDBService.java:276)
> 	at org.jboss.msc.service.ServiceControllerImpl$StopTask.stopService(ServiceControllerImpl.java:2088) [jboss-msc-1.1.5.Final-redhat-1.jar:1.1.5.Final-redhat-1]
> 	at org.jboss.msc.service.ServiceControllerImpl$StopTask.run(ServiceControllerImpl.java:2049) [jboss-msc-1.1.5.Final-redhat-1.jar:1.1.5.Final-redhat-1]
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [rt.jar:1.8.0_92]
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [rt.jar:1.8.0_92]
> 	at java.lang.Thread.run(Thread.java:745) [rt.jar:1.8.0_92]
> {code}



--
This message was sent by Atlassian JIRA
(v6.4.11#64026)


More information about the teiid-issues mailing list