[MARMOTTA-280] SPARQL Timeout: Too many error messages and invalid transaction

• Type: Bug
• Status: Closed
• Priority: Minor
• Resolution: Fixed
• Fix Version/s: 3.1-incubating
• Component/s: KiWi Triple Store
• Assignee: Sebastian Schaffert
• Reporter: Sebastian Schaffert
• Created: 29/Jul/13 09:52
• Updated: 03/Oct/13 13:38
• Resolved: 11/Sep/13 15:56

Description

When the new SPARQL timeout mechanism stops a running SPARQL query, the error log is filled with exception traces; this should not happen, the SPARQL evaluation should abort completely on such errors.

Stack Traces:

11:21:19.926 ERROR o.a.m.k.s.p.KiWiSparqlConnection - error executing SPARQL query
java.util.concurrent.ExecutionException: org.postgresql.util.PSQLException: FEHLER: aktuelle Transaktion wurde abgebrochen, Befehle werden bis zum Ende der Transaktion ignoriert
at java.util.concurrent.FutureTask$Sync.innerGet(FutureTask.java:252) [na:1.7.0_03]
at java.util.concurrent.FutureTask.get(FutureTask.java:111) [na:1.7.0_03]
at org.apache.marmotta.kiwi.sparql.persistence.KiWiSparqlConnection.evaluateJoin(KiWiSparqlConnection.java:314) ~[kiwi-sparql-3.1.0-incubating-20130722.144056-26.jar:3.1.0-incubating-SNAPSHOT]
at org.apache.marmotta.kiwi.sparql.evaluation.KiWiEvaluationStrategyImpl.evaluate(KiWiEvaluationStrategyImpl.java:73) [kiwi-sparql-3.1.0-incubating-20130722.144056-26.jar:3.1.0-incubating-SNAPSHOT]

Later:

11:21:19.927 WARN o.a.m.kiwi.sail.KiWiSailConnection - Rolling back transaction due to connection close
java.lang.Throwable: null
at org.openrdf.sail.helpers.SailConnectionBase.close(SailConnectionBase.java:240) [sesame-sail-api-2.7.3.jar:na]
at org.openrdf.sail.helpers.SailConnectionWrapper.close(SailConnectionWrapper.java:88) [sesame-sail-api-2.7.3.jar:na]
at org.openrdf.sail.helpers.SailConnectionWrapper.close(SailConnectionWrapper.java:88) [sesame-sail-api-2.7.3.jar:na]
at org.openrdf.repository.sail.SailRepositoryConnection.close(SailRepositoryConnection.java:129) [sesame-repository-sail-2.7.3.jar:na]

And later:

11:21:19.928 ERROR o.a.m.p.s.s.sparql.SparqlServiceImpl - error while evaluating query: {}
org.openrdf.query.QueryEvaluationException: org.openrdf.query.QueryEvaluationException: java.sql.SQLException: error executing SPARQL query
at org.openrdf.repository.sail.SailTupleQuery.evaluate(SailTupleQuery.java:67) ~[sesame-repository-sail-2.7.3.jar:na]
at org.openrdf.repository.sail.SailTupleQuery.evaluate(SailTupleQuery.java:75) ~[sesame-repository-sail-2.7.3.jar:na]
at org.apache.marmotta.platform.sparql.services.sparql.SparqlServiceImpl.query(SparqlServiceImpl.java:248) ~[marmotta-sparql-3.1.0-incubating-20130722.130026-21.jar:3.1.0-incubating-SNAPSHOT]
at org.apache.marmotta.platform.sparql.services.sparql.SparqlServiceImpl.access$200(SparqlServiceImpl.java:71) ~[marmotta-sparql-3.1.0-incubating-20130722.130026-21.jar:3.1.0-incubating-SNAPSHOT]
at org.apache.marmotta.platform.sparql.services.sparql.SparqlServiceImpl$2.call(SparqlServiceImpl.java:133) [marmotta-sparql-3.1.0-incubating-20130722.130026-21.jar:3.1.0-incubating-SNAPSHOT]
at org.apache.marmotta.platform.sparql.services.sparql.SparqlServiceImpl$2.call(SparqlServiceImpl.java:122) [marmotta-sparql-3.1.0-incubating-20130722.130026-21.jar:3.1.0-incubating-SNAPSHOT]
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334) [na:1.7.0_03]
at java.util.concurrent.FutureTask.run(FutureTask.java:166) [na:1.7.0_03]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [na:1.7.0_03]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [na:1.7.0_03]
at java.lang.Thread.run(Thread.java:722) [na:1.7.0_03]
Caused by: org.openrdf.sail.SailException: org.openrdf.query.QueryEvaluationException: java.sql.SQLException: error executing SPARQL query
at org.apache.marmotta.kiwi.sparql.sail.KiWiSparqlSailConnection.evaluate(KiWiSparqlSailConnection.java:92) ~[kiwi-sparql-3.1.0-incubating-20130722.144056-26.jar:3.1.0-incubating-SNAPSHOT]
at org.openrdf.repository.sail.SailTupleQuery.evaluate(SailTupleQuery.java:60) ~[sesame-repository-sail-2.7.3.jar:na]
... 10 common frames omitted
Caused by: org.openrdf.query.QueryEvaluationException: java.sql.SQLException: error executing SPARQL query
at org.apache.marmotta.kiwi.sparql.evaluation.KiWiEvaluationStrategyImpl.evaluate(KiWiEvaluationStrategyImpl.java:80) ~[kiwi-sparql-3.1.0-incubating-20130722.144056-26.jar:3.1.0-incubating-SNAPSHOT]
Caused by: java.sql.SQLException: error executing SPARQL query
at org.apache.marmotta.kiwi.sparql.persistence.KiWiSparqlConnection.evaluateJoin(KiWiSparqlConnection.java:343) ~[kiwi-sparql-3.1.0-incubating-20130722.144056-26.jar:3.1.0-incubating-SNAPSHOT]
at org.apache.marmotta.kiwi.sparql.evaluation.KiWiEvaluationStrategyImpl.evaluate(KiWiEvaluationStrategyImpl.java:73) ~[kiwi-sparql-3.1.0-incubating-20130722.144056-26.jar:3.1.0-incubating-SNAPSHOT]
... 22 common frames omitted
Caused by: java.util.concurrent.ExecutionException: org.postgresql.util.PSQLException: FEHLER: aktuelle Transaktion wurde abgebrochen, Befehle werden bis zum Ende der Transaktion ignoriert
at java.util.concurrent.FutureTask$Sync.innerGet(FutureTask.java:252) [na:1.7.0_03]
at java.util.concurrent.FutureTask.get(FutureTask.java:111) [na:1.7.0_03]
at org.apache.marmotta.kiwi.sparql.persistence.KiWiSparqlConnection.evaluateJoin(KiWiSparqlConnection.java:314) ~[kiwi-sparql-3.1.0-incubating-20130722.144056-26.jar:3.1.0-incubating-SNAPSHOT]
... 23 common frames omitted
Caused by: org.postgresql.util.PSQLException: FEHLER: aktuelle Transaktion wurde abgebrochen, Befehle werden bis zum Ende der Transaktion ignoriert
at org.postgresql.core.v3.QueryExecutorImpl.receiveErrorResponse(QueryExecutorImpl.java:2157) ~[postgresql-9.2-1002.jdbc4.jar:na]
at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1886) ~[postgresql-9.2-1002.jdbc4.jar:na]
at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:255) ~[postgresql-9.2-1002.jdbc4.jar:na]
at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:555) ~[postgresql-9.2-1002.jdbc4.jar:na]
at org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:417) ~[postgresql-9.2-1002.jdbc4.jar:na]
at org.postgresql.jdbc2.AbstractJdbc2Statement.executeQuery(AbstractJdbc2Statement.java:302) ~[postgresql-9.2-1002.jdbc4.jar:na]
at org.apache.marmotta.kiwi.sparql.persistence.KiWiSparqlConnection$1.call(KiWiSparqlConnection.java:307) ~[kiwi-sparql-3.1.0-incubating-20130722.144056-26.jar:3.1.0-incubating-SNAPSHOT]
at org.apache.marmotta.kiwi.sparql.persistence.KiWiSparqlConnection$1.call(KiWiSparqlConnection.java:304) ~[kiwi-sparql-3.1.0-incubating-20130722.144056-26.jar:3.1.0-incubating-SNAPSHOT]