[ https://issues.apache.org/jira/browse/OAK-5470?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15827404#comment-15827404 ]
Chetan Mehrotra commented on OAK-5470: -------------------------------------- Seen on 1.4 branch {noformat} java.lang.NullPointerException at org.apache.felix.connect.felix.framework.ServiceRegistry.getService(ServiceRegistry.java:263) at org.apache.felix.connect.PojoSRBundleContext.getService(PojoSRBundleContext.java:162) at org.apache.felix.connect.PojoSR.getService(PojoSR.java:447) at org.apache.felix.connect.launch.PojoServiceRegistry$getService$0.call(Unknown Source) at org.codehaus.groovy.runtime.callsite.CallSiteArray.defaultCall(CallSiteArray.java:45) at org.codehaus.groovy.runtime.callsite.AbstractCallSite.call(AbstractCallSite.java:108) at org.codehaus.groovy.runtime.callsite.AbstractCallSite.call(AbstractCallSite.java:116) at org.apache.jackrabbit.oak.run.osgi.SecurityProviderRegistrationTest.testSecurityConfigurations2(SecurityProviderRegistrationTest.groovy:230) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26) at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27) at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:48) at org.junit.rules.RunRules.evaluate(RunRules.java:20) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:78) at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:57) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:252) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:141) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:112) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:189) at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:165) at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:85) at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:115) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:75) Standard Output 18.01.2017 04:05:08.497 *INFO* [main] org.apache.sling.commons.logservice Service [org.apache.sling.commons.logservice.internal.LogServiceFactory,4, [org.osgi.service.log.LogService]] ServiceEvent REGISTERED 18.01.2017 04:05:08.497 *INFO* [main] org.apache.sling.commons.logservice Service [org.apache.sling.commons.logservice.internal.LogReaderServiceFactory,5, [org.osgi.service.log.LogReaderService]] ServiceEvent REGISTERED 18.01.2017 04:05:08.497 *INFO* [main] org.apache.sling.commons.logservice BundleEvent STARTED 18.01.2017 04:05:08.498 *INFO* [main] org.apache.felix.configadmin BundleEvent STARTING 18.01.2017 04:05:08.498 *INFO* [main] org.apache.felix.configadmin Service [org.apache.felix.cm.file.FilePersistenceManager,6, [org.apache.felix.cm.PersistenceManager]] ServiceEvent REGISTERED 18.01.2017 04:05:08.498 *INFO* [main] org.apache.felix.configadmin Service [org.apache.felix.cm.ConfigurationAdmin,7, [org.osgi.service.cm.ConfigurationAdmin]] ServiceEvent REGISTERED 18.01.2017 04:05:08.499 *INFO* [main] org.apache.felix.configadmin BundleEvent STARTED 18.01.2017 04:05:08.499 *INFO* [main] org.apache.felix.fileinstall BundleEvent STARTING 18.01.2017 04:05:08.499 *INFO* [main] org.apache.felix.fileinstall Service [8, [org.osgi.service.url.URLStreamHandlerService]] ServiceEvent REGISTERED 18.01.2017 04:05:08.499 *INFO* [main] org.apache.felix.fileinstall Service [org.apache.felix.fileinstall,9, [org.osgi.service.cm.ManagedServiceFactory]] ServiceEvent REGISTERED 18.01.2017 04:05:08.500 *INFO* [main] org.apache.felix.fileinstall Service [10, [org.osgi.service.cm.ConfigurationListener, org.apache.felix.fileinstall.ArtifactListener, org.apache.felix.fileinstall.ArtifactInstaller]] ServiceEvent REGISTERED 18.01.2017 04:05:08.500 *WARN* [main] org.apache.felix.fileinstall /tmp/junit7273896538182628832/config does not exist, please create it. 18.01.2017 04:05:08.500 *WARN* [main] org.apache.felix.fileinstall Root path does not exist: /tmp/junit7273896538182628832/config 18.01.2017 04:05:08.501 *INFO* [main] org.apache.felix.fileinstall BundleEvent STARTED 18.01.2017 04:05:08.501 *INFO* [main] org.apache.felix.scr BundleEvent STARTING 18.01.2017 04:05:08.501 *INFO* [main] org.apache.felix.scr Service [Declarative Services Configuration Support Listener,11, [org.osgi.service.cm.ConfigurationListener]] ServiceEvent REGISTERED 18.01.2017 04:05:08.501 *INFO* [main] org.apache.felix.scr Service [Declarative Services Management Agent,12, [org.apache.felix.scr.ScrService]] ServiceEvent REGISTERED 18.01.2017 04:05:08.502 *INFO* [main] org.apache.felix.scr Service [org.apache.felix.scr.ScrService,13, [org.osgi.service.cm.ManagedService]] ServiceEvent REGISTERED 18.01.2017 04:05:08.502 *INFO* [main] org.apache.felix.scr Service [SCR Gogo Shell Support,14, [org.apache.felix.scr.impl.ScrGogoCommand]] ServiceEvent REGISTERED 18.01.2017 04:05:08.502 *INFO* [main] org.apache.felix.scr BundleEvent STARTED 18.01.2017 04:05:08.509 *INFO* [main] org.apache.jackrabbit.oak-jcr BundleEvent STARTING 18.01.2017 04:05:08.509 *INFO* [main] org.apache.jackrabbit.oak-jcr BundleEvent STARTED 18.01.2017 04:05:08.511 *INFO* [main] org.apache.jackrabbit.oak-jcr Service [15, [org.apache.jackrabbit.oak.jcr.observation.jmx.ConsolidatedListenerMBean]] ServiceEvent REGISTERED 18.01.2017 04:05:08.511 *INFO* [main] org.apache.jackrabbit.oak-core BundleEvent STARTING 18.01.2017 04:05:08.511 *INFO* [main] org.apache.jackrabbit.oak-core BundleEvent STARTED 18.01.2017 04:05:08.579 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.plugins.index.property.PropertyIndexProvider,16, [org.apache.jackrabbit.oak.spi.query.QueryIndexProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.580 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.plugins.commit.ConflictValidatorProvider,17, [org.apache.jackrabbit.oak.spi.commit.EditorProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.581 *INFO* [main] org.apache.jackrabbit.oak.plugins.metric.StatisticsProviderFactory Using DefaultStatisticsProvider 18.01.2017 04:05:08.582 *INFO* [main] org.apache.jackrabbit.oak-core Service [18, [org.apache.jackrabbit.oak.stats.StatisticsProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.582 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.plugins.name.NamespaceEditorProvider,19, [org.apache.jackrabbit.oak.spi.commit.EditorProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.582 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.security.user.UserConfigurationImpl,20, [org.apache.jackrabbit.oak.spi.security.user.UserConfiguration, org.apache.jackrabbit.oak.spi.security.SecurityConfiguration]] ServiceEvent REGISTERED 18.01.2017 04:05:08.583 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.plugins.index.counter.NodeCounterEditorProvider,21, [org.apache.jackrabbit.oak.plugins.index.IndexEditorProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.583 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.plugins.index.nodetype.NodeTypeIndexProvider,22, [org.apache.jackrabbit.oak.spi.query.QueryIndexProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.583 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.plugins.index.reference.ReferenceEditorProvider,23, [org.apache.jackrabbit.oak.plugins.index.IndexEditorProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.583 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.plugins.version.VersionEditorProvider,24, [org.apache.jackrabbit.oak.spi.commit.EditorProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.584 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.plugins.name.NameValidatorProvider,25, [org.apache.jackrabbit.oak.spi.commit.EditorProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.584 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.security.authentication.AuthenticationConfigurationImpl,26, [org.apache.jackrabbit.oak.spi.security.authentication.AuthenticationConfiguration, org.apache.jackrabbit.oak.spi.security.SecurityConfiguration]] ServiceEvent REGISTERED 18.01.2017 04:05:08.585 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.plugins.atomic.AtomicCounterEditorProvider,27, [org.apache.jackrabbit.oak.spi.commit.EditorProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.585 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.plugins.index.property.OrderedPropertyIndexEditorProvider,28, [org.apache.jackrabbit.oak.plugins.index.IndexEditorProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.586 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.plugins.index.reference.ReferenceIndexProvider,29, [org.apache.jackrabbit.oak.spi.query.QueryIndexProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.586 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider,30, [org.apache.jackrabbit.oak.spi.security.user.action.AuthorizableActionProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.586 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.security.user.UserAuthenticationFactoryImpl,31, [org.apache.jackrabbit.oak.spi.security.user.UserAuthenticationFactory]] ServiceEvent REGISTERED 18.01.2017 04:05:08.587 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.plugins.itemsave.ItemSaveValidatorProvider,32, [org.apache.jackrabbit.oak.spi.commit.EditorProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.587 *INFO* [main] org.apache.jackrabbit.oak-core Service [33, [org.apache.jackrabbit.oak.api.jmx.ConsolidatedCacheStatsMBean]] ServiceEvent REGISTERED 18.01.2017 04:05:08.588 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.security.authentication.token.TokenConfigurationImpl,34, [org.apache.jackrabbit.oak.spi.security.authentication.token.TokenConfiguration, org.apache.jackrabbit.oak.spi.security.SecurityConfiguration]] ServiceEvent REGISTERED 18.01.2017 04:05:08.588 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.security.principal.PrincipalConfigurationImpl,35, [org.apache.jackrabbit.oak.spi.security.principal.PrincipalConfiguration, org.apache.jackrabbit.oak.spi.security.SecurityConfiguration]] ServiceEvent REGISTERED 18.01.2017 04:05:08.588 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.plugins.index.property.PropertyIndexEditorProvider,36, [org.apache.jackrabbit.oak.plugins.index.IndexEditorProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.590 *INFO* [main] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to register a SecurityProvider... 18.01.2017 04:05:08.590 *INFO* [main] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Aborting: no BundleContext is available 18.01.2017 04:05:08.590 *INFO* [main] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to register a SecurityProvider... 18.01.2017 04:05:08.591 *INFO* [main] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Aborting: no BundleContext is available 18.01.2017 04:05:08.591 *INFO* [main] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to register a SecurityProvider... 18.01.2017 04:05:08.591 *INFO* [main] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Aborting: no BundleContext is available 18.01.2017 04:05:08.591 *INFO* [main] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to register a SecurityProvider... 18.01.2017 04:05:08.591 *INFO* [main] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Aborting: no BundleContext is available 18.01.2017 04:05:08.592 *INFO* [main] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to register a SecurityProvider... 18.01.2017 04:05:08.592 *INFO* [main] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Aborting: preconditions are not satisfied: Preconditions(preconditions = [org.apache.jackrabbit.oak.security.user.UserAuthenticationFactoryImpl, org.apache.jackrabbit.oak.security.principal.PrincipalConfigurationImpl, org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider, org.apache.jackrabbit.oak.security.authentication.token.TokenConfigurationImpl, org.apache.jackrabbit.oak.security.authorization.AuthorizationConfigurationImpl, org.apache.jackrabbit.oak.security.authorization.restriction.RestrictionProviderImpl], candidates = [org.apache.jackrabbit.oak.security.user.UserAuthenticationFactoryImpl, org.apache.jackrabbit.oak.security.principal.PrincipalConfigurationImpl, org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider, org.apache.jackrabbit.oak.security.authentication.token.TokenConfigurationImpl]) 18.01.2017 04:05:08.592 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.security.privilege.PrivilegeConfigurationImpl,37, [org.apache.jackrabbit.oak.spi.security.privilege.PrivilegeConfiguration, org.apache.jackrabbit.oak.spi.security.SecurityConfiguration]] ServiceEvent REGISTERED 18.01.2017 04:05:08.592 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.plugins.nodetype.TypeEditorProvider,38, [org.apache.jackrabbit.oak.spi.commit.EditorProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.593 *INFO* [main] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to register a SecurityProvider... 18.01.2017 04:05:08.593 *INFO* [main] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Aborting: preconditions are not satisfied: Preconditions(preconditions = [org.apache.jackrabbit.oak.security.user.UserAuthenticationFactoryImpl, org.apache.jackrabbit.oak.security.principal.PrincipalConfigurationImpl, org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider, org.apache.jackrabbit.oak.security.authentication.token.TokenConfigurationImpl, org.apache.jackrabbit.oak.security.authorization.AuthorizationConfigurationImpl, org.apache.jackrabbit.oak.security.authorization.restriction.RestrictionProviderImpl], candidates = [org.apache.jackrabbit.oak.security.user.UserAuthenticationFactoryImpl, org.apache.jackrabbit.oak.security.principal.PrincipalConfigurationImpl, org.apache.jackrabbit.oak.security.authorization.AuthorizationConfigurationImpl, org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider, org.apache.jackrabbit.oak.security.authentication.token.TokenConfigurationImpl]) 18.01.2017 04:05:08.593 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.security.authorization.AuthorizationConfigurationImpl,39, [org.apache.jackrabbit.oak.spi.security.authorization.AuthorizationConfiguration, org.apache.jackrabbit.oak.spi.security.SecurityConfiguration]] ServiceEvent REGISTERED 18.01.2017 04:05:08.594 *INFO* [main] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to register a SecurityProvider... 18.01.2017 04:05:08.594 *INFO* [main] org.apache.jackrabbit.oak-core Service [41, [org.apache.jackrabbit.oak.spi.security.SecurityProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.594 *INFO* [main] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration SecurityProvider instance registered 18.01.2017 04:05:08.594 *INFO* [main] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.security.authorization.restriction.RestrictionProviderImpl,40, [org.apache.jackrabbit.oak.spi.security.authorization.restriction.RestrictionProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.595 *INFO* [main] org.apache.jackrabbit.oak-blob BundleEvent STARTING 18.01.2017 04:05:08.595 *INFO* [main] org.apache.jackrabbit.oak-blob BundleEvent STARTED 18.01.2017 04:05:08.596 *INFO* [main] org.apache.jackrabbit.oak-segment BundleEvent STARTING 18.01.2017 04:05:08.596 *INFO* [main] org.apache.jackrabbit.oak-segment BundleEvent STARTED 18.01.2017 04:05:08.598 *INFO* [main] org.apache.jackrabbit.oak-commons BundleEvent STARTING 18.01.2017 04:05:08.598 *INFO* [main] org.apache.jackrabbit.oak-commons BundleEvent STARTED 18.01.2017 04:05:08.598 *INFO* [main] org.apache.jackrabbit.jackrabbit-api BundleEvent STARTING 18.01.2017 04:05:08.598 *INFO* [main] org.apache.jackrabbit.jackrabbit-api BundleEvent STARTED 18.01.2017 04:05:08.599 *INFO* [main] org.apache.jackrabbit.jackrabbit-jcr-commons BundleEvent STARTING 18.01.2017 04:05:08.599 *INFO* [main] org.apache.jackrabbit.jackrabbit-jcr-commons BundleEvent STARTED 18.01.2017 04:05:08.599 *INFO* [main] org.apache.jackrabbit.jackrabbit-data BundleEvent STARTING 18.01.2017 04:05:08.599 *INFO* [main] org.apache.jackrabbit.jackrabbit-data BundleEvent STARTED 18.01.2017 04:05:08.600 *INFO* [main] org.apache.felix.connect BundleEvent STARTING 18.01.2017 04:05:08.600 *INFO* [main] org.apache.felix.connect BundleEvent STARTED 18.01.2017 04:05:08.600 *INFO* [main] org.apache.felix.metatype BundleEvent STARTING 18.01.2017 04:05:08.601 *INFO* [main] org.apache.felix.metatype Service [org.apache.felix.metatype.MetaTypeService,42, [org.osgi.service.metatype.MetaTypeService]] ServiceEvent REGISTERED 18.01.2017 04:05:08.604 *INFO* [main] org.apache.felix.metatype BundleEvent STARTED 18.01.2017 04:05:08.604 *INFO* [main] org.apache.felix.jaas BundleEvent STARTING 18.01.2017 04:05:08.605 *INFO* [main] org.apache.felix.jaas Service [org.apache.felix.jaas.Configuration.factory,43, [org.osgi.service.cm.ManagedServiceFactory]] ServiceEvent REGISTERED 18.01.2017 04:05:08.605 *INFO* [main] org.apache.felix.jaas Service [org.apache.felix.jaas.ConfigurationSpi,44, [org.osgi.service.cm.ManagedService]] ServiceEvent REGISTERED 18.01.2017 04:05:08.605 *INFO* [main] org.apache.felix.jaas Service [45, [org.apache.felix.jaas.LoginContextFactory]] ServiceEvent REGISTERED 18.01.2017 04:05:08.612 *INFO* [main] org.apache.felix.jaas Service [JAAS Web Console Plugin,46, [javax.servlet.Servlet]] ServiceEvent REGISTERED 18.01.2017 04:05:08.613 *INFO* [main] org.apache.felix.jaas Registering LoginModule class [org.apache.jackrabbit.oak.security.authentication.token.TokenLoginModule] from Bundleorg.apache.jackrabbit.oak-core [6] 18.01.2017 04:05:08.613 *INFO* [main] org.apache.felix.jaas Registering LoginModule class [org.apache.jackrabbit.oak.spi.security.authentication.GuestLoginModule] from Bundleorg.apache.jackrabbit.oak-core [6] 18.01.2017 04:05:08.613 *INFO* [main] org.apache.felix.jaas Registering LoginModule class [org.apache.jackrabbit.oak.security.authentication.user.LoginModuleImpl] from Bundleorg.apache.jackrabbit.oak-core [6] 18.01.2017 04:05:08.613 *INFO* [main] org.apache.felix.jaas BundleEvent STARTED 18.01.2017 04:05:08.613 *INFO* [main] org.apache.jackrabbit.oak-lucene BundleEvent STARTING 18.01.2017 04:05:08.614 *INFO* [main] org.apache.jackrabbit.oak-lucene BundleEvent STARTED 18.01.2017 04:05:08.622 *INFO* [main] org.apache.jackrabbit.oak-lucene Service [org.apache.jackrabbit.oak.plugins.index.lucene.IndexAugmentorFactory,47, [org.apache.jackrabbit.oak.plugins.index.lucene.IndexAugmentorFactory]] ServiceEvent REGISTERED 18.01.2017 04:05:08.622 *INFO* [main] org.apache.jackrabbit.oak-lucene Service [org.apache.jackrabbit.oak.plugins.index.lucene.score.impl.ScorerProviderFactoryImpl,48, [org.apache.jackrabbit.oak.plugins.index.lucene.score.ScorerProviderFactory]] ServiceEvent REGISTERED 18.01.2017 04:05:08.626 *INFO* [main] org.apache.jackrabbit.oak-lucene Service [49, [org.apache.jackrabbit.oak.api.jmx.CacheStatsMBean]] ServiceEvent REGISTERED 18.01.2017 04:05:08.626 *INFO* [main] org.apache.jackrabbit.oak.plugins.index.lucene.LuceneIndexProviderService Extracted text caching enabled with maxSize 20 MB, expiry time 300 secs 18.01.2017 04:05:08.627 *INFO* [main] org.apache.jackrabbit.oak.plugins.index.lucene.LuceneIndexProviderService Prefetching of index files enabled. Index would be opened after copying all new files locally 18.01.2017 04:05:08.627 *INFO* [main] org.apache.jackrabbit.oak-lucene Service [50, [org.apache.jackrabbit.oak.plugins.index.lucene.CopyOnReadStatsMBean]] ServiceEvent REGISTERED 18.01.2017 04:05:08.627 *INFO* [main] org.apache.jackrabbit.oak.plugins.index.lucene.LuceneIndexProviderService Enabling CopyOnRead support. Index files would be copied under /tmp/junit7273896538182628832/repository/index 18.01.2017 04:05:08.627 *INFO* [main] org.apache.jackrabbit.oak-lucene Service [51, [org.apache.jackrabbit.oak.spi.query.QueryIndexProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.628 *INFO* [main] org.apache.jackrabbit.oak-lucene Service [52, [org.apache.jackrabbit.oak.spi.commit.BackgroundObserverMBean]] ServiceEvent REGISTERED 18.01.2017 04:05:08.628 *INFO* [main] org.apache.jackrabbit.oak.plugins.index.lucene.LuceneIndexProviderService Registering the LuceneIndexProvider as a BackgroundObserver 18.01.2017 04:05:08.628 *INFO* [main] org.apache.jackrabbit.oak-lucene Service [53, [org.apache.jackrabbit.oak.spi.commit.Observer]] ServiceEvent REGISTERED 18.01.2017 04:05:08.628 *INFO* [main] org.apache.jackrabbit.oak.plugins.index.lucene.LuceneIndexProviderService Enabling CopyOnWrite support. Index files would be copied under /tmp/junit7273896538182628832/repository/index 18.01.2017 04:05:08.628 *INFO* [main] org.apache.jackrabbit.oak-lucene Service [54, [org.apache.jackrabbit.oak.plugins.index.IndexEditorProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.629 *INFO* [main] org.apache.jackrabbit.oak-lucene Service [55, [org.apache.jackrabbit.oak.plugins.index.lucene.TextExtractionStatsMBean]] ServiceEvent REGISTERED 18.01.2017 04:05:08.629 *INFO* [main] org.apache.jackrabbit.oak-lucene Service [56, [org.apache.jackrabbit.oak.plugins.index.lucene.LuceneIndexMBean]] ServiceEvent REGISTERED 18.01.2017 04:05:08.629 *INFO* [main] org.apache.jackrabbit.oak-lucene Service [57, [org.apache.jackrabbit.oak.spi.gc.GCMonitor]] ServiceEvent REGISTERED 18.01.2017 04:05:08.629 *INFO* [main] org.apache.aries.jmx.whiteboard BundleEvent STARTING 18.01.2017 04:05:08.630 *INFO* [main] org.apache.aries.jmx.whiteboard BundleEvent STARTED 18.01.2017 04:05:08.630 *INFO* [main] groovy-all BundleEvent STARTING 18.01.2017 04:05:08.630 *INFO* [main] groovy-all BundleEvent STARTED 18.01.2017 04:05:08.632 *INFO* [main] org.apache.jackrabbit.oak.run.osgi.ConfigInstaller Creating configuration from org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider 18.01.2017 04:05:08.639 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider)] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider,30, [org.apache.jackrabbit.oak.spi.security.user.action.AuthorizableActionProvider]] ServiceEvent UNREGISTERING 18.01.2017 04:05:08.639 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider)] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to unregister the SecurityProvider... 18.01.2017 04:05:08.639 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider)] org.apache.jackrabbit.oak-core Service [41, [org.apache.jackrabbit.oak.spi.security.SecurityProvider]] ServiceEvent UNREGISTERING 18.01.2017 04:05:08.641 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider)] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration SecurityProvider instance unregistered 18.01.2017 04:05:08.641 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider)] org.apache.jackrabbit.oak-core Service [org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider,58, [org.apache.jackrabbit.oak.spi.security.user.action.AuthorizableActionProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.644 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider)] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to register a SecurityProvider... 18.01.2017 04:05:08.645 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider)] org.apache.jackrabbit.oak-core Service [59, [org.apache.jackrabbit.oak.spi.security.SecurityProvider]] ServiceEvent REGISTERED 18.01.2017 04:05:08.645 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.jackrabbit.oak.spi.security.user.action.DefaultAuthorizableActionProvider)] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration SecurityProvider instance registered 18.01.2017 04:05:08.645 *INFO* [Thread-15] org.apache.felix.connect BundleEvent STOPPING 18.01.2017 04:05:08.645 *INFO* [Thread-15] org.apache.sling.commons.logservice BundleEvent STOPPING 18.01.2017 04:05:08.650 *INFO* [Thread-15] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to unregister the SecurityProvider... 18.01.2017 04:05:08.650 *INFO* [Thread-15] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Aborting: no SecurityProvider is registered 18.01.2017 04:05:08.651 *INFO* [Thread-15] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to unregister the SecurityProvider... 18.01.2017 04:05:08.651 *INFO* [Thread-15] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Aborting: no SecurityProvider is registered 18.01.2017 04:05:08.651 *INFO* [Thread-15] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to unregister the SecurityProvider... 18.01.2017 04:05:08.651 *INFO* [Thread-15] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Aborting: no SecurityProvider is registered 18.01.2017 04:05:08.651 *INFO* [Thread-15] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to unregister the SecurityProvider... 18.01.2017 04:05:08.651 *INFO* [Thread-15] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Aborting: no SecurityProvider is registered 18.01.2017 04:05:08.651 *INFO* [Thread-15] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to unregister the SecurityProvider... 18.01.2017 04:05:08.651 *INFO* [Thread-15] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Aborting: no SecurityProvider is registered 18.01.2017 04:05:08.651 *INFO* [Thread-15] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Trying to unregister the SecurityProvider... 18.01.2017 04:05:08.652 *INFO* [Thread-15] org.apache.jackrabbit.oak.security.internal.SecurityProviderRegistration Aborting: no SecurityProvider is registered {noformat} > Test failure: SecurityProviderRegistrationTest.testSecurityConfigurations2 > -------------------------------------------------------------------------- > > Key: OAK-5470 > URL: https://issues.apache.org/jira/browse/OAK-5470 > Project: Jackrabbit Oak > Issue Type: Bug > Components: continuous integration > Reporter: Hudson > > Jenkins CI failure: > https://builds.apache.org/job/Apache%20Jackrabbit%20Oak%20matrix/ > The build Apache Jackrabbit Oak matrix/Ubuntu Slaves=ubuntu,jdk=JDK 1.7 > (latest),nsfixtures=SEGMENT_TAR,profile=unittesting #1371 has failed. > First failed run: [Apache Jackrabbit Oak matrix/Ubuntu Slaves=ubuntu,jdk=JDK > 1.7 (latest),nsfixtures=SEGMENT_TAR,profile=unittesting > #1371|https://builds.apache.org/job/Apache%20Jackrabbit%20Oak%20matrix/Ubuntu%20Slaves=ubuntu,jdk=JDK%201.7%20(latest),nsfixtures=SEGMENT_TAR,profile=unittesting/1371/] > [console > log|https://builds.apache.org/job/Apache%20Jackrabbit%20Oak%20matrix/Ubuntu%20Slaves=ubuntu,jdk=JDK%201.7%20(latest),nsfixtures=SEGMENT_TAR,profile=unittesting/1371/console] -- This message was sent by Atlassian JIRA (v6.3.4#6332)