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

Semen Boikov commented on IGNITE-1090:
--------------------------------------

Test still fails sometimeson TC, see this assert in the log:
{noformat}
[17:48:07]W:             [org.apache.ignite:ignite-core] Exception in thread 
"put-worker-near.GridCachePartitionedOptimisticTxNodeRestartTest0" 
java.lang.AssertionError: Transaction does not own lock for update 
[entry=GridNearCacheEntry [topVer=28, dhtVer=GridCacheVersion [topVer=53462904, 
nodeOrderDrId=1, globalTime=1441982887635, order=1441982887562], part=3, 
super=GridDistributedCacheEntry [super=GridCacheMapEntry 
[key=KeyCacheObjectImpl [val=3, hasValBytes=true], val=CacheObjectImpl [val=3, 
hasValBytes=true], startVer=1441982887550, ver=GridCacheVersion 
[topVer=53462904, nodeOrderDrId=1, globalTime=1441982887631, 
order=1441982887549], hash=-2047822809, extras=GridCacheMvccEntryExtras 
[mvcc=GridCacheMvcc [locs=[GridCacheMvccCandidate 
[nodeId=00799d58-2c53-43c2-b570-a3cba19e8000, ver=GridCacheVersion 
[topVer=53462904, nodeOrderDrId=1, globalTime=1441982887635, 
order=1441982887562], timeout=0, ts=1441982887633, threadId=490249, id=1329198, 
topVer=AffinityTopologyVersion [topVer=28, minorTopVer=0], reentry=null, 
otherNodeId=null, otherVer=GridCacheVersion [topVer=53462904, nodeOrderDrId=1, 
globalTime=1441982887635, order=1441982887562], mappedDhtNodes=null, 
mappedNearNodes=null, ownerVer=null, key=KeyCacheObjectImpl [val=3, 
hasValBytes=true], 
masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=1|single_implicit=0|dht_local=0|near_local=1|removed=0,
 prevVer=null, nextVer=null]], rmts=[GridCacheMvccCandidate 
[nodeId=207ac7eb-22b1-4bd8-a7c6-a21586acc002, ver=GridCacheVersion 
[topVer=53462904, nodeOrderDrId=27, globalTime=1441982887632, 
order=1441982887554], timeout=0, ts=1441982887633, threadId=489982, id=1329188, 
topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], reentry=null, 
otherNodeId=null, otherVer=null, mappedDhtNodes=null, mappedNearNodes=null, 
ownerVer=GridCacheVersion [topVer=53462904, nodeOrderDrId=27, 
globalTime=1441982887631, order=1441982887550], key=KeyCacheObjectImpl [val=3, 
hasValBytes=true], 
masks=local=0|owner=1|ready=0|reentry=0|used=0|tx=1|single_implicit=0|dht_local=0|near_local=0|removed=0,
 prevVer=null, nextVer=null]]]], flags=0]]], tx=GridNearTxLocal 
[nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=true, 
hasRemoteLocks=false, mappings=[207ac7eb-22b1-4bd8-a7c6-a21586acc002], 
super=GridDhtTxLocalAdapter [dhtThreadId=490249, needsCompletedVers=false, 
nearOnOriginatingNode=false, nearNodes=[], dhtNodes=[], explicitLock=false, 
super=IgniteTxLocalAdapter [txMap={IgniteTxKey [key=KeyCacheObjectImpl [val=3, 
hasValBytes=true], cacheId=-838655627]=IgniteTxEntry [key=KeyCacheObjectImpl 
[val=3, hasValBytes=true], cacheId=-838655627, txKey=IgniteTxKey 
[key=KeyCacheObjectImpl [val=3, hasValBytes=true], cacheId=-838655627], 
val=[op=UPDATE, val=UserCacheObjectImpl [val=3, hasValBytes=true]], 
prevVal=[op=UPDATE, val=UserCacheObjectImpl [val=3, hasValBytes=true]], 
entryProcessorsCol=null, entryProcessorCalcVal=null, ttl=-1, 
conflictExpireTime=-1, conflictVer=null, explicitVer=null, 
dhtVer=GridCacheVersion [topVer=53462904, nodeOrderDrId=1, 
globalTime=1441982887635, order=1441982887562], filters=[], 
filtersPassed=false, filtersSet=true, entry=GridNearCacheEntry [topVer=28, 
dhtVer=GridCacheVersion [topVer=53462904, nodeOrderDrId=1, 
globalTime=1441982887635, order=1441982887562], part=3, 
super=GridDistributedCacheEntry [super=GridCacheMapEntry 
[key=KeyCacheObjectImpl [val=3, hasValBytes=true], val=CacheObjectImpl [val=3, 
hasValBytes=true], startVer=1441982887550, ver=GridCacheVersion 
[topVer=53462904, nodeOrderDrId=1, globalTime=1441982887631, 
order=1441982887549], hash=-2047822809, extras=GridCacheMvccEntryExtras 
[mvcc=GridCacheMvcc [locs=[GridCacheMvccCandidate 
[nodeId=00799d58-2c53-43c2-b570-a3cba19e8000, ver=GridCacheVersion 
[topVer=53462904, nodeOrderDrId=1, globalTime=1441982887635, 
order=1441982887562], timeout=0, ts=1441982887633, threadId=490249, id=1329198, 
topVer=AffinityTopologyVersion [topVer=28, minorTopVer=0], reentry=null, 
otherNodeId=null, otherVer=GridCacheVersion [topVer=53462904, nodeOrderDrId=1, 
globalTime=1441982887635, order=1441982887562], mappedDhtNodes=null, 
mappedNearNodes=null, ownerVer=null, key=KeyCacheObjectImpl [val=3, 
hasValBytes=true], 
masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=1|single_implicit=0|dht_local=0|near_local=1|removed=0,
 prevVer=null, nextVer=null]], rmts=[GridCacheMvccCandidate 
[nodeId=207ac7eb-22b1-4bd8-a7c6-a21586acc002, ver=GridCacheVersion 
[topVer=53462904, nodeOrderDrId=27, globalTime=1441982887632, 
order=1441982887554], timeout=0, ts=1441982887633, threadId=489982, id=1329188, 
topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], reentry=null, 
otherNodeId=null, otherVer=null, mappedDhtNodes=null, mappedNearNodes=null, 
ownerVer=GridCacheVersion [topVer=53462904, nodeOrderDrId=27, 
globalTime=1441982887631, order=1441982887550], key=KeyCacheObjectImpl [val=3, 
hasValBytes=true], 
masks=local=0|owner=1|ready=0|reentry=0|used=0|tx=1|single_implicit=0|dht_local=0|near_local=0|removed=0,
 prevVer=null, nextVer=null]]]], flags=0]]], prepared=true, locked=false, 
nodeId=207ac7eb-22b1-4bd8-a7c6-a21586acc002, locMapped=false, expiryPlc=null, 
transferExpiryPlc=false, flags=0, xidVer=GridCacheVersion [topVer=53462904, 
nodeOrderDrId=1, globalTime=1441982887635, order=1441982887562]], IgniteTxKey 
[key=KeyCacheObjectImpl [val=4, hasValBytes=false], 
cacheId=-838655627]=IgniteTxEntry [key=KeyCacheObjectImpl [val=4, 
hasValBytes=false], cacheId=-838655627, txKey=null, val=[op=READ, 
val=CacheObjectImpl [val=4, hasValBytes=true]], prevVal=[op=READ, 
val=CacheObjectImpl [val=4, hasValBytes=true]], entryProcessorsCol=null, 
entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, 
explicitVer=null, dhtVer=null, filters=null, filtersPassed=false, 
filtersSet=true, entry=GridNearCacheEntry [topVer=28, dhtVer=GridCacheVersion 
[topVer=53462903, nodeOrderDrId=1, globalTime=1441982887620, 
order=1441982887513], part=4, super=GridDistributedCacheEntry 
[super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=4, hasValBytes=false], 
val=null, startVer=1441982887563, ver=GridCacheVersion [topVer=53462903, 
nodeOrderDrId=1, globalTime=1441982887635, order=1441982887564], 
hash=614249093, extras=GridCacheObsoleteEntryExtras 
[obsoleteVer=GridCacheVersion [topVer=53462903, nodeOrderDrId=1, 
globalTime=1441982887635, order=1441982887564]], flags=0]]], prepared=false, 
locked=false, nodeId=null, locMapped=false, expiryPlc=null, 
transferExpiryPlc=false, flags=0, xidVer=GridCacheVersion [topVer=53462904, 
nodeOrderDrId=1, globalTime=1441982887635, order=1441982887562]], IgniteTxKey 
[key=KeyCacheObjectImpl [val=8, hasValBytes=true], 
cacheId=-838655627]=IgniteTxEntry [key=KeyCacheObjectImpl [val=8, 
hasValBytes=true], cacheId=-838655627, txKey=null, val=[op=READ, 
val=CacheObjectImpl [val=8, hasValBytes=true]], prevVal=[op=READ, 
val=CacheObjectImpl [val=8, hasValBytes=true]], entryProcessorsCol=null, 
entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, 
explicitVer=null, dhtVer=null, filters=null, filtersPassed=false, 
filtersSet=true, entry=GridNearCacheEntry [topVer=28, dhtVer=GridCacheVersion 
[topVer=53462904, nodeOrderDrId=27, globalTime=1441982887629, 
order=1441982887531], part=8, super=GridDistributedCacheEntry 
[super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=8, hasValBytes=true], 
val=CacheObjectImpl [val=8, hasValBytes=true], startVer=1441982887462, 
ver=GridCacheVersion [topVer=53462904, nodeOrderDrId=27, 
globalTime=1441982887629, order=1441982887531], hash=1228498187, extras=null, 
flags=0]]], prepared=false, locked=false, nodeId=null, locMapped=false, 
expiryPlc=null, transferExpiryPlc=false, flags=0, xidVer=GridCacheVersion 
[topVer=53462904, nodeOrderDrId=1, globalTime=1441982887635, 
order=1441982887562]]}, completedBase=null, sndTransformedVals=false, 
super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=53462904, 
nodeOrderDrId=1, globalTime=1441982887635, order=1441982887562], writeVer=null, 
implicit=false, implicitSingle=false, loc=true, threadId=490249, 
startTime=1441982887633, nodeId=00799d58-2c53-43c2-b570-a3cba19e8000, 
startVer=GridCacheVersion [topVer=53462904, nodeOrderDrId=1, 
globalTime=1441982887635, order=1441982887562], endVer=null, 
isolation=REPEATABLE_READ, concurrency=OPTIMISTIC, timeout=0, 
sysInvalidate=false, sys=false, plc=2, commitVer=GridCacheVersion 
[topVer=53462904, nodeOrderDrId=1, globalTime=1441982887635, 
order=1441982887562], finalizing=NONE, preparing=false, invalidParts={}, 
state=COMMITTING, timedOut=false, topVer=AffinityTopologyVersion [topVer=28, 
minorTopVer=0], duration=0ms, onePhaseCommit=true], size=3]]]]
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.processors.cache.GridCacheMapEntry.innerSet(GridCacheMapEntry.java:1004)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.processors.cache.transactions.IgniteTxLocalAdapter.userCommit(IgniteTxLocalAdapter.java:917)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxLocal.finish(GridNearTxLocal.java:678)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxFinishFuture.onDone(GridNearTxFinishFuture.java:258)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxFinishFuture.onDone(GridNearTxFinishFuture.java:64)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.util.future.GridCompoundFuture.checkComplete(GridCompoundFuture.java:260)
[17:48:07] :             [org.apache.ignite:ignite-core] [17:48:07,657][INFO 
][restart-worker-0][GridCachePartitionedOptimisticTxNodeRestartTest2] 
Non-loopback local IPs: 192.168.2.25, fe80:0:0:0:ca60:ff:fe68:582c%2
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.util.future.GridCompoundFuture.markInitialized(GridCompoundFuture.java:228)
[17:48:07] :             [org.apache.ignite:ignite-core] [17:48:07,657][INFO 
][restart-worker-0][GridCachePartitionedOptimisticTxNodeRestartTest2] Enabled 
local MACs: C8600068582C
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxFinishFuture.finish(GridNearTxFinishFuture.java:343)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxLocal$3.apply(GridNearTxLocal.java:773)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxLocal$3.apply(GridNearTxLocal.java:765)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.util.future.GridFutureAdapter.notifyListener(GridFutureAdapter.java:262)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.util.future.GridFutureAdapter.notifyListeners(GridFutureAdapter.java:250)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:380)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:346)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.processors.cache.distributed.near.GridNearOptimisticTxPrepareFuture.onComplete(GridNearOptimisticTxPrepareFuture.java:244)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.processors.cache.distributed.near.GridNearOptimisticTxPrepareFuture.onError(GridNearOptimisticTxPrepareFuture.java:151)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.processors.cache.distributed.near.GridNearOptimisticTxPrepareFuture$MiniFuture.onResult(GridNearOptimisticTxPrepareFuture.java:814)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.processors.cache.distributed.near.GridNearOptimisticTxPrepareFuture.onNodeLeft(GridNearOptimisticTxPrepareFuture.java:131)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.processors.cache.GridCacheMvccManager$3.onEvent(GridCacheMvccManager.java:212)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.notifyListeners(GridEventStorageManager.java:770)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.notifyListeners(GridEventStorageManager.java:755)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.record(GridEventStorageManager.java:295)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.recordEvent(GridDiscoveryManager.java:1934)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.body0(GridDiscoveryManager.java:2141)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.body(GridDiscoveryManager.java:1974)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
org.apache.ignite.internal.util.worker.GridWorker.run(GridWorker.java:110)
[17:48:07]W:             [org.apache.ignite:ignite-core]        at 
java.lang.Thread.run(Thread.java:745)
[17:48:07]W:             [org.apache.ignite:ignite-core]        Suppressed: 
class org.apache.ignite.IgniteException: Invalid transaction state for commit 
[state=UNKNOWN, tx=GridNearTxLocal [nearLocallyMapped=false, 
colocatedLocallyMapped=false, needCheckBackup=true, hasRemoteLocks=false, 
mappings=[207ac7eb-22b1-4bd8-a7c6-a21586acc002], super=GridDhtTxLocalAdapter 
[dhtThreadId=490249, needsCompletedVers=false, nearOnOriginatingNode=false, 
nearNodes=[], dhtNodes=[], explicitLock=false, super=IgniteTxLocalAdapter 
[txMap={IgniteTxKey [key=KeyCacheObjectImpl [val=3, hasValBytes=true], 
cacheId=-838655627]=IgniteTxEntry [key=KeyCacheObjectImpl [val=3, 
hasValBytes=true], cacheId=-838655627, txKey=IgniteTxKey 
[key=KeyCacheObjectImpl [val=3, hasValBytes=true], cacheId=-838655627], 
val=[op=UPDATE, val=UserCacheObjectImpl [val=3, hasValBytes=true]], 
prevVal=[op=UPDATE, val=UserCacheObjectImpl [val=3, hasValBytes=true]], 
entryProcessorsCol=null, entryProcessorCalcVal=null, ttl=-1, 
conflictExpireTime=-1, conflictVer=null, explicitVer=null, 
dhtVer=GridCacheVersion [topVer=53462904, nodeOrderDrId=1, 
globalTime=1441982887635, order=1441982887562], filters=[], 
filtersPassed=false, filtersSet=true, entry=GridNearCacheEntry [topVer=-1, 
dhtVer=null, part=3, super=GridDistributedCacheEntry [super=GridCacheMapEntry 
[key=KeyCacheObjectImpl [val=3, hasValBytes=true], val=null, 
startVer=1441982887550, ver=GridCacheVersion [topVer=53462904, nodeOrderDrId=1, 
globalTime=1441982887635, order=1441982887562], hash=-2047822809, 
extras=GridCacheMvccEntryExtras [mvcc=GridCacheMvcc [locs=null, 
rmts=[GridCacheMvccCandidate [nodeId=207ac7eb-22b1-4bd8-a7c6-a21586acc002, 
ver=GridCacheVersion [topVer=53462904, nodeOrderDrId=27, 
globalTime=1441982887632, order=1441982887554], timeout=0, ts=1441982887633, 
threadId=489982, id=1329188, topVer=AffinityTopologyVersion [topVer=-1, 
minorTopVer=0], reentry=null, otherNodeId=null, otherVer=null, 
mappedDhtNodes=null, mappedNearNodes=null, ownerVer=GridCacheVersion 
[topVer=53462904, nodeOrderDrId=27, globalTime=1441982887631, 
order=1441982887550], key=KeyCacheObjectImpl [val=3, hasValBytes=true], 
masks=local=0|owner=1|ready=0|reentry=0|used=0|tx=1|single_implicit=0|dht_local=0|near_local=0|removed=0,
 prevVer=null, nextVer=null]]]], flags=0]]], prepared=true, locked=false, 
nodeId=207ac7eb-22b1-4bd8-a7c6-a21586acc002, locMapped=false, expiryPlc=null, 
transferExpiryPlc=false, flags=0, xidVer=GridCacheVersion [topVer=53462904, 
nodeOrderDrId=1, globalTime=1441982887635, order=1441982887562]], IgniteTxKey 
[key=KeyCacheObjectImpl [val=4, hasValBytes=false], 
cacheId=-838655627]=IgniteTxEntry [key=KeyCacheObjectImpl [val=4, 
hasValBytes=false], cacheId=-838655627, txKey=null, val=[op=READ, 
val=CacheObjectImpl [val=4, hasValBytes=true]], prevVal=[op=READ, 
val=CacheObjectImpl [val=4, hasValBytes=true]], entryProcessorsCol=null, 
entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, 
explicitVer=null, dhtVer=null, filters=null, filtersPassed=false, 
filtersSet=true, entry=GridNearCacheEntry [topVer=28, dhtVer=GridCacheVersion 
[topVer=53462903, nodeOrderDrId=1, globalTime=1441982887620, 
order=1441982887513], part=4, super=GridDistributedCacheEntry 
[super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=4, hasValBytes=false], 
val=null, startVer=1441982887563, ver=GridCacheVersion [topVer=53462903, 
nodeOrderDrId=1, globalTime=1441982887635, order=1441982887564], 
hash=614249093, extras=GridCacheObsoleteEntryExtras 
[obsoleteVer=GridCacheVersion [topVer=53462903, nodeOrderDrId=1, 
globalTime=1441982887635, order=1441982887564]], flags=0]]], prepared=false, 
locked=false, nodeId=null, locMapped=false, expiryPlc=null, 
transferExpiryPlc=false, flags=0, xidVer=GridCacheVersion [topVer=53462904, 
nodeOrderDrId=1, globalTime=1441982887635, order=1441982887562]], IgniteTxKey 
[key=KeyCacheObjectImpl [val=8, hasValBytes=true], 
cacheId=-838655627]=IgniteTxEntry [key=KeyCacheObjectImpl [val=8, 
hasValBytes=true], cacheId=-838655627, txKey=null, val=[op=READ, 
val=CacheObjectImpl [val=8, hasValBytes=true]], prevVal=[op=READ, 
val=CacheObjectImpl [val=8, hasValBytes=true]], entryProcessorsCol=null, 
entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, 
explicitVer=null, dhtVer=null, filters=null, filtersPassed=false, 
filtersSet=true, entry=GridNearCacheEntry [topVer=28, dhtVer=GridCacheVersion 
[topVer=53462904, nodeOrderDrId=27, globalTime=1441982887629, 
order=1441982887531], part=8, super=GridDistributedCacheEntry 
[super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=8, hasValBytes=true], 
val=CacheObjectImpl [val=8, hasValBytes=true], startVer=1441982887462, 
ver=GridCacheVersion [topVer=53462904, nodeOrderDrId=27, 
globalTime=1441982887629, order=1441982887531], hash=1228498187, extras=null, 
flags=0]]], prepared=false, locked=false, nodeId=null, locMapped=false, 
expiryPlc=null, transferExpiryPlc=false, flags=0, xidVer=GridCacheVersion 
[topVer=53462904, nodeOrderDrId=1, globalTime=1441982887635, 
order=1441982887562]]}, completedBase=null, sndTransformedVals=false, 
super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=53462904, 
nodeOrderDrId=1, globalTime=1441982887635, order=1441982887562], writeVer=null, 
implicit=false, implicitSingle=false, loc=true, threadId=490249, 
startTime=1441982887633, nodeId=00799d58-2c53-43c2-b570-a3cba19e8000, 
startVer=GridCacheVersion [topVer=53462904, nodeOrderDrId=1, 
globalTime=1441982887635, order=1441982887562], endVer=null, 
isolation=REPEATABLE_READ, concurrency=OPTIMISTIC, timeout=0, 
sysInvalidate=false, sys=false, plc=2, commitVer=GridCacheVersion 
[topVer=53462904, nodeOrderDrId=1, globalTime=1441982887635, 
order=1441982887562], finalizing=NONE, preparing=false, invalidParts={}, 
state=UNKNOWN, timedOut=false, topVer=AffinityTopologyVersion [topVer=28, 
minorTopVer=0], duration=21ms, onePhaseCommit=true], size=3]]]]
[17:48:07]W:             [org.apache.ignite:ignite-core]                at 
org.apache.ignite.internal.util.IgniteUtils.convertException(IgniteUtils.java:880)
[17:48:07]W:             [org.apache.ignite:ignite-core]                at 
org.apache.ignite.internal.processors.cache.transactions.TransactionProxyImpl.close(TransactionProxyImpl.java:279)
[17:48:07]W:             [org.apache.ignite:ignite-core]                at 
org.apache.ignite.internal.processors.cache.distributed.GridCacheAbstractNodeRestartSelfTest$3.run(GridCacheAbstractNodeRestartSelfTest.java:694)
[17:48:07]W:             [org.apache.ignite:ignite-core]                ... 1 
more
{noformat}

> GridCachePartitionedOptimisticTxNodeRestartTest hangs when node lefts topology
> ------------------------------------------------------------------------------
>
>                 Key: IGNITE-1090
>                 URL: https://issues.apache.org/jira/browse/IGNITE-1090
>             Project: Ignite
>          Issue Type: Bug
>          Components: cache
>            Reporter: Denis Magda
>            Assignee: Semen Boikov
>            Priority: Critical
>             Fix For: ignite-1.4
>
>
> The test hangs with the following errors:
> {noformat}
> [16:26:33] (err) Failed to execute compound future reducer: Compound future 
> listener: GridCompoundIdentityFuture [super=GridCompoundFuture [lsnrCalls=0, 
> finished=false, rdc=Map reducer: {}, init=true, 
> res=java.util.concurrent.atomic.AtomicMarkableReference@3c6fff03, err=null, 
> done=false, cancelled=false, err=null, futs=[true]]]class 
> org.apache.ignite.IgniteCheckedException: Failed to wait for topology version 
> to change: AffinityTopologyVersion [topVer=274, minorTopVer=0]
>       at 
> org.apache.ignite.internal.processors.cache.distributed.GridFutureRemapTimeoutObject.onTimeout(GridFutureRemapTimeoutObject.java:64)
>       at 
> org.apache.ignite.internal.processors.timeout.GridTimeoutProcessor$TimeoutWorker.body(GridTimeoutProcessor.java:158)
>       at 
> org.apache.ignite.internal.util.worker.GridWorker.run(GridWorker.java:108)
>       at java.lang.Thread.run(Thread.java:745)
> Caused by: class 
> org.apache.ignite.internal.cluster.ClusterTopologyCheckedException: Remote 
> node left grid (will retry): 703c58e1-e099-4f22-b5c3-6c3676338007
>       at 
> org.apache.ignite.internal.processors.cache.distributed.near.GridNearGetFuture.onNodeLeft(GridNearGetFuture.java:215)
>       at 
> org.apache.ignite.internal.processors.cache.GridCacheMvccManager$3.onEvent(GridCacheMvccManager.java:186)
>       at 
> org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.notifyListeners(GridEventStorageManager.java:745)
>       at 
> org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.notifyListeners(GridEventStorageManager.java:730)
>       at 
> org.apache.ignite.internal.managers.eventstorage.GridEventStorageManager.record(GridEventStorageManager.java:270)
>       at 
> org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.recordEvent(GridDiscoveryManager.java:1719)
>       at 
> org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.body0(GridDiscoveryManager.java:1910)
>       at 
> org.apache.ignite.internal.managers.discovery.GridDiscoveryManager$DiscoveryWorker.body(GridDiscoveryManager.java:1758)
>       ... 2 more
> {noformat}
> This issue appeared after IGNITE-882 was fixed. Until it wasn't fixed the 
> tests hung because of this issue:
> {noformat}
> Caused by: class org.apache.ignite.IgniteCheckedException: Remote node ID is 
> not as expected [expected=9019c94c-84f5-4065-89b1-f16fdf708009, 
> rcvd=707ed613-1b65-4771-ac98-5faa6857e007]
>               at 
> org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi.safeHandshake(TcpCommunicationSpi.java:2203)
>               at 
> org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi.createTcpClient(TcpCommunicationSpi.java:2025)
> {noformat}



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

Reply via email to