Anton Vinogradov created IGNITE-1601:
----------------------------------------

             Summary: [Test Failed] 
GridCacheNearTxExceptionSelfTest.testTransformBackup        
                 Key: IGNITE-1601
                 URL: https://issues.apache.org/jira/browse/IGNITE-1601
             Project: Ignite
          Issue Type: Test
    Affects Versions: ignite-1.5
            Reporter: Anton Vinogradov
            Priority: Blocker
             Fix For: ignite-1.5


There is no guarantee that test failure will be produced each test run, please 
analyze logs in case of reproduction problem:

junit.framework.AssertionFailedError: Unexpected entry for grid [i=2, 
entry=GridNearCacheEntry [topVer=3, dhtVer=GridCacheVersion [topVer=55115678, 
nodeOrderDrId=2, globalTime=1443635682299, order=1443635677727], part=5, 
super=GridDistributedCacheEntry [super=GridCacheMapEntry 
[key=KeyCacheObjectImpl [val=5, hasValBytes=true], val=CacheObjectImpl [val=1, 
hasValBytes=true], startVer=1443635677720, ver=GridCacheVersion 
[topVer=55115678, nodeOrderDrId=3, globalTime=1443635682301, 
order=1443635677719], hash=-871541811, extras=GridCacheMvccEntryExtras 
[mvcc=GridCacheMvcc [locs=null, rmts=[GridCacheMvccCandidate 
[nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, ver=GridCacheVersion 
[topVer=55115678, nodeOrderDrId=2, globalTime=1443635682301, 
order=1443635677731], timeout=0, ts=1443635682299, threadId=80062, id=6177849, 
topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], reentry=null, 
otherNodeId=null, otherVer=null, mappedDhtNodes=null, mappedNearNodes=null, 
ownerVer=null, key=KeyCacheObjectImpl [val=5, hasValBytes=true], 
masks=local=0|owner=1|ready=0|reentry=0|used=1|tx=1|single_implicit=0|dht_local=0|near_local=0|removed=0,
 prevVer=null, nextVer=null]]]], flags=0]]]]
    at junit.framework.Assert.fail(Assert.java:57)
    at junit.framework.Assert.assertTrue(Assert.java:22)
    at junit.framework.Assert.assertFalse(Assert.java:39)
    at junit.framework.TestCase.assertFalse(TestCase.java:210)
    at 
org.apache.ignite.internal.processors.cache.IgniteTxExceptionAbstractSelfTest.checkUnlocked(IgniteTxExceptionAbstractSelfTest.java:396)
    at 
org.apache.ignite.internal.processors.cache.IgniteTxExceptionAbstractSelfTest.checkTransform(IgniteTxExceptionAbstractSelfTest.java:480)
    at 
org.apache.ignite.internal.processors.cache.IgniteTxExceptionAbstractSelfTest.testTransformBackup(IgniteTxExceptionAbstractSelfTest.java:234)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
    at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:606)
    at junit.framework.TestCase.runTest(TestCase.java:176)
    at 
org.apache.ignite.testframework.junits.GridAbstractTest.runTestInternal(GridAbstractTest.java:1665)
    at 
org.apache.ignite.testframework.junits.GridAbstractTest.access$000(GridAbstractTest.java:111)
    at 
org.apache.ignite.testframework.junits.GridAbstractTest$6.run(GridAbstractTest.java:1603)
------- Stdout: -------
[20:54:42,285][INFO ][main][root] >>> Starting test: testTransformBackup <<<
[20:54:42,286][INFO ][test-runner][root] Going to transform: 2
[20:54:42,298][INFO ][test-runner][root] Caught expected exception: class 
org.apache.ignite.transactions.TransactionHeuristicException: Commit produced a 
runtime exception (all transaction entries will be invalidated): 
GridDhtTxRemote[id=a1a446f1051-0348ff9e-0000-0002-0000-01501f645bf8, 
concurrency=OPTIMISTIC, isolation=READ_COMMITTED, state=COMMITTING, 
invalidate=false, rollbackOnly=false, 
nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, duration=0]
[20:54:42,298][INFO ][test-runner][root] Check key: 2
[20:54:42,298][INFO ][test-runner][root] Entry: null
[20:54:42,299][INFO ][test-runner][root] Dht entry: GridDhtCacheEntry [rdrs=[], 
locPart=GridDhtLocalPartition [id=2, mapPubSize=0, rmvQueue=GridCircularBuffer 
[sizeMask=31, idxGen=2], state=OWNING, reservations=0, empty=false, 
createTime=09/30/2015 20:54:35, mapPubSize=0], super=GridDistributedCacheEntry 
[super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=2, hasValBytes=true], 
val=null, startVer=1443635676707, ver=GridCacheVersion [topVer=55115678, 
nodeOrderDrId=2, globalTime=1443635682296, order=1443635677722], 
hash=821347078, extras=null, flags=3]]]
[20:54:42,299][INFO ][test-runner][root] Entry: null
[20:54:42,299][INFO ][test-runner][root] Dht entry: GridDhtCacheEntry [rdrs=[], 
locPart=GridDhtLocalPartition [id=2, mapPubSize=0, rmvQueue=GridCircularBuffer 
[sizeMask=31, idxGen=2], state=OWNING, reservations=0, empty=false, 
createTime=09/30/2015 20:54:35, mapPubSize=0], super=GridDistributedCacheEntry 
[super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=2, hasValBytes=true], 
val=null, startVer=1443635676707, ver=GridCacheVersion [topVer=55115678, 
nodeOrderDrId=2, globalTime=1443635682280, order=1443635677702], 
hash=821347078, extras=null, flags=3]]]
[20:54:42,299][INFO ][test-runner][root] Entry: null
[20:54:42,299][INFO ][test-runner][root] Dht entry: null
[20:54:42,299][INFO ][test-runner][root] Put key: 5
[20:54:42,301][INFO ][test-runner][root] Going to transform: 5
[20:54:42,303][INFO ][test-runner][root] Caught expected exception: class 
org.apache.ignite.transactions.TransactionHeuristicException: Commit produced a 
runtime exception (all transaction entries will be invalidated): 
GridDhtTxRemote[id=32a446f1051-0348ff9e-0000-0002-0000-01501f645bfd, 
concurrency=OPTIMISTIC, isolation=READ_COMMITTED, state=COMMITTING, 
invalidate=false, rollbackOnly=false, 
nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, duration=0]
[20:54:42,303][INFO ][test-runner][root] Check key: 5
[20:54:42,304][INFO ][test-runner][root] Entry: GridNearCacheEntry [topVer=3, 
dhtVer=GridCacheVersion [topVer=55115678, nodeOrderDrId=2, 
globalTime=1443635682299, order=1443635677727], part=5, 
super=GridDistributedCacheEntry [super=GridCacheMapEntry 
[key=KeyCacheObjectImpl [val=5, hasValBytes=true], val=CacheObjectImpl [val=1, 
hasValBytes=true], startVer=1443635677731, ver=GridCacheVersion 
[topVer=55115678, nodeOrderDrId=2, globalTime=1443635682299, 
order=1443635677727], hash=-871541811, extras=null, flags=0]]]
[20:54:42,304][INFO ][test-runner][root] Dht entry: GridDhtCacheEntry [rdrs=[], 
locPart=GridDhtLocalPartition [id=5, mapPubSize=1, rmvQueue=GridCircularBuffer 
[sizeMask=31, idxGen=1], state=OWNING, reservations=0, empty=false, 
createTime=09/30/2015 20:54:35, mapPubSize=1], super=GridDistributedCacheEntry 
[super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=5, hasValBytes=true], 
val=null, startVer=1443635676721, ver=GridCacheVersion [topVer=55115678, 
nodeOrderDrId=2, globalTime=1443635682301, order=1443635677731], 
hash=-871541811, extras=null, flags=2]]]
[20:54:42,304][INFO ][test-runner][root] Entry: null
[20:54:42,304][INFO ][test-runner][root] Dht entry: GridDhtCacheEntry 
[rdrs=[ReaderId [nodeId=20c863f0-057b-47b8-a807-aa3b20e15002, msgId=6116062, 
txFut=null]], locPart=GridDhtLocalPartition [id=5, mapPubSize=1, 
rmvQueue=GridCircularBuffer [sizeMask=31, idxGen=1], state=OWNING, 
reservations=0, empty=false, createTime=09/30/2015 20:54:35, mapPubSize=1], 
super=GridDistributedCacheEntry [super=GridCacheMapEntry 
[key=KeyCacheObjectImpl [val=5, hasValBytes=true], val=CacheObjectImpl [val=1, 
hasValBytes=true], startVer=1443635676721, ver=GridCacheVersion 
[topVer=55115678, nodeOrderDrId=2, globalTime=1443635682299, 
order=1443635677727], hash=-871541811, extras=null, flags=2]]]
[20:54:42,304][INFO ][test-runner][root] Entry: GridNearCacheEntry [topVer=3, 
dhtVer=GridCacheVersion [topVer=55115678, nodeOrderDrId=2, 
globalTime=1443635682299, order=1443635677727], part=5, 
super=GridDistributedCacheEntry [super=GridCacheMapEntry 
[key=KeyCacheObjectImpl [val=5, hasValBytes=true], val=CacheObjectImpl [val=1, 
hasValBytes=true], startVer=1443635677720, ver=GridCacheVersion 
[topVer=55115678, nodeOrderDrId=3, globalTime=1443635682301, 
order=1443635677719], hash=-871541811, extras=GridCacheMvccEntryExtras 
[mvcc=GridCacheMvcc [locs=null, rmts=[GridCacheMvccCandidate 
[nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, ver=GridCacheVersion 
[topVer=55115678, nodeOrderDrId=2, globalTime=1443635682301, 
order=1443635677731], timeout=0, ts=1443635682299, threadId=80062, id=6177849, 
topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], reentry=null, 
otherNodeId=null, otherVer=null, mappedDhtNodes=null, mappedNearNodes=null, 
ownerVer=null, key=KeyCacheObjectImpl [val=5, hasValBytes=true], 
masks=local=0|owner=1|ready=0|reentry=0|used=1|tx=1|single_implicit=0|dht_local=0|near_local=0|removed=0,
 prevVer=null, nextVer=null]]]], flags=0]]]
[20:54:42,306][INFO ][main][root] >>> Stopping test: testTransformBackup in 21 
ms <<<
------- Stderr: -------
[20:54:42,297][ERROR][ignite-#62809%sys-near.GridCacheNearTxExceptionSelfTest0%][GridNearTxLocal]
 Commit failed.
class 
org.apache.ignite.internal.transactions.IgniteTxHeuristicCheckedException: 
Commit produced a runtime exception (all transaction entries will be 
invalidated): 
GridDhtTxRemote[id=a1a446f1051-0348ff9e-0000-0002-0000-01501f645bf8, 
concurrency=OPTIMISTIC, isolation=READ_COMMITTED, state=COMMITTING, 
invalidate=false, rollbackOnly=false, 
nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, duration=0]
    at 
org.apache.ignite.internal.processors.cache.distributed.GridDistributedTxRemoteAdapter.commitIfLocked(GridDistributedTxRemoteAdapter.java:672)
    at 
org.apache.ignite.internal.processors.cache.distributed.GridDistributedTxRemoteAdapter.commit(GridDistributedTxRemoteAdapter.java:723)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.finish(IgniteTxHandler.java:1027)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.processDhtTxPrepareRequest(IgniteTxHandler.java:809)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler$5.apply(IgniteTxHandler.java:138)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler$5.apply(IgniteTxHandler.java:136)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.processMessage(GridCacheIoManager.java:508)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.onMessage0(GridCacheIoManager.java:274)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.handleMessage(GridCacheIoManager.java:198)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.access$000(GridCacheIoManager.java:77)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager$1.onMessage(GridCacheIoManager.java:160)
    at 
org.apache.ignite.internal.managers.communication.GridIoManager.processRegularMessage0(GridIoManager.java:811)
    at 
org.apache.ignite.internal.managers.communication.GridIoManager.access$1500(GridIoManager.java:106)
    at 
org.apache.ignite.internal.managers.communication.GridIoManager$5.run(GridIoManager.java:774)
    at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
    at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
    at java.lang.Thread.run(Thread.java:745)
Caused by: class org.apache.ignite.spi.IgniteSpiException: Test exception.
    at 
org.apache.ignite.internal.processors.cache.IgniteTxExceptionAbstractSelfTest$TestIndexingSpi.store(IgniteTxExceptionAbstractSelfTest.java:646)
    at 
org.apache.ignite.internal.managers.indexing.GridIndexingManager.store(GridIndexingManager.java:101)
    at 
org.apache.ignite.internal.processors.query.GridQueryProcessor.store(GridQueryProcessor.java:482)
    at 
org.apache.ignite.internal.processors.cache.query.GridCacheQueryManager.store(GridCacheQueryManager.java:408)
    at 
org.apache.ignite.internal.processors.cache.GridCacheMapEntry.updateIndex(GridCacheMapEntry.java:3533)
    at 
org.apache.ignite.internal.processors.cache.GridCacheMapEntry.innerSet(GridCacheMapEntry.java:1098)
    at 
org.apache.ignite.internal.processors.cache.distributed.GridDistributedTxRemoteAdapter.commitIfLocked(GridDistributedTxRemoteAdapter.java:580)
    ... 16 more
[20:54:42,297][WARN 
][ignite-#62809%sys-near.GridCacheNearTxExceptionSelfTest0%][IgniteTxHandler] 
Failed to commit transaction (all transaction entries were invalidated): 
GridDhtTxRemote[id=a1a446f1051-0348ff9e-0000-0002-0000-01501f645bf8, 
concurrency=OPTIMISTIC, isolation=READ_COMMITTED, state=UNKNOWN, 
invalidate=false, rollbackOnly=false, 
nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, duration=0]
[20:54:42,298][ERROR][ignite-#62863%sys-near.GridCacheNearTxExceptionSelfTest1%][IgniteTxHandler]
 Failed to prepare DHT transaction: GridDhtTxLocal 
[nearNodeId=0076131e-f2eb-4d52-bf16-dd2a9687e000, 
nearFutId=262dfa32051-ba6a5651-6ec8-48dc-9d55-1ed91b0759f5, 
nearMiniId=362dfa32051-ba6a5651-6ec8-48dc-9d55-1ed91b0759f5, 
nearFinFutId=772dfa32051-ba6a5651-6ec8-48dc-9d55-1ed91b0759f5, 
nearFinMiniId=872dfa32051-ba6a5651-6ec8-48dc-9d55-1ed91b0759f5, 
nearXidVer=GridCacheVersion [topVer=55115678, nodeOrderDrId=1, 
globalTime=1443635682286, order=1443635677714], super=GridDhtTxLocalAdapter 
[dhtThreadId=79981, needsCompletedVers=true, nearOnOriginatingNode=true, 
nearNodes=[], dhtNodes=[0076131e-f2eb-4d52-bf16-dd2a9687e000], 
explicitLock=false, super=IgniteTxLocalAdapter [txMap={IgniteTxKey 
[key=KeyCacheObjectImpl [val=2, hasValBytes=true], cacheId=1]=IgniteTxEntry 
[key=KeyCacheObjectImpl [val=2, hasValBytes=true], cacheId=1, txKey=IgniteTxKey 
[key=KeyCacheObjectImpl [val=2, hasValBytes=true], cacheId=1], 
val=[op=TRANSFORM, val=null], prevVal=[op=NOOP, val=null], 
entryProcessorsCol=[IgniteBiTuple 
[val1=o.a.i.i.processors.cache.IgniteTxExceptionAbstractSelfTest$2$1@768a1f4e, 
val2=[Ljava.lang.Object;@660d76ae]], entryProcessorCalcVal=UserCacheObjectImpl 
[val=2, hasValBytes=false], ttl=-1, conflictExpireTime=-1, conflictVer=null, 
explicitVer=null, dhtVer=null, filters=[], filtersPassed=false, 
filtersSet=false, entry=GridDhtCacheEntry [rdrs=[], 
locPart=GridDhtLocalPartition [id=2, mapPubSize=0, rmvQueue=GridCircularBuffer 
[sizeMask=31, idxGen=2], state=OWNING, reservations=0, empty=false, 
createTime=09/30/2015 20:54:35, mapPubSize=0], super=GridDistributedCacheEntry 
[super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=2, hasValBytes=true], 
val=null, startVer=1443635676707, ver=GridCacheVersion [topVer=55115678, 
nodeOrderDrId=2, globalTime=1443635682280, order=1443635677702], 
hash=821347078, extras=GridCacheMvccEntryExtras [mvcc=GridCacheMvcc 
[locs=[GridCacheMvccCandidate [nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, 
ver=GridCacheVersion [topVer=55115678, nodeOrderDrId=2, 
globalTime=1443635682296, order=1443635677722], timeout=0, ts=1443635682289, 
threadId=80132, id=6177841, topVer=AffinityTopologyVersion [topVer=3, 
minorTopVer=0], reentry=null, otherNodeId=0076131e-f2eb-4d52-bf16-dd2a9687e000, 
otherVer=GridCacheVersion [topVer=55115678, nodeOrderDrId=1, 
globalTime=1443635682286, order=1443635677714], mappedDhtNodes=null, 
mappedNearNodes=null, ownerVer=null, key=KeyCacheObjectImpl [val=2, 
hasValBytes=true], 
masks=local=1|owner=1|ready=1|reentry=0|used=0|tx=1|single_implicit=1|dht_local=1|near_local=0|removed=0,
 prevVer=null, nextVer=null]], rmts=null]], flags=3]]], prepared=true, 
locked=false, nodeId=null, locMapped=false, expiryPlc=null, 
transferExpiryPlc=false, flags=0, xidVer=null]}, completedBase=null, 
sndTransformedVals=false, super=IgniteTxAdapter [xidVer=GridCacheVersion 
[topVer=55115678, nodeOrderDrId=2, globalTime=1443635682296, 
order=1443635677722], writeVer=GridCacheVersion [topVer=55115678, 
nodeOrderDrId=2, globalTime=1443635682296, order=1443635677723], implicit=true, 
implicitSingle=true, loc=true, threadId=80132, startTime=1443635682289, 
nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, startVer=GridCacheVersion 
[topVer=55115678, nodeOrderDrId=2, globalTime=1443635682296, 
order=1443635677722], endVer=null, isolation=READ_COMMITTED, 
concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, 
commitVer=null, finalizing=NONE, preparing=true, invalidParts={}, 
state=MARKED_ROLLBACK, timedOut=false, topVer=AffinityTopologyVersion 
[topVer=3, minorTopVer=0], duration=0ms, onePhaseCommit=true], size=1]]]
class 
org.apache.ignite.internal.transactions.IgniteTxHeuristicCheckedException: 
Commit produced a runtime exception (all transaction entries will be 
invalidated): 
GridDhtTxRemote[id=a1a446f1051-0348ff9e-0000-0002-0000-01501f645bf8, 
concurrency=OPTIMISTIC, isolation=READ_COMMITTED, state=COMMITTING, 
invalidate=false, rollbackOnly=false, 
nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, duration=0]
    at 
org.apache.ignite.internal.processors.cache.distributed.GridDistributedTxRemoteAdapter.commitIfLocked(GridDistributedTxRemoteAdapter.java:672)
    at 
org.apache.ignite.internal.processors.cache.distributed.GridDistributedTxRemoteAdapter.commit(GridDistributedTxRemoteAdapter.java:723)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.finish(IgniteTxHandler.java:1027)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.processDhtTxPrepareRequest(IgniteTxHandler.java:809)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler$5.apply(IgniteTxHandler.java:138)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler$5.apply(IgniteTxHandler.java:136)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.processMessage(GridCacheIoManager.java:508)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.onMessage0(GridCacheIoManager.java:274)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.handleMessage(GridCacheIoManager.java:198)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.access$000(GridCacheIoManager.java:77)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager$1.onMessage(GridCacheIoManager.java:160)
    at 
org.apache.ignite.internal.managers.communication.GridIoManager.processRegularMessage0(GridIoManager.java:811)
    at 
org.apache.ignite.internal.managers.communication.GridIoManager.access$1500(GridIoManager.java:106)
    at 
org.apache.ignite.internal.managers.communication.GridIoManager$5.run(GridIoManager.java:774)
    at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
    at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
    at java.lang.Thread.run(Thread.java:745)
Caused by: class org.apache.ignite.spi.IgniteSpiException: Test exception.
    at 
org.apache.ignite.internal.processors.cache.IgniteTxExceptionAbstractSelfTest$TestIndexingSpi.store(IgniteTxExceptionAbstractSelfTest.java:646)
    at 
org.apache.ignite.internal.managers.indexing.GridIndexingManager.store(GridIndexingManager.java:101)
    at 
org.apache.ignite.internal.processors.query.GridQueryProcessor.store(GridQueryProcessor.java:482)
    at 
org.apache.ignite.internal.processors.cache.query.GridCacheQueryManager.store(GridCacheQueryManager.java:408)
    at 
org.apache.ignite.internal.processors.cache.GridCacheMapEntry.updateIndex(GridCacheMapEntry.java:3533)
    at 
org.apache.ignite.internal.processors.cache.GridCacheMapEntry.innerSet(GridCacheMapEntry.java:1098)
    at 
org.apache.ignite.internal.processors.cache.distributed.GridDistributedTxRemoteAdapter.commitIfLocked(GridDistributedTxRemoteAdapter.java:580)
    ... 16 more
[20:54:42,302][ERROR][ignite-#62805%sys-near.GridCacheNearTxExceptionSelfTest0%][GridNearTxLocal]
 Commit failed.
class 
org.apache.ignite.internal.transactions.IgniteTxHeuristicCheckedException: 
Commit produced a runtime exception (all transaction entries will be 
invalidated): 
GridDhtTxRemote[id=32a446f1051-0348ff9e-0000-0002-0000-01501f645bfd, 
concurrency=OPTIMISTIC, isolation=READ_COMMITTED, state=COMMITTING, 
invalidate=false, rollbackOnly=false, 
nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, duration=0]
    at 
org.apache.ignite.internal.processors.cache.distributed.GridDistributedTxRemoteAdapter.commitIfLocked(GridDistributedTxRemoteAdapter.java:672)
    at 
org.apache.ignite.internal.processors.cache.distributed.GridDistributedTxRemoteAdapter.commit(GridDistributedTxRemoteAdapter.java:723)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.finish(IgniteTxHandler.java:1027)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.processDhtTxPrepareRequest(IgniteTxHandler.java:809)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler$5.apply(IgniteTxHandler.java:138)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler$5.apply(IgniteTxHandler.java:136)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.processMessage(GridCacheIoManager.java:508)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.onMessage0(GridCacheIoManager.java:274)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.handleMessage(GridCacheIoManager.java:198)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.access$000(GridCacheIoManager.java:77)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager$1.onMessage(GridCacheIoManager.java:160)
    at 
org.apache.ignite.internal.managers.communication.GridIoManager.processRegularMessage0(GridIoManager.java:811)
    at 
org.apache.ignite.internal.managers.communication.GridIoManager.access$1500(GridIoManager.java:106)
    at 
org.apache.ignite.internal.managers.communication.GridIoManager$5.run(GridIoManager.java:774)
    at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
    at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
    at java.lang.Thread.run(Thread.java:745)
Caused by: class org.apache.ignite.spi.IgniteSpiException: Test exception.
    at 
org.apache.ignite.internal.processors.cache.IgniteTxExceptionAbstractSelfTest$TestIndexingSpi.store(IgniteTxExceptionAbstractSelfTest.java:646)
    at 
org.apache.ignite.internal.managers.indexing.GridIndexingManager.store(GridIndexingManager.java:101)
    at 
org.apache.ignite.internal.processors.query.GridQueryProcessor.store(GridQueryProcessor.java:482)
    at 
org.apache.ignite.internal.processors.cache.query.GridCacheQueryManager.store(GridCacheQueryManager.java:408)
    at 
org.apache.ignite.internal.processors.cache.GridCacheMapEntry.updateIndex(GridCacheMapEntry.java:3533)
    at 
org.apache.ignite.internal.processors.cache.GridCacheMapEntry.innerSet(GridCacheMapEntry.java:1098)
    at 
org.apache.ignite.internal.processors.cache.distributed.GridDistributedTxRemoteAdapter.commitIfLocked(GridDistributedTxRemoteAdapter.java:580)
    ... 16 more
[20:54:42,302][WARN 
][ignite-#62805%sys-near.GridCacheNearTxExceptionSelfTest0%][IgniteTxHandler] 
Failed to commit transaction (all transaction entries were invalidated): 
GridDhtTxRemote[id=32a446f1051-0348ff9e-0000-0002-0000-01501f645bfd, 
concurrency=OPTIMISTIC, isolation=READ_COMMITTED, state=UNKNOWN, 
invalidate=false, rollbackOnly=false, 
nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, duration=0]
[20:54:42,303][ERROR][ignite-#62873%sys-near.GridCacheNearTxExceptionSelfTest1%][IgniteTxHandler]
 Failed to prepare DHT transaction: GridDhtTxLocal 
[nearNodeId=0076131e-f2eb-4d52-bf16-dd2a9687e000, 
nearFutId=792dfa32051-ba6a5651-6ec8-48dc-9d55-1ed91b0759f5, 
nearMiniId=892dfa32051-ba6a5651-6ec8-48dc-9d55-1ed91b0759f5, 
nearFinFutId=4a2dfa32051-ba6a5651-6ec8-48dc-9d55-1ed91b0759f5, 
nearFinMiniId=5a2dfa32051-ba6a5651-6ec8-48dc-9d55-1ed91b0759f5, 
nearXidVer=GridCacheVersion [topVer=55115678, nodeOrderDrId=1, 
globalTime=1443635682301, order=1443635677730], super=GridDhtTxLocalAdapter 
[dhtThreadId=79987, needsCompletedVers=true, nearOnOriginatingNode=true, 
nearNodes=[20c863f0-057b-47b8-a807-aa3b20e15002], 
dhtNodes=[0076131e-f2eb-4d52-bf16-dd2a9687e000], explicitLock=false, 
super=IgniteTxLocalAdapter [txMap={IgniteTxKey [key=KeyCacheObjectImpl [val=5, 
hasValBytes=true], cacheId=1]=IgniteTxEntry [key=KeyCacheObjectImpl [val=5, 
hasValBytes=true], cacheId=1, txKey=IgniteTxKey [key=KeyCacheObjectImpl [val=5, 
hasValBytes=true], cacheId=1], val=[op=TRANSFORM, val=null], prevVal=[op=NOOP, 
val=null], entryProcessorsCol=[IgniteBiTuple 
[val1=o.a.i.i.processors.cache.IgniteTxExceptionAbstractSelfTest$2$1@531fb8b, 
val2=[Ljava.lang.Object;@14796557]], entryProcessorCalcVal=UserCacheObjectImpl 
[val=2, hasValBytes=false], ttl=-1, conflictExpireTime=-1, conflictVer=null, 
explicitVer=null, dhtVer=null, filters=[], filtersPassed=false, 
filtersSet=false, entry=GridDhtCacheEntry [rdrs=[ReaderId 
[nodeId=20c863f0-057b-47b8-a807-aa3b20e15002, msgId=6116062, txFut=null]], 
locPart=GridDhtLocalPartition [id=5, mapPubSize=1, rmvQueue=GridCircularBuffer 
[sizeMask=31, idxGen=1], state=OWNING, reservations=0, empty=false, 
createTime=09/30/2015 20:54:35, mapPubSize=1], super=GridDistributedCacheEntry 
[super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=5, hasValBytes=true], 
val=CacheObjectImpl [val=1, hasValBytes=true], startVer=1443635676721, 
ver=GridCacheVersion [topVer=55115678, nodeOrderDrId=2, 
globalTime=1443635682299, order=1443635677727], hash=-871541811, 
extras=GridCacheMvccEntryExtras [mvcc=GridCacheMvcc 
[locs=[GridCacheMvccCandidate [nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, 
ver=GridCacheVersion [topVer=55115678, nodeOrderDrId=2, 
globalTime=1443635682301, order=1443635677731], timeout=0, ts=1443635682299, 
threadId=80132, id=6177847, topVer=AffinityTopologyVersion [topVer=3, 
minorTopVer=0], reentry=null, otherNodeId=0076131e-f2eb-4d52-bf16-dd2a9687e000, 
otherVer=GridCacheVersion [topVer=55115678, nodeOrderDrId=1, 
globalTime=1443635682301, order=1443635677730], mappedDhtNodes=null, 
mappedNearNodes=null, ownerVer=null, key=KeyCacheObjectImpl [val=5, 
hasValBytes=true], 
masks=local=1|owner=1|ready=1|reentry=0|used=0|tx=1|single_implicit=1|dht_local=1|near_local=0|removed=0,
 prevVer=null, nextVer=null]], rmts=null]], flags=2]]], prepared=true, 
locked=false, nodeId=null, locMapped=false, expiryPlc=null, 
transferExpiryPlc=false, flags=0, xidVer=null]}, completedBase=null, 
sndTransformedVals=false, super=IgniteTxAdapter [xidVer=GridCacheVersion 
[topVer=55115678, nodeOrderDrId=2, globalTime=1443635682301, 
order=1443635677731], writeVer=GridCacheVersion [topVer=55115678, 
nodeOrderDrId=2, globalTime=1443635682301, order=1443635677732], implicit=true, 
implicitSingle=true, loc=true, threadId=80132, startTime=1443635682299, 
nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, startVer=GridCacheVersion 
[topVer=55115678, nodeOrderDrId=2, globalTime=1443635682301, 
order=1443635677731], endVer=null, isolation=READ_COMMITTED, 
concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, 
commitVer=null, finalizing=NONE, preparing=true, invalidParts={}, 
state=MARKED_ROLLBACK, timedOut=false, topVer=AffinityTopologyVersion 
[topVer=3, minorTopVer=0], duration=0ms, onePhaseCommit=true], size=1]]]
class 
org.apache.ignite.internal.transactions.IgniteTxHeuristicCheckedException: 
Commit produced a runtime exception (all transaction entries will be 
invalidated): 
GridDhtTxRemote[id=32a446f1051-0348ff9e-0000-0002-0000-01501f645bfd, 
concurrency=OPTIMISTIC, isolation=READ_COMMITTED, state=COMMITTING, 
invalidate=false, rollbackOnly=false, 
nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, duration=0]
    at 
org.apache.ignite.internal.processors.cache.distributed.GridDistributedTxRemoteAdapter.commitIfLocked(GridDistributedTxRemoteAdapter.java:672)
    at 
org.apache.ignite.internal.processors.cache.distributed.GridDistributedTxRemoteAdapter.commit(GridDistributedTxRemoteAdapter.java:723)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.finish(IgniteTxHandler.java:1027)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.processDhtTxPrepareRequest(IgniteTxHandler.java:809)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler$5.apply(IgniteTxHandler.java:138)
    at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler$5.apply(IgniteTxHandler.java:136)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.processMessage(GridCacheIoManager.java:508)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.onMessage0(GridCacheIoManager.java:274)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.handleMessage(GridCacheIoManager.java:198)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager.access$000(GridCacheIoManager.java:77)
    at 
org.apache.ignite.internal.processors.cache.GridCacheIoManager$1.onMessage(GridCacheIoManager.java:160)
    at 
org.apache.ignite.internal.managers.communication.GridIoManager.processRegularMessage0(GridIoManager.java:811)
    at 
org.apache.ignite.internal.managers.communication.GridIoManager.access$1500(GridIoManager.java:106)
    at 
org.apache.ignite.internal.managers.communication.GridIoManager$5.run(GridIoManager.java:774)
    at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
    at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
    at java.lang.Thread.run(Thread.java:745)
Caused by: class org.apache.ignite.spi.IgniteSpiException: Test exception.
    at 
org.apache.ignite.internal.processors.cache.IgniteTxExceptionAbstractSelfTest$TestIndexingSpi.store(IgniteTxExceptionAbstractSelfTest.java:646)
    at 
org.apache.ignite.internal.managers.indexing.GridIndexingManager.store(GridIndexingManager.java:101)
    at 
org.apache.ignite.internal.processors.query.GridQueryProcessor.store(GridQueryProcessor.java:482)
    at 
org.apache.ignite.internal.processors.cache.query.GridCacheQueryManager.store(GridCacheQueryManager.java:408)
    at 
org.apache.ignite.internal.processors.cache.GridCacheMapEntry.updateIndex(GridCacheMapEntry.java:3533)
    at 
org.apache.ignite.internal.processors.cache.GridCacheMapEntry.innerSet(GridCacheMapEntry.java:1098)
    at 
org.apache.ignite.internal.processors.cache.distributed.GridDistributedTxRemoteAdapter.commitIfLocked(GridDistributedTxRemoteAdapter.java:580)
    ... 16 more
[20:54:42,304][ERROR][main][root] Test failed.
junit.framework.AssertionFailedError: Unexpected entry for grid [i=2, 
entry=GridNearCacheEntry [topVer=3, dhtVer=GridCacheVersion [topVer=55115678, 
nodeOrderDrId=2, globalTime=1443635682299, order=1443635677727], part=5, 
super=GridDistributedCacheEntry [super=GridCacheMapEntry 
[key=KeyCacheObjectImpl [val=5, hasValBytes=true], val=CacheObjectImpl [val=1, 
hasValBytes=true], startVer=1443635677720, ver=GridCacheVersion 
[topVer=55115678, nodeOrderDrId=3, globalTime=1443635682301, 
order=1443635677719], hash=-871541811, extras=GridCacheMvccEntryExtras 
[mvcc=GridCacheMvcc [locs=null, rmts=[GridCacheMvccCandidate 
[nodeId=100c7cf0-d287-448c-b6d8-c2d96bda3001, ver=GridCacheVersion 
[topVer=55115678, nodeOrderDrId=2, globalTime=1443635682301, 
order=1443635677731], timeout=0, ts=1443635682299, threadId=80062, id=6177849, 
topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], reentry=null, 
otherNodeId=null, otherVer=null, mappedDhtNodes=null, mappedNearNodes=null, 
ownerVer=null, key=KeyCacheObjectImpl [val=5, hasValBytes=true], 
masks=local=0|owner=1|ready=0|reentry=0|used=1|tx=1|single_implicit=0|dht_local=0|near_local=0|removed=0,
 prevVer=null, nextVer=null]]]], flags=0]]]]
    at junit.framework.Assert.fail(Assert.java:57)
    at junit.framework.Assert.assertTrue(Assert.java:22)
    at junit.framework.Assert.assertFalse(Assert.java:39)
    at junit.framework.TestCase.assertFalse(TestCase.java:210)
    at 
org.apache.ignite.internal.processors.cache.IgniteTxExceptionAbstractSelfTest.checkUnlocked(IgniteTxExceptionAbstractSelfTest.java:396)
    at 
org.apache.ignite.internal.processors.cache.IgniteTxExceptionAbstractSelfTest.checkTransform(IgniteTxExceptionAbstractSelfTest.java:480)
    at 
org.apache.ignite.internal.processors.cache.IgniteTxExceptionAbstractSelfTest.testTransformBackup(IgniteTxExceptionAbstractSelfTest.java:234)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
    at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:606)
    at junit.framework.TestCase.runTest(TestCase.java:176)
    at 
org.apache.ignite.testframework.junits.GridAbstractTest.runTestInternal(GridAbstractTest.java:1665)
    at 
org.apache.ignite.testframework.junits.GridAbstractTest.access$000(GridAbstractTest.java:111)
    at 
org.apache.ignite.testframework.junits.GridAbstractTest$6.run(GridAbstractTest.java:1603)



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)

Reply via email to