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.
