Ivan Artukhov created IGNITE-8236:
-------------------------------------
Summary: Sporadic NPE in IgniteAtomicSequenceExample
Key: IGNITE-8236
URL: https://issues.apache.org/jira/browse/IGNITE-8236
Project: Ignite
Issue Type: Bug
Components: data structures
Affects Versions: 1.9
Reporter: Ivan Artukhov
Attachments: IgniteAtomicSequenceExample.1.zip
Platforms: Linux, Windows
Reproducibility: ~30%
Sometimes the _datastructures.IgniteAtomicSequenceExample_ throws the following
exception during run:
{code}
[06:26:26,810][SEVERE][utility-#62%null%][GridCacheIoManager] Failed processing
message [senderId=71fea304-3e08-4706-880a-7b00bebb280f,
msg=GridNearTxPrepareRequest
[futId=d889888b261-bc99dff6-1c40-4ab1-90d2-5a1d12832afc,
miniId=e889888b261-bc99dff6-1c40-4ab1-90d2-5a1d12832afc, near=false,
topVer=AffinityTopologyVersion [topVer=2, minorTopVer=0], last=true,
lastBackups=null, retVal=false, implicitSingle=false, explicitLock=false,
subjId=71fea304-3e08-4706-880a-7b00bebb280f, taskNameHash=0,
firstClientReq=false, super=GridDistributedTxPrepareRequest [threadId=134,
concurrency=PESSIMISTIC, isolation=REPEATABLE_READ, writeVer=GridCacheVersion
[topVer=134994380, time=1523514386721, order=1523514383656, nodeOrder=2],
timeout=0, invalidate=false, reads=[], writes=[IgniteTxEntry
[key=KeyCacheObjectImpl [val=CacheDataStructuresConfigurationKey [],
hasValBytes=true], cacheId=-2100569601, partId=-1, txKey=IgniteTxKey
[key=KeyCacheObjectImpl [val=CacheDataStructuresConfigurationKey [],
hasValBytes=true], cacheId=-2100569601], val=[op=TRANSFORM, val=null],
prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null],
entryProcessorsCol=[IgniteBiTuple [val1=AddAtomicProcessor
[info=DataStructureInfo [name=example-sequence, type=ATOMIC_SEQ]],
val2=[Ljava.lang.Object;@1540f725]], ttl=-1, conflictExpireTime=-1,
conflictVer=null, explicitVer=null, dhtVer=null, filters=[],
filtersPassed=false, filtersSet=false, entry=GridDhtColocatedCacheEntry
[super=GridDhtCacheEntry [rdrs=[], locPart=GridDhtLocalPartition
[rmvQueueMaxSize=128, rmvdEntryTtl=10000, id=21,
map=o.a.i.i.processors.cache.GridCacheConcurrentMapImpl@1ea42fb7, cntr=1,
shouldBeRenting=false, state=OWNING, reservations=0, empty=false,
createTime=04/12/2018 06:26:18], super=GridDistributedCacheEntry
[super=GridCacheMapEntry [key=KeyCacheObjectImpl
[val=CacheDataStructuresConfigurationKey [], hasValBytes=true],
val=CacheObjectImpl [val={example-sequence=DataStructureInfo
[name=example-sequence, type=ATOMIC_SEQ]}, hasValBytes=true],
startVer=1523514383659, ver=GridCacheVersion [topVer=134994380,
time=1523514386783, order=1523514383665, nodeOrder=1], hash=-1424345221,
extras=GridCacheMvccEntryExtras [mvcc=GridCacheMvcc
[locs=[GridCacheMvccCandidate [nodeId=15305184-e5a2-4872-a549-d98e0df8b745,
ver=GridCacheVersion [topVer=134994380, time=1523514386744,
order=1523514383660, nodeOrder=1], threadId=113, id=6,
topVer=AffinityTopologyVersion [topVer=2, minorTopVer=0], reentry=null,
otherNodeId=15305184-e5a2-4872-a549-d98e0df8b745, otherVer=GridCacheVersion
[topVer=134994380, time=1523514386744, order=1523514383660, nodeOrder=1],
mappedDhtNodes=null, mappedNearNodes=null, ownerVer=GridCacheVersion
[topVer=134994380, time=1523514386732, order=1523514383657, nodeOrder=1],
serOrder=null, key=KeyCacheObjectImpl [val=CacheDataStructuresConfigurationKey
[], hasValBytes=true],
masks=local=1|owner=1|ready=1|reentry=0|used=0|tx=1|single_implicit=0|dht_local=1|near_local=0|removed=0|read=0,
prevVer=null, nextVer=GridCacheVersion [topVer=134994380, time=1523514386789,
order=1523514383667, nodeOrder=1]]], rmts=null]], flags=0]]]], prepared=0,
locked=false, nodeId=null, locMapped=false, expiryPlc=null,
transferExpiryPlc=false, flags=0, partUpdateCntr=0, serReadVer=null,
xidVer=null]], dhtVers={IgniteTxKey [key=KeyCacheObjectImpl
[val=CacheDataStructuresConfigurationKey [], hasValBytes=true],
cacheId=-2100569601]=null}, txSize=0, onePhaseCommit=true, sys=true, plc=5,
txState=IgniteTxStateImpl [activeCacheIds=GridLongList [idx=1,
arr=[-2100569601]], txMap={IgniteTxKey [key=KeyCacheObjectImpl
[val=CacheDataStructuresConfigurationKey [], hasValBytes=true],
cacheId=-2100569601]=IgniteTxEntry [key=KeyCacheObjectImpl
[val=CacheDataStructuresConfigurationKey [], hasValBytes=true],
cacheId=-2100569601, partId=21, txKey=IgniteTxKey [key=KeyCacheObjectImpl
[val=CacheDataStructuresConfigurationKey [], hasValBytes=true],
cacheId=-2100569601], val=[op=TRANSFORM, val=null], prevVal=[op=NOOP,
val=null], oldVal=[op=NOOP, val=null], entryProcessorsCol=[IgniteBiTuple
[val1=AddAtomicProcessor [info=DataStructureInfo [name=example-sequence,
type=ATOMIC_SEQ]], val2=[Ljava.lang.Object;@1540f725]], ttl=-1,
conflictExpireTime=-1, conflictVer=null, explicitVer=null, dhtVer=null,
filters=[], filtersPassed=false, filtersSet=false,
entry=GridDhtColocatedCacheEntry [super=GridDhtCacheEntry [rdrs=[],
locPart=GridDhtLocalPartition [rmvQueueMaxSize=128, rmvdEntryTtl=10000, id=21,
map=o.a.i.i.processors.cache.GridCacheConcurrentMapImpl@1ea42fb7, cntr=1,
shouldBeRenting=false, state=OWNING, reservations=0, empty=false,
createTime=04/12/2018 06:26:18], super=GridDistributedCacheEntry
[super=GridCacheMapEntry [key=KeyCacheObjectImpl
[val=CacheDataStructuresConfigurationKey [], hasValBytes=true],
val=CacheObjectImpl [val={example-sequence=DataStructureInfo
[name=example-sequence, type=ATOMIC_SEQ]}, hasValBytes=true],
startVer=1523514383659, ver=GridCacheVersion [topVer=134994380,
time=1523514386783, order=1523514383665, nodeOrder=1], hash=-1424345221,
extras=GridCacheMvccEntryExtras [mvcc=GridCacheMvcc
[locs=[GridCacheMvccCandidate [nodeId=15305184-e5a2-4872-a549-d98e0df8b745,
ver=GridCacheVersion [topVer=134994380, time=1523514386744,
order=1523514383660, nodeOrder=1], threadId=113, id=6,
topVer=AffinityTopologyVersion [topVer=2, minorTopVer=0], reentry=null,
otherNodeId=15305184-e5a2-4872-a549-d98e0df8b745, otherVer=GridCacheVersion
[topVer=134994380, time=1523514386744, order=1523514383660, nodeOrder=1],
mappedDhtNodes=null, mappedNearNodes=null, ownerVer=GridCacheVersion
[topVer=134994380, time=1523514386732, order=1523514383657, nodeOrder=1],
serOrder=null, key=KeyCacheObjectImpl [val=CacheDataStructuresConfigurationKey
[], hasValBytes=true],
masks=local=1|owner=1|ready=1|reentry=0|used=0|tx=1|single_implicit=0|dht_local=1|near_local=0|removed=0|read=0,
prevVer=null, nextVer=GridCacheVersion [topVer=134994380, time=1523514386789,
order=1523514383667, nodeOrder=1]]], rmts=null]], flags=0]]]], prepared=0,
locked=false, nodeId=null, locMapped=false, expiryPlc=null,
transferExpiryPlc=false, flags=0, partUpdateCntr=1, serReadVer=null,
xidVer=GridCacheVersion [topVer=134994380, time=1523514386732,
order=1523514383657, nodeOrder=1]]}], super=GridDistributedBaseMessage
[ver=GridCacheVersion [topVer=134994380, time=1523514386721,
order=1523514383656, nodeOrder=2], committedVers=null, rolledbackVers=null,
cnt=0, super=GridCacheMessage [msgId=19, depInfo=GridDeploymentInfoBean
[clsLdrId=2589888b261-71fea304-3e08-4706-880a-7b00bebb280f, depMode=SHARED,
userVer=0, locDepOwner=false, participants=null], err=null, skipPrepare=false,
cacheId=0, cacheId=0]]]]]
java.lang.NullPointerException
at
org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTxPrepareFuture.map(GridDhtTxPrepareFuture.java:1513)
at
org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTxPrepareFuture.map(GridDhtTxPrepareFuture.java:1462)
at
org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTxPrepareFuture.prepare0(GridDhtTxPrepareFuture.java:1194)
at
org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTxPrepareFuture.mapIfLocked(GridDhtTxPrepareFuture.java:667)
at
org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTxPrepareFuture.prepare(GridDhtTxPrepareFuture.java:1040)
at
org.apache.ignite.internal.processors.cache.distributed.dht.GridDhtTxLocal.prepareAsync(GridDhtTxLocal.java:480)
at
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.prepareNearTx(IgniteTxHandler.java:504)
at
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.prepareTx(IgniteTxHandler.java:276)
at
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler.processNearTxPrepareRequest(IgniteTxHandler.java:162)
at
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler$1.apply(IgniteTxHandler.java:184)
at
org.apache.ignite.internal.processors.cache.transactions.IgniteTxHandler$1.apply(IgniteTxHandler.java:182)
at
org.apache.ignite.internal.processors.cache.GridCacheIoManager.processMessage(GridCacheIoManager.java:836)
at
org.apache.ignite.internal.processors.cache.GridCacheIoManager.onMessage0(GridCacheIoManager.java:378)
at
org.apache.ignite.internal.processors.cache.GridCacheIoManager.handleMessage(GridCacheIoManager.java:302)
at
org.apache.ignite.internal.processors.cache.GridCacheIoManager.access$000(GridCacheIoManager.java:96)
at
org.apache.ignite.internal.processors.cache.GridCacheIoManager$1.onMessage(GridCacheIoManager.java:247)
at
org.apache.ignite.internal.managers.communication.GridIoManager.invokeListener(GridIoManager.java:1519)
at
org.apache.ignite.internal.managers.communication.GridIoManager.processRegularMessage0(GridIoManager.java:1147)
at
org.apache.ignite.internal.managers.communication.GridIoManager.access$4200(GridIoManager.java:119)
at
org.apache.ignite.internal.managers.communication.GridIoManager$9.run(GridIoManager.java:1087)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
{code}
Logs are attached.
--
This message was sent by Atlassian JIRA
(v7.6.3#76005)
