[
https://issues.apache.org/jira/browse/IGNITE-10136?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
Maxim Muzafarov updated IGNITE-10136:
-------------------------------------
Fix Version/s: (was: 2.8)
2.8.1
2.9
> 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.9, 2.8.1
>
>
> {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)
