[
https://issues.apache.org/jira/browse/IGNITE-1393?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
Ryabov Dmitrii updated IGNITE-1393:
-----------------------------------
Comment: was deleted
(was: I can't reproduce error in current master - tests don't fail by described
error, but logs contain several {{IgniteTxHeuristicCheckedException}}s.
Currently, the only failing test is testStopMultithreaded(). It fails because
of unfinished partition exchange which cause deadlock detection and timeout.
Looks like ["Data grid in deadlock on
stop"|https://issues.apache.org/jira/browse/IGNITE-4365].
So, I propose to resolve this ticket as “Cannot Reproduce”.
)
> [Test] AssertionError when stop node executing transaction -
> GridCacheStopSelfTest
> -----------------------------------------------------------------------------------
>
> Key: IGNITE-1393
> URL: https://issues.apache.org/jira/browse/IGNITE-1393
> Project: Ignite
> Issue Type: Sub-task
> Components: cache
> Reporter: Semen Boikov
> Assignee: Ryabov Dmitrii
> Labels: Muted_test
>
> I fixed GridCacheStopSelfTest which was disabled for long time, now it fails
> because of asserts:
> {noformat}
> [10:53:02,362][ERROR][async-runner-1][GridNearTxLocal] Heuristic transaction
> failure.
> class
> org.apache.ignite.internal.transactions.IgniteTxHeuristicCheckedException:
> Failed to locally write to cache (all transaction entries will be
> invalidated, however there was a window when entries for this transaction
> were visible to others): GridNearTxLocal [nearLocallyMapped=false,
> colocatedLocallyMapped=true, hasRemoteLocks=false,
> mappings=[009f5238-db3d-426f-b787-9a4a156e8000], super=GridDhtTxLocalAdapter
> [dhtThreadId=101, needsCompletedVers=false, nearNodes=[], dhtNodes=[],
> explicitLock=false, super=IgniteTxLocalAdapter [txMap={IgniteTxKey
> [key=KeyCacheObjectImpl [val=22, hasValBytes=true], cacheId=1]=IgniteTxEntry
> [key=KeyCacheObjectImpl [val=22, hasValBytes=true], cacheId=1,
> txKey=IgniteTxKey [key=KeyCacheObjectImpl [val=22, hasValBytes=true],
> cacheId=1], val=[op=CREATE, val=UserCacheObjectImpl [val=22,
> hasValBytes=true]], prevVal=[op=CREATE, val=UserCacheObjectImpl [val=22,
> hasValBytes=true]], entryProcessorsCol=null, entryProcessorCalcVal=null,
> ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null,
> dhtVer=GridCacheVersion [topVer=53261582, nodeOrderDrId=1,
> globalTime=1441781582327, order=1441781581691], filters=[],
> filtersPassed=false, filtersSet=true, entry=GridDhtColocatedCacheEntry
> [super=GridDhtCacheEntry [rdrs=[], locPart=GridDhtLocalPartition [id=22,
> mapPubSize=1, rmvQueue=GridCircularBuffer [sizeMask=31, idxGen=0],
> state=OWNING, reservations=0, empty=false, createTime=09/09/2015 10:53:02,
> mapPubSize=1], super=GridDistributedCacheEntry [super=GridCacheMapEntry
> [key=KeyCacheObjectImpl [val=22, hasValBytes=true], val=CacheObjectImpl
> [val=22, hasValBytes=true], startVer=1441781581658, ver=GridCacheVersion
> [topVer=53261582, nodeOrderDrId=1, globalTime=1441781582327,
> order=1441781581691], hash=2018242870, extras=null, flags=2]]]],
> prepared=false, locked=true, nodeId=009f5238-db3d-426f-b787-9a4a156e8000,
> locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0,
> xidVer=GridCacheVersion [topVer=53261582, nodeOrderDrId=1,
> globalTime=1441781582217, order=1441781581591]]}, completedBase=null,
> sndTransformedVals=false, super=IgniteTxAdapter [xidVer=GridCacheVersion
> [topVer=53261582, nodeOrderDrId=1, globalTime=1441781582217,
> order=1441781581591], writeVer=GridCacheVersion [topVer=53261582,
> nodeOrderDrId=1, globalTime=1441781582327, order=1441781581691],
> implicit=false, implicitSingle=false, loc=true, threadId=101,
> startTime=1441781582212, nodeId=009f5238-db3d-426f-b787-9a4a156e8000,
> startVer=GridCacheVersion [topVer=53261582, nodeOrderDrId=1,
> globalTime=1441781582218, order=1441781581611], endVer=GridCacheVersion
> [topVer=53261582, nodeOrderDrId=1, globalTime=1441781582336,
> order=1441781581738], isolation=REPEATABLE_READ, concurrency=PESSIMISTIC,
> timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=GridCacheVersion
> [topVer=53261582, nodeOrderDrId=1, globalTime=1441781582217,
> order=1441781581591], finalizing=NONE, preparing=false, state=COMMITTED,
> timedOut=false, topVer=AffinityTopologyVersion [topVer=1, minorTopVer=0],
> duration=138ms, onePhaseCommit=true], size=1]]]
> at
> org.apache.ignite.internal.processors.cache.transactions.IgniteTxLocalAdapter.userCommit(IgniteTxLocalAdapter.java:1036)
> at
> org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxLocal.finish(GridNearTxLocal.java:654)
> at
> org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxLocal$3.apply(GridNearTxLocal.java:749)
> at
> org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxLocal$3.apply(GridNearTxLocal.java:741)
> at
> org.apache.ignite.internal.util.future.GridFutureAdapter.notifyListener(GridFutureAdapter.java:262)
> at
> org.apache.ignite.internal.util.future.GridFutureAdapter.listen(GridFutureAdapter.java:225)
> at
> org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxLocal.commitAsync(GridNearTxLocal.java:741)
> at
> org.apache.ignite.internal.processors.cache.GridCacheAdapter.commitTxAsync(GridCacheAdapter.java:4024)
> at
> org.apache.ignite.internal.processors.cache.GridCacheSharedContext.commitTxAsync(GridCacheSharedContext.java:636)
> at
> org.apache.ignite.internal.processors.cache.transactions.TransactionProxyImpl.commit(TransactionProxyImpl.java:256)
> at
> org.apache.ignite.internal.processors.cache.GridCacheStopSelfTest$1.call(GridCacheStopSelfTest.java:165)
> at
> org.apache.ignite.internal.processors.cache.GridCacheStopSelfTest$1.call(GridCacheStopSelfTest.java:154)
> at
> org.apache.ignite.testframework.GridTestUtils$5.run(GridTestUtils.java:653)
> at
> org.apache.ignite.testframework.GridTestUtils$7.call(GridTestUtils.java:949)
> at
> org.apache.ignite.testframework.GridTestThread.run(GridTestThread.java:86)
> Caused by: java.lang.AssertionError: Lock is not owned for commit in
> PESSIMISTIC mode [entry=GridDhtColocatedCacheEntry [super=GridDhtCacheEntry
> [rdrs=[], locPart=GridDhtLocalPartition [id=22, mapPubSize=1,
> rmvQueue=GridCircularBuffer [sizeMask=31, idxGen=0], state=OWNING,
> reservations=0, empty=false, createTime=09/09/2015 10:53:02, mapPubSize=1],
> super=GridDistributedCacheEntry [super=GridCacheMapEntry
> [key=KeyCacheObjectImpl [val=22, hasValBytes=true], val=CacheObjectImpl
> [val=22, hasValBytes=true], startVer=1441781581658, ver=GridCacheVersion
> [topVer=53261582, nodeOrderDrId=1, globalTime=1441781582327,
> order=1441781581691], hash=2018242870, extras=null, flags=2]]]],
> tx=GridNearTxLocal [nearLocallyMapped=false, colocatedLocallyMapped=true,
> hasRemoteLocks=false, mappings=[009f5238-db3d-426f-b787-9a4a156e8000],
> super=GridDhtTxLocalAdapter [dhtThreadId=101, needsCompletedVers=false,
> nearNodes=[], dhtNodes=[], explicitLock=false, super=IgniteTxLocalAdapter
> [txMap={IgniteTxKey [key=KeyCacheObjectImpl [val=22, hasValBytes=true],
> cacheId=1]=IgniteTxEntry [key=KeyCacheObjectImpl [val=22, hasValBytes=true],
> cacheId=1, txKey=IgniteTxKey [key=KeyCacheObjectImpl [val=22,
> hasValBytes=true], cacheId=1], val=[op=CREATE, val=UserCacheObjectImpl
> [val=22, hasValBytes=true]], prevVal=[op=CREATE, val=UserCacheObjectImpl
> [val=22, hasValBytes=true]], entryProcessorsCol=null,
> entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null,
> explicitVer=null, dhtVer=GridCacheVersion [topVer=53261582, nodeOrderDrId=1,
> globalTime=1441781582327, order=1441781581691], filters=[],
> filtersPassed=false, filtersSet=true, entry=GridDhtColocatedCacheEntry
> [super=GridDhtCacheEntry [rdrs=[], locPart=GridDhtLocalPartition [id=22,
> mapPubSize=1, rmvQueue=GridCircularBuffer [sizeMask=31, idxGen=0],
> state=OWNING, reservations=0, empty=false, createTime=09/09/2015 10:53:02,
> mapPubSize=1], super=GridDistributedCacheEntry [super=GridCacheMapEntry
> [key=KeyCacheObjectImpl [val=22, hasValBytes=true], val=CacheObjectImpl
> [val=22, hasValBytes=true], startVer=1441781581658, ver=GridCacheVersion
> [topVer=53261582, nodeOrderDrId=1, globalTime=1441781582327,
> order=1441781581691], hash=2018242870, extras=null, flags=2]]]],
> prepared=false, locked=true, nodeId=009f5238-db3d-426f-b787-9a4a156e8000,
> locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0,
> xidVer=GridCacheVersion [topVer=53261582, nodeOrderDrId=1,
> globalTime=1441781582217, order=1441781581591]]}, completedBase=null,
> sndTransformedVals=false, super=IgniteTxAdapter [xidVer=GridCacheVersion
> [topVer=53261582, nodeOrderDrId=1, globalTime=1441781582217,
> order=1441781581591], writeVer=GridCacheVersion [topVer=53261582,
> nodeOrderDrId=1, globalTime=1441781582327, order=1441781581691],
> implicit=false, implicitSingle=false, loc=true, threadId=101,
> startTime=1441781582212, nodeId=009f5238-db3d-426f-b787-9a4a156e8000,
> startVer=GridCacheVersion [topVer=53261582, nodeOrderDrId=1,
> globalTime=1441781582218, order=1441781581611], endVer=GridCacheVersion
> [topVer=53261582, nodeOrderDrId=1, globalTime=1441781582336,
> order=1441781581738], isolation=REPEATABLE_READ, concurrency=PESSIMISTIC,
> timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=GridCacheVersion
> [topVer=53261582, nodeOrderDrId=1, globalTime=1441781582217,
> order=1441781581591], finalizing=NONE, preparing=false, state=COMMITTED,
> timedOut=false, topVer=AffinityTopologyVersion [topVer=1, minorTopVer=0],
> duration=128ms, onePhaseCommit=true], size=1]]]]
> at
> org.apache.ignite.internal.processors.cache.transactions.IgniteTxLocalAdapter.checkCommitLocks(IgniteTxLocalAdapter.java:509)
> at
> org.apache.ignite.internal.processors.cache.transactions.IgniteTxLocalAdapter.userCommit(IgniteTxLocalAdapter.java:1004)
> {noformat}
--
This message was sent by Atlassian JIRA
(v6.4.14#64029)
