[ 
https://issues.apache.org/jira/browse/IGNITE-25618?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=17973518#comment-17973518
 ] 

Pavel Pereslegin commented on IGNITE-25618:
-------------------------------------------

A detailed description of the problem and the best solutions are described in 
the pull request.

> Investigate ItSqlLogicTest.sql(order/test_order_same_value.test flaky failure
> -----------------------------------------------------------------------------
>
>                 Key: IGNITE-25618
>                 URL: https://issues.apache.org/jira/browse/IGNITE-25618
>             Project: Ignite
>          Issue Type: Bug
>          Components: sql, sql ai3
>            Reporter: Pavel Pereslegin
>            Assignee: Pavel Pereslegin
>            Priority: Major
>              Labels: ignite-3
>         Attachments: 
> _Integration_Tests_Module_SQL_Engine_SQL_Logic_1_19483.log.zip
>
>          Time Spent: 0.5h
>  Remaining Estimate: 0h
>
> After IGNITE-24914, we still encounter an flaky failures of the 
> "test_order_same_value.test" test (it's now extremely rare, but still 
> present).
> {noformat}
> org.opentest4j.AssertionFailedError: Not expected result at: 
> (test_order_same_value.test:71). Statement: INSERT INTO integers SELECT * 
> FROM integers
>       at 
> app//org.apache.ignite.internal.sql.sqllogic.Statement.execute(Statement.java:129)
>       at 
> app//org.apache.ignite.internal.sql.sqllogic.SqlScriptRunner.run(SqlScriptRunner.java:70)
>       at 
> java.base@21.0.1/java.util.concurrent.FutureTask.run(FutureTask.java:317)
>       at 
> java.base@21.0.1/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144)
>       at 
> java.base@21.0.1/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642)
>       at java.base@21.0.1/java.lang.Thread.run(Thread.java:1583)
> Caused by: org.apache.ignite.sql.SqlException: IGN-TX-16 Transaction is 
> already finished txId=[01972428-55a3-0000-84db-a7e000000001, 
> txState=FINISHING]. TraceId:4cc579db
>       at 
> java.base@21.0.1/java.lang.invoke.MethodHandle.invokeWithArguments(MethodHandle.java:733)
>       at 
> app//org.apache.ignite.internal.util.ExceptionUtils$1.copy(ExceptionUtils.java:916)
>       at 
> app//org.apache.ignite.internal.util.ExceptionUtils$ExceptionFactory.createCopy(ExceptionUtils.java:850)
>       at 
> app//org.apache.ignite.internal.util.ExceptionUtils.copyExceptionWithCause(ExceptionUtils.java:652)
>       at 
> app//org.apache.ignite.internal.util.ExceptionUtils.copyExceptionWithCauseInternal(ExceptionUtils.java:785)
>       at 
> app//org.apache.ignite.internal.util.ExceptionUtils.copyExceptionWithCause(ExceptionUtils.java:630)
>       at 
> app//org.apache.ignite.internal.util.IgniteUtils.getInterruptibly(IgniteUtils.java:822)
>       at 
> app//org.apache.ignite.internal.sql.api.IgniteSqlImpl.sync(IgniteSqlImpl.java:686)
>       at 
> app//org.apache.ignite.internal.sql.api.IgniteSqlImpl.execute(IgniteSqlImpl.java:233)
>       at 
> app//org.apache.ignite.internal.sql.api.PublicApiThreadingIgniteSql.lambda$execute$2(PublicApiThreadingIgniteSql.java:81)
>       at 
> app//org.apache.ignite.internal.thread.PublicApiThreading.executeWithRole(PublicApiThreading.java:144)
>       at 
> app//org.apache.ignite.internal.thread.PublicApiThreading.execUserSyncOperation(PublicApiThreading.java:102)
>       at 
> app//org.apache.ignite.internal.sql.api.PublicApiThreadingIgniteSql.execute(PublicApiThreadingIgniteSql.java:81)
>       at app//org.apache.ignite.sql.IgniteSql.execute(IgniteSql.java:90)
>       at 
> app//org.apache.ignite.internal.sql.sqllogic.ScriptContext.executeQuery(ScriptContext.java:97)
>       at 
> app//org.apache.ignite.internal.sql.sqllogic.Statement.execute(Statement.java:127)
>       ... 5 more
> Caused by: java.util.concurrent.ExecutionException: 
> org.apache.ignite.sql.SqlException: IGN-TX-16 Transaction is already finished 
> txId=[01972428-55a3-0000-84db-a7e000000001, txState=FINISHING]. 
> TraceId:4cc579db
>       at 
> java.base/java.util.concurrent.CompletableFuture.reportGet(CompletableFuture.java:396)
>       at 
> java.base/java.util.concurrent.CompletableFuture.get(CompletableFuture.java:2073)
>       at 
> org.apache.ignite.internal.util.IgniteUtils.getInterruptibly(IgniteUtils.java:820)
>       ... 14 more
> Caused by: org.apache.ignite.sql.SqlException: IGN-TX-16 Transaction is 
> already finished txId=[01972428-55a3-0000-84db-a7e000000001, 
> txState=FINISHING]. TraceId:4cc579db
>       at 
> app//org.apache.ignite.internal.lang.SqlExceptionMapperUtil.mapToPublicSqlException(SqlExceptionMapperUtil.java:73)
>       at 
> app//org.apache.ignite.internal.sql.engine.SqlQueryProcessor$PrefetchCallback.onPrefetchComplete(SqlQueryProcessor.java:587)
>       at 
> app//org.apache.ignite.internal.sql.engine.exec.ExecutionServiceImpl$DistributedQueryManager.lambda$executeFragment$6(ExecutionServiceImpl.java:927)
>       at 
> java.base@21.0.1/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:863)
>       at 
> java.base@21.0.1/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:841)
>       at 
> java.base@21.0.1/java.util.concurrent.CompletableFuture$Completion.run(CompletableFuture.java:482)
>       at 
> app//org.apache.ignite.internal.sql.engine.exec.QueryTaskExecutorImpl.lambda$execute$0(QueryTaskExecutorImpl.java:86)
>       ... 3 more
> Caused by: org.apache.ignite.lang.IgniteException: IGN-TX-16 Transaction is 
> already finished txId=[01972428-55a3-0000-84db-a7e000000001, 
> txState=FINISHING]. TraceId:4cc579db
>       at 
> app//org.apache.ignite.internal.sql.engine.util.SqlExceptionMapperProvider.lambda$mappers$1(SqlExceptionMapperProvider.java:59)
>       at 
> app//org.apache.ignite.internal.lang.IgniteExceptionMapper.map(IgniteExceptionMapper.java:61)
>       at 
> app//org.apache.ignite.internal.lang.IgniteExceptionMapperUtil.map(IgniteExceptionMapperUtil.java:195)
>       at 
> app//org.apache.ignite.internal.lang.IgniteExceptionMapperUtil.mapToPublicException(IgniteExceptionMapperUtil.java:125)
>       at 
> app//org.apache.ignite.internal.lang.IgniteExceptionMapperUtil.mapToPublicException(IgniteExceptionMapperUtil.java:88)
>       at 
> app//org.apache.ignite.internal.lang.SqlExceptionMapperUtil.mapToPublicSqlException(SqlExceptionMapperUtil.java:63)
>       ... 9 more
> Caused by: 
> org.apache.ignite.internal.sql.engine.exec.RemoteFragmentExecutionException: 
> IGN-TX-16 Transaction is already finished 
> txId=[01972428-55a3-0000-84db-a7e000000001, txState=FINISHING]. 
> TraceId:4cc579db
>       at 
> app//org.apache.ignite.internal.sql.engine.exec.ExecutionServiceImpl.onMessage(ExecutionServiceImpl.java:575)
>       at 
> app//org.apache.ignite.internal.sql.engine.exec.ExecutionServiceImpl.lambda$start$4(ExecutionServiceImpl.java:305)
>       at 
> app//org.apache.ignite.internal.sql.engine.message.MessageServiceImpl.onMessageInternal(MessageServiceImpl.java:171)
>       at 
> app//org.apache.ignite.internal.sql.engine.message.MessageServiceImpl.lambda$onMessage$2(MessageServiceImpl.java:137)
>       ... 4 more
> {noformat}
> https://ci.ignite.apache.org/project.html?projectId=ApacheIgnite3xGradle_Test_IntegrationTests&buildTypeId=&tab=testDetails&testNameId=4679394585576706488&order=TEST_STATUS_DESC&branch_ApacheIgnite3xGradle_Test_IntegrationTests=__all_branches__&itemsCount=50



--
This message was sent by Atlassian Jira
(v8.20.10#820010)

Reply via email to