INFO 2017-06-13 20:36:22 [localhost-startStop-1]
org.apache.ignite.internal.IgniteKernal%svip - [[OS: Linux
4.1.12-61.1.18.el7uek.x86_64 amd64]]
INFO 2017-06-13 20:36:22 [localhost-startStop-1]
org.apache.ignite.internal.IgniteKernal%svip - [[PID: 7608]]
[20:36:22] VM information: Java(TM) SE Runtime Environment 1.8.0_102-b14
Oracle Corporation Java HotSpot(TM) 64-Bit Server VM 25.102-b14
INFO 2017-06-13 20:36:22 [localhost-startStop-1]
org.apache.ignite.internal.IgniteKernal%svip - [[Language runtime: Java
Platform API Specification ver. 1.8]]
INFO 2017-06-13 20:36:22 [localhost-startStop-1]
org.apache.ignite.internal.IgniteKernal%svip - [[VM information: Java(TM) SE
Runtime Environment 1.8.0_102-b14 Oracle Corporation Java HotSpot(TM) 64-Bit
Server VM 25.102-b14]]
INFO 2017-06-13 20:36:22 [localhost-startStop-1]
org.apache.ignite.internal.IgniteKernal%svip - [[VM total memory: 2.1GB]]
INFO 2017-06-13 20:36:22 [localhost-startStop-1]
org.apache.ignite.internal.IgniteKernal%svip - [[Remote Management [restart:
off, REST: on, JMX (remote: off)]]]
INFO 2017-06-13 20:36:22 [localhost-startStop-1]
org.apache.ignite.internal.IgniteKernal%svip - [[System cache's MemoryPolicy
size is configured to 40 MB. Use MemoryConfiguration.systemCacheMemorySize
property to change the setting.]]
INFO 2017-06-13 20:36:22 [localhost-startStop-1]
org.apache.ignite.internal.IgniteKernal%svip - [[Configured caches [in
'default' memoryPolicy: ['ignite-sys-cache', 'ignite-atomics-sys-cache']]]]
INFO 2017-06-13 20:36:22 [localhost-startStop-1]
org.apache.ignite.internal.IgniteKernal%svip - [[Local node user attribute
[IgSupport_LogicClusterGroups=com.bpcbt.common.support.ignite.beans.IgLogicClusterGroups@0]]]
WARN 2017-06-13 20:36:22 [pub-#14%svip%]
org.apache.ignite.internal.GridDiagnostic - [[Initial heap size is 154MB
(should be no less than 512MB, use -Xms512m -Xmx512m).]]
[20:36:22] Initial heap size is 154MB (should be no less than 512MB, use
-Xms512m -Xmx512m).
[20:36:23] Configured plugins:
INFO 2017-06-13 20:36:23 [localhost-startStop-1]
org.apache.ignite.internal.processors.plugin.IgnitePluginProcessor -
[[Configured plugins:]]
[20:36:23] ^-- None
INFO 2017-06-13 20:36:23 [localhost-startStop-1]
org.apache.ignite.internal.processors.plugin.IgnitePluginProcessor - [[ ^--
None]]
[20:36:23]
INFO 2017-06-13 20:36:23 [localhost-startStop-1]
org.apache.ignite.internal.processors.plugin.IgnitePluginProcessor - [[]]
INFO 2017-06-13 20:36:23 [localhost-startStop-1]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[Successfully
bound communication NIO server to TCP port [port=9343, locHost=/127.0.0.1,
selectorsCnt=4, selectorSpins=0, pairedConn=false]]]
WARN 2017-06-13 20:36:23 [localhost-startStop-1]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[Message
queue limit is set to 0 which may lead to potential OOMEs when running cache
operations in FULL_ASYNC or PRIMARY_SYNC modes due to message queues growth
on sender and receiver sides.]]
[20:36:23] Message queue limit is set to 0 which may lead to potential OOMEs
when running cache operations in FULL_ASYNC or PRIMARY_SYNC modes due to
message queues growth on sender and receiver sides.
WARN 2017-06-13 20:36:23 [localhost-startStop-1]
org.apache.ignite.spi.checkpoint.noop.NoopCheckpointSpi - [[Checkpoints are
disabled (to enable configure any GridCheckpointSpi implementation)]]
WARN 2017-06-13 20:36:23 [localhost-startStop-1]
org.apache.ignite.internal.managers.collision.GridCollisionManager -
[[Collision resolution is disabled (all jobs will be activated upon
arrival).]]
[20:36:23] Security status [authentication=off, tls/ssl=off]
INFO 2017-06-13 20:36:23 [localhost-startStop-1]
org.apache.ignite.internal.IgniteKernal%svip - [[Security status
[authentication=off, tls/ssl=off]]]
INFO 2017-06-13 20:36:23 [localhost-startStop-1]
org.apache.ignite.internal.processors.rest.protocols.tcp.GridTcpRestProtocol
- [[Command protocol successfully started [name=TCP binary,
host=0.0.0.0/0.0.0.0, port=11214]]]
INFO 2017-06-13 20:36:23 [localhost-startStop-1]
org.apache.ignite.internal.IgniteKernal%svip - [[Non-loopback local IPs:
192.168.122.1, 192.168.209.65]]
INFO 2017-06-13 20:36:23 [localhost-startStop-1]
org.apache.ignite.internal.IgniteKernal%svip - [[Enabled local MACs:
0021F6321229, 5254000A6937]]
INFO 2017-06-13 20:36:23 [localhost-startStop-1]
org.apache.ignite.spi.discovery.tcp.TcpDiscoverySpi - [[Successfully bound
to TCP port [port=9463, localHost=/127.0.0.1,
locNodeId=7fc5ea30-913d-4ff5-932b-62d81c6027db]]]
INFO 2017-06-13 20:36:24 [localhost-startStop-1]
org.apache.ignite.internal.processors.cache.GridCacheProcessor - [[Started
cache [name=ignite-sys-cache, memoryPolicyName=sysMemPlc, mode=REPLICATED]]]
INFO 2017-06-13 20:36:24 [localhost-startStop-1]
org.apache.ignite.internal.processors.cache.GridCacheProcessor - [[Started
cache [name=ignite-atomics-sys-cache, memoryPolicyName=sysMemPlc,
mode=REPLICATED]]]
INFO 2017-06-13 20:36:24 [grid-nio-worker-tcp-comm-0-#17%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[Established
outgoing communication connection [locAddr=/127.0.0.1:47331,
rmtAddr=/127.0.0.1:9340]]]
WARN 2017-06-13 20:36:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Failed to wait for partition map exchange
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0],
node=7fc5ea30-913d-4ff5-932b-62d81c6027db]. Dumping pending objects that
might be the cause: ]]
WARN 2017-06-13 20:36:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Ready affinity version: AffinityTopologyVersion [topVer=-1,
minorTopVer=0]]]
WARN 2017-06-13 20:36:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last exchange future: GridDhtPartitionsExchangeFuture [dummy=false,
forcePreload=false, reassign=false, discoEvt=DiscoveryEvent
[evtNode=TcpDiscoveryNode [id=7fc5ea30-913d-4ff5-932b-62d81c6027db,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62,
intOrder=33, lastExchangeTime=1497353794662, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], topVer=62,
nodeId8=7fc5ea30, msg=null, type=NODE_JOINED, tstamp=1497353784308],
crd=TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false],
exchId=GridDhtPartitionExchangeId [topVer=AffinityTopologyVersion
[topVer=62, minorTopVer=0], nodeId=7fc5ea30, evt=NODE_JOINED], added=false,
initFut=GridFutureAdapter [ignoreInterrupts=false, state=DONE, res=true,
hash=1130708319], init=true, lastVer=null, partReleaseFut=GridCompoundFuture
[rdc=null, initFlag=1, lsnrCalls=4, done=true, cancelled=false, err=null,
futs=[true, true, true, true]], affChangeMsg=null, skipPreload=false,
clientOnlyExchange=false, initTs=1497353784601, centralizedAff=false,
changeGlobalStateE=null, exchangeOnChangeGlobalState=false,
forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353794662, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:36:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending exchange futures:]]
WARN 2017-06-13 20:36:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last 10 exchange futures (total: 1):]]
WARN 2017-06-13 20:36:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[>>> GridDhtPartitionsExchangeFuture [dummy=false, forcePreload=false,
reassign=false, discoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353794662, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], topVer=62, nodeId8=7fc5ea30, msg=null, type=NODE_JOINED,
tstamp=1497353784308], crd=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], exchId=GridDhtPartitionExchangeId
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0], nodeId=7fc5ea30,
evt=NODE_JOINED], added=false, initFut=GridFutureAdapter
[ignoreInterrupts=false, state=DONE, res=true, hash=1130708319], init=true,
lastVer=null, partReleaseFut=GridCompoundFuture [rdc=null, initFlag=1,
lsnrCalls=4, done=true, cancelled=false, err=null, futs=[true, true, true,
true]], affChangeMsg=null, skipPreload=false, clientOnlyExchange=false,
initTs=1497353784601, centralizedAff=false, changeGlobalStateE=null,
exchangeOnChangeGlobalState=false, forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353794662, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:36:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transactions:]]
WARN 2017-06-13 20:36:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending explicit locks:]]
WARN 2017-06-13 20:36:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending cache futures:]]
WARN 2017-06-13 20:36:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending atomic cache futures:]]
WARN 2017-06-13 20:36:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending data streamer futures:]]
WARN 2017-06-13 20:36:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transaction deadlock detection futures:]]
WARN 2017-06-13 20:36:34 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi -
[[Communication SPI recovery descriptors:
[key=ConnectionKey [nodeId=f03fe6d2-8858-4b32-9ac2-260d1a79693a, idx=0,
connCnt=-1], msgsSent=3, msgsAckedByRmt=3, msgsRcvd=2, lastAcked=0,
reserveCnt=1, descIdHash=2015302722]
Communication SPI clients:
[node=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
client=GridTcpNioCommunicationClient [ses=GridSelectorNioSessionImpl
[worker=DirectNioClientWorker [super=AbstractNioClientWorker
[selector=sun.nio.ch.EPollSelectorImpl@3e96a835, idx=0, bytesRcvd=45363,
bytesSent=1305, bytesRcvd0=0, bytesSent0=0, select=true, super=GridWorker
[name=grid-nio-worker-tcp-comm-0, igniteInstanceName=svip, finished=false,
hashCode=518525437, interrupted=false,
runner=grid-nio-worker-tcp-comm-0-#17%svip%]]],
writeBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
readBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
inRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=0, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false],
outRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=0, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false], super=GridNioSessionImpl
[locAddr=/127.0.0.1:47331, rmtAddr=/127.0.0.1:9340,
createTime=1497353784631, closeTime=0, bytesSent=1305, bytesRcvd=45363,
bytesSent0=0, bytesRcvd0=0, sndSchedTime=1497353784631,
lastSndTime=1497353784897, lastRcvTime=1497353787145, readsPaused=false,
filterChain=FilterChain[filters=[GridNioCodecFilter
[parser=o.a.i.i.util.nio.GridDirectParser@5e7030df, directMode=true],
GridConnectionBytesVerifyFilter], accepted=false]],
super=GridAbstractCommunicationClient [lastUsed=1497353784642, closed=false,
connIdx=0]]]
]]
WARN 2017-06-13 20:36:34 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[NIO server
statistics [readerSesBalanceCnt=0, writerSesBalanceCnt=0]]]
WARN 2017-06-13 20:36:34 [grid-nio-worker-tcp-comm-3-#20%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=3, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:36:34 [grid-nio-worker-tcp-comm-1-#18%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=1, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:36:34 [grid-nio-worker-tcp-comm-2-#19%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=2, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:36:34 [grid-nio-worker-tcp-comm-0-#17%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=0, keysCnt=1, bytesRcvd=45363, bytesRcvd0=0,
>> bytesSent=1305, bytesSent0=0]
Connection info [in=false, rmtAddr=/127.0.0.1:9340,
locAddr=/127.0.0.1:47331, msgsSent=3, msgsAckedByRmt=3,
descIdHash=2015302722, msgsRcvd=2, lastAcked=0, descIdHash=2015302722,
bytesRcvd=45363, bytesRcvd0=0, bytesSent=1305, bytesSent0=0, opQueueSize=0,
msgWriter=DirectMessageWriter [state=DirectMessageState [pos=0,
stack=[StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
null, null, null, null, null, null]]], msgReader=DirectMessageReader
[state=DirectMessageState [pos=0, stack=[StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013892784, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], null,
null, null, null, null, null, null]], lastRead=true]]
]]
WARN 2017-06-13 20:36:44 [localhost-startStop-1]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Failed to wait for initial partition map exchange. Possible reasons are:
^-- Transactions in deadlock.
^-- Long running transactions (ignore if this is the case).
^-- Unreleased explicit locks.]]
WARN 2017-06-13 20:36:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Failed to wait for partition map exchange
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0],
node=7fc5ea30-913d-4ff5-932b-62d81c6027db]. Dumping pending objects that
might be the cause: ]]
WARN 2017-06-13 20:36:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Ready affinity version: AffinityTopologyVersion [topVer=-1,
minorTopVer=0]]]
WARN 2017-06-13 20:36:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last exchange future: GridDhtPartitionsExchangeFuture [dummy=false,
forcePreload=false, reassign=false, discoEvt=DiscoveryEvent
[evtNode=TcpDiscoveryNode [id=7fc5ea30-913d-4ff5-932b-62d81c6027db,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62,
intOrder=33, lastExchangeTime=1497353804668, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], topVer=62,
nodeId8=7fc5ea30, msg=null, type=NODE_JOINED, tstamp=1497353784308],
crd=TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false],
exchId=GridDhtPartitionExchangeId [topVer=AffinityTopologyVersion
[topVer=62, minorTopVer=0], nodeId=7fc5ea30, evt=NODE_JOINED], added=false,
initFut=GridFutureAdapter [ignoreInterrupts=false, state=DONE, res=true,
hash=1130708319], init=true, lastVer=null, partReleaseFut=GridCompoundFuture
[rdc=null, initFlag=1, lsnrCalls=4, done=true, cancelled=false, err=null,
futs=[true, true, true, true]], affChangeMsg=null, skipPreload=false,
clientOnlyExchange=false, initTs=1497353784601, centralizedAff=false,
changeGlobalStateE=null, exchangeOnChangeGlobalState=false,
forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353804668, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:36:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending exchange futures:]]
WARN 2017-06-13 20:36:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last 10 exchange futures (total: 1):]]
WARN 2017-06-13 20:36:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[>>> GridDhtPartitionsExchangeFuture [dummy=false, forcePreload=false,
reassign=false, discoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353804668, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], topVer=62, nodeId8=7fc5ea30, msg=null, type=NODE_JOINED,
tstamp=1497353784308], crd=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], exchId=GridDhtPartitionExchangeId
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0], nodeId=7fc5ea30,
evt=NODE_JOINED], added=false, initFut=GridFutureAdapter
[ignoreInterrupts=false, state=DONE, res=true, hash=1130708319], init=true,
lastVer=null, partReleaseFut=GridCompoundFuture [rdc=null, initFlag=1,
lsnrCalls=4, done=true, cancelled=false, err=null, futs=[true, true, true,
true]], affChangeMsg=null, skipPreload=false, clientOnlyExchange=false,
initTs=1497353784601, centralizedAff=false, changeGlobalStateE=null,
exchangeOnChangeGlobalState=false, forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353804668, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:36:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transactions:]]
WARN 2017-06-13 20:36:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending explicit locks:]]
WARN 2017-06-13 20:36:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending cache futures:]]
WARN 2017-06-13 20:36:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending atomic cache futures:]]
WARN 2017-06-13 20:36:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending data streamer futures:]]
WARN 2017-06-13 20:36:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transaction deadlock detection futures:]]
WARN 2017-06-13 20:36:44 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi -
[[Communication SPI recovery descriptors:
[key=ConnectionKey [nodeId=f03fe6d2-8858-4b32-9ac2-260d1a79693a, idx=0,
connCnt=-1], msgsSent=3, msgsAckedByRmt=3, msgsRcvd=2, lastAcked=0,
reserveCnt=1, descIdHash=2015302722]
Communication SPI clients:
[node=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
client=GridTcpNioCommunicationClient [ses=GridSelectorNioSessionImpl
[worker=DirectNioClientWorker [super=AbstractNioClientWorker
[selector=sun.nio.ch.EPollSelectorImpl@3e96a835, idx=0, bytesRcvd=45363,
bytesSent=1305, bytesRcvd0=0, bytesSent0=0, select=true, super=GridWorker
[name=grid-nio-worker-tcp-comm-0, igniteInstanceName=svip, finished=false,
hashCode=518525437, interrupted=false,
runner=grid-nio-worker-tcp-comm-0-#17%svip%]]],
writeBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
readBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
inRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=0, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false],
outRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=0, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false], super=GridNioSessionImpl
[locAddr=/127.0.0.1:47331, rmtAddr=/127.0.0.1:9340,
createTime=1497353784631, closeTime=0, bytesSent=1305, bytesRcvd=45363,
bytesSent0=0, bytesRcvd0=0, sndSchedTime=1497353784631,
lastSndTime=1497353784897, lastRcvTime=1497353787145, readsPaused=false,
filterChain=FilterChain[filters=[GridNioCodecFilter
[parser=o.a.i.i.util.nio.GridDirectParser@5e7030df, directMode=true],
GridConnectionBytesVerifyFilter], accepted=false]],
super=GridAbstractCommunicationClient [lastUsed=1497353784642, closed=false,
connIdx=0]]]
]]
WARN 2017-06-13 20:36:44 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[NIO server
statistics [readerSesBalanceCnt=0, writerSesBalanceCnt=0]]]
WARN 2017-06-13 20:36:44 [grid-nio-worker-tcp-comm-0-#17%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=0, keysCnt=1, bytesRcvd=45363, bytesRcvd0=0,
>> bytesSent=1305, bytesSent0=0]
Connection info [in=false, rmtAddr=/127.0.0.1:9340,
locAddr=/127.0.0.1:47331, msgsSent=3, msgsAckedByRmt=3,
descIdHash=2015302722, msgsRcvd=2, lastAcked=0, descIdHash=2015302722,
bytesRcvd=45363, bytesRcvd0=0, bytesSent=1305, bytesSent0=0, opQueueSize=0,
msgWriter=DirectMessageWriter [state=DirectMessageState [pos=0,
stack=[StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
null, null, null, null, null, null]]], msgReader=DirectMessageReader
[state=DirectMessageState [pos=0, stack=[StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013892784, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], null,
null, null, null, null, null, null]], lastRead=true]]
]]
WARN 2017-06-13 20:36:44 [grid-nio-worker-tcp-comm-2-#19%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=2, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:36:44 [grid-nio-worker-tcp-comm-3-#20%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=3, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:36:44 [grid-nio-worker-tcp-comm-1-#18%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=1, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:36:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Failed to wait for partition map exchange
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0],
node=7fc5ea30-913d-4ff5-932b-62d81c6027db]. Dumping pending objects that
might be the cause: ]]
WARN 2017-06-13 20:36:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Ready affinity version: AffinityTopologyVersion [topVer=-1,
minorTopVer=0]]]
WARN 2017-06-13 20:36:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last exchange future: GridDhtPartitionsExchangeFuture [dummy=false,
forcePreload=false, reassign=false, discoEvt=DiscoveryEvent
[evtNode=TcpDiscoveryNode [id=7fc5ea30-913d-4ff5-932b-62d81c6027db,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62,
intOrder=33, lastExchangeTime=1497353814702, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], topVer=62,
nodeId8=7fc5ea30, msg=null, type=NODE_JOINED, tstamp=1497353784308],
crd=TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false],
exchId=GridDhtPartitionExchangeId [topVer=AffinityTopologyVersion
[topVer=62, minorTopVer=0], nodeId=7fc5ea30, evt=NODE_JOINED], added=false,
initFut=GridFutureAdapter [ignoreInterrupts=false, state=DONE, res=true,
hash=1130708319], init=true, lastVer=null, partReleaseFut=GridCompoundFuture
[rdc=null, initFlag=1, lsnrCalls=4, done=true, cancelled=false, err=null,
futs=[true, true, true, true]], affChangeMsg=null, skipPreload=false,
clientOnlyExchange=false, initTs=1497353784601, centralizedAff=false,
changeGlobalStateE=null, exchangeOnChangeGlobalState=false,
forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353814702, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:36:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending exchange futures:]]
WARN 2017-06-13 20:36:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last 10 exchange futures (total: 1):]]
WARN 2017-06-13 20:36:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[>>> GridDhtPartitionsExchangeFuture [dummy=false, forcePreload=false,
reassign=false, discoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353814702, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], topVer=62, nodeId8=7fc5ea30, msg=null, type=NODE_JOINED,
tstamp=1497353784308], crd=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], exchId=GridDhtPartitionExchangeId
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0], nodeId=7fc5ea30,
evt=NODE_JOINED], added=false, initFut=GridFutureAdapter
[ignoreInterrupts=false, state=DONE, res=true, hash=1130708319], init=true,
lastVer=null, partReleaseFut=GridCompoundFuture [rdc=null, initFlag=1,
lsnrCalls=4, done=true, cancelled=false, err=null, futs=[true, true, true,
true]], affChangeMsg=null, skipPreload=false, clientOnlyExchange=false,
initTs=1497353784601, centralizedAff=false, changeGlobalStateE=null,
exchangeOnChangeGlobalState=false, forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353814702, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:36:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transactions:]]
WARN 2017-06-13 20:36:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending explicit locks:]]
WARN 2017-06-13 20:36:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending cache futures:]]
WARN 2017-06-13 20:36:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending atomic cache futures:]]
WARN 2017-06-13 20:36:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending data streamer futures:]]
WARN 2017-06-13 20:36:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transaction deadlock detection futures:]]
WARN 2017-06-13 20:36:54 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi -
[[Communication SPI recovery descriptors:
[key=ConnectionKey [nodeId=f03fe6d2-8858-4b32-9ac2-260d1a79693a, idx=0,
connCnt=-1], msgsSent=3, msgsAckedByRmt=3, msgsRcvd=2, lastAcked=2,
reserveCnt=1, descIdHash=2015302722]
Communication SPI clients:
[node=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
client=GridTcpNioCommunicationClient [ses=GridSelectorNioSessionImpl
[worker=DirectNioClientWorker [super=AbstractNioClientWorker
[selector=sun.nio.ch.EPollSelectorImpl@3e96a835, idx=0, bytesRcvd=45363,
bytesSent=1315, bytesRcvd0=0, bytesSent0=10, select=true, super=GridWorker
[name=grid-nio-worker-tcp-comm-0, igniteInstanceName=svip, finished=false,
hashCode=518525437, interrupted=false,
runner=grid-nio-worker-tcp-comm-0-#17%svip%]]],
writeBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
readBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
inRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=2, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false],
outRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=2, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false], super=GridNioSessionImpl
[locAddr=/127.0.0.1:47331, rmtAddr=/127.0.0.1:9340,
createTime=1497353784631, closeTime=0, bytesSent=1315, bytesRcvd=45363,
bytesSent0=10, bytesRcvd0=0, sndSchedTime=1497353784631,
lastSndTime=1497353813114, lastRcvTime=1497353787145, readsPaused=false,
filterChain=FilterChain[filters=[GridNioCodecFilter
[parser=o.a.i.i.util.nio.GridDirectParser@5e7030df, directMode=true],
GridConnectionBytesVerifyFilter], accepted=false]],
super=GridAbstractCommunicationClient [lastUsed=1497353784642, closed=false,
connIdx=0]]]
]]
WARN 2017-06-13 20:36:54 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[NIO server
statistics [readerSesBalanceCnt=0, writerSesBalanceCnt=0]]]
WARN 2017-06-13 20:36:54 [grid-nio-worker-tcp-comm-0-#17%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=0, keysCnt=1, bytesRcvd=45363, bytesRcvd0=0,
>> bytesSent=1315, bytesSent0=10]
Connection info [in=false, rmtAddr=/127.0.0.1:9340,
locAddr=/127.0.0.1:47331, msgsSent=3, msgsAckedByRmt=3,
descIdHash=2015302722, msgsRcvd=2, lastAcked=2, descIdHash=2015302722,
bytesRcvd=45363, bytesRcvd0=0, bytesSent=1315, bytesSent0=10, opQueueSize=0,
msgWriter=DirectMessageWriter [state=DirectMessageState [pos=0,
stack=[StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
null, null, null, null, null, null]]], msgReader=DirectMessageReader
[state=DirectMessageState [pos=0, stack=[StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013892784, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], null,
null, null, null, null, null, null]], lastRead=true]]
]]
WARN 2017-06-13 20:36:54 [grid-nio-worker-tcp-comm-1-#18%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=1, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:36:54 [grid-nio-worker-tcp-comm-2-#19%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=2, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:36:54 [grid-nio-worker-tcp-comm-3-#20%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=3, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:04 [localhost-startStop-1]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Still waiting for initial partition map exchange
[fut=GridDhtPartitionsExchangeFuture [dummy=false, forcePreload=false,
reassign=false, discoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353824361, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], topVer=62, nodeId8=7fc5ea30, msg=null, type=NODE_JOINED,
tstamp=1497353784308], crd=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], exchId=GridDhtPartitionExchangeId
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0], nodeId=7fc5ea30,
evt=NODE_JOINED], added=false, initFut=GridFutureAdapter
[ignoreInterrupts=false, state=DONE, res=true, hash=1130708319], init=true,
lastVer=null, partReleaseFut=GridCompoundFuture [rdc=null, initFlag=1,
lsnrCalls=4, done=true, cancelled=false, err=null, futs=[true, true, true,
true]], affChangeMsg=null, skipPreload=false, clientOnlyExchange=false,
initTs=1497353784601, centralizedAff=false, changeGlobalStateE=null,
exchangeOnChangeGlobalState=false, forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353824361, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]]
WARN 2017-06-13 20:37:04 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Failed to wait for partition map exchange
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0],
node=7fc5ea30-913d-4ff5-932b-62d81c6027db]. Dumping pending objects that
might be the cause: ]]
WARN 2017-06-13 20:37:04 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Ready affinity version: AffinityTopologyVersion [topVer=-1,
minorTopVer=0]]]
WARN 2017-06-13 20:37:04 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last exchange future: GridDhtPartitionsExchangeFuture [dummy=false,
forcePreload=false, reassign=false, discoEvt=DiscoveryEvent
[evtNode=TcpDiscoveryNode [id=7fc5ea30-913d-4ff5-932b-62d81c6027db,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62,
intOrder=33, lastExchangeTime=1497353824726, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], topVer=62,
nodeId8=7fc5ea30, msg=null, type=NODE_JOINED, tstamp=1497353784308],
crd=TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false],
exchId=GridDhtPartitionExchangeId [topVer=AffinityTopologyVersion
[topVer=62, minorTopVer=0], nodeId=7fc5ea30, evt=NODE_JOINED], added=false,
initFut=GridFutureAdapter [ignoreInterrupts=false, state=DONE, res=true,
hash=1130708319], init=true, lastVer=null, partReleaseFut=GridCompoundFuture
[rdc=null, initFlag=1, lsnrCalls=4, done=true, cancelled=false, err=null,
futs=[true, true, true, true]], affChangeMsg=null, skipPreload=false,
clientOnlyExchange=false, initTs=1497353784601, centralizedAff=false,
changeGlobalStateE=null, exchangeOnChangeGlobalState=false,
forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353824726, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:37:04 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending exchange futures:]]
WARN 2017-06-13 20:37:04 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last 10 exchange futures (total: 1):]]
WARN 2017-06-13 20:37:04 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[>>> GridDhtPartitionsExchangeFuture [dummy=false, forcePreload=false,
reassign=false, discoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353824726, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], topVer=62, nodeId8=7fc5ea30, msg=null, type=NODE_JOINED,
tstamp=1497353784308], crd=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], exchId=GridDhtPartitionExchangeId
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0], nodeId=7fc5ea30,
evt=NODE_JOINED], added=false, initFut=GridFutureAdapter
[ignoreInterrupts=false, state=DONE, res=true, hash=1130708319], init=true,
lastVer=null, partReleaseFut=GridCompoundFuture [rdc=null, initFlag=1,
lsnrCalls=4, done=true, cancelled=false, err=null, futs=[true, true, true,
true]], affChangeMsg=null, skipPreload=false, clientOnlyExchange=false,
initTs=1497353784601, centralizedAff=false, changeGlobalStateE=null,
exchangeOnChangeGlobalState=false, forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353824726, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:37:04 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transactions:]]
WARN 2017-06-13 20:37:04 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending explicit locks:]]
WARN 2017-06-13 20:37:04 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending cache futures:]]
WARN 2017-06-13 20:37:04 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending atomic cache futures:]]
WARN 2017-06-13 20:37:04 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending data streamer futures:]]
WARN 2017-06-13 20:37:04 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transaction deadlock detection futures:]]
WARN 2017-06-13 20:37:04 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi -
[[Communication SPI recovery descriptors:
[key=ConnectionKey [nodeId=f03fe6d2-8858-4b32-9ac2-260d1a79693a, idx=0,
connCnt=-1], msgsSent=3, msgsAckedByRmt=3, msgsRcvd=2, lastAcked=2,
reserveCnt=1, descIdHash=2015302722]
Communication SPI clients:
[node=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
client=GridTcpNioCommunicationClient [ses=GridSelectorNioSessionImpl
[worker=DirectNioClientWorker [super=AbstractNioClientWorker
[selector=sun.nio.ch.EPollSelectorImpl@3e96a835, idx=0, bytesRcvd=45363,
bytesSent=1315, bytesRcvd0=0, bytesSent0=0, select=true, super=GridWorker
[name=grid-nio-worker-tcp-comm-0, igniteInstanceName=svip, finished=false,
hashCode=518525437, interrupted=false,
runner=grid-nio-worker-tcp-comm-0-#17%svip%]]],
writeBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
readBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
inRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=2, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false],
outRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=2, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false], super=GridNioSessionImpl
[locAddr=/127.0.0.1:47331, rmtAddr=/127.0.0.1:9340,
createTime=1497353784631, closeTime=0, bytesSent=1315, bytesRcvd=45363,
bytesSent0=0, bytesRcvd0=0, sndSchedTime=1497353818946,
lastSndTime=1497353813114, lastRcvTime=1497353818946, readsPaused=false,
filterChain=FilterChain[filters=[GridNioCodecFilter
[parser=o.a.i.i.util.nio.GridDirectParser@5e7030df, directMode=true],
GridConnectionBytesVerifyFilter], accepted=false]],
super=GridAbstractCommunicationClient [lastUsed=1497353784642, closed=false,
connIdx=0]]]
]]
WARN 2017-06-13 20:37:04 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[NIO server
statistics [readerSesBalanceCnt=0, writerSesBalanceCnt=0]]]
WARN 2017-06-13 20:37:04 [grid-nio-worker-tcp-comm-0-#17%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=0, keysCnt=1, bytesRcvd=45363, bytesRcvd0=0,
>> bytesSent=1315, bytesSent0=0]
Connection info [in=false, rmtAddr=/127.0.0.1:9340,
locAddr=/127.0.0.1:47331, msgsSent=3, msgsAckedByRmt=3,
descIdHash=2015302722, msgsRcvd=2, lastAcked=2, descIdHash=2015302722,
bytesRcvd=45363, bytesRcvd0=0, bytesSent=1315, bytesSent0=0, opQueueSize=0,
msgWriter=DirectMessageWriter [state=DirectMessageState [pos=0,
stack=[StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
null, null, null, null, null, null]]], msgReader=DirectMessageReader
[state=DirectMessageState [pos=0, stack=[StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013892784, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], null,
null, null, null, null, null, null]], lastRead=true]]
]]
WARN 2017-06-13 20:37:04 [grid-nio-worker-tcp-comm-2-#19%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=2, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:04 [grid-nio-worker-tcp-comm-3-#20%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=3, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:04 [grid-nio-worker-tcp-comm-1-#18%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=1, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:14 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Failed to wait for partition map exchange
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0],
node=7fc5ea30-913d-4ff5-932b-62d81c6027db]. Dumping pending objects that
might be the cause: ]]
WARN 2017-06-13 20:37:14 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Ready affinity version: AffinityTopologyVersion [topVer=-1,
minorTopVer=0]]]
WARN 2017-06-13 20:37:14 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last exchange future: GridDhtPartitionsExchangeFuture [dummy=false,
forcePreload=false, reassign=false, discoEvt=DiscoveryEvent
[evtNode=TcpDiscoveryNode [id=7fc5ea30-913d-4ff5-932b-62d81c6027db,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62,
intOrder=33, lastExchangeTime=1497353834746, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], topVer=62,
nodeId8=7fc5ea30, msg=null, type=NODE_JOINED, tstamp=1497353784308],
crd=TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false],
exchId=GridDhtPartitionExchangeId [topVer=AffinityTopologyVersion
[topVer=62, minorTopVer=0], nodeId=7fc5ea30, evt=NODE_JOINED], added=false,
initFut=GridFutureAdapter [ignoreInterrupts=false, state=DONE, res=true,
hash=1130708319], init=true, lastVer=null, partReleaseFut=GridCompoundFuture
[rdc=null, initFlag=1, lsnrCalls=4, done=true, cancelled=false, err=null,
futs=[true, true, true, true]], affChangeMsg=null, skipPreload=false,
clientOnlyExchange=false, initTs=1497353784601, centralizedAff=false,
changeGlobalStateE=null, exchangeOnChangeGlobalState=false,
forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353834746, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:37:14 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending exchange futures:]]
WARN 2017-06-13 20:37:14 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last 10 exchange futures (total: 1):]]
WARN 2017-06-13 20:37:14 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[>>> GridDhtPartitionsExchangeFuture [dummy=false, forcePreload=false,
reassign=false, discoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353834746, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], topVer=62, nodeId8=7fc5ea30, msg=null, type=NODE_JOINED,
tstamp=1497353784308], crd=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], exchId=GridDhtPartitionExchangeId
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0], nodeId=7fc5ea30,
evt=NODE_JOINED], added=false, initFut=GridFutureAdapter
[ignoreInterrupts=false, state=DONE, res=true, hash=1130708319], init=true,
lastVer=null, partReleaseFut=GridCompoundFuture [rdc=null, initFlag=1,
lsnrCalls=4, done=true, cancelled=false, err=null, futs=[true, true, true,
true]], affChangeMsg=null, skipPreload=false, clientOnlyExchange=false,
initTs=1497353784601, centralizedAff=false, changeGlobalStateE=null,
exchangeOnChangeGlobalState=false, forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353834746, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:37:14 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transactions:]]
WARN 2017-06-13 20:37:14 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending explicit locks:]]
WARN 2017-06-13 20:37:14 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending cache futures:]]
WARN 2017-06-13 20:37:14 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending atomic cache futures:]]
WARN 2017-06-13 20:37:14 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending data streamer futures:]]
WARN 2017-06-13 20:37:14 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transaction deadlock detection futures:]]
WARN 2017-06-13 20:37:14 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi -
[[Communication SPI recovery descriptors:
[key=ConnectionKey [nodeId=f03fe6d2-8858-4b32-9ac2-260d1a79693a, idx=0,
connCnt=-1], msgsSent=3, msgsAckedByRmt=3, msgsRcvd=2, lastAcked=2,
reserveCnt=1, descIdHash=2015302722]
Communication SPI clients:
[node=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
client=GridTcpNioCommunicationClient [ses=GridSelectorNioSessionImpl
[worker=DirectNioClientWorker [super=AbstractNioClientWorker
[selector=sun.nio.ch.EPollSelectorImpl@3e96a835, idx=0, bytesRcvd=45363,
bytesSent=1315, bytesRcvd0=0, bytesSent0=0, select=true, super=GridWorker
[name=grid-nio-worker-tcp-comm-0, igniteInstanceName=svip, finished=false,
hashCode=518525437, interrupted=false,
runner=grid-nio-worker-tcp-comm-0-#17%svip%]]],
writeBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
readBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
inRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=2, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false],
outRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=2, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false], super=GridNioSessionImpl
[locAddr=/127.0.0.1:47331, rmtAddr=/127.0.0.1:9340,
createTime=1497353784631, closeTime=0, bytesSent=1315, bytesRcvd=45363,
bytesSent0=0, bytesRcvd0=0, sndSchedTime=1497353818946,
lastSndTime=1497353813114, lastRcvTime=1497353818946, readsPaused=false,
filterChain=FilterChain[filters=[GridNioCodecFilter
[parser=o.a.i.i.util.nio.GridDirectParser@5e7030df, directMode=true],
GridConnectionBytesVerifyFilter], accepted=false]],
super=GridAbstractCommunicationClient [lastUsed=1497353784642, closed=false,
connIdx=0]]]
]]
WARN 2017-06-13 20:37:14 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[NIO server
statistics [readerSesBalanceCnt=0, writerSesBalanceCnt=0]]]
WARN 2017-06-13 20:37:14 [grid-nio-worker-tcp-comm-0-#17%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=0, keysCnt=1, bytesRcvd=45363, bytesRcvd0=0,
>> bytesSent=1315, bytesSent0=0]
Connection info [in=false, rmtAddr=/127.0.0.1:9340,
locAddr=/127.0.0.1:47331, msgsSent=3, msgsAckedByRmt=3,
descIdHash=2015302722, msgsRcvd=2, lastAcked=2, descIdHash=2015302722,
bytesRcvd=45363, bytesRcvd0=0, bytesSent=1315, bytesSent0=0, opQueueSize=0,
msgWriter=DirectMessageWriter [state=DirectMessageState [pos=0,
stack=[StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
null, null, null, null, null, null]]], msgReader=DirectMessageReader
[state=DirectMessageState [pos=0, stack=[StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013892784, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], null,
null, null, null, null, null, null]], lastRead=true]]
]]
WARN 2017-06-13 20:37:14 [grid-nio-worker-tcp-comm-1-#18%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=1, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:14 [grid-nio-worker-tcp-comm-2-#19%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=2, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:14 [grid-nio-worker-tcp-comm-3-#20%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=3, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:24 [localhost-startStop-1]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Still waiting for initial partition map exchange
[fut=GridDhtPartitionsExchangeFuture [dummy=false, forcePreload=false,
reassign=false, discoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353844387, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], topVer=62, nodeId8=7fc5ea30, msg=null, type=NODE_JOINED,
tstamp=1497353784308], crd=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], exchId=GridDhtPartitionExchangeId
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0], nodeId=7fc5ea30,
evt=NODE_JOINED], added=false, initFut=GridFutureAdapter
[ignoreInterrupts=false, state=DONE, res=true, hash=1130708319], init=true,
lastVer=null, partReleaseFut=GridCompoundFuture [rdc=null, initFlag=1,
lsnrCalls=4, done=true, cancelled=false, err=null, futs=[true, true, true,
true]], affChangeMsg=null, skipPreload=false, clientOnlyExchange=false,
initTs=1497353784601, centralizedAff=false, changeGlobalStateE=null,
exchangeOnChangeGlobalState=false, forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353844387, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]]
WARN 2017-06-13 20:37:24 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Failed to wait for partition map exchange
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0],
node=7fc5ea30-913d-4ff5-932b-62d81c6027db]. Dumping pending objects that
might be the cause: ]]
WARN 2017-06-13 20:37:24 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Ready affinity version: AffinityTopologyVersion [topVer=-1,
minorTopVer=0]]]
WARN 2017-06-13 20:37:24 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last exchange future: GridDhtPartitionsExchangeFuture [dummy=false,
forcePreload=false, reassign=false, discoEvt=DiscoveryEvent
[evtNode=TcpDiscoveryNode [id=7fc5ea30-913d-4ff5-932b-62d81c6027db,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62,
intOrder=33, lastExchangeTime=1497353844791, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], topVer=62,
nodeId8=7fc5ea30, msg=null, type=NODE_JOINED, tstamp=1497353784308],
crd=TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false],
exchId=GridDhtPartitionExchangeId [topVer=AffinityTopologyVersion
[topVer=62, minorTopVer=0], nodeId=7fc5ea30, evt=NODE_JOINED], added=false,
initFut=GridFutureAdapter [ignoreInterrupts=false, state=DONE, res=true,
hash=1130708319], init=true, lastVer=null, partReleaseFut=GridCompoundFuture
[rdc=null, initFlag=1, lsnrCalls=4, done=true, cancelled=false, err=null,
futs=[true, true, true, true]], affChangeMsg=null, skipPreload=false,
clientOnlyExchange=false, initTs=1497353784601, centralizedAff=false,
changeGlobalStateE=null, exchangeOnChangeGlobalState=false,
forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353844791, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:37:24 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending exchange futures:]]
WARN 2017-06-13 20:37:24 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last 10 exchange futures (total: 1):]]
WARN 2017-06-13 20:37:24 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[>>> GridDhtPartitionsExchangeFuture [dummy=false, forcePreload=false,
reassign=false, discoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353844791, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], topVer=62, nodeId8=7fc5ea30, msg=null, type=NODE_JOINED,
tstamp=1497353784308], crd=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], exchId=GridDhtPartitionExchangeId
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0], nodeId=7fc5ea30,
evt=NODE_JOINED], added=false, initFut=GridFutureAdapter
[ignoreInterrupts=false, state=DONE, res=true, hash=1130708319], init=true,
lastVer=null, partReleaseFut=GridCompoundFuture [rdc=null, initFlag=1,
lsnrCalls=4, done=true, cancelled=false, err=null, futs=[true, true, true,
true]], affChangeMsg=null, skipPreload=false, clientOnlyExchange=false,
initTs=1497353784601, centralizedAff=false, changeGlobalStateE=null,
exchangeOnChangeGlobalState=false, forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353844791, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:37:24 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transactions:]]
WARN 2017-06-13 20:37:24 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending explicit locks:]]
WARN 2017-06-13 20:37:24 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending cache futures:]]
WARN 2017-06-13 20:37:24 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending atomic cache futures:]]
WARN 2017-06-13 20:37:24 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending data streamer futures:]]
WARN 2017-06-13 20:37:24 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transaction deadlock detection futures:]]
WARN 2017-06-13 20:37:24 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi -
[[Communication SPI recovery descriptors:
[key=ConnectionKey [nodeId=f03fe6d2-8858-4b32-9ac2-260d1a79693a, idx=0,
connCnt=-1], msgsSent=3, msgsAckedByRmt=3, msgsRcvd=2, lastAcked=2,
reserveCnt=1, descIdHash=2015302722]
Communication SPI clients:
[node=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
client=GridTcpNioCommunicationClient [ses=GridSelectorNioSessionImpl
[worker=DirectNioClientWorker [super=AbstractNioClientWorker
[selector=sun.nio.ch.EPollSelectorImpl@3e96a835, idx=0, bytesRcvd=45363,
bytesSent=1315, bytesRcvd0=0, bytesSent0=0, select=true, super=GridWorker
[name=grid-nio-worker-tcp-comm-0, igniteInstanceName=svip, finished=false,
hashCode=518525437, interrupted=false,
runner=grid-nio-worker-tcp-comm-0-#17%svip%]]],
writeBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
readBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
inRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=2, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false],
outRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=2, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false], super=GridNioSessionImpl
[locAddr=/127.0.0.1:47331, rmtAddr=/127.0.0.1:9340,
createTime=1497353784631, closeTime=0, bytesSent=1315, bytesRcvd=45363,
bytesSent0=0, bytesRcvd0=0, sndSchedTime=1497353818946,
lastSndTime=1497353813114, lastRcvTime=1497353818946, readsPaused=false,
filterChain=FilterChain[filters=[GridNioCodecFilter
[parser=o.a.i.i.util.nio.GridDirectParser@5e7030df, directMode=true],
GridConnectionBytesVerifyFilter], accepted=false]],
super=GridAbstractCommunicationClient [lastUsed=1497353784642, closed=false,
connIdx=0]]]
]]
WARN 2017-06-13 20:37:24 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[NIO server
statistics [readerSesBalanceCnt=0, writerSesBalanceCnt=0]]]
WARN 2017-06-13 20:37:24 [grid-nio-worker-tcp-comm-0-#17%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=0, keysCnt=1, bytesRcvd=45363, bytesRcvd0=0,
>> bytesSent=1315, bytesSent0=0]
Connection info [in=false, rmtAddr=/127.0.0.1:9340,
locAddr=/127.0.0.1:47331, msgsSent=3, msgsAckedByRmt=3,
descIdHash=2015302722, msgsRcvd=2, lastAcked=2, descIdHash=2015302722,
bytesRcvd=45363, bytesRcvd0=0, bytesSent=1315, bytesSent0=0, opQueueSize=0,
msgWriter=DirectMessageWriter [state=DirectMessageState [pos=0,
stack=[StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
null, null, null, null, null, null]]], msgReader=DirectMessageReader
[state=DirectMessageState [pos=0, stack=[StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013892784, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], null,
null, null, null, null, null, null]], lastRead=true]]
]]
WARN 2017-06-13 20:37:24 [grid-nio-worker-tcp-comm-1-#18%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=1, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:24 [grid-nio-worker-tcp-comm-2-#19%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=2, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:24 [grid-nio-worker-tcp-comm-3-#20%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=3, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
INFO 2017-06-13 20:37:34 [ignite-update-notifier-timer]
org.apache.ignite.internal.processors.cluster.GridUpdateNotifier - [[Update
status is not available.]]
WARN 2017-06-13 20:37:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Failed to wait for partition map exchange
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0],
node=7fc5ea30-913d-4ff5-932b-62d81c6027db]. Dumping pending objects that
might be the cause: ]]
WARN 2017-06-13 20:37:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Ready affinity version: AffinityTopologyVersion [topVer=-1,
minorTopVer=0]]]
WARN 2017-06-13 20:37:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last exchange future: GridDhtPartitionsExchangeFuture [dummy=false,
forcePreload=false, reassign=false, discoEvt=DiscoveryEvent
[evtNode=TcpDiscoveryNode [id=7fc5ea30-913d-4ff5-932b-62d81c6027db,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62,
intOrder=33, lastExchangeTime=1497353854788, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], topVer=62,
nodeId8=7fc5ea30, msg=null, type=NODE_JOINED, tstamp=1497353784308],
crd=TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false],
exchId=GridDhtPartitionExchangeId [topVer=AffinityTopologyVersion
[topVer=62, minorTopVer=0], nodeId=7fc5ea30, evt=NODE_JOINED], added=false,
initFut=GridFutureAdapter [ignoreInterrupts=false, state=DONE, res=true,
hash=1130708319], init=true, lastVer=null, partReleaseFut=GridCompoundFuture
[rdc=null, initFlag=1, lsnrCalls=4, done=true, cancelled=false, err=null,
futs=[true, true, true, true]], affChangeMsg=null, skipPreload=false,
clientOnlyExchange=false, initTs=1497353784601, centralizedAff=false,
changeGlobalStateE=null, exchangeOnChangeGlobalState=false,
forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353854788, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:37:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending exchange futures:]]
WARN 2017-06-13 20:37:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last 10 exchange futures (total: 1):]]
WARN 2017-06-13 20:37:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[>>> GridDhtPartitionsExchangeFuture [dummy=false, forcePreload=false,
reassign=false, discoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353854788, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], topVer=62, nodeId8=7fc5ea30, msg=null, type=NODE_JOINED,
tstamp=1497353784308], crd=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], exchId=GridDhtPartitionExchangeId
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0], nodeId=7fc5ea30,
evt=NODE_JOINED], added=false, initFut=GridFutureAdapter
[ignoreInterrupts=false, state=DONE, res=true, hash=1130708319], init=true,
lastVer=null, partReleaseFut=GridCompoundFuture [rdc=null, initFlag=1,
lsnrCalls=4, done=true, cancelled=false, err=null, futs=[true, true, true,
true]], affChangeMsg=null, skipPreload=false, clientOnlyExchange=false,
initTs=1497353784601, centralizedAff=false, changeGlobalStateE=null,
exchangeOnChangeGlobalState=false, forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353854788, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:37:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transactions:]]
WARN 2017-06-13 20:37:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending explicit locks:]]
WARN 2017-06-13 20:37:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending cache futures:]]
WARN 2017-06-13 20:37:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending atomic cache futures:]]
WARN 2017-06-13 20:37:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending data streamer futures:]]
WARN 2017-06-13 20:37:34 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transaction deadlock detection futures:]]
WARN 2017-06-13 20:37:34 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi -
[[Communication SPI recovery descriptors:
[key=ConnectionKey [nodeId=f03fe6d2-8858-4b32-9ac2-260d1a79693a, idx=0,
connCnt=-1], msgsSent=3, msgsAckedByRmt=3, msgsRcvd=2, lastAcked=2,
reserveCnt=1, descIdHash=2015302722]
Communication SPI clients:
[node=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
client=GridTcpNioCommunicationClient [ses=GridSelectorNioSessionImpl
[worker=DirectNioClientWorker [super=AbstractNioClientWorker
[selector=sun.nio.ch.EPollSelectorImpl@3e96a835, idx=0, bytesRcvd=45363,
bytesSent=1315, bytesRcvd0=0, bytesSent0=0, select=true, super=GridWorker
[name=grid-nio-worker-tcp-comm-0, igniteInstanceName=svip, finished=false,
hashCode=518525437, interrupted=false,
runner=grid-nio-worker-tcp-comm-0-#17%svip%]]],
writeBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
readBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
inRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=2, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false],
outRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=2, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false], super=GridNioSessionImpl
[locAddr=/127.0.0.1:47331, rmtAddr=/127.0.0.1:9340,
createTime=1497353784631, closeTime=0, bytesSent=1315, bytesRcvd=45363,
bytesSent0=0, bytesRcvd0=0, sndSchedTime=1497353848962,
lastSndTime=1497353813114, lastRcvTime=1497353848962, readsPaused=false,
filterChain=FilterChain[filters=[GridNioCodecFilter
[parser=o.a.i.i.util.nio.GridDirectParser@5e7030df, directMode=true],
GridConnectionBytesVerifyFilter], accepted=false]],
super=GridAbstractCommunicationClient [lastUsed=1497353784642, closed=false,
connIdx=0]]]
]]
WARN 2017-06-13 20:37:34 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[NIO server
statistics [readerSesBalanceCnt=0, writerSesBalanceCnt=0]]]
WARN 2017-06-13 20:37:34 [grid-nio-worker-tcp-comm-0-#17%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=0, keysCnt=1, bytesRcvd=45363, bytesRcvd0=0,
>> bytesSent=1315, bytesSent0=0]
Connection info [in=false, rmtAddr=/127.0.0.1:9340,
locAddr=/127.0.0.1:47331, msgsSent=3, msgsAckedByRmt=3,
descIdHash=2015302722, msgsRcvd=2, lastAcked=2, descIdHash=2015302722,
bytesRcvd=45363, bytesRcvd0=0, bytesSent=1315, bytesSent0=0, opQueueSize=0,
msgWriter=DirectMessageWriter [state=DirectMessageState [pos=0,
stack=[StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
null, null, null, null, null, null]]], msgReader=DirectMessageReader
[state=DirectMessageState [pos=0, stack=[StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013892784, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], null,
null, null, null, null, null, null]], lastRead=true]]
]]
WARN 2017-06-13 20:37:34 [grid-nio-worker-tcp-comm-1-#18%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=1, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:34 [grid-nio-worker-tcp-comm-2-#19%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=2, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:34 [grid-nio-worker-tcp-comm-3-#20%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=3, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:44 [localhost-startStop-1]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Still waiting for initial partition map exchange
[fut=GridDhtPartitionsExchangeFuture [dummy=false, forcePreload=false,
reassign=false, discoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353864442, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], topVer=62, nodeId8=7fc5ea30, msg=null, type=NODE_JOINED,
tstamp=1497353784308], crd=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], exchId=GridDhtPartitionExchangeId
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0], nodeId=7fc5ea30,
evt=NODE_JOINED], added=false, initFut=GridFutureAdapter
[ignoreInterrupts=false, state=DONE, res=true, hash=1130708319], init=true,
lastVer=null, partReleaseFut=GridCompoundFuture [rdc=null, initFlag=1,
lsnrCalls=4, done=true, cancelled=false, err=null, futs=[true, true, true,
true]], affChangeMsg=null, skipPreload=false, clientOnlyExchange=false,
initTs=1497353784601, centralizedAff=false, changeGlobalStateE=null,
exchangeOnChangeGlobalState=false, forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353864442, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]]
WARN 2017-06-13 20:37:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Failed to wait for partition map exchange
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0],
node=7fc5ea30-913d-4ff5-932b-62d81c6027db]. Dumping pending objects that
might be the cause: ]]
WARN 2017-06-13 20:37:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Ready affinity version: AffinityTopologyVersion [topVer=-1,
minorTopVer=0]]]
WARN 2017-06-13 20:37:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last exchange future: GridDhtPartitionsExchangeFuture [dummy=false,
forcePreload=false, reassign=false, discoEvt=DiscoveryEvent
[evtNode=TcpDiscoveryNode [id=7fc5ea30-913d-4ff5-932b-62d81c6027db,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62,
intOrder=33, lastExchangeTime=1497353864796, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], topVer=62,
nodeId8=7fc5ea30, msg=null, type=NODE_JOINED, tstamp=1497353784308],
crd=TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false],
exchId=GridDhtPartitionExchangeId [topVer=AffinityTopologyVersion
[topVer=62, minorTopVer=0], nodeId=7fc5ea30, evt=NODE_JOINED], added=false,
initFut=GridFutureAdapter [ignoreInterrupts=false, state=DONE, res=true,
hash=1130708319], init=true, lastVer=null, partReleaseFut=GridCompoundFuture
[rdc=null, initFlag=1, lsnrCalls=4, done=true, cancelled=false, err=null,
futs=[true, true, true, true]], affChangeMsg=null, skipPreload=false,
clientOnlyExchange=false, initTs=1497353784601, centralizedAff=false,
changeGlobalStateE=null, exchangeOnChangeGlobalState=false,
forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353864796, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:37:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending exchange futures:]]
WARN 2017-06-13 20:37:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last 10 exchange futures (total: 1):]]
WARN 2017-06-13 20:37:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[>>> GridDhtPartitionsExchangeFuture [dummy=false, forcePreload=false,
reassign=false, discoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353864796, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], topVer=62, nodeId8=7fc5ea30, msg=null, type=NODE_JOINED,
tstamp=1497353784308], crd=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], exchId=GridDhtPartitionExchangeId
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0], nodeId=7fc5ea30,
evt=NODE_JOINED], added=false, initFut=GridFutureAdapter
[ignoreInterrupts=false, state=DONE, res=true, hash=1130708319], init=true,
lastVer=null, partReleaseFut=GridCompoundFuture [rdc=null, initFlag=1,
lsnrCalls=4, done=true, cancelled=false, err=null, futs=[true, true, true,
true]], affChangeMsg=null, skipPreload=false, clientOnlyExchange=false,
initTs=1497353784601, centralizedAff=false, changeGlobalStateE=null,
exchangeOnChangeGlobalState=false, forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353864796, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:37:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transactions:]]
WARN 2017-06-13 20:37:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending explicit locks:]]
WARN 2017-06-13 20:37:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending cache futures:]]
WARN 2017-06-13 20:37:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending atomic cache futures:]]
WARN 2017-06-13 20:37:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending data streamer futures:]]
WARN 2017-06-13 20:37:44 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transaction deadlock detection futures:]]
WARN 2017-06-13 20:37:44 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi -
[[Communication SPI recovery descriptors:
[key=ConnectionKey [nodeId=f03fe6d2-8858-4b32-9ac2-260d1a79693a, idx=0,
connCnt=-1], msgsSent=3, msgsAckedByRmt=3, msgsRcvd=2, lastAcked=2,
reserveCnt=1, descIdHash=2015302722]
Communication SPI clients:
[node=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
client=GridTcpNioCommunicationClient [ses=GridSelectorNioSessionImpl
[worker=DirectNioClientWorker [super=AbstractNioClientWorker
[selector=sun.nio.ch.EPollSelectorImpl@3e96a835, idx=0, bytesRcvd=45363,
bytesSent=1315, bytesRcvd0=0, bytesSent0=0, select=true, super=GridWorker
[name=grid-nio-worker-tcp-comm-0, igniteInstanceName=svip, finished=false,
hashCode=518525437, interrupted=false,
runner=grid-nio-worker-tcp-comm-0-#17%svip%]]],
writeBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
readBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
inRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=2, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false],
outRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=2, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false], super=GridNioSessionImpl
[locAddr=/127.0.0.1:47331, rmtAddr=/127.0.0.1:9340,
createTime=1497353784631, closeTime=0, bytesSent=1315, bytesRcvd=45363,
bytesSent0=0, bytesRcvd0=0, sndSchedTime=1497353848962,
lastSndTime=1497353813114, lastRcvTime=1497353848962, readsPaused=false,
filterChain=FilterChain[filters=[GridNioCodecFilter
[parser=o.a.i.i.util.nio.GridDirectParser@5e7030df, directMode=true],
GridConnectionBytesVerifyFilter], accepted=false]],
super=GridAbstractCommunicationClient [lastUsed=1497353784642, closed=false,
connIdx=0]]]
]]
WARN 2017-06-13 20:37:44 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[NIO server
statistics [readerSesBalanceCnt=0, writerSesBalanceCnt=0]]]
WARN 2017-06-13 20:37:44 [grid-nio-worker-tcp-comm-0-#17%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=0, keysCnt=1, bytesRcvd=45363, bytesRcvd0=0,
>> bytesSent=1315, bytesSent0=0]
Connection info [in=false, rmtAddr=/127.0.0.1:9340,
locAddr=/127.0.0.1:47331, msgsSent=3, msgsAckedByRmt=3,
descIdHash=2015302722, msgsRcvd=2, lastAcked=2, descIdHash=2015302722,
bytesRcvd=45363, bytesRcvd0=0, bytesSent=1315, bytesSent0=0, opQueueSize=0,
msgWriter=DirectMessageWriter [state=DirectMessageState [pos=0,
stack=[StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
null, null, null, null, null, null]]], msgReader=DirectMessageReader
[state=DirectMessageState [pos=0, stack=[StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013892784, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], null,
null, null, null, null, null, null]], lastRead=true]]
]]
WARN 2017-06-13 20:37:44 [grid-nio-worker-tcp-comm-1-#18%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=1, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:44 [grid-nio-worker-tcp-comm-2-#19%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=2, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:44 [grid-nio-worker-tcp-comm-3-#20%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=3, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Failed to wait for partition map exchange
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0],
node=7fc5ea30-913d-4ff5-932b-62d81c6027db]. Dumping pending objects that
might be the cause: ]]
WARN 2017-06-13 20:37:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Ready affinity version: AffinityTopologyVersion [topVer=-1,
minorTopVer=0]]]
WARN 2017-06-13 20:37:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last exchange future: GridDhtPartitionsExchangeFuture [dummy=false,
forcePreload=false, reassign=false, discoEvt=DiscoveryEvent
[evtNode=TcpDiscoveryNode [id=7fc5ea30-913d-4ff5-932b-62d81c6027db,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62,
intOrder=33, lastExchangeTime=1497353874839, loc=true,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], topVer=62,
nodeId8=7fc5ea30, msg=null, type=NODE_JOINED, tstamp=1497353784308],
crd=TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false],
exchId=GridDhtPartitionExchangeId [topVer=AffinityTopologyVersion
[topVer=62, minorTopVer=0], nodeId=7fc5ea30, evt=NODE_JOINED], added=false,
initFut=GridFutureAdapter [ignoreInterrupts=false, state=DONE, res=true,
hash=1130708319], init=true, lastVer=null, partReleaseFut=GridCompoundFuture
[rdc=null, initFlag=1, lsnrCalls=4, done=true, cancelled=false, err=null,
futs=[true, true, true, true]], affChangeMsg=null, skipPreload=false,
clientOnlyExchange=false, initTs=1497353784601, centralizedAff=false,
changeGlobalStateE=null, exchangeOnChangeGlobalState=false,
forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353874839, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:37:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending exchange futures:]]
WARN 2017-06-13 20:37:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Last 10 exchange futures (total: 1):]]
WARN 2017-06-13 20:37:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[>>> GridDhtPartitionsExchangeFuture [dummy=false, forcePreload=false,
reassign=false, discoEvt=DiscoveryEvent [evtNode=TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353874839, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], topVer=62, nodeId8=7fc5ea30, msg=null, type=NODE_JOINED,
tstamp=1497353784308], crd=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], exchId=GridDhtPartitionExchangeId
[topVer=AffinityTopologyVersion [topVer=62, minorTopVer=0], nodeId=7fc5ea30,
evt=NODE_JOINED], added=false, initFut=GridFutureAdapter
[ignoreInterrupts=false, state=DONE, res=true, hash=1130708319], init=true,
lastVer=null, partReleaseFut=GridCompoundFuture [rdc=null, initFlag=1,
lsnrCalls=4, done=true, cancelled=false, err=null, futs=[true, true, true,
true]], affChangeMsg=null, skipPreload=false, clientOnlyExchange=false,
initTs=1497353784601, centralizedAff=false, changeGlobalStateE=null,
exchangeOnChangeGlobalState=false, forcedRebFut=null, evtLatch=0,
remaining=[a7a74608-3b2d-440f-910d-3ef3537d907f,
a4a43486-2322-475c-9b25-aef7907500dc, f03fe6d2-8858-4b32-9ac2-260d1a79693a],
srvNodes=[TcpDiscoveryNode [id=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1,
intOrder=1, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=a4a43486-2322-475c-9b25-aef7907500dc, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9461], discPort=9461, order=2, intOrder=2,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], TcpDiscoveryNode [id=a7a74608-3b2d-440f-910d-3ef3537d907f,
addrs=[127.0.0.1], sockAddrs=[/127.0.0.1:9462], discPort=9462, order=60,
intOrder=32, lastExchangeTime=1497353784020, loc=false,
ver=2.0.0#20170430-sha1:d4eef3c6, isClient=false], TcpDiscoveryNode
[id=7fc5ea30-913d-4ff5-932b-62d81c6027db, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9463], discPort=9463, order=62, intOrder=33,
lastExchangeTime=1497353874839, loc=true, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false]], super=GridFutureAdapter [ignoreInterrupts=false,
state=INIT, res=null, hash=277178513]]]]
WARN 2017-06-13 20:37:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transactions:]]
WARN 2017-06-13 20:37:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending explicit locks:]]
WARN 2017-06-13 20:37:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending cache futures:]]
WARN 2017-06-13 20:37:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending atomic cache futures:]]
WARN 2017-06-13 20:37:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending data streamer futures:]]
WARN 2017-06-13 20:37:54 [exchange-worker-#29%svip%]
org.apache.ignite.internal.processors.cache.GridCachePartitionExchangeManager
- [[Pending transaction deadlock detection futures:]]
WARN 2017-06-13 20:37:54 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi -
[[Communication SPI recovery descriptors:
[key=ConnectionKey [nodeId=f03fe6d2-8858-4b32-9ac2-260d1a79693a, idx=0,
connCnt=-1], msgsSent=3, msgsAckedByRmt=3, msgsRcvd=2, lastAcked=2,
reserveCnt=1, descIdHash=2015302722]
Communication SPI clients:
[node=f03fe6d2-8858-4b32-9ac2-260d1a79693a,
client=GridTcpNioCommunicationClient [ses=GridSelectorNioSessionImpl
[worker=DirectNioClientWorker [super=AbstractNioClientWorker
[selector=sun.nio.ch.EPollSelectorImpl@3e96a835, idx=0, bytesRcvd=45363,
bytesSent=1315, bytesRcvd0=0, bytesSent0=0, select=true, super=GridWorker
[name=grid-nio-worker-tcp-comm-0, igniteInstanceName=svip, finished=false,
hashCode=518525437, interrupted=false,
runner=grid-nio-worker-tcp-comm-0-#17%svip%]]],
writeBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
readBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
inRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=2, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false],
outRecovery=GridNioRecoveryDescriptor [acked=3, resendCnt=0, rcvCnt=2,
sentCnt=3, reserved=true, lastAck=2, nodeLeft=false, node=TcpDiscoveryNode
[id=f03fe6d2-8858-4b32-9ac2-260d1a79693a, addrs=[127.0.0.1],
sockAddrs=[/127.0.0.1:9460], discPort=9460, order=1, intOrder=1,
lastExchangeTime=1497353784020, loc=false, ver=2.0.0#20170430-sha1:d4eef3c6,
isClient=false], connected=true, connectCnt=1, queueLimit=4096,
reserveCnt=1, pairedConnections=false], super=GridNioSessionImpl
[locAddr=/127.0.0.1:47331, rmtAddr=/127.0.0.1:9340,
createTime=1497353784631, closeTime=0, bytesSent=1315, bytesRcvd=45363,
bytesSent0=0, bytesRcvd0=0, sndSchedTime=1497353848962,
lastSndTime=1497353813114, lastRcvTime=1497353848962, readsPaused=false,
filterChain=FilterChain[filters=[GridNioCodecFilter
[parser=o.a.i.i.util.nio.GridDirectParser@5e7030df, directMode=true],
GridConnectionBytesVerifyFilter], accepted=false]],
super=GridAbstractCommunicationClient [lastUsed=1497353784642, closed=false,
connIdx=0]]]
]]
WARN 2017-06-13 20:37:54 [exchange-worker-#29%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[NIO server
statistics [readerSesBalanceCnt=0, writerSesBalanceCnt=0]]]
WARN 2017-06-13 20:37:54 [grid-nio-worker-tcp-comm-0-#17%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=0, keysCnt=1, bytesRcvd=45363, bytesRcvd0=0,
>> bytesSent=1315, bytesSent0=0]
Connection info [in=false, rmtAddr=/127.0.0.1:9340,
locAddr=/127.0.0.1:47331, msgsSent=3, msgsAckedByRmt=3,
descIdHash=2015302722, msgsRcvd=2, lastAcked=2, descIdHash=2015302722,
bytesRcvd=45363, bytesRcvd0=0, bytesSent=1315, bytesSent0=0, opQueueSize=0,
msgWriter=DirectMessageWriter [state=DirectMessageState [pos=0,
stack=[StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013860000, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0, hdrWritten=false],
null, null, null, null, null, null]]], msgReader=DirectMessageReader
[state=DirectMessageState [pos=0, stack=[StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0],
StateItem [stream=DirectByteBufferStreamImplV2
[buf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
baseOff=139765013892784, arrOff=-1, tmpArrOff=0, tmpArrBytes=0,
msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1, keyDone=false,
readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0, uuidMost=0,
uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], StateItem
[stream=DirectByteBufferStreamImplV2 [buf=java.nio.DirectByteBuffer[pos=0
lim=32768 cap=32768], baseOff=139765013892784, arrOff=-1, tmpArrOff=0,
tmpArrBytes=0, msgTypeDone=false, msg=null, mapIt=null, it=null, arrPos=-1,
keyDone=false, readSize=-1, readItems=0, prim=0, primShift=0, uuidState=0,
uuidMost=0, uuidLeast=0, uuidLocId=0, lastFinished=true], state=0], null,
null, null, null, null, null, null]], lastRead=true]]
]]
WARN 2017-06-13 20:37:54 [grid-nio-worker-tcp-comm-1-#18%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=1, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:54 [grid-nio-worker-tcp-comm-2-#19%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=2, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
WARN 2017-06-13 20:37:54 [grid-nio-worker-tcp-comm-3-#20%svip%]
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi - [[
>> Selector info [idx=3, keysCnt=0, bytesRcvd=0, bytesRcvd0=0, bytesSent=0,
>> bytesSent0=0]
]]
--
View this message in context:
http://apache-ignite-users.70518.x6.nabble.com/Failed-to-wait-for-initial-partition-map-exchange-tp6252p13645.html
Sent from the Apache Ignite Users mailing list archive at Nabble.com.
