Hi, Would you please share a stacktrace? Looks like an error occurs while service deployment was in progress.
On Mon, Nov 13, 2017 at 5:44 AM, Raymond Wilson <[email protected]> wrote: > 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. > > > -- Best regards, Andrey V. Mashenkov
