You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@ignite.apache.org by Raymond Wilson <ra...@trimble.com> on 2017/11/13 02:44:23 UTC

Error when deploying a service into an Ignite cluster

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.

Re: Error when deploying a service into an Ignite cluster

Posted by Andrey Mashenkov <an...@gmail.com>.
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 <ra...@trimble.com>
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