You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@ignite.apache.org by "Ilya Lantukh (JIRA)" <ji...@apache.org> on 2018/08/28 12:22:00 UTC
[jira] [Updated] (IGNITE-9392) CacheAsyncOperationsFailoverTxTest
hangs on TC
[ https://issues.apache.org/jira/browse/IGNITE-9392?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Ilya Lantukh updated IGNITE-9392:
---------------------------------
Description:
Exchange worker hangs while waiting for partition release:
{code}
[13:42:50] : [Step 3/4] Thread [name="exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%", id=245275, state=TIMED_WAITING, blockCnt=135, waitCnt=176]
[13:42:50] : [Step 3/4] at sun.misc.Unsafe.park(Native Method)
[13:42:50] : [Step 3/4] at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:338)
[13:42:50] : [Step 3/4] at o.a.i.i.util.future.GridFutureAdapter.get0(GridFutureAdapter.java:217)
[13:42:50] : [Step 3/4] at o.a.i.i.util.future.GridFutureAdapter.get(GridFutureAdapter.java:159)
[13:42:50] : [Step 3/4] at o.a.i.i.processors.cache.distributed.dht.preloader.GridDhtPartitionsExchangeFuture.waitPartitionRelease(GridDhtPartitionsExchangeFuture.java:1367)
[13:42:50] : [Step 3/4] at o.a.i.i.processors.cache.distributed.dht.preloader.GridDhtPartitionsExchangeFuture.distributedExchange(GridDhtPartitionsExchangeFuture.java:1211)
[13:42:50] : [Step 3/4] at o.a.i.i.processors.cache.distributed.dht.preloader.GridDhtPartitionsExchangeFuture.init(GridDhtPartitionsExchangeFuture.java:752)
[13:42:50] : [Step 3/4] at o.a.i.i.processors.cache.GridCachePartitionExchangeManager$ExchangeWorker.body0(GridCachePartitionExchangeManager.java:2525)
[13:42:50] : [Step 3/4] at o.a.i.i.processors.cache.GridCachePartitionExchangeManager$ExchangeWorker.body(GridCachePartitionExchangeManager.java:2405)
[13:42:50] : [Step 3/4] at o.a.i.i.util.worker.GridWorker.run(GridWorker.java:110)
[13:42:50] : [Step 3/4] at java.lang.Thread.run(Thread.java:748)
{code}
At that moment there are lots of pending transactions and one pending TX finish future:
{code}
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,632][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Failed to wait for partition map exchange [topVer=AffinityTopologyVersion [topVer=37, minorTopVer=0], node=98909049-bca4-4cba-b659-768ccfe00000]. Dumping pending objects that might be the cause:
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,632][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Ready affinity version: AffinityTopologyVersion [topVer=36, minorTopVer=0]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,633][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Last exchange future: GridDhtPartitionsExchangeFuture [firstDiscoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode [id=387bab47-9542-4d98-8dda-03e3a3f00003, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47503], discPort=47503, order=4, intOrder=4, lastExchangeTime=1535366199108, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], topVer=37, nodeId8=98909049, msg=Node left: TcpDiscoveryNode [id=387bab47-9542-4d98-8dda-03e3a3f00003, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47503], discPort=47503, order=4, intOrder=4, lastExchangeTime=1535366199108, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], type=NODE_LEFT, tstamp=1535366275135], crd=TcpDiscoveryNode [id=98909049-bca4-4cba-b659-768ccfe00000, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47500], discPort=47500, order=1, intOrder=1, lastExchangeTime=1535366575460, loc=true, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], exchId=GridDhtPartitionExchangeId [topVer=AffinityTopologyVersion [topVer=37, minorTopVer=0], discoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode [id=387bab47-9542-4d98-8dda-03e3a3f00003, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47503], discPort=47503, order=4, intOrder=4, lastExchangeTime=1535366199108, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], topVer=37, nodeId8=98909049, msg=Node left: TcpDiscoveryNode [id=387bab47-9542-4d98-8dda-03e3a3f00003, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47503], discPort=47503, order=4, intOrder=4, lastExchangeTime=1535366199108, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], type=NODE_LEFT, tstamp=1535366275135], nodeId=387bab47, evt=NODE_LEFT], added=true, initFut=GridFutureAdapter [ignoreInterrupts=false, state=DONE, res=true, hash=277440323], init=true, lastVer=null, partReleaseFut=AffinityTopologyVersion [topVer=37, minorTopVer=0]AffinityTopologyVersion [topVer=37, minorTopVer=0]AffinityTopologyVersion [topVer=37, minorTopVer=0]AffinityTopologyVersion [topVer=37, minorTopVer=0]AffinityTopologyVersion [topVer=37, minorTopVer=0]AffinityTopologyVersion [topVer=37, minorTopVer=0]AffinityTopologyVersion [topVer=37, minorTopVer=0]PartitionReleaseFuture [topVer=, futures=[ExplicitLockReleaseFuture [topVer=, futures=[]], AtomicUpdateReleaseFuture [topVer=, futures=[]], DataStreamerReleaseFuture [topVer=, futures=[]], LocalTxReleaseFuture [topVer=, futures=[]], AllTxReleaseFuture [topVer=, futures=[RemoteTxReleaseFuture [topVer=, futures=[]]]]]], exchActions=null, affChangeMsg=null, initTs=1535366569559, centralizedAff=false, forceAffReassignment=false, exchangeLocE=null, cacheChangeFailureMsgSent=false, done=false, state=CRD, evtLatch=0, remaining=HashSet [], super=GridFutureAdapter [ignoreInterrupts=false, state=INIT, res=null, hash=1589453249]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,637][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][GridCachePartitionExchangeManager] First 10 pending exchange futures [total=6]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,637][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][GridCachePartitionExchangeManager] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=38, minorTopVer=0], evt=NODE_JOINED, evtNode=TcpDiscoveryNode [id=c8b524f5-0438-48bf-8111-2b7827a00001, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47501], discPort=47501, order=38, intOrder=20, lastExchangeTime=1535366570549, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=false]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,637][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][GridCachePartitionExchangeManager] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=39, minorTopVer=0], evt=NODE_FAILED, evtNode=TcpDiscoveryNode [id=c8b524f5-0438-48bf-8111-2b7827a00001, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47501], discPort=47501, order=38, intOrder=20, lastExchangeTime=1535366570549, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=false]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,638][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] First 5 pending affinity ready futures [total=1]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,638][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> AffinityReadyFuture [topVer=AffinityTopologyVersion [topVer=37, minorTopVer=0], super=GridFutureAdapter [ignoreInterrupts=false, state=INIT, res=null, hash=1631593566]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,639][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Last 10 exchange futures (total: 40):
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,639][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=39, minorTopVer=0], evt=NODE_FAILED, evtNode=TcpDiscoveryNode [id=c8b524f5-0438-48bf-8111-2b7827a00001, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47501], discPort=47501, order=38, intOrder=20, lastExchangeTime=1535366570549, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=false]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,640][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=38, minorTopVer=0], evt=NODE_JOINED, evtNode=TcpDiscoveryNode [id=c8b524f5-0438-48bf-8111-2b7827a00001, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47501], discPort=47501, order=38, intOrder=20, lastExchangeTime=1535366570549, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=false]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,640][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=37, minorTopVer=0], evt=NODE_LEFT, evtNode=TcpDiscoveryNode [id=387bab47-9542-4d98-8dda-03e3a3f00003, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47503], discPort=47503, order=4, intOrder=4, lastExchangeTime=1535366199108, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=false]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,641][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=36, minorTopVer=0], evt=NODE_LEFT, evtNode=TcpDiscoveryNode [id=566684ea-f0a5-4619-a0dd-387736700002, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47502], discPort=47502, order=3, intOrder=3, lastExchangeTime=1535366198998, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=true]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,641][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=35, minorTopVer=0], evt=NODE_LEFT, evtNode=TcpDiscoveryNode [id=849aa29d-5a6c-4228-b5fe-7a0f48b00001, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47501], discPort=47501, order=2, intOrder=2, lastExchangeTime=1535366198399, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=true]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,642][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=34, minorTopVer=0], evt=NODE_LEFT, evtNode=TcpDiscoveryNode [id=873ab0fc-6f7c-4fed-83d1-323f7df00004, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47504], discPort=47504, order=33, intOrder=19, lastExchangeTime=1535366271688, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=true]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,643][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=33, minorTopVer=0], evt=NODE_JOINED, evtNode=TcpDiscoveryNode [id=873ab0fc-6f7c-4fed-83d1-323f7df00004, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47504], discPort=47504, order=33, intOrder=19, lastExchangeTime=1535366271688, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=true]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,644][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=32, minorTopVer=0], evt=NODE_LEFT, evtNode=TcpDiscoveryNode [id=f0f235df-1ecc-47b0-860d-931e6ee00004, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47504], discPort=47504, order=31, intOrder=18, lastExchangeTime=1535366264541, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=true]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,644][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=31, minorTopVer=0], evt=NODE_JOINED, evtNode=TcpDiscoveryNode [id=f0f235df-1ecc-47b0-860d-931e6ee00004, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47504], discPort=47504, order=31, intOrder=18, lastExchangeTime=1535366264541, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=true]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,645][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=30, minorTopVer=0], evt=NODE_LEFT, evtNode=TcpDiscoveryNode [id=015abbfb-0294-4f02-a9ca-98c69ad00004, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47504], discPort=47504, order=29, intOrder=17, lastExchangeTime=1535366258731, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=true]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,646][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Latch manager state: ExchangeLatchManager [serverLatches=ConcurrentHashMap {}, clientLatches=ConcurrentHashMap {}]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,646][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Pending transactions:
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,646][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352062, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352062, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320091ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,648][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352059, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352059, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320091ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,649][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352001, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352001, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320091ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,651][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352006, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352006, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320101ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,652][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352013, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352013, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320101ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,654][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352046, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352046, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320101ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,655][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352044, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352044, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320101ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,657][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352040, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352040, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320101ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,659][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352049, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352049, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320101ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,660][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352055, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352055, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320111ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,662][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352052, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352052, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320111ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,664][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352048, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352048, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320111ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,666][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352030, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352030, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320111ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,667][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352026, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352026, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320111ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,669][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352009, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352009, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320111ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,671][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352020, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352020, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320121ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,672][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352016, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352016, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320121ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,674][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351870, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351870, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320121ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,676][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351866, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351866, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320121ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,685][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[1544803905], recovery=false, txMap=HashSet [IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2112141998, hash=-1383882701, key=2296], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2112141998, hash=-1383882701, key=2296], cacheId=1544803905], val=[op=CREATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1452435226, hash=289612481, val=34]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2112141998, hash=-1383882701, key=2296], val=null, ver=GridCacheVersion [topVer=0, order=0, nodeOrder=0], hash=-1383882701, extras=null, flags=0]GridDistributedCacheEntry [super=]GridDhtDetachedCacheEntry [super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=870737873, hash=1278628342, key=3064], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=870737873, hash=1278628342, key=3064], cacheId=1544803905], val=[op=UPDATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1325953753, hash=41378315, val=24]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=870737873, hash=1278628342, key=3064], val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1275092526, hash=537846647, val=44], ver=GridCacheVersion [topVer=146846232, order=1535366349082, nodeOrder=1], hash=1278628342, extras=null, flags=2]GridDistributedCacheEntry [super=]GridDhtCacheEntry [rdrs=ReaderId[] [], part=448, super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1298699088, hash=592648577, key=5977], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1298699088, hash=592648577, key=5977], cacheId=1544803905], val=[op=UPDATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1028279808, hash=-1016202477, val=16]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1298699088, hash=592648577, key=5977], val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1796045267, hash=-767968311, val=26], ver=GridCacheVersion [topVer=146846233, order=1535366352235, nodeOrder=3], hash=592648577, extras=null, flags=2]GridDistributedCacheEntry [super=]GridDhtCacheEntry [rdrs=ReaderId[] [], part=722, super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1855421848, hash=-2065441515, key=367], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1855421848, hash=-2065441515, key=367], cacheId=1544803905], val=[op=CREATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1811296785, hash=-2014310314, val=45]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1855421848, hash=-2065441515, key=367], val=null, ver=GridCacheVersion [topVer=0, order=0, nodeOrder=0], hash=-2065441515, extras=null, flags=0]GridDistributedCacheEntry [super=]GridDhtDetachedCacheEntry [super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2105907224, hash=-596640830, key=2699], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2105907224, hash=-596640830, key=2699], cacheId=1544803905], val=[op=CREATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1851917758, hash=-1577314937, val=28]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2105907224, hash=-596640830, key=2699], val=null, ver=GridCacheVersion [topVer=0, order=0, nodeOrder=0], hash=-596640830, extras=null, flags=0]GridDistributedCacheEntry [super=]GridDhtDetachedCacheEntry [super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=291286342, hash=-321630884, key=4343], cacheId=1544803905, txKey=Igni... and 2290 skipped ... cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1595422801, hash=961579171, key=6874], cacheId=1544803905], val=[op=UPDATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=392180266, hash=537846647, val=44]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1595422801, hash=961579171, key=6874], val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=882069171, hash=1411837401, val=10], ver=GridCacheVersion [topVer=146846232, order=1535366351443, nodeOrder=1], hash=961579171, extras=null, flags=2]GridDistributedCacheEntry [super=]GridDhtCacheEntry [rdrs=ReaderId[] [], part=499, super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]]]], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320121ms, onePhaseCommit=false], size=49]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,696][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351998, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351998, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320141ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,698][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351994, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351994, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320141ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,700][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351937, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351937, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320141ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,701][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351940, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351940, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320151ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,703][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351983, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351983, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320151ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,705][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351980, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351980, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320151ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,706][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351976, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351976, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320151ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,708][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351991, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351991, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320151ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,709][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351987, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351987, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320151ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,711][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351909, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351909, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320161ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,713][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351962, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351962, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320161ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,715][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351917, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351917, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320161ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,717][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351906, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351906, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320161ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,718][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351951, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351951, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320161ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,720][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351948, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351948, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320161ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,721][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351944, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351944, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320172ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,723][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351958, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351958, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320172ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,724][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351965, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351965, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320172ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,726][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351955, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351955, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320172ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,727][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351973, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351973, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320172ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,729][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351969, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351969, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320172ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,730][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352069, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352069, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320172ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,732][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352071, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352071, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320182ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,733][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352077, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352077, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320182ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,735][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352066, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352066, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320182ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,736][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352089, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352089, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320182ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,737][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352095, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352095, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320182ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,739][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352092, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352092, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320182ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,740][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352036, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352036, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320182ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,742][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352078, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352078, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320192ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,743][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352074, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352074, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320192ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,745][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352081, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352081, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320192ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,746][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352087, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352087, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320192ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,748][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352083, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352083, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320192ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,749][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351877, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351877, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320192ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,750][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351931, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351931, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320192ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,752][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351874, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351874, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320202ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,753][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351913, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351913, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320202ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,755][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351927, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351927, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320202ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,756][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351924, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351924, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320202ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,758][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351933, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351933, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320202ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,759][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351920, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351920, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320202ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,761][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351903, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351903, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320202ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,762][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351900, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351900, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320212ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,764][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351898, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351898, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320212ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,765][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352098, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352098, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320212ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,766][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351881, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351881, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320212ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,768][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351887, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351887, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320212ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,769][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351884, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351884, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320212ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,771][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351895, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351895, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320212ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,772][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351891, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351891, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320222ms, onePhaseCommit=false], size=0]]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,773][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Pending explicit locks:
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,774][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Pending cache futures:
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,781][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridNearTxFinishFuture [futId=346a3c78561-b787c4db-3317-4ef5-8ee9-ec1aa34d0bfc, tx=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320222ms, onePhaseCommit=false]IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[1544803905], recovery=false, txMap=HashSet [IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2112141998, hash=-1383882701, key=2296], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2112141998, hash=-1383882701, key=2296], cacheId=1544803905], val=[op=CREATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1452435226, hash=289612481, val=34]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2112141998, hash=-1383882701, key=2296], val=null, ver=GridCacheVersion [topVer=0, order=0, nodeOrder=0], hash=-1383882701, extras=null, flags=0]GridDistributedCacheEntry [super=]GridDhtDetachedCacheEntry [super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=870737873, hash=1278628342, key=3064], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=870737873, hash=1278628342, key=3064], cacheId=1544803905], val=[op=UPDATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1325953753, hash=41378315, val=24]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=870737873, hash=1278628342, key=3064], val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1275092526, hash=537846647, val=44], ver=GridCacheVersion [topVer=146846232, order=1535366349082, nodeOrder=1], hash=1278628342, extras=null, flags=2]GridDistributedCacheEntry [super=]GridDhtCacheEntry [rdrs=ReaderId[] [], part=448, super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1298699088, hash=592648577, key=5977], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1298699088, hash=592648577, key=5977], cacheId=1544803905], val=[op=UPDATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1028279808, hash=-1016202477, val=16]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1298699088, hash=592648577, key=5977], val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1796045267, hash=-767968311, val=26], ver=GridCacheVersion [topVer=146846233, order=1535366352235, nodeOrder=3], hash=592648577, extras=null, flags=2]GridDistributedCacheEntry [super=]GridDhtCacheEntry [rdrs=ReaderId[] [], part=722, super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1855421848, hash=-2065441515, key=367], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1855421848, hash=-2065441515, key=367], cacheId=1544803905], val=[op=CREATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1811296785, hash=-2014310314, val=45]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1855421848, hash=-2065441515, key=367], val=null, ver=GridCacheVersion [topVer=0, order=0, nodeOrder=0], hash=-2065441515, extras=null, flags=0]GridDistributedCacheEntry [super=]GridDhtDetachedCacheEntry [super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2105907224, hash=-596640830, key=2699], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2105907224, hash=-596640830, key=2699], cacheId=1544803905], val=[op=CREATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1851917758, hash=-1577314937, val=28]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2105907224, hash=-596640830, key=2699], val=null, ver=GridCacheVersion [topVer=0, order=0, nodeOrder=0], hash=-596640830, extras=null, flags=0]GridDistributedCacheEntry [super=]GridDhtDetachedCacheEntry [super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer... and 65162 skipped ...ache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1595422801, hash=961579171, key=6874], cacheId=1544803905], val=[op=UPDATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=392180266, hash=537846647, val=44]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1595422801, hash=961579171, key=6874], val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=882069171, hash=1411837401, val=10], ver=GridCacheVersion [topVer=146846232, order=1535366351443, nodeOrder=1], hash=961579171, extras=null, flags=2]GridDistributedCacheEntry [super=]GridDhtCacheEntry [rdrs=ReaderId[] [], part=499, super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]]]], super=, size=49]GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=]GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=], commit=true, mappings=IgniteTxMappingsImpl [], trackable=true, finishOnePhaseCalled=false, innerFuts=EmptyList [], super=GridCompoundIdentityFuture [super=GridCompoundFuture [rdc=AlwaysTrueReducer [], initFlag=0, lsnrCalls=0, done=false, cancelled=false, err=null, futs=EmptyList []]]]
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,791][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Pending atomic cache futures:
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,791][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Pending data streamer futures:
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,791][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Pending transaction deadlock detection futures:
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,791][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][GridAffinityAssignmentCache] First 3 pending affinity ready futures [grp=default, total=1, lastVer=AffinityTopologyVersion [topVer=36, minorTopVer=0]]:
[13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,791][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][GridAffinityAssignmentCache] >>> AffinityReadyFuture [reqTopVer=AffinityTopologyVersion [topVer=37, minorTopVer=0]]
{code}
> CacheAsyncOperationsFailoverTxTest hangs on TC
> ----------------------------------------------
>
> Key: IGNITE-9392
> URL: https://issues.apache.org/jira/browse/IGNITE-9392
> Project: Ignite
> Issue Type: Bug
> Reporter: Ilya Lantukh
> Assignee: Ilya Lantukh
> Priority: Major
>
> Exchange worker hangs while waiting for partition release:
> {code}
> [13:42:50] : [Step 3/4] Thread [name="exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%", id=245275, state=TIMED_WAITING, blockCnt=135, waitCnt=176]
> [13:42:50] : [Step 3/4] at sun.misc.Unsafe.park(Native Method)
> [13:42:50] : [Step 3/4] at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:338)
> [13:42:50] : [Step 3/4] at o.a.i.i.util.future.GridFutureAdapter.get0(GridFutureAdapter.java:217)
> [13:42:50] : [Step 3/4] at o.a.i.i.util.future.GridFutureAdapter.get(GridFutureAdapter.java:159)
> [13:42:50] : [Step 3/4] at o.a.i.i.processors.cache.distributed.dht.preloader.GridDhtPartitionsExchangeFuture.waitPartitionRelease(GridDhtPartitionsExchangeFuture.java:1367)
> [13:42:50] : [Step 3/4] at o.a.i.i.processors.cache.distributed.dht.preloader.GridDhtPartitionsExchangeFuture.distributedExchange(GridDhtPartitionsExchangeFuture.java:1211)
> [13:42:50] : [Step 3/4] at o.a.i.i.processors.cache.distributed.dht.preloader.GridDhtPartitionsExchangeFuture.init(GridDhtPartitionsExchangeFuture.java:752)
> [13:42:50] : [Step 3/4] at o.a.i.i.processors.cache.GridCachePartitionExchangeManager$ExchangeWorker.body0(GridCachePartitionExchangeManager.java:2525)
> [13:42:50] : [Step 3/4] at o.a.i.i.processors.cache.GridCachePartitionExchangeManager$ExchangeWorker.body(GridCachePartitionExchangeManager.java:2405)
> [13:42:50] : [Step 3/4] at o.a.i.i.util.worker.GridWorker.run(GridWorker.java:110)
> [13:42:50] : [Step 3/4] at java.lang.Thread.run(Thread.java:748)
> {code}
> At that moment there are lots of pending transactions and one pending TX finish future:
> {code}
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,632][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Failed to wait for partition map exchange [topVer=AffinityTopologyVersion [topVer=37, minorTopVer=0], node=98909049-bca4-4cba-b659-768ccfe00000]. Dumping pending objects that might be the cause:
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,632][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Ready affinity version: AffinityTopologyVersion [topVer=36, minorTopVer=0]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,633][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Last exchange future: GridDhtPartitionsExchangeFuture [firstDiscoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode [id=387bab47-9542-4d98-8dda-03e3a3f00003, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47503], discPort=47503, order=4, intOrder=4, lastExchangeTime=1535366199108, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], topVer=37, nodeId8=98909049, msg=Node left: TcpDiscoveryNode [id=387bab47-9542-4d98-8dda-03e3a3f00003, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47503], discPort=47503, order=4, intOrder=4, lastExchangeTime=1535366199108, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], type=NODE_LEFT, tstamp=1535366275135], crd=TcpDiscoveryNode [id=98909049-bca4-4cba-b659-768ccfe00000, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47500], discPort=47500, order=1, intOrder=1, lastExchangeTime=1535366575460, loc=true, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], exchId=GridDhtPartitionExchangeId [topVer=AffinityTopologyVersion [topVer=37, minorTopVer=0], discoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode [id=387bab47-9542-4d98-8dda-03e3a3f00003, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47503], discPort=47503, order=4, intOrder=4, lastExchangeTime=1535366199108, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], topVer=37, nodeId8=98909049, msg=Node left: TcpDiscoveryNode [id=387bab47-9542-4d98-8dda-03e3a3f00003, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47503], discPort=47503, order=4, intOrder=4, lastExchangeTime=1535366199108, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], type=NODE_LEFT, tstamp=1535366275135], nodeId=387bab47, evt=NODE_LEFT], added=true, initFut=GridFutureAdapter [ignoreInterrupts=false, state=DONE, res=true, hash=277440323], init=true, lastVer=null, partReleaseFut=AffinityTopologyVersion [topVer=37, minorTopVer=0]AffinityTopologyVersion [topVer=37, minorTopVer=0]AffinityTopologyVersion [topVer=37, minorTopVer=0]AffinityTopologyVersion [topVer=37, minorTopVer=0]AffinityTopologyVersion [topVer=37, minorTopVer=0]AffinityTopologyVersion [topVer=37, minorTopVer=0]AffinityTopologyVersion [topVer=37, minorTopVer=0]PartitionReleaseFuture [topVer=, futures=[ExplicitLockReleaseFuture [topVer=, futures=[]], AtomicUpdateReleaseFuture [topVer=, futures=[]], DataStreamerReleaseFuture [topVer=, futures=[]], LocalTxReleaseFuture [topVer=, futures=[]], AllTxReleaseFuture [topVer=, futures=[RemoteTxReleaseFuture [topVer=, futures=[]]]]]], exchActions=null, affChangeMsg=null, initTs=1535366569559, centralizedAff=false, forceAffReassignment=false, exchangeLocE=null, cacheChangeFailureMsgSent=false, done=false, state=CRD, evtLatch=0, remaining=HashSet [], super=GridFutureAdapter [ignoreInterrupts=false, state=INIT, res=null, hash=1589453249]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,637][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][GridCachePartitionExchangeManager] First 10 pending exchange futures [total=6]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,637][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][GridCachePartitionExchangeManager] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=38, minorTopVer=0], evt=NODE_JOINED, evtNode=TcpDiscoveryNode [id=c8b524f5-0438-48bf-8111-2b7827a00001, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47501], discPort=47501, order=38, intOrder=20, lastExchangeTime=1535366570549, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=false]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,637][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][GridCachePartitionExchangeManager] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=39, minorTopVer=0], evt=NODE_FAILED, evtNode=TcpDiscoveryNode [id=c8b524f5-0438-48bf-8111-2b7827a00001, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47501], discPort=47501, order=38, intOrder=20, lastExchangeTime=1535366570549, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=false]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,638][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] First 5 pending affinity ready futures [total=1]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,638][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> AffinityReadyFuture [topVer=AffinityTopologyVersion [topVer=37, minorTopVer=0], super=GridFutureAdapter [ignoreInterrupts=false, state=INIT, res=null, hash=1631593566]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,639][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Last 10 exchange futures (total: 40):
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,639][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=39, minorTopVer=0], evt=NODE_FAILED, evtNode=TcpDiscoveryNode [id=c8b524f5-0438-48bf-8111-2b7827a00001, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47501], discPort=47501, order=38, intOrder=20, lastExchangeTime=1535366570549, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=false]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,640][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=38, minorTopVer=0], evt=NODE_JOINED, evtNode=TcpDiscoveryNode [id=c8b524f5-0438-48bf-8111-2b7827a00001, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47501], discPort=47501, order=38, intOrder=20, lastExchangeTime=1535366570549, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=false]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,640][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=37, minorTopVer=0], evt=NODE_LEFT, evtNode=TcpDiscoveryNode [id=387bab47-9542-4d98-8dda-03e3a3f00003, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47503], discPort=47503, order=4, intOrder=4, lastExchangeTime=1535366199108, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=false]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,641][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=36, minorTopVer=0], evt=NODE_LEFT, evtNode=TcpDiscoveryNode [id=566684ea-f0a5-4619-a0dd-387736700002, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47502], discPort=47502, order=3, intOrder=3, lastExchangeTime=1535366198998, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=true]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,641][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=35, minorTopVer=0], evt=NODE_LEFT, evtNode=TcpDiscoveryNode [id=849aa29d-5a6c-4228-b5fe-7a0f48b00001, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47501], discPort=47501, order=2, intOrder=2, lastExchangeTime=1535366198399, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=true]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,642][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=34, minorTopVer=0], evt=NODE_LEFT, evtNode=TcpDiscoveryNode [id=873ab0fc-6f7c-4fed-83d1-323f7df00004, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47504], discPort=47504, order=33, intOrder=19, lastExchangeTime=1535366271688, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=true]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,643][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=33, minorTopVer=0], evt=NODE_JOINED, evtNode=TcpDiscoveryNode [id=873ab0fc-6f7c-4fed-83d1-323f7df00004, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47504], discPort=47504, order=33, intOrder=19, lastExchangeTime=1535366271688, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=true]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,644][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=32, minorTopVer=0], evt=NODE_LEFT, evtNode=TcpDiscoveryNode [id=f0f235df-1ecc-47b0-860d-931e6ee00004, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47504], discPort=47504, order=31, intOrder=18, lastExchangeTime=1535366264541, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=true]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,644][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=31, minorTopVer=0], evt=NODE_JOINED, evtNode=TcpDiscoveryNode [id=f0f235df-1ecc-47b0-860d-931e6ee00004, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47504], discPort=47504, order=31, intOrder=18, lastExchangeTime=1535366264541, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=true]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,645][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridDhtPartitionsExchangeFuture [topVer=AffinityTopologyVersion [topVer=30, minorTopVer=0], evt=NODE_LEFT, evtNode=TcpDiscoveryNode [id=015abbfb-0294-4f02-a9ca-98c69ad00004, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47504], discPort=47504, order=29, intOrder=17, lastExchangeTime=1535366258731, loc=false, ver=2.7.0#20180824-sha1:b0175cf6, isClient=false], done=true]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,646][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Latch manager state: ExchangeLatchManager [serverLatches=ConcurrentHashMap {}, clientLatches=ConcurrentHashMap {}]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,646][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Pending transactions:
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,646][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352062, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352062, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320091ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,648][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352059, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352059, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320091ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,649][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352001, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352001, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320091ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,651][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352006, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352006, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320101ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,652][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352013, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352013, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320101ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,654][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352046, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352046, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320101ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,655][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352044, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352044, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320101ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,657][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352040, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352040, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320101ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,659][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352049, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352049, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320101ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,660][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352055, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352055, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320111ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,662][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352052, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352052, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320111ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,664][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352048, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352048, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320111ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,666][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352030, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352030, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320111ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,667][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352026, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352026, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320111ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,669][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352009, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352009, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320111ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,671][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352020, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352020, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320121ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,672][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352016, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352016, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320121ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,674][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351870, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351870, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320121ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,676][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351866, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351866, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320121ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,685][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[1544803905], recovery=false, txMap=HashSet [IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2112141998, hash=-1383882701, key=2296], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2112141998, hash=-1383882701, key=2296], cacheId=1544803905], val=[op=CREATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1452435226, hash=289612481, val=34]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2112141998, hash=-1383882701, key=2296], val=null, ver=GridCacheVersion [topVer=0, order=0, nodeOrder=0], hash=-1383882701, extras=null, flags=0]GridDistributedCacheEntry [super=]GridDhtDetachedCacheEntry [super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=870737873, hash=1278628342, key=3064], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=870737873, hash=1278628342, key=3064], cacheId=1544803905], val=[op=UPDATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1325953753, hash=41378315, val=24]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=870737873, hash=1278628342, key=3064], val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1275092526, hash=537846647, val=44], ver=GridCacheVersion [topVer=146846232, order=1535366349082, nodeOrder=1], hash=1278628342, extras=null, flags=2]GridDistributedCacheEntry [super=]GridDhtCacheEntry [rdrs=ReaderId[] [], part=448, super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1298699088, hash=592648577, key=5977], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1298699088, hash=592648577, key=5977], cacheId=1544803905], val=[op=UPDATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1028279808, hash=-1016202477, val=16]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1298699088, hash=592648577, key=5977], val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1796045267, hash=-767968311, val=26], ver=GridCacheVersion [topVer=146846233, order=1535366352235, nodeOrder=3], hash=592648577, extras=null, flags=2]GridDistributedCacheEntry [super=]GridDhtCacheEntry [rdrs=ReaderId[] [], part=722, super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1855421848, hash=-2065441515, key=367], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1855421848, hash=-2065441515, key=367], cacheId=1544803905], val=[op=CREATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1811296785, hash=-2014310314, val=45]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1855421848, hash=-2065441515, key=367], val=null, ver=GridCacheVersion [topVer=0, order=0, nodeOrder=0], hash=-2065441515, extras=null, flags=0]GridDistributedCacheEntry [super=]GridDhtDetachedCacheEntry [super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2105907224, hash=-596640830, key=2699], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2105907224, hash=-596640830, key=2699], cacheId=1544803905], val=[op=CREATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1851917758, hash=-1577314937, val=28]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2105907224, hash=-596640830, key=2699], val=null, ver=GridCacheVersion [topVer=0, order=0, nodeOrder=0], hash=-596640830, extras=null, flags=0]GridDistributedCacheEntry [super=]GridDhtDetachedCacheEntry [super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=291286342, hash=-321630884, key=4343], cacheId=1544803905, txKey=Igni... and 2290 skipped ... cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1595422801, hash=961579171, key=6874], cacheId=1544803905], val=[op=UPDATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=392180266, hash=537846647, val=44]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1595422801, hash=961579171, key=6874], val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=882069171, hash=1411837401, val=10], ver=GridCacheVersion [topVer=146846232, order=1535366351443, nodeOrder=1], hash=961579171, extras=null, flags=2]GridDistributedCacheEntry [super=]GridDhtCacheEntry [rdrs=ReaderId[] [], part=499, super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]]]], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320121ms, onePhaseCommit=false], size=49]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,696][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351998, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351998, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320141ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,698][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351994, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351994, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320141ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,700][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351937, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351937, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320141ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,701][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351940, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351940, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320151ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,703][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351983, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351983, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320151ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,705][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351980, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351980, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320151ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,706][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351976, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351976, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320151ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,708][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351991, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351991, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320151ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,709][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351987, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351987, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320151ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,711][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351909, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351909, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320161ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,713][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351962, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351962, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320161ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,715][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351917, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351917, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320161ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,717][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351906, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351906, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320161ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,718][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351951, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351951, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320161ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,720][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351948, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351948, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320161ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,721][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351944, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351944, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320172ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,723][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351958, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351958, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320172ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,724][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351965, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351965, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320172ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,726][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351955, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351955, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320172ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,727][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351973, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351973, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320172ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,729][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351969, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351969, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320172ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,730][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352069, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352069, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320172ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,732][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352071, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352071, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320182ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,733][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352077, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352077, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320182ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,735][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352066, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352066, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320182ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,736][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352089, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352089, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320182ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,737][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352095, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352095, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320182ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,739][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352092, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352092, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320182ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,740][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352036, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352036, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320182ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,742][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352078, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352078, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320192ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,743][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352074, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352074, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320192ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,745][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352081, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352081, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320192ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,746][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352087, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352087, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320192ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,748][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352083, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352083, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320192ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,749][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351877, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351877, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320192ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,750][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351931, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351931, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320192ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,752][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351874, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351874, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320202ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,753][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351913, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351913, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320202ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,755][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351927, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351927, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320202ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,756][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351924, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351924, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320202ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,758][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351933, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351933, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320202ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,759][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351920, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351920, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320202ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,761][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351903, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351903, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320202ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,762][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351900, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351900, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320212ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,764][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351898, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351898, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320212ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,765][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366352098, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366352098, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320212ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,766][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351881, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351881, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320212ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,768][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351887, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351887, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320212ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,769][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351884, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351884, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320212ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,771][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351895, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351895, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320212ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,772][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> [txVer=null, exchWait=false, tx=GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[], recovery=null, txMap=EmptySet []], super=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351891, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351891, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320222ms, onePhaseCommit=false], size=0]]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,773][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Pending explicit locks:
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,774][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Pending cache futures:
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,781][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] >>> GridNearTxFinishFuture [futId=346a3c78561-b787c4db-3317-4ef5-8ee9-ec1aa34d0bfc, tx=IgniteTxAdapter [xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1], writeVer=null, implicit=true, loc=true, threadId=247549, startTime=1535366274549, nodeId=98909049-bca4-4cba-b659-768ccfe00000, startVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1], endVer=null, isolation=READ_COMMITTED, concurrency=OPTIMISTIC, timeout=0, sysInvalidate=false, sys=false, plc=2, commitVer=null, finalizing=NONE, invalidParts=null, state=ACTIVE, timedOut=false, topVer=AffinityTopologyVersion [topVer=-1, minorTopVer=0], duration=320222ms, onePhaseCommit=false]IgniteTxLocalAdapter [completedBase=null, sndTransformedVals=false, depEnabled=false, txState=IgniteTxStateImpl [activeCacheIds=[1544803905], recovery=false, txMap=HashSet [IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2112141998, hash=-1383882701, key=2296], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2112141998, hash=-1383882701, key=2296], cacheId=1544803905], val=[op=CREATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1452435226, hash=289612481, val=34]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2112141998, hash=-1383882701, key=2296], val=null, ver=GridCacheVersion [topVer=0, order=0, nodeOrder=0], hash=-1383882701, extras=null, flags=0]GridDistributedCacheEntry [super=]GridDhtDetachedCacheEntry [super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=870737873, hash=1278628342, key=3064], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=870737873, hash=1278628342, key=3064], cacheId=1544803905], val=[op=UPDATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1325953753, hash=41378315, val=24]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=870737873, hash=1278628342, key=3064], val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1275092526, hash=537846647, val=44], ver=GridCacheVersion [topVer=146846232, order=1535366349082, nodeOrder=1], hash=1278628342, extras=null, flags=2]GridDistributedCacheEntry [super=]GridDhtCacheEntry [rdrs=ReaderId[] [], part=448, super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1298699088, hash=592648577, key=5977], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1298699088, hash=592648577, key=5977], cacheId=1544803905], val=[op=UPDATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1028279808, hash=-1016202477, val=16]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1298699088, hash=592648577, key=5977], val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1796045267, hash=-767968311, val=26], ver=GridCacheVersion [topVer=146846233, order=1535366352235, nodeOrder=3], hash=592648577, extras=null, flags=2]GridDistributedCacheEntry [super=]GridDhtCacheEntry [rdrs=ReaderId[] [], part=722, super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1855421848, hash=-2065441515, key=367], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1855421848, hash=-2065441515, key=367], cacheId=1544803905], val=[op=CREATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1811296785, hash=-2014310314, val=45]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1855421848, hash=-2065441515, key=367], val=null, ver=GridCacheVersion [topVer=0, order=0, nodeOrder=0], hash=-2065441515, extras=null, flags=0]GridDistributedCacheEntry [super=]GridDhtDetachedCacheEntry [super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]], IgniteTxEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2105907224, hash=-596640830, key=2699], cacheId=1544803905, txKey=IgniteTxKey [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2105907224, hash=-596640830, key=2699], cacheId=1544803905], val=[op=CREATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=1851917758, hash=-1577314937, val=28]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=2105907224, hash=-596640830, key=2699], val=null, ver=GridCacheVersion [topVer=0, order=0, nodeOrder=0], hash=-596640830, extras=null, flags=0]GridDistributedCacheEntry [super=]GridDhtDetachedCacheEntry [super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer... and 65162 skipped ...ache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1595422801, hash=961579171, key=6874], cacheId=1544803905], val=[op=UPDATE, val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=392180266, hash=537846647, val=44]], prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null, filters=CacheEntryPredicate[] [], filtersPassed=false, filtersSet=true, entry=GridCacheMapEntry [key=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestKey [idHash=1595422801, hash=961579171, key=6874], val=o.a.i.i.processors.cache.distributed.CacheAsyncOperationsFailoverAbstractTest$TestValue [idHash=882069171, hash=1411837401, val=10], ver=GridCacheVersion [topVer=146846232, order=1535366351443, nodeOrder=1], hash=961579171, extras=null, flags=2]GridDistributedCacheEntry [super=]GridDhtCacheEntry [rdrs=ReaderId[] [], part=499, super=], prepared=0, locked=false, nodeId=null, locMapped=false, expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null, xidVer=GridCacheVersion [topVer=146846232, order=1535366351861, nodeOrder=1]]]], super=, size=49]GridDhtTxLocalAdapter [nearOnOriginatingNode=false, nearNodes=KeySetView [], dhtNodes=KeySetView [], explicitLock=false, super=]GridNearTxLocal [mappings=IgniteTxMappingsImpl [], nearLocallyMapped=false, colocatedLocallyMapped=false, needCheckBackup=null, hasRemoteLocks=false, trackTimeout=false, lb=null, thread=<failed to find active thread 247549>, mappings=IgniteTxMappingsImpl [], super=], commit=true, mappings=IgniteTxMappingsImpl [], trackable=true, finishOnePhaseCalled=false, innerFuts=EmptyList [], super=GridCompoundIdentityFuture [super=GridCompoundFuture [rdc=AlwaysTrueReducer [], initFlag=0, lsnrCalls=0, done=false, cancelled=false, err=null, futs=EmptyList []]]]
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,791][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Pending atomic cache futures:
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,791][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Pending data streamer futures:
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,791][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][diagnostic] Pending transaction deadlock detection futures:
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,791][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][GridAffinityAssignmentCache] First 3 pending affinity ready futures [grp=default, total=1, lastVer=AffinityTopologyVersion [topVer=36, minorTopVer=0]]:
> [13:43:14]W: [org.apache.ignite:ignite-core] [2018-08-27 10:43:14,791][WARN ][exchange-worker-#214881%distributed.CacheAsyncOperationsFailoverTxTest0%][GridAffinityAssignmentCache] >>> AffinityReadyFuture [reqTopVer=AffinityTopologyVersion [topVer=37, minorTopVer=0]]
> {code}
--
This message was sent by Atlassian JIRA
(v7.6.3#76005)