You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@ignite.apache.org by "Maxim Muzafarov (Jira)" <ji...@apache.org> on 2019/10/02 13:51:00 UTC
[jira] [Commented] (IGNITE-10136) NPE in
PartitionUpdateCountersMessage
[ https://issues.apache.org/jira/browse/IGNITE-10136?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=16942832#comment-16942832 ]
Maxim Muzafarov commented on IGNITE-10136:
------------------------------------------
[~skozlov]
Does this issue is still actual?
> NPE in PartitionUpdateCountersMessage
> -------------------------------------
>
> Key: IGNITE-10136
> URL: https://issues.apache.org/jira/browse/IGNITE-10136
> Project: Ignite
> Issue Type: Bug
> Affects Versions: 2.7
> Reporter: Sergey Kozlov
> Assignee: Sergey Kozlov
> Priority: Critical
> Fix For: 2.8
>
>
> {noformat}
> [14:00:55,950][INFO][db-checkpoint-thread-#73][GridCacheDatabaseSharedManager] Checkpoint started [checkpointId=9d5398bc-896a-469c-8686-38e2afd517c1, startPtr=FileWALPointer [idx=0, fileOff=17828636, len=210609], checkpointLockWait=0ms, checkpointLockHoldTime=11ms, walCpRecordFsyncDuration=12ms, pages=636, reason='timeout']
> [14:00:56,029][INFO][db-checkpoint-thread-#73][GridCacheDatabaseSharedManager] Checkpoint finished [cpId=9d5398bc-896a-469c-8686-38e2afd517c1, pages=636, markPos=FileWALPointer [idx=0, fileOff=17828636, len=210609], walSegmentsCleared=0, walSegmentsCovered=[], markDuration=26ms, pagesWrite=21ms, fsync=58ms, total=105ms]
> [14:00:56,940][INFO][db-checkpoint-thread-#73][GridCacheDatabaseSharedManager] Checkpoint started [checkpointId=5f46c89e-ead8-4c87-adad-72a50c26bd7c, startPtr=FileWALPointer [idx=0, fileOff=20005440, len=210609], checkpointLockWait=0ms, checkpointLockHoldTime=8ms, walCpRecordFsyncDuration=5ms, pages=474, reason='timeout']
> [14:00:57,003][INFO][db-checkpoint-thread-#73][GridCacheDatabaseSharedManager] Checkpoint finished [cpId=5f46c89e-ead8-4c87-adad-72a50c26bd7c, pages=474, markPos=FileWALPointer [idx=0, fileOff=20005440, len=210609], walSegmentsCleared=0, walSegmentsCovered=[], markDuration=15ms, pagesWrite=10ms, fsync=53ms, total=78ms]
> [14:00:57,065][SEVERE][grid-nio-worker-tcp-comm-2-#42][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=792 lim=885 cap=32768], reader=RollingUpgradeMessageReader [state=StateItem [stream=DirectByteBufferStreamImplV2 [baseOff=140703933959040, arrOff=-1, tmpArrOff=0, valReadBytes=0, tmpArrBytes=0, msgTypeDone=true, msg=GridCacheIdMessage [cacheId=0]GridDistributedBaseMessage [ver=GridCacheVersion [topVer=152301622, order=1540821647376, nodeOrder=4], committedVers=null, rolledbackVers=null, cnt=0, super=]GridDistributedTxPrepareRequest [threadId=236, concurrency=PESSIMISTIC, isolation=REPEATABLE_READ, writeVer=GridCacheVersion [topVer=152301622, order=1540821647377, nodeOrder=4], timeout=0, reads=null, writes=ArrayList [], dhtVers=null, txSize=-1, plc=2, txState=null, flags=last, super=]GridDhtTxPrepareRequest [nearNodeId=3800f476-beb1-46b0-8a39-faa51c91831d, futId=f794020c661-cc8749ef-caa5-4f1e-9d89-4a9beff59798, miniId=1, topVer=AffinityTopologyVersion [topVer=5, minorTopVer=8], invalidateNearEntries={}, nearWrites=null, owned=null, nearXidVer=GridCacheVersion [topVer=152301622, order=1540821647374, nodeOrder=5], subjId=3800f476-beb1-46b0-8a39-faa51c91831d, taskNameHash=0, preloadKeys=null, mvccSnapshot=MvccSnapshotResponse [futId=1, crdVer=1540821617885, cntr=16, opCntr=1, txs=null, cleanupVer=15, tracking=0], skipCompletedVers=false, super=], 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, fieldCnt=7, readFieldCnt=0, curName=msg, typeRead=true, itemTypeRead=false, keyTypeRead=false, valTypeRead=false, curType=21, curItemType=null, curKeyType=null, curValType=null, readMsgCls=class o.a.i.i.managers.communication.GridIoMessage]StateItem [stream=DirectByteBufferStreamImplV2 [baseOff=140703933959040, arrOff=-1, tmpArrOff=0, valReadBytes=0, tmpArrBytes=0, msgTypeDone=true, msg=PartitionUpdateCountersMessage{cacheId=-553317389, size=0, cntrs=}, 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, fieldCnt=-1, readFieldCnt=0, curName=null, typeRead=false, itemTypeRead=false, keyTypeRead=false, valTypeRead=false, curType=0, curItemType=null, curKeyType=null, curValType=null, readMsgCls=null]StateItem [stream=DirectByteBufferStreamImplV2 [baseOff=140703933959040, arrOff=-1, tmpArrOff=0, valReadBytes=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, fieldCnt=-1, readFieldCnt=0, curName=null, typeRead=false, itemTypeRead=false, keyTypeRead=false, valTypeRead=false, curType=0, curItemType=null, curKeyType=null, curValType=null, readMsgCls=null]StateItem [stream=DirectByteBufferStreamImplV2 [baseOff=140703933959040, arrOff=-1, tmpArrOff=0, valReadBytes=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, fieldCnt=-1, readFieldCnt=0, curName=null, typeRead=false, itemTypeRead=false, keyTypeRead=false, valTypeRead=false, curType=0, curItemType=null, curKeyType=null, curValType=null, readMsgCls=null]StateItem [stream=DirectByteBufferStreamImplV2 [baseOff=140703933959040, arrOff=-1, tmpArrOff=0, valReadBytes=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, fieldCnt=-1, readFieldCnt=0, curName=null, typeRead=false, itemTypeRead=false, keyTypeRead=false, valTypeRead=false, curType=0, curItemType=null, curKeyType=null, curValType=null, readMsgCls=null]DirectMessageState [pos=0, stack=[, , , , , null, null, null, null, null]], lastRead=true], ses=GridSelectorNioSessionImpl [worker=GridWorker [name=grid-nio-worker-tcp-comm-2, igniteInstanceName=null, finished=false, heartbeatTs=1540821657026, hashCode=1663168647, interrupted=false, runner=grid-nio-worker-tcp-comm-2-#42]AbstractNioClientWorker [idx=2, bytesRcvd=1489505, bytesSent=791387, bytesRcvd0=874094, bytesSent0=495009, select=true, super=]DirectNioClientWorker [super=], writeBuf=java.nio.DirectByteBuffer[pos=0 lim=32768 cap=32768], readBuf=java.nio.DirectByteBuffer[pos=792 lim=885 cap=32768], inRecovery=GridNioRecoveryDescriptor [acked=1440, resendCnt=0, rcvCnt=1559, sentCnt=1447, reserved=true, lastAck=1536, nodeLeft=false, node=TcpDiscoveryNode [id=06168729-530d-4318-b066-29b42762edda, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47503], discPort=47503, order=4, intOrder=4, lastExchangeTime=1540821634193, loc=false, ver=2.7.1#20181029-sha1:83c27088, isClient=false], connected=true, connectCnt=0, queueLimit=4096, reserveCnt=1, pairedConnections=false], outRecovery=GridNioRecoveryDescriptor [acked=1440, resendCnt=0, rcvCnt=1559, sentCnt=1447, reserved=true, lastAck=1536, nodeLeft=false, node=TcpDiscoveryNode [id=06168729-530d-4318-b066-29b42762edda, addrs=ArrayList [127.0.0.1], sockAddrs=HashSet [/127.0.0.1:47503], discPort=47503, order=4, intOrder=4, lastExchangeTime=1540821634193, loc=false, ver=2.7.1#20181029-sha1:83c27088, isClient=false], connected=true, connectCnt=0, queueLimit=4096, reserveCnt=1, pairedConnections=false], super=GridNioSessionImpl [locAddr=/127.0.0.1:47101, rmtAddr=/127.0.0.1:41260, createTime=1540821640738, closeTime=0, bytesSent=791387, bytesRcvd=1489505, bytesSent0=495009, bytesRcvd0=874094, sndSchedTime=1540821640738, lastSndTime=1540821657026, lastRcvTime=1540821657036, readsPaused=false, filterChain=GridNioCodecFilter [parser=o.a.i.i.util.nio.GridDirectParser@4d763e1f, directMode=true]FilterChain[filters=[, GridConnectionBytesVerifyFilter], accepted=true, markedForClose=false]]]
> java.lang.NullPointerException
> at org.apache.ignite.internal.processors.cache.distributed.dht.PartitionUpdateCountersMessage.readFrom(PartitionUpdateCountersMessage.java:215)
> at org.apache.ignite.internal.direct.stream.v2.DirectByteBufferStreamImplV2.readMessage(DirectByteBufferStreamImplV2.java:1178)
> at org.apache.ignite.internal.direct.stream.v2.DirectByteBufferStreamImplV2.read(DirectByteBufferStreamImplV2.java:1779)
> at org.apache.ignite.internal.direct.stream.v2.DirectByteBufferStreamImplV2.readCollection(DirectByteBufferStreamImplV2.java:1257)
> at org.gridgain.grid.internal.communication.RollingUpgradeMessageReader.readCollection(RollingUpgradeMessageReader.java:401)
> at org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTxPrepareRequest.readFrom(GridDhtTxPrepareRequest.java:645)
> at org.apache.ignite.internal.direct.stream.v2.DirectByteBufferStreamImplV2.readMessage(DirectByteBufferStreamImplV2.java:1178)
> at org.gridgain.grid.internal.communication.RollingUpgradeMessageReader.readMessage(RollingUpgradeMessageReader.java:365)
> at org.apache.ignite.internal.managers.communication.GridIoMessage.readFrom(GridIoMessage.java:262)
> 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:3553)
> at org.apache.ignite.internal.util.nio.GridNioFilterChain.onMessageReceived(GridNioFilterChain.java:175)
> at org.apache.ignite.internal.util.nio.GridNioServer$DirectNioClientWorker.processRead(GridNioServer.java:1303)
> at org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.processSelectedKeysOptimized(GridNioServer.java:2389)
> at org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.bodyInternal(GridNioServer.java:2156)
> at org.apache.ignite.internal.util.nio.GridNioServer$AbstractNioClientWorker.body(GridNioServer.java:1797)
> at org.apache.ignite.internal.util.worker.GridWorker.run(GridWorker.java:120)
> at java.lang.Thread.run(Thread.java:748)
> [14:00:57,956][INFO][db-checkpoint-thread-#73][GridCacheDatabaseSharedManager] Checkpoint started [checkpointId=82318c66-2933-493a-8e7e-c4170420cd70, startPtr=FileWALPointer [idx=0, fileOff=20368709, len=210609], checkpointLockWait=0ms, checkpointLockHoldTime=20ms, walCpRecordFsyncDuration=1ms, pages=44, reason='timeout']
> [14:00:57,962][INFO][db-checkpoint-thread-#73][GridCacheDatabaseSharedManager] Checkpoint finished [cpId=82318c66-2933-493a-8e7e-c4170420cd70, pages=44, markPos=FileWALPointer [idx=0, fileOff=20368709, len=210609], walSegmentsCleared=0, walSegmentsCovered=[], markDuration=23ms, pagesWrite=1ms, fsync=4ms, total=29ms]
> {noformat}
--
This message was sent by Atlassian Jira
(v8.3.4#803005)