Eventually managed to understand the root cause using the Felix
ScrService and printing out component information.

See https://issues.apache.org/jira/browse/OAK-6736 .

Thanks,

Robert


On Wed, 2017-09-27 at 19:27 +0530, Chetan Mehrotra wrote:
> You need to do two changes
> 
> 1. Set ds.loglevel=4 as you have done
> 2. Configure logger corresponding to bundle symbolic name to trace
> level. Do it for the bundles you are interested in
> 
> <logger name="org.apache.jackrabbit.oak-core" level="TRACE" />
> 
> > BTW, did you ever try to set up the web console? I would give it a
> > shot.
> 
> Not here but the standalone example do configure the Felix WebConsole
> [1]. You can try if standalone comes up with your changes to see it
> works for basic case
> 
> Chetan Mehrotra
> [1] https://github.com/apache/jackrabbit-oak/blob/trunk/oak-examples/
> standalone/src/main/java/org/apache/jackrabbit/oak/standalone/WebCons
> oleSupport.java
> 
> 
> On Wed, Sep 27, 2017 at 5:18 PM, Robert Munteanu <[email protected]>
> wrote:
> > Hi Chetan,
> > 
> > On Wed, 2017-09-27 at 15:48 +0530, Chetan Mehrotra wrote:
> > > Hi Robert,
> > > 
> > > The unit-test.log should give details about which bundle is
> > > starting
> > > and which components are activated like [1]. For the error you
> > > are
> > > seeing it means RepositoryManager is not getting activated for
> > > some
> > > reason (may be some missing dependency).
> > > 
> > > So we would need to analyze from OSGi side to see which component
> > > has
> > > dependency missing. This is bit tricky in absence of Felix
> > > WebConsole.
> > > Probably enabling SCR logs (ds.loglevel=3?) would give some
> > > insight
> > > here
> > 
> > How would I do that? I tried the following change but got no extra
> > logs:
> > 
> > diff --git a/oak-
> > pojosr/src/test/groovy/org/apache/jackrabbit/oak/run/osgi/AbstractR
> > epos
> > itoryFactoryTest.groovy b/oak-
> > pojosr/src/test/groovy/org/apache/jackrabbit/oak/run/osgi/AbstractR
> > epos
> > itoryFactoryTest.groovy
> > index e0d08b5025..91f39bc277 100644
> > --- a/oak-
> > pojosr/src/test/groovy/org/apache/jackrabbit/oak/run/osgi/AbstractR
> > epos
> > itoryFactoryTest.groovy
> > +++ b/oak-
> > pojosr/src/test/groovy/org/apache/jackrabbit/oak/run/osgi/AbstractR
> > epos
> > itoryFactoryTest.groovy
> > @@ -57,6 +57,7 @@ abstract class AbstractRepositoryFactoryTest{
> >          config = [
> >                  (REPOSITORY_HOME): workDir.absolutePath,
> >                  (REPOSITORY_TIMEOUT_IN_SECS) : 60,
> > +                "ds.loglevel" : 3
> >          ]
> >      }
> > 
> > BTW, did you ever try to set up the web console? I would give it a
> > shot.
> > 
> > Thanks,
> > 
> > Robert
> > 
> > > 
> > > Chetan Mehrotra
> > > [1]
> > > 27.09.2017 15:43:06.603 *INFO* [main]
> > > org.apache.jackrabbit.oak-query-spi BundleEvent STARTED
> > > 27.09.2017 15:43:06.603 *INFO* [main] org.apache.jackrabbit.oak-
> > > core
> > > BundleEvent STARTING
> > > 27.09.2017 15:43:06.761 *INFO* [main] org.apache.jackrabbit.oak-
> > > core
> > > Service
> > > [org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthor
> > > izab
> > > leActionProvider,17,
> > > [org.apache.jackrabbit.oak.spi.security.user.action.AuthorizableA
> > > ctio
> > > nProvider]]
> > > ServiceEvent REGISTERED
> > > 27.09.2017 15:43:06.762 *INFO* [main] org.apache.jackrabbit.oak-
> > > core
> > > Service
> > > [org.apache.jackrabbit.oak.security.authorization.restriction.Res
> > > tric
> > > tionProviderImpl,18,
> > > [org.apache.jackrabbit.oak.spi.security.authorization.restriction
> > > .Res
> > > trictionProvider]]
> > > ServiceEvent REGISTERED
> > > 27.09.2017 15:43:06.770 *INFO* [main]
> > > org.apache.jackrabbit.oak.plugins.metric.StatisticsProviderFactor
> > > y
> > > Using MetricsStatisticsProvider
> > > 27.09.2017 15:43:06.804 *INFO* [main] org.apache.jackrabbit.oak-
> > > core
> > > Service [19, [com.codahale.metrics.MetricRegistry]] ServiceEvent
> > > REGISTERED
> > > 27.09.2017 15:43:06.825 *INFO* [main]
> > > org.apache.jackrabbit.oak.segment.file.FileStore Creating file
> > > store
> > > FileStoreBuilder{version=1.8-SNAPSHOT,
> > > directory=/home/chetanm/git/apache/jackrabbit-oak/oak-
> > > pojosr/target/junit5333968922356600629/repository/segmentstore,
> > > blobStore=null, maxFileSize=256, segmentCacheSize=256,
> > > stringCacheSize=256, templateCacheSize=64,
> > > stringDeduplicationCacheSize=15000,
> > > templateDeduplicationCacheSize=3000,
> > > nodeDeduplicationCacheSize=1048576, memoryMapping=true,
> > > gcOptions=SegmentGCOptions{paused=false,
> > > estimationDisabled=false,
> > > gcSizeDeltaEstimation=1073741824, retryCount=5, forceTimeout=60,
> > > retainedGenerations=2, gcType=FULL}}
> > > 27.09.2017 15:43:07.070 *INFO* [main]
> > > org.apache.jackrabbit.oak.segment.file.FileStore TarMK opened:
> > > /home/chetanm/git/apache/jackrabbit-oak/oak-
> > > pojosr/target/junit5333968922356600629/repository/segmentstore
> > > (mmap=true)
> > > 27.09.2017 15:43:07.135 *INFO* [main]
> > > org.apache.jackrabbit.oak-segment-tar Service [21,
> > > [org.apache.jackrabbit.oak.api.jmx.CacheStatsMBean]] ServiceEvent
> > > REGISTERED
> > > 27.09.2017 15:43:07.137 *INFO* [main]
> > > org.apache.jackrabbit.oak-segment-tar Service [22,
> > > [org.apache.jackrabbit.oak.api.jmx.CacheStatsMBean]] ServiceEvent
> > > REGISTERED
> > > 27.09.2017 15:43:07.138 *INFO* [main]
> > > org.apache.jackrabbit.oak-segment-tar Service [23,
> > > [org.apache.jackrabbit.oak.api.jmx.CacheStatsMBean]] ServiceEvent
> > > REGISTERED
> > > 27.09.2017 15:43:07.140 *INFO* [main]
> > > org.apache.jackrabbit.oak-segment-tar Service [24,
> > > [org.apache.jackrabbit.oak.api.jmx.CacheStatsMBean]] ServiceEvent
> > > REGISTERED
> > > 27.09.2017 15:43:07.141 *INFO* [main]
> > > org.apache.jackrabbit.oak-segment-tar Service [25,
> > > [org.apache.jackrabbit.oak.api.jmx.CacheStatsMBean]] ServiceEvent
> > > REGISTERED
> > > 27.09.2017 15:43:07.143 *INFO* [main]
> > > org.apache.jackrabbit.oak-segment-tar Service [26,
> > > [org.apache.jackrabbit.oak.api.jmx.CacheStatsMBean]] ServiceEvent
> > > REGISTERED
> > > 27.09.2017 15:43:07.145 *INFO* [main]
> > > org.apache.jackrabbit.oak-segment-tar Service [27,
> > > [org.apache.jackrabbit.oak.spi.gc.GCMonitor]] ServiceEvent
> > > REGISTERED
> > > 27.09.2017 15:43:07.148 *INFO* [main]
> > > org.apache.jackrabbit.oak-segment-tar Service [28,
> > > [org.apache.jackrabbit.oak.segment.compaction.SegmentRevisionGC]]
> > > ServiceEvent REGISTERED
> > > 27.09.2017 15:43:07.153 *INFO* [main]
> > > org.apache.jackrabbit.oak-segment-tar Service [29,
> > > [org.apache.jackrabbit.oak.spi.state.RevisionGCMBean]]
> > > ServiceEvent
> > > REGISTERED
> > > 27.09.2017 15:43:07.153 *INFO* [main]
> > > org.apache.jackrabbit.oak-segment-tar Service [30,
> > > [org.apache.jackrabbit.oak.segment.file.FileStoreStatsMBean]]
> > > ServiceEvent REGISTERED
> > > 27.09.2017 15:43:07.155 *INFO* [main]
> > > org.apache.jackrabbit.oak.segment.SegmentNodeStore$SegmentNodeSto
> > > reBu
> > > ilder
> > > Creating segment node store
> > > SegmentNodeStoreBuilder{blobStore=inline}
> > > 27.09.2017 15:43:07.161 *INFO* [main]
> > > org.apache.jackrabbit.oak.segment.scheduler.LockBasedScheduler
> > > Initializing SegmentNodeStore with the commitFairLock option
> > > enabled.
> > > 27.09.2017 15:43:07.170 *INFO* [main]
> > > org.apache.jackrabbit.oak-segment-tar Service [31,
> > > [org.apache.jackrabbit.oak.api.jmx.CheckpointMBean]] ServiceEvent
> > > REGISTERED
> > > 27.09.2017 15:43:07.183 *INFO* [main]
> > > org.apache.jackrabbit.oak.spi.cluster.ClusterRepositoryInfo
> > > getOrCreateId: created a new
> > > clusterId=c696b381-f3e7-4826-ac5e-552f3ac4fecc
> > > 27.09.2017 15:43:07.184 *INFO* [main]
> > > org.apache.jackrabbit.oak-segment-tar Service [32,
> > > [org.apache.jackrabbit.oak.api.Descriptors]] ServiceEvent
> > > REGISTERED

Reply via email to