[jira] [Created] (IGNITE-1976) [Test Failed] IgniteAtomicLongChangingTopologySelfTest.testClientQueueCreateCloseFailover

[Anton Vinogradov (Jira)]

Denis Magda created IGNITE-1976:
-----------------------------------

             Summary: [Test Failed] IgniteAtomicLongChangingTopologySelfTest.testClientQueueCreateCloseFailover
                 Key: IGNITE-1976
                 URL: https://issues.apache.org/jira/browse/IGNITE-1976
             Project: Ignite
          Issue Type: Bug
            Reporter: Denis Magda
             Fix For: 1.6


The test fails from time to time freezing the whole test suite.

In the logs I see the following error that repeats periodically

{noformat}
 Caused by: class org.apache.ignite.internal.cluster.ClusterTopologyCheckedException: Primary node left grid.
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.sendReply(IgniteTxHandler.java:1050)
[17:55:43]W: [org.apache.ignite:ignite-core] ... 14 more
[17:55:43]W: [org.apache.ignite:ignite-core] [17:55:43,892][ERROR][ignite-#70461%utility-dht.IgniteAtomicLongChangingTopologySelfTest5%][GridNearTxFinishFuture] Failed to automatically rollback transaction: GridNearTxLocal [mappings=IgniteTxMappingsSingleImpl [mapping=GridDistributedTxMapping [entries=[IgniteTxEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], cacheId=1278244283, txKey=null, val=[op=DELETE, val=null], prevVal=[op=NOOP, val=null], entryProcessorsCol=null, entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=[], filtersPassed=false, filtersSet=true, entry=GridDhtDetachedCacheEntry [super=GridDistributedCacheEntry [super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], val=null, startVer=1448031356110, ver=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356110], hash=3411296, extras=null, flags=0]]], prepared=false, locked=false, nodeId=aecc2437-2647-4dc1-a2cc-3bf612b00000, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356108]]], explicitLock=false, dhtVer=null, last=false, near=false, clientFirst=false, node=aecc2437-2647-4dc1-a2cc-3bf612b00000]], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=false, hasRemoteLocks=false, mappings=IgniteTxMappingsSingleImpl [mapping=GridDistributedTxMapping [entries=[IgniteTxEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], cacheId=1278244283, txKey=null, val=[op=DELETE, val=null], prevVal=[op=NOOP, val=null], entryProcessorsCol=null, entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=[], filtersPassed=false, filtersSet=true, entry=GridDhtDetachedCacheEntry [super=GridDistributedCacheEntry [super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], val=null, startVer=1448031356110, ver=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356110], hash=3411296, extras=null, flags=0]]], prepared=false, locked=false, nodeId=aecc2437-2647-4dc1-a2cc-3bf612b00000, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356108]]], explicitLock=false, dhtVer=null, last=false, near=false, clientFirst=false, node=aecc2437-2647-4dc1-a2cc-3bf612b00000]], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=[], dhtNodes=[], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=true, txState=IgniteTxImplicitSingleStateImpl [entry=IgniteTxEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], cacheId=1278244283, txKey=null, val=[op=DELETE, val=null], prevVal=[op=NOOP, val=null], entryProcessorsCol=null, entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=[], filtersPassed=false, filtersSet=true, entry=GridDhtDetachedCacheEntry [super=GridDistributedCacheEntry [super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], val=null, startVer=1448031356110, ver=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356110], hash=3411296, extras=null, flags=0]]], prepared=false, locked=false, nodeId=aecc2437-2647-4dc1-a2cc-3bf612b00000, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356108]], init=true], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356108], writeVer=null, implicit=true, loc=true, threadId=122606, startTime=1448031343879, nodeId=691aca27-c82d-4de7-9191-2a88bd100005, startVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356108], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=true, plc=2, commitVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356108], finalizing=NONE, preparing=false, invalidParts=null, state=ROLLED_BACK, timedOut=false, topVer=AffinityTopologyVersion [topVer=26, minorTopVer=0], duration=10ms, onePhaseCommit=true], size=1]]]
[17:55:43]W: [org.apache.ignite:ignite-core] class org.apache.ignite.IgniteCheckedException: Invalid transaction state for commit [state=ROLLED_BACK, tx=GridNearTxLocal [mappings=IgniteTxMappingsSingleImpl [mapping=GridDistributedTxMapping [entries=[IgniteTxEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], cacheId=1278244283, txKey=null, val=[op=DELETE, val=null], prevVal=[op=NOOP, val=null], entryProcessorsCol=null, entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=[], filtersPassed=false, filtersSet=true, entry=GridDhtDetachedCacheEntry [super=GridDistributedCacheEntry [super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], val=null, startVer=1448031356110, ver=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356110], hash=3411296, extras=null, flags=0]]], prepared=false, locked=false, nodeId=aecc2437-2647-4dc1-a2cc-3bf612b00000, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356108]]], explicitLock=false, dhtVer=null, last=false, near=false, clientFirst=false, node=aecc2437-2647-4dc1-a2cc-3bf612b00000]], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=false, hasRemoteLocks=false, mappings=IgniteTxMappingsSingleImpl [mapping=GridDistributedTxMapping [entries=[IgniteTxEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], cacheId=1278244283, txKey=null, val=[op=DELETE, val=null], prevVal=[op=NOOP, val=null], entryProcessorsCol=null, entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=[], filtersPassed=false, filtersSet=true, entry=GridDhtDetachedCacheEntry [super=GridDistributedCacheEntry [super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], val=null, startVer=1448031356110, ver=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356110], hash=3411296, extras=null, flags=0]]], prepared=false, locked=false, nodeId=aecc2437-2647-4dc1-a2cc-3bf612b00000, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356108]]], explicitLock=false, dhtVer=null, last=false, near=false, clientFirst=false, node=aecc2437-2647-4dc1-a2cc-3bf612b00000]], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=[], dhtNodes=[], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=true, txState=IgniteTxImplicitSingleStateImpl [entry=IgniteTxEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], cacheId=1278244283, txKey=null, val=[op=DELETE, val=null], prevVal=[op=NOOP, val=null], entryProcessorsCol=null, entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=[], filtersPassed=false, filtersSet=true, entry=GridDhtDetachedCacheEntry [super=GridDistributedCacheEntry [super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], val=null, startVer=1448031356110, ver=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356110], hash=3411296, extras=null, flags=0]]], prepared=false, locked=false, nodeId=aecc2437-2647-4dc1-a2cc-3bf612b00000, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356108]], init=true], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356108], writeVer=null, implicit=true, loc=true, threadId=122606, startTime=1448031343879, nodeId=691aca27-c82d-4de7-9191-2a88bd100005, startVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356108], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=true, plc=2, commitVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343887, order=1448031356108], finalizing=NONE, preparing=false, invalidParts=null, state=ROLLED_BACK, timedOut=false, topVer=AffinityTopologyVersion [topVer=26, minorTopVer=0], duration=10ms, onePhaseCommit=true], size=1]]]]
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxLocal.finish(GridNearTxLocal.java:712)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxFinishFuture.onDone(GridNearTxFinishFuture.java:238)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxFinishFuture.onDone(GridNearTxFinishFuture.java:64)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:323)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.util.future.GridCompoundFuture.checkComplete(GridCompoundFuture.java:296)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.util.future.GridCompoundFuture.markInitialized(GridCompoundFuture.java:287)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxFinishFuture.finish(GridNearTxFinishFuture.java:343)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxLocal.rollbackAsync(GridNearTxLocal.java:885)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTxLocalAdapter.rollback(GridDhtTxLocalAdapter.java:847)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxFinishFuture.onDone(GridNearTxFinishFuture.java:213)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxFinishFuture.onDone(GridNearTxFinishFuture.java:64)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:334)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.util.future.GridCompoundFuture$Listener.apply(GridCompoundFuture.java:397)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.util.future.GridCompoundFuture$Listener.apply(GridCompoundFuture.java:360)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.util.future.GridFutureAdapter.notifyListener(GridFutureAdapter.java:262)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.util.future.GridFutureAdapter.notifyListeners(GridFutureAdapter.java:250)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:380)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:346)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:334)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxFinishFuture$MiniFuture.onResult(GridNearTxFinishFuture.java:752)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.distributed.near.GridNearTxFinishFuture.onResult(GridNearTxFinishFuture.java:190)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.processDhtTxFinishResponse(IgniteTxHandler.java:545)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.access$300(IgniteTxHandler.java:88)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler$8.apply(IgniteTxHandler.java:157)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler$8.apply(IgniteTxHandler.java:155)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.GridCacheIoManager.processMessage(GridCacheIoManager.java:576)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.GridCacheIoManager.onMessage0(GridCacheIoManager.java:275)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.GridCacheIoManager.handleMessage(GridCacheIoManager.java:199)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.GridCacheIoManager.access$000(GridCacheIoManager.java:78)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.GridCacheIoManager$1.onMessage(GridCacheIoManager.java:161)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.managers.communication.GridIoManager.processRegularMessage0(GridIoManager.java:811)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.managers.communication.GridIoManager.access$1500(GridIoManager.java:106)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.managers.communication.GridIoManager$5.run(GridIoManager.java:774)
[17:55:43]W: [org.apache.ignite:ignite-core] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
[17:55:43]W: [org.apache.ignite:ignite-core] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[17:55:43]W: [org.apache.ignite:ignite-core] at java.lang.Thread.run(Thread.java:745)
[17:55:43]W: [org.apache.ignite:ignite-core] [17:55:43] (err) Failed to execute compound future reducer: Compound future listener: GridNearTxFinishFuture [futId=688f4698151-b48c0b0c-5411-4eb8-bdcf-b5c7b355d5fc, tx=GridNearTxLocal [mappings=IgniteTxMappingsSingleImpl [mapping=GridDistributedTxMapping [entries=[IgniteTxEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], cacheId=1278244283, txKey=null, val=[op=DELETE, val=null], prevVal=[op=NOOP, val=null], entryProcessorsCol=null, entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=[], filtersPassed=false, filtersSet=true, entry=GridDhtDetachedCacheEntry [super=GridDistributedCacheEntry [super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], val=null, startVer=1448031356113, ver=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343899, order=1448031356113], hash=3411296, extras=null, flags=0]]], prepared=false, locked=false, nodeId=aecc2437-2647-4dc1-a2cc-3bf612b00000, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343898, order=1448031356111]]], explicitLock=false, dhtVer=null, last=false, near=false, clientFirst=false, node=aecc2437-2647-4dc1-a2cc-3bf612b00000]], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=false, hasRemoteLocks=false, mappings=IgniteTxMappingsSingleImpl [mapping=GridDistributedTxMapping [entries=[IgniteTxEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], cacheId=1278244283, txKey=null, val=[op=DELETE, val=null], prevVal=[op=NOOP, val=null], entryProcessorsCol=null, entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=[], filtersPassed=false, filtersSet=true, entry=GridDhtDetachedCacheEntry [super=GridDistributedCacheEntry [super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], val=null, startVer=1448031356113, ver=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343899, order=1448031356113], hash=3411296, extras=null, flags=0]]], prepared=false, locked=false, nodeId=aecc2437-2647-4dc1-a2cc-3bf612b00000, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343898, order=1448031356111]]], explicitLock=false, dhtVer=null, last=false, near=false, clientFirst=false, node=aecc2437-2647-4dc1-a2cc-3bf612b00000]], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=[], dhtNodes=[], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=true, txState=IgniteTxImplicitSingleStateImpl [entry=IgniteTxEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], cacheId=1278244283, txKey=null, val=[op=DELETE, val=null], prevVal=[op=NOOP, val=null], entryProcessorsCol=null, entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=[], filtersPassed=false, filtersSet=true, entry=GridDhtDetachedCacheEntry [super=GridDistributedCacheEntry [super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], val=null, startVer=1448031356113, ver=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343899, order=1448031356113], hash=3411296, extras=null, flags=0]]], prepared=false, locked=false, nodeId=aecc2437-2647-4dc1-a2cc-3bf612b00000, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343898, order=1448031356111]], init=true], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343898, order=1448031356111], writeVer=null, implicit=true, loc=true, threadId=122606, startTime=1448031343889, nodeId=691aca27-c82d-4de7-9191-2a88bd100005, startVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343898, order=1448031356111], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=true, plc=2, commitVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343898, order=1448031356111], finalizing=NONE, preparing=false, invalidParts=null, state=PREPARED, timedOut=false, topVer=AffinityTopologyVersion [topVer=26, minorTopVer=0], duration=10ms, onePhaseCommit=true], size=1]]], commit=true, mappings=IgniteTxMappingsSingleImpl [mapping=GridDistributedTxMapping [entries=[IgniteTxEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], cacheId=1278244283, txKey=null, val=[op=DELETE, val=null], prevVal=[op=NOOP, val=null], entryProcessorsCol=null, entryProcessorCalcVal=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=[], filtersPassed=false, filtersSet=true, entry=GridDhtDetachedCacheEntry [super=GridDistributedCacheEntry [super=GridCacheMapEntry [key=KeyCacheObjectImpl [val=GridCacheQueueHeaderKey [name=q-48], hasValBytes=true], val=null, startVer=1448031356113, ver=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343899, order=1448031356113], hash=3411296, extras=null, flags=0]]], prepared=false, locked=false, nodeId=aecc2437-2647-4dc1-a2cc-3bf612b00000, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343898, order=1448031356111]]], explicitLock=false, dhtVer=null, last=false, near=false, clientFirst=false, node=aecc2437-2647-4dc1-a2cc-3bf612b00000]], trackable=true, finishOnePhaseCalled=false, innerFuts=[[node=c6f0fe54-2d56-4452-b3ea-9d3580100002, loc=false, done=true]], super=GridCompoundIdentityFuture [super=GridCompoundFuture [rdc=o.a.i.i.util.lang.GridFunc$27@3f97007a, flags=1, lsnrCalls=0, done=false, cancelled=false, err=null, futs=[true]]]]class org.apache.ignite.internal.transactions.IgniteTxRollbackCheckedException: Failed to commit transaction (transaction has been rolled back on backup node): GridCacheVersion [topVer=59511360, nodeOrderDrId=6, globalTime=1448031343898, order=1448031356111]
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.sendReply(IgniteTxHandler.java:1053)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.processDhtTxFinishRequest(IgniteTxHandler.java:874)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler$7.apply(IgniteTxHandler.java:151)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler$7.apply(IgniteTxHandler.java:149)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.GridCacheIoManager.processMessage(GridCacheIoManager.java:576)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.GridCacheIoManager.onMessage0(GridCacheIoManager.java:275)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.GridCacheIoManager.handleMessage(GridCacheIoManager.java:199)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.GridCacheIoManager.access$000(GridCacheIoManager.java:78)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.processors.cache.GridCacheIoManager$1.onMessage(GridCacheIoManager.java:161)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.managers.communication.GridIoManager.processRegularMessage0(GridIoManager.java:811)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.managers.communication.GridIoManager.access$1500(GridIoManager.java:106)
[17:55:43]W: [org.apache.ignite:ignite-core] at org.apache.ignite.internal.managers.communication.GridIoManager$5.run(GridIoManager.java:774)
[17:55:43]W: [org.apache.ignite:ignite-core] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
[17:55:43]W: [org.apache.ignite:ignite-core] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
[17:55:43]W: [org.apache.ignite:ignite-core] at java.lang.Thread.run(Thread.java:745)
{noformat}



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