[
https://issues.jboss.org/browse/TEIID-2823?page=com.atlassian.jira.plugin...
]
Steven Hawkins commented on TEIID-2823:
---------------------------------------
Teiid typically logs most "errors" as warnings. We differentiate between
unexpected errors, such as problems with Teiid code. And errors from query execution,
which can be attributable to user or other more benign circumstances - for example we
don't want to fill up the logs with errors every time a query is submitted with a
parsing error.
You'll have to provide more context about this situation as to what exception the
client may or may not be seeing and the details of the query execution - for example is
the procedure using an exception handling block that is swallowing the exception.
Postgres is throwing PSQLExceptions, but Teiid is logging as
warnings, and nothing is getting back to client
------------------------------------------------------------------------------------------------------------
Key: TEIID-2823
URL:
https://issues.jboss.org/browse/TEIID-2823
Project: Teiid
Issue Type: Bug
Components: JDBC Connector
Affects Versions: 8.4
Reporter: Van Halbert
Assignee: Steven Hawkins
Postgres is throwing PSQLExceptions, but Teiid is logging them as warning. The problem
is the error isn't being returned to the client. The app continues to run with no
knowledge of all the errors on the server. Here's an example of the server error:
09:50:35,349 WARN [org.teiid.CONNECTOR] (Worker6_QueryProcessorQueue12168) Connector
worker process failed for atomic-request=Pn2BUCkOYts6.0.9.4084:
org.teiid.translator.jdbc.JDBCExecutionException: 0 TEIID11013:TEIID11004 Error executing
statement(s): [Prepared Values: [267, 2625077, 27, -280251] SQL: INSERT INTO
"public"."history" ("tid", "bid", "aid",
"delta") VALUES (?, ?, ?, ?)]
at
org.teiid.translator.jdbc.JDBCUpdateExecution.executeTranslatedCommand(JDBCUpdateExecution.java:242)
at org.teiid.translator.jdbc.JDBCUpdateExecution.execute(JDBCUpdateExecution.java:76)
at
org.teiid.dqp.internal.datamgr.ConnectorWorkItem$1.execute(ConnectorWorkItem.java:345)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.dqp.internal.datamgr.ConnectorWorkItem.execute(ConnectorWorkItem.java:312)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at
org.teiid.dqp.internal.process.DataTierTupleSource.getResults(DataTierTupleSource.java:301)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at
org.teiid.dqp.internal.process.DataTierTupleSource.nextTuple(DataTierTupleSource.java:138)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.query.processor.relational.AccessNode.nextBatchDirect(AccessNode.java:306)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at
org.teiid.query.processor.relational.RelationalNode.nextBatch(RelationalNode.java:278)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at
org.teiid.query.processor.relational.RelationalPlan.nextBatch(RelationalPlan.java:149)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.query.processor.QueryProcessor.nextBatchDirect(QueryProcessor.java:149)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.query.processor.QueryProcessor.nextBatch(QueryProcessor.java:112)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.query.processor.BatchIterator.finalRow(BatchIterator.java:69)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at
org.teiid.common.buffer.AbstractTupleSource.getCurrentTuple(AbstractTupleSource.java:70)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.query.processor.BatchIterator.getCurrentTuple(BatchIterator.java:84)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.common.buffer.AbstractTupleSource.hasNext(AbstractTupleSource.java:92)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.query.processor.proc.ProcedurePlan.executePlan(ProcedurePlan.java:563)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at
org.teiid.query.processor.proc.CreateCursorResultSetInstruction.process(CreateCursorResultSetInstruction.java:68)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.query.processor.proc.ProcedurePlan.processProcedure(ProcedurePlan.java:356)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.query.processor.proc.ProcedurePlan.nextBatchDirect(ProcedurePlan.java:283)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.query.processor.proc.ProcedurePlan.nextBatch(ProcedurePlan.java:257)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at
org.teiid.query.processor.relational.PlanExecutionNode.nextBatchDirect(PlanExecutionNode.java:118)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at
org.teiid.query.processor.relational.RelationalNode.nextBatch(RelationalNode.java:278)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at
org.teiid.query.processor.relational.ProjectNode.nextBatchDirect(ProjectNode.java:146)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at
org.teiid.query.processor.relational.RelationalNode.nextBatch(RelationalNode.java:278)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at
org.teiid.query.processor.relational.RelationalPlan.nextBatch(RelationalPlan.java:149)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.query.processor.QueryProcessor.nextBatchDirect(QueryProcessor.java:149)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.query.processor.QueryProcessor.nextBatch(QueryProcessor.java:112)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.query.processor.BatchCollector.collectTuples(BatchCollector.java:157)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.query.processor.BatchCollector.collectTuples(BatchCollector.java:139)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.dqp.internal.process.RequestWorkItem.processMore(RequestWorkItem.java:435)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.dqp.internal.process.RequestWorkItem.process(RequestWorkItem.java:320)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.dqp.internal.process.AbstractWorkItem.run(AbstractWorkItem.java:51)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.dqp.internal.process.RequestWorkItem.run(RequestWorkItem.java:248)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at org.teiid.dqp.internal.process.DQPWorkContext.runInContext(DQPWorkContext.java:269)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at
org.teiid.dqp.internal.process.ThreadReuseExecutor$RunnableWrapper.run(ThreadReuseExecutor.java:119)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at
org.teiid.dqp.internal.process.ThreadReuseExecutor$3.run(ThreadReuseExecutor.java:214)
[teiid-engine-8.4.1-redhat-7.jar:8.4.1-redhat-7]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
[rt.jar:1.7.0_13]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[rt.jar:1.7.0_13]
at java.lang.Thread.run(Thread.java:722) [rt.jar:1.7.0_13]
Caused by: org.postgresql.util.PSQLException: ERROR: insert or update on table
"history" violates foreign key constraint "history_bid_fkey"
Detail: Key (bid)=(2625077) is not present in table "branches".
at
org.postgresql.core.v3.QueryExecutorImpl.receiveErrorResponse(QueryExecutorImpl.java:2102)
at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1835)
at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:257)
at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:500)
at
org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:388)
at
org.postgresql.jdbc2.AbstractJdbc2Statement.executeUpdate(AbstractJdbc2Statement.java:334)
at
org.jboss.jca.adapters.jdbc.WrappedPreparedStatement.executeUpdate(WrappedPreparedStatement.java:493)
at
org.teiid.translator.jdbc.JDBCUpdateExecution.executeTranslatedCommand(JDBCUpdateExecution.java:213)
... 38 more
--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators
For more information on JIRA, see:
http://www.atlassian.com/software/jira