[
https://issues.apache.org/jira/browse/OAK-5470?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15827404#comment-15827404
]
Chetan Mehrotra edited comment on OAK-5470 at 1/18/17 4:15 AM:
---------------------------------------------------------------
Seen on 1.4 branch [logs|^unit-tests-build-1371.log]
{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}
was (Author: chetanm):
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
> Attachments: unit-tests-build-1371.log
>
>
> 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)
