ignite-issues mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "Semen Boikov (JIRA)" <j...@apache.org>
Subject [jira] [Updated] (IGNITE-1905) High contention for CacheLockImpl causes AssertionErrors
Date Mon, 11 Jan 2016 10:46:39 GMT

     [ https://issues.apache.org/jira/browse/IGNITE-1905?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]

Semen Boikov updated IGNITE-1905:
---------------------------------
    Fix Version/s:     (was: 1.6)

> High contention for CacheLockImpl causes AssertionErrors
> --------------------------------------------------------
>
>                 Key: IGNITE-1905
>                 URL: https://issues.apache.org/jira/browse/IGNITE-1905
>             Project: Ignite
>          Issue Type: Bug
>          Components: cache
>    Affects Versions: ignite-1.4
>         Environment: Windows 7
>            Reporter: Denis Magda
>            Assignee: Semen Boikov
>            Priority: Critical
>         Attachments: ClientTest.java, ServerTest.java
>
>
> When multiple threads, running on the same client node, compete for CacheLockImpl this
leads to AssertionErrors.
> Pseudo-code snippet, that is called from multiple threads and causes the assertions,
looks like this:
> {noformat}
> boolean locked = lock.tryLock(100, TimeUnit.MILLISECONDS);
> if (locked)
>     lock.unlock();
> {noformat}
> Initially the issue was detected on ignite-1.4.
> In server's node logs the following assertion appears
> {noformat}
> java.lang.AssertionError
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtLockFuture.addOwned(GridDhtLockFuture.java:958)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtLockFuture.map(GridDhtLockFuture.java:918)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtLockFuture.onOwnerChanged(GridDhtLockFuture.java:663)
> 	at org.apache.ignite.internal.processors.cache.GridCacheMvccManager$2.onOwnerChanged(GridCacheMvccManager.java:155)
> 	at org.apache.ignite.internal.processors.cache.distributed.GridDistributedCacheEntry.checkOwnerChanged(GridDistributedCacheEntry.java:810)
> 	at org.apache.ignite.internal.processors.cache.distributed.GridDistributedCacheEntry.readyLock(GridDistributedCacheEntry.java:516)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtLockFuture.readyLocks(GridDhtLockFuture.java:576)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtLockFuture.map(GridDhtLockFuture.java:764)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTransactionalCacheAdapter.lockAllAsync(GridDhtTransactionalCacheAdapter.java:973)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTransactionalCacheAdapter.processNearLockRequest(GridDhtTransactionalCacheAdapter.java:557)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTransactionalCacheAdapter.access$000(GridDhtTransactionalCacheAdapter.java:88)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTransactionalCacheAdapter$2.apply(GridDhtTransactionalCacheAdapter.java:132)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTransactionalCacheAdapter$2.apply(GridDhtTransactionalCacheAdapter.java:130)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager.processMessage(GridCacheIoManager.java:580)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager.onMessage0(GridCacheIoManager.java:280)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager.handleMessage(GridCacheIoManager.java:198)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager.access$000(GridCacheIoManager.java:77)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager$1.onMessage(GridCacheIoManager.java:160)
> 	at org.apache.ignite.internal.managers.communication.GridIoManager.processRegularMessage0(GridIoManager.java:811)
> 	at org.apache.ignite.internal.managers.communication.GridIoManager.access$1500(GridIoManager.java:106)
> 	at org.apache.ignite.internal.managers.communication.GridIoManager$5.run(GridIoManager.java:774)
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> 	at java.lang.Thread.run(Thread.java:745)
> {noformat}
>                       
> In addition from time to time a client node also outputs a different kind of assertion:
> {noformat}
> Exception in thread "ignite-#4%sys-null%" java.lang.AssertionError
> 	at org.apache.ignite.internal.processors.cache.GridCacheExplicitLockSpan.markOwned(GridCacheExplicitLockSpan.java:196)
> 	at org.apache.ignite.internal.processors.cache.GridCacheMvccManager.markExplicitOwner(GridCacheMvccManager.java:862)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.colocated.GridDhtColocatedLockFuture$MiniFuture.onResult(GridDhtColocatedLockFuture.java:1412)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.colocated.GridDhtColocatedLockFuture.onResult(GridDhtColocatedLockFuture.java:437)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.colocated.GridDhtColocatedCache.processLockResponse(GridDhtColocatedCache.java:888)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.colocated.GridDhtColocatedCache.access$100(GridDhtColocatedCache.java:80)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.colocated.GridDhtColocatedCache$3.apply(GridDhtColocatedCache.java:145)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.colocated.GridDhtColocatedCache$3.apply(GridDhtColocatedCache.java:143)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager.processMessage(GridCacheIoManager.java:580)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager.onMessage0(GridCacheIoManager.java:280)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager.handleMessage(GridCacheIoManager.java:198)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager.access$000(GridCacheIoManager.java:77)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager$1.onMessage(GridCacheIoManager.java:160)
> 	at org.apache.ignite.internal.managers.communication.GridIoManager.processRegularMessage0(GridIoManager.java:811)
> 	at org.apache.ignite.internal.managers.communication.GridIoManager.access$1500(GridIoManager.java:106)
> 	at org.apache.ignite.internal.managers.communication.GridIoManager$5.run(GridIoManager.java:774)
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> 	at java.lang.Thread.run(Thread.java:745)
> {noformat}
> Ran the test against ignite-1.5 and got a different kind of assertions on the server
node:
> {noformat}
> Exception in thread "ignite-#246%sys-null%" java.lang.AssertionError: Entry does not
own lock for tx [locNodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3, entry=GridDhtColocatedCacheEntry
[super=GridDhtCacheEntry [rdrs=[], locPart=GridDhtLocalPartition [id=49, mapPubSize=5, rmvQueue=GridCircularBuffer
[sizeMask=511, idxGen=0], state=OWNING, reservations=0, empty=false, createTime=11/13/2015
15:08:42, mapPubSize=5], super=GridDistributedCacheEntry [super=GridCacheMapEntry [key=KeyCacheObjectImpl
[val=1, hasValBytes=true], val=CacheObjectImpl [val=null, hasValBytes=true], startVer=1447412910273,
ver=GridCacheVersion [topVer=58892922, nodeOrderDrId=1, globalTime=0, order=0], hash=-320443512,
extras=GridCacheMvccEntryExtras [mvcc=GridCacheMvcc [locs=[GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968535, order=1447412964154],
timeout=100, ts=1447412968537, threadId=101, id=2245, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968535, order=1447412964154], mappedDhtNodes=[TcpDiscoveryNode
[id=ce646644-b983-4d81-ba40-c39a057b4cc5, addrs=[0:0:0:0:0:0:0:1, 10.0.0.18, 127.0.0.1], sockAddrs=[/10.0.0.18:47501,
/0:0:0:0:0:0:0:1:47501, /10.0.0.18:47501, /127.0.0.1:47501], discPort=47501, order=2, intOrder=2,
lastExchangeTime=1447412934615, loc=false, ver=1.5.0#19700101-sha1:00000000, isClient=false]],
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968452,
order=1447412964076], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=1|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968537, order=1447412964156],
timeout=100, ts=1447412968547, threadId=99, id=2246, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968537, order=1447412964156], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968454,
order=1447412964078], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968539, order=1447412964158],
timeout=100, ts=1447412968547, threadId=75, id=2247, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968539, order=1447412964158], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968456,
order=1447412964080], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968541, order=1447412964160],
timeout=100, ts=1447412968547, threadId=83, id=2248, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968541, order=1447412964160], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968458,
order=1447412964082], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968543, order=1447412964162],
timeout=100, ts=1447412968547, threadId=86, id=2249, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968543, order=1447412964162], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968461,
order=1447412964084], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968545, order=1447412964164],
timeout=100, ts=1447412968557, threadId=69, id=2250, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968545, order=1447412964164], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968463,
order=1447412964086], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968547, order=1447412964166],
timeout=100, ts=1447412968557, threadId=95, id=2251, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968547, order=1447412964166], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968465,
order=1447412964088], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968550, order=1447412964168],
timeout=100, ts=1447412968557, threadId=102, id=2252, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968550, order=1447412964168], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968467,
order=1447412964090], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968552, order=1447412964170],
timeout=100, ts=1447412968557, threadId=67, id=2253, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968552, order=1447412964170], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968470,
order=1447412964092], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968554, order=1447412964172],
timeout=100, ts=1447412968557, threadId=78, id=2254, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968554, order=1447412964172], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968472,
order=1447412964094], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968556, order=1447412964174],
timeout=100, ts=1447412968567, threadId=70, id=2255, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968556, order=1447412964174], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968474,
order=1447412964096], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968559, order=1447412964176],
timeout=100, ts=1447412968567, threadId=79, id=2256, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968559, order=1447412964176], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968476,
order=1447412964098], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968561, order=1447412964178],
timeout=100, ts=1447412968567, threadId=103, id=2257, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968561, order=1447412964178], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968479,
order=1447412964100], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968563, order=1447412964180],
timeout=100, ts=1447412968567, threadId=90, id=2258, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968563, order=1447412964180], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968481,
order=1447412964102], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968566, order=1447412964182],
timeout=100, ts=1447412968577, threadId=66, id=2259, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968566, order=1447412964182], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968483,
order=1447412964104], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968568, order=1447412964184],
timeout=100, ts=1447412968577, threadId=82, id=2260, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968568, order=1447412964184], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968485,
order=1447412964106], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968570, order=1447412964186],
timeout=100, ts=1447412968577, threadId=91, id=2261, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968570, order=1447412964186], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968487,
order=1447412964108], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968584, order=1447412964188],
timeout=100, ts=1447412968597, threadId=94, id=2262, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968584, order=1447412964188], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968494,
order=1447412964114], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968585, order=1447412964189],
timeout=100, ts=1447412968597, threadId=68, id=2263, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968585, order=1447412964189], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968494,
order=1447412964114], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968586, order=1447412964192],
timeout=100, ts=1447412968597, threadId=84, id=2264, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968586, order=1447412964192], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968494,
order=1447412964114], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968591, order=1447412964194],
timeout=100, ts=1447412968597, threadId=85, id=2265, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968591, order=1447412964194], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968497,
order=1447412964116], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968593, order=1447412964196],
timeout=100, ts=1447412968597, threadId=104, id=2266, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968593, order=1447412964196], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968499,
order=1447412964118], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968595, order=1447412964198],
timeout=100, ts=1447412968597, threadId=92, id=2267, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968595, order=1447412964198], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968502,
order=1447412964120], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968596, order=1447412964200],
timeout=100, ts=1447412968607, threadId=88, id=2268, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968596, order=1447412964200], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968504,
order=1447412964122], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968601, order=1447412964202],
timeout=100, ts=1447412968607, threadId=98, id=2269, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968601, order=1447412964202], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968506,
order=1447412964124], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968603, order=1447412964204],
timeout=100, ts=1447412968607, threadId=72, id=2270, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968603, order=1447412964204], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968508,
order=1447412964126], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968605, order=1447412964206],
timeout=100, ts=1447412968617, threadId=96, id=2271, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968605, order=1447412964206], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968510,
order=1447412964128], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968606, order=1447412964208],
timeout=100, ts=1447412968617, threadId=80, id=2272, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968606, order=1447412964208], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968514,
order=1447412964132], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968606, order=1447412964210],
timeout=100, ts=1447412968617, threadId=81, id=2273, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968606, order=1447412964210], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968514,
order=1447412964132], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968610, order=1447412964212],
timeout=100, ts=1447412968617, threadId=97, id=2274, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968610, order=1447412964212], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968516,
order=1447412964134], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968612, order=1447412964214],
timeout=100, ts=1447412968617, threadId=65, id=2275, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968612, order=1447412964214], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968518,
order=1447412964136], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968614, order=1447412964216],
timeout=100, ts=1447412968617, threadId=89, id=2276, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968614, order=1447412964216], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968520,
order=1447412964138], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968616, order=1447412964218],
timeout=100, ts=1447412968627, threadId=73, id=2277, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968616, order=1447412964218], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968525,
order=1447412964144], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968616, order=1447412964220],
timeout=100, ts=1447412968627, threadId=74, id=2278, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968616, order=1447412964220], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968525,
order=1447412964144], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968616, order=1447412964222],
timeout=100, ts=1447412968627, threadId=71, id=2279, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968616, order=1447412964222], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968525,
order=1447412964144], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968621, order=1447412964224],
timeout=100, ts=1447412968627, threadId=87, id=2280, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968621, order=1447412964224], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968527,
order=1447412964146], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null], GridCacheMvccCandidate [nodeId=8f8c5147-2d8f-44e6-8da8-ef8a5bae1fd3,
ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968624, order=1447412964226],
timeout=100, ts=1447412968627, threadId=76, id=2281, topVer=AffinityTopologyVersion [topVer=3,
minorTopVer=0], reentry=null, otherNodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, otherVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968624, order=1447412964226], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968529,
order=1447412964148], serOrder=null, key=KeyCacheObjectImpl [val=1, hasValBytes=true], masks=local=1|owner=0|ready=1|reentry=0|used=0|tx=0|single_implicit=0|dht_local=1|near_local=0|removed=0,
prevVer=null, nextVer=null]], rmts=null]], flags=0]]]], mappedVer=GridCacheVersion [topVer=58892924,
nodeOrderDrId=3, globalTime=1447412968533, order=1447412964152], ver=GridCacheVersion [topVer=58892922,
nodeOrderDrId=1, globalTime=0, order=0], tx=null, req=GridNearLockRequest [topVer=AffinityTopologyVersion
[topVer=3, minorTopVer=0], miniId=6b229800151-652e9fe6-66fa-4415-aeb1-1ec44adaf8d2, implicitTx=false,
implicitSingleTx=false, onePhaseCommit=false, dhtVers=[null], subjId=null, taskNameHash=0,
hasTransforms=false, syncCommit=false, accessTtl=-1, retVal=true, firstClientReq=true, filter=null,
super=GridDistributedLockRequest [nodeId=f35fe3b2-93e7-4da5-8c59-94325ccd971b, nearXidVer=GridCacheVersion
[topVer=58892924, nodeOrderDrId=3, globalTime=1447412968533, order=1447412964152], threadId=77,
futId=4b229800151-652e9fe6-66fa-4415-aeb1-1ec44adaf8d2, timeout=100, isInTx=false, isInvalidate=false,
isRead=false, isolation=null, retVals=[true], txSize=1, flags=0, keysCnt=1, super=GridDistributedBaseMessage
[ver=GridCacheVersion [topVer=58892924, nodeOrderDrId=3, globalTime=1447412968533, order=1447412964152],
candsByIdx=null, committedVers=null, rolledbackVers=null, cnt=0, super=GridCacheMessage [msgId=4463,
depInfo=null, err=null, skipPrepare=false]]]], err=null]
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTransactionalCacheAdapter.createLockReply(GridDhtTransactionalCacheAdapter.java:1132)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTransactionalCacheAdapter.access$400(GridDhtTransactionalCacheAdapter.java:88)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTransactionalCacheAdapter$10.apply(GridDhtTransactionalCacheAdapter.java:986)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTransactionalCacheAdapter$10.apply(GridDhtTransactionalCacheAdapter.java:979)
> 	at org.apache.ignite.internal.util.future.GridEmbeddedFuture$1.applyx(GridEmbeddedFuture.java:59)
> 	at org.apache.ignite.internal.util.future.GridEmbeddedFuture$AsyncListener1.apply(GridEmbeddedFuture.java:297)
> 	at org.apache.ignite.internal.util.future.GridEmbeddedFuture$AsyncListener1.apply(GridEmbeddedFuture.java:290)
> 	at org.apache.ignite.internal.util.future.GridFutureAdapter.notifyListener(GridFutureAdapter.java:262)
> 	at org.apache.ignite.internal.util.future.GridFutureAdapter.notifyListeners(GridFutureAdapter.java:250)
> 	at org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:380)
> 	at org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:346)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtLockFuture.onComplete(GridDhtLockFuture.java:733)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtLockFuture.onDone(GridDhtLockFuture.java:711)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtLockFuture.onDone(GridDhtLockFuture.java:80)
> 	at org.apache.ignite.internal.util.future.GridFutureAdapter.onDone(GridFutureAdapter.java:323)
> 	at org.apache.ignite.internal.util.future.GridCompoundFuture.checkComplete(GridCompoundFuture.java:285)
> 	at org.apache.ignite.internal.util.future.GridCompoundFuture.markInitialized(GridCompoundFuture.java:276)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtLockFuture.map(GridDhtLockFuture.java:943)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtLockFuture.onOwnerChanged(GridDhtLockFuture.java:666)
> 	at org.apache.ignite.internal.processors.cache.GridCacheMvccManager$2.onOwnerChanged(GridCacheMvccManager.java:156)
> 	at org.apache.ignite.internal.processors.cache.distributed.GridDistributedCacheEntry.checkOwnerChanged(GridDistributedCacheEntry.java:814)
> 	at org.apache.ignite.internal.processors.cache.distributed.GridDistributedCacheEntry.removeLock(GridDistributedCacheEntry.java:448)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtCacheEntry.removeLock(GridDhtCacheEntry.java:319)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTransactionalCacheAdapter.removeLocks(GridDhtTransactionalCacheAdapter.java:1486)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTransactionalCacheAdapter.processNearUnlockRequest(GridDhtTransactionalCacheAdapter.java:1336)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTransactionalCacheAdapter.access$200(GridDhtTransactionalCacheAdapter.java:88)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTransactionalCacheAdapter$5.apply(GridDhtTransactionalCacheAdapter.java:150)
> 	at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTransactionalCacheAdapter$5.apply(GridDhtTransactionalCacheAdapter.java:148)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager.processMessage(GridCacheIoManager.java:540)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager.onMessage0(GridCacheIoManager.java:273)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager.handleMessage(GridCacheIoManager.java:197)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager.access$000(GridCacheIoManager.java:76)
> 	at org.apache.ignite.internal.processors.cache.GridCacheIoManager$1.onMessage(GridCacheIoManager.java:159)
> 	at org.apache.ignite.internal.managers.communication.GridIoManager.processRegularMessage0(GridIoManager.java:811)
> 	at org.apache.ignite.internal.managers.communication.GridIoManager.access$1500(GridIoManager.java:106)
> 	at org.apache.ignite.internal.managers.communication.GridIoManager$5.run(GridIoManager.java:774)
> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> 	at java.lang.Thread.run(Thread.java:745)
> {noformat}
> To reproduce run attached sources in the following order:
> - Start two server nodes (ServerTest.java);
> - Start a client node (ClientTest.java).
> If the issue is not reproduced on your machine try to adjust {{lock.tryLock}} timeout
value.



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

Mime
View raw message