Vyacheslav Koptilin created IGNITE-26734:
--------------------------------------------
Summary: ItDurableFinishTest.testCommitAlreadyAbortedTx may fail
with AssertionError
Key: IGNITE-26734
URL: https://issues.apache.org/jira/browse/IGNITE-26734
Project: Ignite
Issue Type: Bug
Components: transactions ai3
Reporter: Vyacheslav Koptilin
The test failure:
{code:java}
org.apache.ignite.internal.table.ItDurableFinishTest.testCommitAlreadyAbortedTx()
java.lang.AssertionError: java.util.concurrent.ExecutionException:
org.apache.ignite.internal.placementdriver.PrimaryReplicaAwaitTimeoutException:
IGN-PLACEMENTDRIVER-1 The primary replica await timed out
[replicationGroupId=22_part_0, referenceTimestamp=HybridTimestamp
[physical=2025-10-15 06:53:56:645 +0000, logical=2,
composite=115376864404766722], currentLease=Lease [leaseholder=idft_tcaat_3344,
leaseholderId=e1dd67fe-63c1-4b0b-a455-92daf836ec41, accepted=false,
startTime=HybridTimestamp [physical=2025-10-15 06:53:56:502 +0000, logical=0,
composite=115376864395395072], expirationTime=HybridTimestamp
[physical=2025-10-15 06:55:56:502 +0000, logical=0,
composite=115376872259715072], prolongable=true, proposedCandidate=null,
replicationGroupId=22_part_0]] TraceId:83c18584
java.lang.AssertionError: java.util.concurrent.ExecutionException:
org.apache.ignite.internal.placementdriver.PrimaryReplicaAwaitTimeoutException:
IGN-PLACEMENTDRIVER-1 The primary replica await timed out
[replicationGroupId=22_part_0, referenceTimestamp=HybridTimestamp
[physical=2025-10-15 06:53:56:645 +0000, logical=2,
composite=115376864404766722], currentLease=Lease [leaseholder=idft_tcaat_3344,
leaseholderId=e1dd67fe-63c1-4b0b-a455-92daf836ec41, accepted=false,
startTime=HybridTimestamp [physical=2025-10-15 06:53:56:502 +0000, logical=0,
composite=115376864395395072], expirationTime=HybridTimestamp
[physical=2025-10-15 06:55:56:502 +0000, logical=0,
composite=115376872259715072], prolongable=true, proposedCandidate=null,
replicationGroupId=22_part_0]] TraceId:83c18584
at
org.apache.ignite.internal.testframework.matchers.CompletableFutureMatcher.matchesSafely(CompletableFutureMatcher.java:71)
at
org.apache.ignite.internal.testframework.matchers.CompletableFutureMatcher.matchesSafely(CompletableFutureMatcher.java:28)
at org.hamcrest.TypeSafeMatcher.matches(TypeSafeMatcher.java:83)
at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:10)
at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:6)
at
org.apache.ignite.internal.table.ItDurableFinishTest.prepareTransactionData(ItDurableFinishTest.java:103)
at
org.apache.ignite.internal.table.ItDurableFinishTest.testCommitAlreadyAbortedTx(ItDurableFinishTest.java:320)
at java.base/java.lang.reflect.Method.invoke(Method.java:568)
at java.base/java.util.ArrayList.forEach(ArrayList.java:1511)
at java.base/java.util.ArrayList.forEach(ArrayList.java:1511)
Caused by: java.util.concurrent.ExecutionException:
org.apache.ignite.internal.placementdriver.PrimaryReplicaAwaitTimeoutException:
IGN-PLACEMENTDRIVER-1 The primary replica await timed out
[replicationGroupId=22_part_0, referenceTimestamp=HybridTimestamp
[physical=2025-10-15 06:53:56:645 +0000, logical=2,
composite=115376864404766722], currentLease=Lease [leaseholder=idft_tcaat_3344,
leaseholderId=e1dd67fe-63c1-4b0b-a455-92daf836ec41, accepted=false,
startTime=HybridTimestamp [physical=2025-10-15 06:53:56:502 +0000, logical=0,
composite=115376864395395072], expirationTime=HybridTimestamp
[physical=2025-10-15 06:55:56:502 +0000, logical=0,
composite=115376872259715072], prolongable=true, proposedCandidate=null,
replicationGroupId=22_part_0]] TraceId:83c18584
at
java.base/java.util.concurrent.CompletableFuture.reportGet(CompletableFuture.java:396)
at
java.base/java.util.concurrent.CompletableFuture.get(CompletableFuture.java:2096)
at
org.apache.ignite.internal.testframework.matchers.CompletableFutureMatcher.matchesSafely(CompletableFutureMatcher.java:67)
... 9 more
Caused by:
org.apache.ignite.internal.placementdriver.PrimaryReplicaAwaitTimeoutException:
IGN-PLACEMENTDRIVER-1 The primary replica await timed out
[replicationGroupId=22_part_0, referenceTimestamp=HybridTimestamp
[physical=2025-10-15 06:53:56:645 +0000, logical=2,
composite=115376864404766722], currentLease=Lease [leaseholder=idft_tcaat_3344,
leaseholderId=e1dd67fe-63c1-4b0b-a455-92daf836ec41, accepted=false,
startTime=HybridTimestamp [physical=2025-10-15 06:53:56:502 +0000, logical=0,
composite=115376864395395072], expirationTime=HybridTimestamp
[physical=2025-10-15 06:55:56:502 +0000, logical=0,
composite=115376872259715072], prolongable=true, proposedCandidate=null,
replicationGroupId=22_part_0]] TraceId:83c18584
at
app//org.apache.ignite.internal.placementdriver.leases.LeaseTracker.lambda$awaitPrimaryReplicaImpl$6(LeaseTracker.java:311)
at
[email protected]/java.util.concurrent.CompletableFuture$UniRun.tryFire(CompletableFuture.java:787)
at
[email protected]/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:510)
at
[email protected]/java.util.concurrent.CompletableFuture.complete(CompletableFuture.java:2147)
at
app//org.apache.ignite.internal.raft.RaftGroupServiceImpl.lambda$sendWithRetry$50(RaftGroupServiceImpl.java:717)
at
[email protected]/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:863)
at
[email protected]/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:841)
at
[email protected]/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:510)
at
[email protected]/java.util.concurrent.CompletableFuture.complete(CompletableFuture.java:2147)
at
app//org.apache.ignite.internal.network.DefaultMessagingService.onInvokeResponse(DefaultMessagingService.java:632)
at
app//org.apache.ignite.internal.network.DefaultMessagingService.send0(DefaultMessagingService.java:292)
at
app//org.apache.ignite.internal.network.DefaultMessagingService.respond(DefaultMessagingService.java:227)
at
app//org.apache.ignite.internal.network.MessagingService.respond(MessagingService.java:138)
at
app//org.apache.ignite.raft.jraft.rpc.impl.IgniteRpcServer$NetworkRpcContext.sendResponse(IgniteRpcServer.java:240)
at
app//org.apache.ignite.raft.jraft.rpc.impl.ActionRequestProcessor.sendResponse(ActionRequestProcessor.java:268)
at
app//org.apache.ignite.raft.jraft.rpc.impl.ActionRequestProcessor$2$1.result(ActionRequestProcessor.java:228)
at
app//org.apache.ignite.internal.metastorage.server.raft.MetaStorageListener.onReadBusy(MetaStorageListener.java:115)
at
app//org.apache.ignite.internal.metastorage.server.raft.MetaStorageListener.onRead(MetaStorageListener.java:95)
at
app//org.apache.ignite.raft.jraft.rpc.impl.ActionRequestProcessor$2.run(ActionRequestProcessor.java:222)
at
app//org.apache.ignite.raft.jraft.closure.ReadIndexClosure.run(ReadIndexClosure.java:87)
at
app//org.apache.ignite.raft.jraft.core.ReadOnlyServiceImpl.notifySuccess(ReadOnlyServiceImpl.java:452)
at
app//org.apache.ignite.raft.jraft.core.ReadOnlyServiceImpl$ReadIndexResponseClosure.run(ReadOnlyServiceImpl.java:179)
at
app//org.apache.ignite.raft.jraft.core.NodeImpl.readLeader(NodeImpl.java:1980)
at
app//org.apache.ignite.raft.jraft.core.NodeImpl.handleReadIndexRequest(NodeImpl.java:1827)
at
app//org.apache.ignite.raft.jraft.core.ReadOnlyServiceImpl.executeReadIndexEvents(ReadOnlyServiceImpl.java:239)
at
app//org.apache.ignite.raft.jraft.core.ReadOnlyServiceImpl$ReadIndexEventHandler.onEvent(ReadOnlyServiceImpl.java:123)
at
app//org.apache.ignite.raft.jraft.core.ReadOnlyServiceImpl$ReadIndexEventHandler.onEvent(ReadOnlyServiceImpl.java:106)
at
app//org.apache.ignite.raft.jraft.disruptor.StripedDisruptor$StripeEntryHandler.onEvent(StripedDisruptor.java:322)
at
app//org.apache.ignite.raft.jraft.disruptor.StripedDisruptor$StripeEntryHandler.onEvent(StripedDisruptor.java:279)
at
app//com.lmax.disruptor.BatchEventProcessor.processEvents(BatchEventProcessor.java:167)
at
app//com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:122)
at [email protected]/java.lang.Thread.run(Thread.java:833)
Caused by: java.util.concurrent.CompletionException:
java.util.concurrent.TimeoutException
at
java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:332)
at
java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:347)
at
java.base/java.util.concurrent.CompletableFuture$UniCompose.tryFire(CompletableFuture.java:1141)
at
java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:510)
at
java.base/java.util.concurrent.CompletableFuture.completeExceptionally(CompletableFuture.java:2162)
at
java.base/java.util.concurrent.CompletableFuture$Timeout.run(CompletableFuture.java:2874)
at
java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at
java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:304)
at
java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)
at
java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
... 1 more
Caused by: java.util.concurrent.TimeoutException
... 7 more {code}
Need to find the root cause
--
This message was sent by Atlassian Jira
(v8.20.10#820010)
