[
https://issues.apache.org/jira/browse/IGNITE-5538?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=16080467#comment-16080467
]
Ilya Suntsov commented on IGNITE-5538:
--------------------------------------
I've re-checked this issue and got another exception on
*PersistentStoreExampleNodeStartup*
{noformat}
2017-07-10
18:03:21,143][ERROR][grid-nio-worker-tcp-comm-2-#19%null%][GridDirectParser]
Failed to read message [msg=GridIoMessage [plc=0, topic=null, topicOrd=-1,
ordered=false, timeout=0, skipOnTimeout=false, msg=null],
buf=java.nio.DirectByteBuffer[pos=4 lim=186 cap=32768],
reader=DirectMessageReader [state=DirectMessageState [pos=0, stack=[StateItem
[stream=DirectByteBufferStreamImplV2 [baseOff=140442328149504, 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, null, null]],
lastRead=false], ses=GridSelectorNioSessionImpl [worker=DirectNioClientWorker
[super=AbstractNioClientWorker [idx=2, bytesRcvd=9078, bytesSent=1092,
bytesRcvd0=228, bytesSent0=28, select=true, super=GridWorker
[name=grid-nio-worker-tcp-comm-2, igniteInstanceName=null, finished=false,
hashCode=1625090318, interrupted=false,
runner=grid-nio-worker-tcp-comm-2-#19%null%]]],
writeBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
readBuf=java.nio.DirectByteBuffer[pos=4 lim=186 cap=32768],
inRecovery=GridNioRecoveryDescriptor [acked=102, resendCnt=0, rcvCnt=103,
sentCnt=102, reserved=true, lastAck=96, nodeLeft=false, node=TcpDiscoveryNode
[id=c7daa293-fa04-46e2-9bac-00bc74fea454, addrs=[0:0:0:0:0:0:0:1, 127.0.0.1,
192.168.1.143, 2001:db8:85a3:0:0:8a2e:370:7334], sockAddrs=[/0:0:0:0:0:0:0:1:0,
/127.0.0.1:0, /2001:db8:85a3:0:0:8a2e:370:7334:0, mpb/192.168.1.143:0],
discPort=0, order=2, intOrder=2, lastExchangeTime=1499698832629, loc=false,
ver=2.1.2#20170707-sha1:17904cb1, isClient=true], connected=true, connectCnt=1,
queueLimit=4096, reserveCnt=158, pairedConnections=false],
outRecovery=GridNioRecoveryDescriptor [acked=102, resendCnt=0, rcvCnt=103,
sentCnt=102, reserved=true, lastAck=96, nodeLeft=false, node=TcpDiscoveryNode
[id=c7daa293-fa04-46e2-9bac-00bc74fea454, addrs=[0:0:0:0:0:0:0:1, 127.0.0.1,
192.168.1.143, 2001:db8:85a3:0:0:8a2e:370:7334], sockAddrs=[/0:0:0:0:0:0:0:1:0,
/127.0.0.1:0, /2001:db8:85a3:0:0:8a2e:370:7334:0, mpb/192.168.1.143:0],
discPort=0, order=2, intOrder=2, lastExchangeTime=1499698832629, loc=false,
ver=2.1.2#20170707-sha1:17904cb1, isClient=true], connected=true, connectCnt=1,
queueLimit=4096, reserveCnt=158, pairedConnections=false],
super=GridNioSessionImpl [locAddr=/0:0:0:0:0:0:0:1:47100,
rmtAddr=/0:0:0:0:0:0:0:1:50726, createTime=1499699001135, closeTime=0,
bytesSent=28, bytesRcvd=228, bytesSent0=28, bytesRcvd0=228,
sndSchedTime=1499699001135, lastSndTime=1499699001135,
lastRcvTime=1499699001135, readsPaused=false,
filterChain=FilterChain[filters=[GridNioCodecFilter
[parser=o.a.i.i.util.nio.GridDirectParser@6df9f203, directMode=true],
GridConnectionBytesVerifyFilter], accepted=true]]]
java.lang.NullPointerException
at
org.apache.ignite.internal.managers.communication.GridIoMessageFactory.create(GridIoMessageFactory.java:879)
at
org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi$9.create(TcpCommunicationSpi.java:2140)
at
org.apache.ignite.internal.direct.stream.v2.DirectByteBufferStreamImplV2.readMessage(DirectByteBufferStreamImplV2.java:1154)
at
org.apache.ignite.internal.direct.DirectMessageReader.readMessage(DirectMessageReader.java:311)
at
org.apache.ignite.internal.managers.communication.GridIoMessage.readFrom(GridIoMessage.java:261)
at
org.apache.ignite.internal.util.nio.GridDirectParser.decode(GridDirectParser.java:90)
at
org.apache.ignite.internal.util.nio.GridNioCodecFilter.onMessageReceived(GridNioCodecFilter.java:114)
at
org.apache.ignite.internal.util.nio.GridNioFilterAdapter.proceedMessageReceived(GridNioFilterAdapter.java:109)
at
org.apache.ignite.internal.util.nio.GridConnectionBytesVerifyFilter.onMessageReceived(GridConnectionBytesVerifyFilter.java:133)
at
org.apache.ignite.internal.util.nio.GridNioFilterAdapter.proceedMessageReceived(GridNioFilterAdapter.java:109)
at
org.apache.ignite.internal.util.nio.GridNioServer$HeadFilter.onMessageReceived(GridNioServer.java:3222)
at
org.apache.ignite.internal.util.nio.GridNioFilterChain.onMessageReceived(GridNioFilterChain.java:175)
at
org.apache.ignite.internal.util.nio.GridNioServer$DirectNioClientWorker.processRead(GridNioServer.java:1213)
at
org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.processSelectedKeysOptimized(GridNioServer.java:2180)
at
org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.bodyInternal(GridNioServer.java:1968)
at
org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.body(GridNioServer.java:1669)
at
org.apache.ignite.internal.util.worker.GridWorker.run(GridWorker.java:110)
at java.lang.Thread.run(Thread.java:745)
[2017-07-10
18:03:22,147][ERROR][grid-nio-worker-tcp-comm-2-#19%null%][TcpCommunicationSpi]
Closing NIO session because of unhandled exception.
class org.apache.ignite.internal.util.nio.GridNioException: null
at
org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.processSelectedKeysOptimized(GridNioServer.java:2199)
at
org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.bodyInternal(GridNioServer.java:1968)
at
org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.body(GridNioServer.java:1669)
at
org.apache.ignite.internal.util.worker.GridWorker.run(GridWorker.java:110)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.NullPointerException
{noformat}
> NPE (PersistentStoreExample)
> ----------------------------
>
> Key: IGNITE-5538
> URL: https://issues.apache.org/jira/browse/IGNITE-5538
> Project: Ignite
> Issue Type: Bug
> Components: cache
> Affects Versions: 2.1
> Reporter: Ilya Suntsov
> Assignee: Pavel Kovalenko
> Fix For: 2.1
>
> Attachments: PersistentStoreExampleNode.txt,
> PersistentStoreExample.txt
>
>
> Steps to reproduce:
> 1. Start *PersistentStoreExampleNodeStartup*
> 2. Start *PersistentStoreExample* (UPLOAD=true)
> Result:
> 1. Topology snapshot [ver=2, servers=1, clients=1, CPUs=8, heap=7.1GB]
> 2. Started preloading
> 3. On ExampleNode got exception:
> {noformat}
> [2017-06-19 13:11:28,545][WARN
> ][grid-nio-worker-tcp-comm-3-#20%null%][TcpCommunicationSpi] Failed to
> process selector key (will close): GridSelectorNioSessionImpl
> [worker=DirectNioClientWorker [super=AbstractNioClientWorker [idx=3,
> bytesRcvd=2052, bytesSent=252, bytesRcvd0=228, bytesSent0=28, select=true,
> super=GridWorker [name=grid-nio-worker-tcp-comm-3, igniteInstanceName=null,
> finished=false, hashCode=1279096191, interrupted=false,
> runner=grid-nio-worker-tcp-comm-3-#20%null%]]],
> writeBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768],
> readBuf=java.nio.DirectByteBuffer[pos=4 lim=186 cap=32768],
> inRecovery=GridNioRecoveryDescriptor [acked=103, resendCnt=0, rcvCnt=104,
> sentCnt=103, reserved=true, lastAck=96, nodeLeft=false, node=TcpDiscoveryNode
> [id=be66eae2-3986-4772-b02b-bf2813370a15, addrs=[0:0:0:0:0:0:0:1, 127.0.0.1,
> 172.25.4.115, 172.25.4.116, 2001:db8:85a3:0:0:8a2e:370:7334],
> sockAddrs=[/0:0:0:0:0:0:0:1:0, /127.0.0.1:0, /172.25.4.115:0,
> /172.25.4.116:0, /2001:db8:85a3:0:0:8a2e:370:7334:0], discPort=0, order=2,
> intOrder=2, lastExchangeTime=1497867042970, loc=false,
> ver=2.1.1#20170618-sha1:09ce29e0, isClient=true], connected=true,
> connectCnt=1, queueLimit=4096, reserveCnt=35, pairedConnections=false],
> outRecovery=GridNioRecoveryDescriptor [acked=103, resendCnt=0, rcvCnt=104,
> sentCnt=103, reserved=true, lastAck=96, nodeLeft=false, node=TcpDiscoveryNode
> [id=be66eae2-3986-4772-b02b-bf2813370a15, addrs=[0:0:0:0:0:0:0:1, 127.0.0.1,
> 172.25.4.115, 172.25.4.116, 2001:db8:85a3:0:0:8a2e:370:7334],
> sockAddrs=[/0:0:0:0:0:0:0:1:0, /127.0.0.1:0, /172.25.4.115:0,
> /172.25.4.116:0, /2001:db8:85a3:0:0:8a2e:370:7334:0], discPort=0, order=2,
> intOrder=2, lastExchangeTime=1497867042970, loc=false,
> ver=2.1.1#20170618-sha1:09ce29e0, isClient=true], connected=true,
> connectCnt=1, queueLimit=4096, reserveCnt=35, pairedConnections=false],
> super=GridNioSessionImpl [locAddr=/0:0:0:0:0:0:0:1:47100,
> rmtAddr=/0:0:0:0:0:0:0:1:60813, createTime=1497867087529, closeTime=0,
> bytesSent=28, bytesRcvd=228, bytesSent0=28, bytesRcvd0=228,
> sndSchedTime=1497867087529, lastSndTime=1497867087529,
> lastRcvTime=1497867087541, readsPaused=false,
> filterChain=FilterChain[filters=[GridNioCodecFilter
> [parser=o.a.i.i.util.nio.GridDirectParser@7a94a8f6, directMode=true],
> GridConnectionBytesVerifyFilter], accepted=true]]
> [2017-06-19
> 13:11:28,545][ERROR][grid-nio-worker-tcp-comm-3-#20%null%][TcpCommunicationSpi]
> Closing NIO session because of unhandled exception.
> class org.apache.ignite.internal.util.nio.GridNioException: null
> at
> org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.processSelectedKeysOptimized(GridNioServer.java:2199)
> at
> org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.bodyInternal(GridNioServer.java:1968)
> at
> org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.body(GridNioServer.java:1669)
> at
> org.apache.ignite.internal.util.worker.GridWorker.run(GridWorker.java:110)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: java.lang.NullPointerException
> at
> org.apache.ignite.internal.managers.communication.GridIoMessageFactory.create(GridIoMessageFactory.java:879)
> at
> org.apache.ignite.spi.communication.tcp.TcpCommunicationSpi$9.create(TcpCommunicationSpi.java:2134)
> at
> org.apache.ignite.internal.direct.stream.v2.DirectByteBufferStreamImplV2.readMessage(DirectByteBufferStreamImplV2.java:1154)
> at
> org.apache.ignite.internal.direct.DirectMessageReader.readMessage(DirectMessageReader.java:311)
> at
> org.apache.ignite.internal.managers.communication.GridIoMessage.readFrom(GridIoMessage.java:261)
> at
> org.apache.ignite.internal.util.nio.GridDirectParser.decode(GridDirectParser.java:90)
> at
> org.apache.ignite.internal.util.nio.GridNioCodecFilter.onMessageReceived(GridNioCodecFilter.java:114)
> at
> org.apache.ignite.internal.util.nio.GridNioFilterAdapter.proceedMessageReceived(GridNioFilterAdapter.java:109)
> at
> org.apache.ignite.internal.util.nio.GridConnectionBytesVerifyFilter.onMessageReceived(GridConnectionBytesVerifyFilter.java:133)
> at
> org.apache.ignite.internal.util.nio.GridNioFilterAdapter.proceedMessageReceived(GridNioFilterAdapter.java:109)
> at
> org.apache.ignite.internal.util.nio.GridNioServer$HeadFilter.onMessageReceived(GridNioServer.java:3222)
> at
> org.apache.ignite.internal.util.nio.GridNioFilterChain.onMessageReceived(GridNioFilterChain.java:175)
> at
> org.apache.ignite.internal.util.nio.GridNioServer$DirectNioClientWorker.processRead(GridNioServer.java:1213)
> at
> org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.processSelectedKeysOptimized(GridNioServer.java:2180)
> ... 4 more
> {noformat}
> Full logs in attachment.
--
This message was sent by Atlassian JIRA
(v6.4.14#64029)
