ignite-user mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Raymond Wilson <raymond_wil...@trimble.com>
Subject Error when deploying a service into an Ignite cluster
Date Mon, 13 Nov 2017 02:44:23 GMT
I have made a simple C# service in Ignite 2.2. When I deploy it, like this:



                services.DeployNodeSingleton(“AddSurveyedSurface”, new
AddSurveyedSurfaceService());

I get the following error:



ERROR 2017-11-13 15:29:35,984 319109ms
GridServiceProcessor                     ?                  - Error when
executing service: AddSurveyedSurface

Below is the filtered section of the DEBUG level log from BareTail which
has references to the GridServiceProcessor or to AddSurveyedSurface, but
I’m having trouble seeing what the error is. Is there a way of getting more
specific error information?





2017-11-13 15:39:42:0661             + 245     DEBUG 2017-11-13
15:39:42,402 92483ms query
?                  - Filter invoked for event
[evt=CacheContinuousQueryEvent [evtType=CREATED,
key=GridServiceDeploymentKey [name=AddSurveyedSurface],
newVal=GridServiceDeployment [nodeId=2c73436e-1136-446e-b513-98db94337601,
cfg=LazyServiceConfiguration
[srvcClsName=org.apache.ignite.internal.processors.platform.dotnet.PlatformDotNetServiceImpl,
svcCls=, nodeFilterCls=IsAllPredicate]], oldVal=null, partCntr=38],
primary=true, notify=true]

2017-11-13 15:39:42:0661             + 246     DEBUG 2017-11-13
15:39:42,402 92483ms query
?                  - Send the following event to listener:
CacheContinuousQueryEntry [evtType=CREATED, key=KeyCacheObjectImpl
[part=17, val=GridServiceDeploymentKey [name=AddSurveyedSurface],
hasValBytes=true], newVal=CacheObjectImpl [val=GridServiceDeployment
[nodeId=2c73436e-1136-446e-b513-98db94337601, cfg=LazyServiceConfiguration
[srvcClsName=org.apache.ignite.internal.processors.platform.dotnet.PlatformDotNetServiceImpl,
svcCls=, nodeFilterCls=IsAllPredicate]], hasValBytes=true], oldVal=null,
cacheId=-2100569601, part=17, updateCntr=38, flags=0,
topVer=AffinityTopologyVersion [topVer=6, minorTopVer=0], filteredCnt=0]

2017-11-13 15:39:42:0661             + 247     ERROR 2017-11-13
15:39:42,402 92483ms GridServiceProcessor
?                  - Error when executing service: AddSurveyedSurface

2017-11-13 15:39:42:0661             + 248     DEBUG 2017-11-13
15:39:42,402 92483ms query
?                  - Entry updated on affinity node
[evt=CacheContinuousQueryEvent [evtType=CREATED,
key=GridServiceDeploymentKey [name=AddSurveyedSurface],
newVal=GridServiceDeployment [nodeId=2c73436e-1136-446e-b513-98db94337601,
cfg=LazyServiceConfiguration
[srvcClsName=org.apache.ignite.internal.processors.platform.dotnet.PlatformDotNetServiceImpl,
svcCls=, nodeFilterCls=IsAllPredicate]], oldVal=null, partCntr=38],
primary=true]

2017-11-13 15:39:42:0661             + 249     DEBUG 2017-11-13
15:39:42,402 92483ms query
?                  - Filter invoked for event
[evt=CacheContinuousQueryEvent [evtType=CREATED,
key=GridServiceDeploymentKey [name=AddSurveyedSurface],
newVal=GridServiceDeployment [nodeId=2c73436e-1136-446e-b513-98db94337601,
cfg=LazyServiceConfiguration
[srvcClsName=org.apache.ignite.internal.processors.platform.dotnet.PlatformDotNetServiceImpl,
svcCls=, nodeFilterCls=IsAllPredicate]], oldVal=null, partCntr=38],
primary=true, notify=true]

2017-11-13 15:39:42:0661             + 250     DEBUG 2017-11-13
15:39:42,403 92484ms query
?                  - Send the following event to listener:
CacheContinuousQueryEntry [evtType=CREATED, key=KeyCacheObjectImpl
[part=17, val=GridServiceDeploymentKey [name=AddSurveyedSurface],
hasValBytes=true], newVal=CacheObjectImpl [val=GridServiceDeployment
[nodeId=2c73436e-1136-446e-b513-98db94337601, cfg=LazyServiceConfiguration
[srvcClsName=org.apache.ignite.internal.processors.platform.dotnet.PlatformDotNetServiceImpl,
svcCls=, nodeFilterCls=IsAllPredicate]], hasValBytes=true], oldVal=null,
cacheId=-2100569601, part=17, updateCntr=38, flags=0,
topVer=AffinityTopologyVersion [topVer=6, minorTopVer=0], filteredCnt=0]

2017-11-13 15:39:42:0661             + 251     DEBUG 2017-11-13
15:39:42,403 92484ms GridCacheMapEntry
?                  - Updated cache entry [val=CacheObjectImpl
[val=GridServiceDeployment [nodeId=2c73436e-1136-446e-b513-98db94337601,
cfg=LazyServiceConfiguration
[srvcClsName=org.apache.ignite.internal.processors.platform.dotnet.PlatformDotNetServiceImpl,
svcCls=, nodeFilterCls=IsAllPredicate]], hasValBytes=true], old=null,
entry=GridDhtCacheEntry [rdrs=[], part=17, super=GridDistributedCacheEntry
[super=GridCacheMapEntry [key=KeyCacheObjectImpl [part=17,
val=GridServiceDeploymentKey [name=AddSurveyedSurface], hasValBytes=true],
val=CacheObjectImpl [val=GridServiceDeployment
[nodeId=2c73436e-1136-446e-b513-98db94337601, cfg=LazyServiceConfiguration
[srvcClsName=org.apache.ignite.internal.processors.platform.dotnet.PlatformDotNetServiceImpl,
svcCls=, nodeFilterCls=IsAllPredicate]], hasValBytes=true],
startVer=1510540746122, ver=GridCacheVersion [topVer=122020708,
order=1510540746123, nodeOrder=1], hash=-473671117,
extras=GridCacheMvccEntryExtras [mvcc=GridCacheMvcc
[locs=[GridCacheMvccCandidate [nodeId=6a0c6484-50c5-4da0-a263-a8147e356d7e,
ver=GridCacheVersion [topVer=122020708, order=1510540746121, nodeOrder=1],
threadId=1, id=3, topVer=AffinityTopologyVersion [topVer=6, minorTopVer=0],
reentry=null, otherNodeId=2c73436e-1136-446e-b513-98db94337601,
otherVer=GridCacheVersion [topVer=122020708, order=1510540746116,
nodeOrder=6], mappedDhtNodes=null, mappedNearNodes=null, ownerVer=null,
serOrder=null, key=KeyCacheObjectImpl [part=17,
val=GridServiceDeploymentKey [name=AddSurveyedSurface], hasValBytes=true],
masks=local=1|owner=1|ready=1|reentry=0|used=0|tx=1|single_implicit=1|dht_local=1|near_local=0|removed=0|read=0,
prevVer=null, nextVer=null]], rmts=null]], flags=2]]]]

2017-11-13 15:39:42:0661             + 253     DEBUG 2017-11-13
15:39:42,407 92488ms GridCacheMapEntry
?                  - Removed lock candidate from entry
[doomed=GridCacheMvccCandidate
[nodeId=6a0c6484-50c5-4da0-a263-a8147e356d7e, ver=GridCacheVersion
[topVer=122020708, order=1510540746121, nodeOrder=1], threadId=1, id=3,
topVer=AffinityTopologyVersion [topVer=6, minorTopVer=0], reentry=null,
otherNodeId=2c73436e-1136-446e-b513-98db94337601, otherVer=GridCacheVersion
[topVer=122020708, order=1510540746116, nodeOrder=6], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=null, serOrder=null, key=KeyCacheObjectImpl
[part=17, val=GridServiceDeploymentKey [name=AddSurveyedSurface],
hasValBytes=true],
masks=local=1|owner=1|ready=1|reentry=0|used=1|tx=1|single_implicit=1|dht_local=1|near_local=0|removed=1|read=0,
prevVer=null, nextVer=null], owner=null, prev=GridCacheMvccCandidate
[nodeId=6a0c6484-50c5-4da0-a263-a8147e356d7e, ver=GridCacheVersion
[topVer=122020708, order=1510540746121, nodeOrder=1], threadId=1, id=3,
topVer=AffinityTopologyVersion [topVer=6, minorTopVer=0], reentry=null,
otherNodeId=2c73436e-1136-446e-b513-98db94337601, otherVer=GridCacheVersion
[topVer=122020708, order=1510540746116, nodeOrder=6], mappedDhtNodes=null,
mappedNearNodes=null, ownerVer=null, serOrder=null, key=KeyCacheObjectImpl
[part=17, val=GridServiceDeploymentKey [name=AddSurveyedSurface],
hasValBytes=true],
masks=local=1|owner=1|ready=1|reentry=0|used=1|tx=1|single_implicit=1|dht_local=1|near_local=0|removed=1|read=0,
prevVer=null, nextVer=null], entry=GridDhtCacheEntry [rdrs=[], part=17,
super=GridDistributedCacheEntry [super=GridCacheMapEntry
[key=KeyCacheObjectImpl [part=17, val=GridServiceDeploymentKey
[name=AddSurveyedSurface], hasValBytes=true], val=CacheObjectImpl
[val=GridServiceDeployment [nodeId=2c73436e-1136-446e-b513-98db94337601,
cfg=LazyServiceConfiguration
[srvcClsName=org.apache.ignite.internal.processors.platform.dotnet.PlatformDotNetServiceImpl,
svcCls=, nodeFilterCls=IsAllPredicate]], hasValBytes=true],
startVer=1510540746122, ver=GridCacheVersion [topVer=122020708,
order=1510540746123, nodeOrder=1], hash=-473671117, extras=null, flags=2]]]]

2017-11-13 15:39:42:0661             + 254     DEBUG 2017-11-13
15:39:42,407 92488ms GridCacheMvccManager
  ?                  - Received owner changed callback [KeyCacheObjectImpl
[part=17, val=GridServiceDeploymentKey [name=AddSurveyedSurface],
hasValBytes=true], owner=null]

2017-11-13 15:39:42:0661             + 255     DEBUG 2017-11-13
15:39:42,407 92488ms GridCacheMvccManager
?                  - Lock future not found for owner change callback (will
try transaction futures) [owner=null, entry=GridDhtCacheEntry [rdrs=[],
part=17, super=GridDistributedCacheEntry [super=GridCacheMapEntry
[key=KeyCacheObjectImpl [part=17, val=GridServiceDeploymentKey
[name=AddSurveyedSurface], hasValBytes=true], val=CacheObjectImpl
[val=GridServiceDeployment [nodeId=2c73436e-1136-446e-b513-98db94337601,
cfg=LazyServiceConfiguration
[srvcClsName=org.apache.ignite.internal.processors.platform.dotnet.PlatformDotNetServiceImpl,
svcCls=, nodeFilterCls=IsAllPredicate]], hasValBytes=true],
startVer=1510540746122, ver=GridCacheVersion [topVer=122020708,
order=1510540746123, nodeOrder=1], hash=-473671117, extras=null, flags=2]]]]

2017-11-13 15:39:42:0661             + 262     DEBUG 2017-11-13
15:39:42,409 92490ms GridCacheIoManager
?                  - Finished processing cache communication message
[nodeId=2c73436e-1136-446e-b513-98db94337601, msg=GridNearTxPrepareRequest
[futId=1247e33bf51-6079579b-d074-490d-9885-22f859c61e36, miniId=1,
topVer=AffinityTopologyVersion [topVer=6, minorTopVer=0],
subjId=2c73436e-1136-446e-b513-98db94337601, taskNameHash=0,
flags=clientReqsingle, super=GridDistributedTxPrepareRequest [threadId=1,
concurrency=OPTIMISTIC, isolation=READ_COMMITTED, writeVer=GridCacheVersion
[topVer=122020708, order=1510540746116, nodeOrder=6], timeout=0,
reads=null, writes=[IgniteTxEntry [key=KeyCacheObjectImpl [part=17,
val=GridServiceDeploymentKey [name=AddSurveyedSurface], hasValBytes=true],
cacheId=-2100569601, txKey=IgniteTxKey [key=KeyCacheObjectImpl [part=17,
val=GridServiceDeploymentKey [name=AddSurveyedSurface], hasValBytes=true],
cacheId=-2100569601], val=[op=CREATE, val=CacheObjectImpl
[val=GridServiceDeployment [nodeId=2c73436e-1136-446e-b513-98db94337601,
cfg=LazyServiceConfiguration
[srvcClsName=org.apache.ignite.internal.processors.platform.dotnet.PlatformDotNetServiceImpl,
svcCls=, nodeFilterCls=IsAllPredicate]], hasValBytes=true]],
prevVal=[op=NOOP, val=null], oldVal=[op=NOOP, val=null],
entryProcessorsCol=null, ttl=-1, conflictExpireTime=-1, conflictVer=null,
explicitVer=null, dhtVer=null,
filters=[org.apache.ignite.internal.processors.cache.CacheEntrySerializablePredicate@628749d7],
filtersPassed=false, filtersSet=false, entry=GridDhtCacheEntry [rdrs=[],
part=17, super=GridDistributedCacheEntry [super=GridCacheMapEntry
[key=KeyCacheObjectImpl [part=17, val=GridServiceDeploymentKey
[name=AddSurveyedSurface], hasValBytes=true], val=CacheObjectImpl
[val=GridServiceDeployment [nodeId=2c73436e-1136-446e-b513-98db94337601,
cfg=LazyServiceConfiguration
[srvcClsName=org.apache.ignite.internal.processors.platform.dotnet.PlatformDotNetServiceImpl,
svcCls=, nodeFilterCls=IsAllPredicate]], hasValBytes=true],
startVer=1510540746122, ver=GridCacheVersion [topVer=122020708,
order=1510540746123, nodeOrder=1], hash=-473671117, extras=null,
flags=2]]], prepared=1, locked=false, nodeId=null, locMapped=false,
expiryPlc=null, transferExpiryPlc=false, flags=0, partUpdateCntr=38,
serReadVer=null, xidVer=null]], dhtVers=null, txSize=0, plc=5,
txState=IgniteTxImplicitSingleStateImpl [init=true, recovery=false],
flags=retVal|onePhase|last|sys, super=GridDistributedBaseMessage
[ver=GridCacheVersion [topVer=122020708, order=1510540746116, nodeOrder=6],
committedVers=null, rolledbackVers=null, cnt=0, super=GridCacheIdMessage
[cacheId=0]]]]]

The service deployment then appears to hang.



Thanks,

Raymond.

Mime
View raw message