See <https://builds.apache.org/job/sling-trunk-1.7/org.apache.sling$org.apache.sling.event/986/>
------------------------------------------ [...truncated 4739 lines...] 10.10.2014 08:12:37.795 *INFO* [FelixStartLevel] org.apache.sling.auth.core BundleEvent STARTED 10.10.2014 08:12:37.812 *INFO* [FelixStartLevel] org.apache.sling.auth.core Service [org.apache.sling.auth.core.impl.LogoutServlet,42] ServiceEvent REGISTERED 10.10.2014 08:12:37.813 *INFO* [FelixStartLevel] org.apache.sling.auth.core Service [org.apache.sling.auth.core.impl.LoginServlet,43] ServiceEvent REGISTERED 10.10.2014 08:12:37.815 *INFO* [FelixStartLevel] org.apache.sling.discovery.api BundleEvent RESOLVED 10.10.2014 08:12:37.815 *INFO* [FelixStartLevel] org.apache.sling.discovery.api BundleEvent STARTING 10.10.2014 08:12:37.815 *INFO* [FelixStartLevel] org.apache.sling.discovery.api BundleEvent STARTED 10.10.2014 08:12:37.819 *INFO* [FelixStartLevel] org.apache.sling.settings BundleEvent RESOLVED 10.10.2014 08:12:37.819 *INFO* [FelixStartLevel] org.apache.sling.discovery.standalone BundleEvent RESOLVED 10.10.2014 08:12:37.819 *INFO* [FelixStartLevel] org.apache.sling.discovery.standalone BundleEvent STARTING 10.10.2014 08:12:37.819 *INFO* [FelixStartLevel] org.apache.sling.discovery.standalone BundleEvent STARTED 10.10.2014 08:12:37.833 *INFO* [FelixStartLevel] org.apache.sling.api BundleEvent STARTING 10.10.2014 08:12:37.833 *INFO* [FelixStartLevel] org.apache.sling.api BundleEvent STARTED 10.10.2014 08:12:37.834 *INFO* [FelixStartLevel] org.apache.sling.settings BundleEvent STARTING 10.10.2014 08:12:37.836 *INFO* [FelixStartLevel] org.apache.sling.settings BundleEvent STARTED 10.10.2014 08:12:37.841 *INFO* [FelixStartLevel] org.apache.sling.serviceusermapper BundleEvent RESOLVED 10.10.2014 08:12:37.841 *INFO* [FelixStartLevel] org.apache.sling.resourceresolver BundleEvent RESOLVED 10.10.2014 08:12:37.841 *INFO* [FelixStartLevel] org.apache.sling.resourceresolver BundleEvent STARTING 10.10.2014 08:12:37.841 *INFO* [FelixStartLevel] org.apache.sling.resourceresolver BundleEvent STARTED 10.10.2014 08:12:37.849 *INFO* [FelixStartLevel] org.apache.sling.resourceresolver Service [org.apache.sling.resourceresolver.impl.ResourceAccessSecurityTracker,44] ServiceEvent REGISTERED 10.10.2014 08:12:37.851 *INFO* [FelixStartLevel] org.apache.sling.adapter BundleEvent RESOLVED 10.10.2014 08:12:37.851 *INFO* [FelixStartLevel] org.apache.sling.adapter BundleEvent STARTING 10.10.2014 08:12:37.852 *INFO* [FelixStartLevel] org.apache.sling.adapter BundleEvent STARTED 10.10.2014 08:12:37.856 *INFO* [FelixStartLevel] org.apache.sling.adapter Service [org.apache.sling.adapter.internal.AdapterManagerImpl,45] ServiceEvent REGISTERED 10.10.2014 08:12:37.876 *INFO* [FelixStartLevel] org.apache.felix.inventory Service [48] ServiceEvent REGISTERED 10.10.2014 08:12:37.877 *INFO* [FelixStartLevel] org.apache.felix.inventory Service [47] ServiceEvent REGISTERED 10.10.2014 08:12:37.877 *INFO* [FelixStartLevel] org.apache.sling.adapter Service [org.apache.sling.adapter.internal.AdapterWebConsolePlugin,46] ServiceEvent REGISTERED 10.10.2014 08:12:37.882 *INFO* [FelixStartLevel] org.apache.sling.jcr.resource BundleEvent RESOLVED 10.10.2014 08:12:37.882 *INFO* [FelixStartLevel] org.apache.sling.jcr.api BundleEvent RESOLVED 10.10.2014 08:12:37.882 *INFO* [FelixStartLevel] org.apache.sling.jcr.resource BundleEvent STARTING 10.10.2014 08:12:37.882 *INFO* [FelixStartLevel] org.apache.sling.jcr.resource BundleEvent STARTED 10.10.2014 08:12:37.891 *INFO* [FelixStartLevel] org.apache.sling.jcr.resource Service [org.apache.sling.jcr.resource.internal.scripting.JcrObjectsBindingsValuesProvider,49] ServiceEvent REGISTERED 10.10.2014 08:12:37.892 *INFO* [FelixStartLevel] org.apache.sling.jcr.resource Service [org.apache.sling.jcr.resource.internal.WorkspaceAuthInfoPostProcessor,50] ServiceEvent REGISTERED 10.10.2014 08:12:37.895 *INFO* [FelixStartLevel] org.apache.sling.jcr.classloader BundleEvent RESOLVED 10.10.2014 08:12:37.895 *INFO* [FelixStartLevel] org.apache.sling.jcr.classloader BundleEvent STARTING 10.10.2014 08:12:37.895 *INFO* [FelixStartLevel] org.apache.sling.jcr.classloader BundleEvent STARTED 10.10.2014 08:12:37.915 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-jcr-commons BundleEvent RESOLVED 10.10.2014 08:12:37.915 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-api BundleEvent RESOLVED 10.10.2014 08:12:37.915 *INFO* [FelixStartLevel] org.apache.sling.engine BundleEvent RESOLVED 10.10.2014 08:12:37.915 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-jcr-rmi BundleEvent RESOLVED 10.10.2014 08:12:37.915 *INFO* [FelixStartLevel] org.apache.sling.jcr.contentloader BundleEvent RESOLVED 10.10.2014 08:12:37.916 *INFO* [FelixStartLevel] org.apache.sling.jcr.base BundleEvent RESOLVED 10.10.2014 08:12:37.916 *INFO* [FelixStartLevel] org.apache.sling.jcr.contentloader BundleEvent STARTING 10.10.2014 08:12:37.916 *INFO* [FelixStartLevel] org.apache.sling.jcr.contentloader BundleEvent STARTED 10.10.2014 08:12:37.922 *INFO* [FelixStartLevel] org.apache.sling.jcr.contentloader Service [org.apache.sling.jcr.contentloader.internal.DefaultContentImporter,51] ServiceEvent REGISTERED 10.10.2014 08:12:37.922 *INFO* [FelixStartLevel] org.apache.sling.engine BundleEvent STARTING 10.10.2014 08:12:37.922 *INFO* [FelixStartLevel] org.apache.sling.engine BundleEvent STARTED 10.10.2014 08:12:37.993 *INFO* [FelixStartLevel] org.apache.sling.commons.mime registerMimeType: Ignoring mapping xls=application/msexcel: Mapping xls=application/vnd.ms-excel alread exists 10.10.2014 08:12:37.993 *INFO* [FelixStartLevel] org.apache.sling.commons.mime registerMimeType: Ignoring mapping xlsx=application/msexcel: Mapping xlsx=application/vnd.openxmlformats-officedocument.spreadsheetml.sheet alread exists 10.10.2014 08:12:37.993 *INFO* [FelixStartLevel] org.apache.sling.commons.mime registerMimeType: Ignoring mapping ppt=application/mspowerpoint: Mapping ppt=application/vnd.ms-powerpoint alread exists 10.10.2014 08:12:37.993 *INFO* [FelixStartLevel] org.apache.sling.commons.mime registerMimeType: Ignoring mapping pptx=application/mspowerpoint: Mapping pptx=application/vnd.openxmlformats-officedocument.presentationml.presentation alread exists 10.10.2014 08:12:37.994 *INFO* [FelixStartLevel] org.apache.sling.commons.mime registerMimeType: Ignoring mapping class=application/octet-stream: Mapping class=application/java-vm alread exists 10.10.2014 08:12:37.994 *INFO* [FelixStartLevel] org.apache.sling.commons.mime registerMimeType: Ignoring mapping exe=application/octet-stream: Mapping exe=application/x-msdownload alread exists 10.10.2014 08:12:37.994 *INFO* [FelixStartLevel] org.apache.sling.commons.mime registerMimeType: Ignoring mapping msi=application/octet-stream: Mapping msi=application/x-msdownload alread exists 10.10.2014 08:12:37.994 *INFO* [FelixStartLevel] org.apache.sling.commons.mime registerMimeType: Ignoring mapping psd=application/photoshop: Mapping psd=image/vnd.adobe.photoshop alread exists 10.10.2014 08:12:37.994 *INFO* [FelixStartLevel] org.apache.sling.commons.mime registerMimeType: Ignoring mapping rtf=text/rtf: Mapping rtf=application/rtf alread exists 10.10.2014 08:12:37.997 *INFO* [FelixStartLevel] org.apache.sling.commons.mime Service [52] ServiceEvent REGISTERED 10.10.2014 08:12:38.008 *INFO* [FelixStartLevel] org.apache.sling.engine.impl.SlingMainServlet ApacheSling/2.3 (jetty/7.x.y-SNAPSHOT, Java HotSpot(TM) Server VM 1.7.0_25, Linux 3.13.0-36-lowlatency i386) ready to serve requests 10.10.2014 08:12:38.010 *INFO* [FelixStartLevel] org.apache.sling.engine Service [org.apache.sling.engine.impl.helper.SlingServletContext,53] ServiceEvent REGISTERED 10.10.2014 08:12:38.014 *INFO* [FelixStartLevel] org.apache.felix.inventory Service [56] ServiceEvent REGISTERED 10.10.2014 08:12:38.015 *INFO* [FelixStartLevel] org.apache.felix.inventory Service [55] ServiceEvent REGISTERED 10.10.2014 08:12:38.016 *INFO* [FelixStartLevel] org.apache.sling.engine Service [Apache Sling Servlet Filter Configuration Printer,54] ServiceEvent REGISTERED 10.10.2014 08:12:38.018 *INFO* [FelixStartLevel] org.apache.sling.engine Service [org.apache.sling.engine.impl.request.RequestHistoryConsolePlugin$Plugin,57] ServiceEvent REGISTERED 10.10.2014 08:12:38.020 *INFO* [FelixStartLevel] org.apache.sling.engine Service [58] ServiceEvent REGISTERED 10.10.2014 08:12:38.021 *INFO* [FelixStartLevel] org.apache.sling.engine Service [Sling Request Processor,59] ServiceEvent REGISTERED 10.10.2014 08:12:38.035 *INFO* [FelixStartLevel] org.apache.sling.engine Service [org.apache.sling.engine.impl.log.RequestLoggerFilter,61] ServiceEvent REGISTERED 10.10.2014 08:12:38.035 *INFO* [FelixStartLevel] org.apache.sling.engine Service [60] ServiceEvent REGISTERED 10.10.2014 08:12:38.036 *INFO* [FelixStartLevel] org.apache.sling.engine Service [62] ServiceEvent REGISTERED 10.10.2014 08:12:38.037 *INFO* [FelixStartLevel] org.apache.sling.engine Service [63] ServiceEvent REGISTERED 10.10.2014 08:12:38.039 *INFO* [FelixStartLevel] org.apache.sling.engine Service [org.apache.sling.engine.impl.debug.RequestProgressTrackerLogFilter,64] ServiceEvent REGISTERED 10.10.2014 08:12:38.040 *INFO* [FelixStartLevel] org.apache.sling.serviceusermapper BundleEvent STARTING 10.10.2014 08:12:38.040 *INFO* [FelixStartLevel] org.apache.sling.serviceusermapper BundleEvent STARTED 10.10.2014 08:12:38.063 *INFO* [FelixStartLevel] org.apache.sling.serviceusermapper Service [org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl,65] ServiceEvent REGISTERED 10.10.2014 08:12:38.063 *INFO* [FelixStartLevel] org.apache.sling.jcr.jcr-wrapper BundleEvent STARTING 10.10.2014 08:12:38.063 *INFO* [FelixStartLevel] org.apache.sling.jcr.jcr-wrapper BundleEvent STARTED 10.10.2014 08:12:38.063 *INFO* [FelixStartLevel] org.apache.sling.jcr.api BundleEvent STARTING 10.10.2014 08:12:38.063 *INFO* [FelixStartLevel] org.apache.sling.jcr.api BundleEvent STARTED 10.10.2014 08:12:38.064 *INFO* [FelixStartLevel] org.apache.sling.jcr.base BundleEvent STARTING 10.10.2014 08:12:38.064 *INFO* [FelixStartLevel] org.apache.sling.jcr.base BundleEvent STARTED 10.10.2014 08:12:38.067 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-api BundleEvent STARTING 10.10.2014 08:12:38.068 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-api BundleEvent STARTED 10.10.2014 08:12:38.068 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-jcr-commons BundleEvent STARTING 10.10.2014 08:12:38.068 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-jcr-commons BundleEvent STARTED 10.10.2014 08:12:38.069 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-spi BundleEvent RESOLVED 10.10.2014 08:12:38.070 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-spi BundleEvent STARTING 10.10.2014 08:12:38.070 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-spi BundleEvent STARTED 10.10.2014 08:12:38.075 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-spi-commons BundleEvent RESOLVED 10.10.2014 08:12:38.075 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-spi-commons BundleEvent STARTING 10.10.2014 08:12:38.075 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-spi-commons BundleEvent STARTED 10.10.2014 08:12:38.075 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-jcr-rmi BundleEvent STARTING 10.10.2014 08:12:38.076 *INFO* [FelixStartLevel] org.apache.jackrabbit.jackrabbit-jcr-rmi BundleEvent STARTED 10.10.2014 08:12:38.077 *INFO* [FelixStartLevel] derby BundleEvent RESOLVED 10.10.2014 08:12:38.077 *INFO* [FelixStartLevel] derby BundleEvent STARTING 10.10.2014 08:12:38.250 *INFO* [FelixStartLevel] derby BundleEvent STARTED 10.10.2014 08:12:38.252 *INFO* [FelixStartLevel] org.apache.sling.jcr.jackrabbit.server BundleEvent RESOLVED 10.10.2014 08:12:38.252 *INFO* [FelixStartLevel] org.apache.sling.jcr.jackrabbit.server BundleEvent STARTING 10.10.2014 08:12:38.257 *INFO* [FelixStartLevel] org.apache.sling.jcr.jackrabbit.server.impl.Activator Creating default config for Jackrabbit in jackrabbit 10.10.2014 08:12:38.283 *INFO* [FelixStartLevel] org.apache.sling.jcr.jackrabbit.server.impl.Activator verifyConfiguration: Created configuration org.apache.sling.jcr.jackrabbit.server.SlingServerRepository.9e0897df-5f00-4809-bd47-0406f97af9e2 for org.apache.sling.jcr.jackrabbit.server.SlingServerRepository 10.10.2014 08:12:38.287 *INFO* [FelixStartLevel] org.apache.sling.jcr.jackrabbit.server BundleEvent STARTED 10.10.2014 08:12:38.446 *WARN* [FelixStartLevel] org.apache.jackrabbit.core.util.RepositoryLock Existing lock file <https://builds.apache.org/job/sling-trunk-1.7/org.apache.sling$org.apache.sling.event/ws/jackrabbit/.lock> detected. Repository was not shut down properly. 10.10.2014 08:12:38.447 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.RepositoryImpl Starting repository... 10.10.2014 08:12:38.449 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.fs.local.LocalFileSystem LocalFileSystem initialized at path <https://builds.apache.org/job/sling-trunk-1.7/org.apache.sling$org.apache.sling.event/ws/jackrabbit/repository> 10.10.2014 08:12:38.616 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.fs.local.LocalFileSystem LocalFileSystem initialized at path <https://builds.apache.org/job/sling-trunk-1.7/org.apache.sling$org.apache.sling.event/ws/jackrabbit/version> 10.10.2014 08:12:39.279 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.RepositoryImpl initializing workspace 'default'... 10.10.2014 08:12:39.279 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.fs.local.LocalFileSystem LocalFileSystem initialized at path <https://builds.apache.org/job/sling-trunk-1.7/org.apache.sling$org.apache.sling.event/ws/jackrabbit/workspaces/default> 10.10.2014 08:12:39.738 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.query.lucene.SearchIndex Index initialized: <https://builds.apache.org/job/sling-trunk-1.7/org.apache.sling$org.apache.sling.event/ws/jackrabbit/repository/index> Version: 3 10.10.2014 08:12:39.806 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.query.lucene.Recovery Found uncommitted redo log. Applying changes now... 10.10.2014 08:12:39.816 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.query.lucene.Recovery Redo changes applied. 10.10.2014 08:12:39.867 *INFO* [jackrabbit-pool-1] org.apache.jackrabbit.core.query.lucene.IndexMerger merged 21 documents in 48 ms into _b. 10.10.2014 08:12:39.878 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.query.lucene.SearchIndex Index initialized: <https://builds.apache.org/job/sling-trunk-1.7/org.apache.sling$org.apache.sling.event/ws/jackrabbit/workspaces/default/index> Version: 3 10.10.2014 08:12:39.878 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.RepositoryImpl workspace 'default' initialized 10.10.2014 08:12:39.885 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.RepositoryImpl SecurityManager = class org.apache.jackrabbit.core.DefaultSecurityManager 10.10.2014 08:12:39.885 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.RepositoryImpl initializing workspace 'security'... 10.10.2014 08:12:39.885 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.fs.local.LocalFileSystem LocalFileSystem initialized at path <https://builds.apache.org/job/sling-trunk-1.7/org.apache.sling$org.apache.sling.event/ws/jackrabbit/workspaces/security> 10.10.2014 08:12:39.990 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.query.lucene.SearchIndex Index initialized: <https://builds.apache.org/job/sling-trunk-1.7/org.apache.sling$org.apache.sling.event/ws/jackrabbit/workspaces/security/index> Version: 3 10.10.2014 08:12:39.990 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.RepositoryImpl workspace 'security' initialized 10.10.2014 08:12:39.992 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.DefaultSecurityManager init: use Repository Login-Configuration for Jackrabbit 10.10.2014 08:12:40.032 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.RepositoryImpl Repository started (1585ms) 10.10.2014 08:12:40.035 *INFO* [FelixStartLevel] org.apache.sling.jcr.jackrabbit.server Service [66] ServiceEvent REGISTERED 10.10.2014 08:12:40.078 *WARN* [FelixStartLevel] org.apache.sling.jcr.jackrabbit.server.impl.security.PluggableDefaultAccessManager No pluggable AccessManager available, falling back to DefaultAccessManager 10.10.2014 08:12:40.114 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.security.authorization.acl.CachingEntryCollector Creating cache with max size of: 5000 10.10.2014 08:12:40.114 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.security.authorization.acl.CachingEntryCollector Root is special-cased: true 10.10.2014 08:12:40.114 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.security.authorization.acl.CachingEntryCollector Cache Update Strategy: T 10.10.2014 08:12:40.114 *INFO* [FelixStartLevel] org.apache.jackrabbit.core.security.authorization.acl.CachingEntryCollector Caching entries with no ACLs: false 10.10.2014 08:12:41.210 *INFO* [FelixStartLevel] org.apache.sling.jcr.base.internal.RepositoryPrinterProvider Providing new configuration printer for org.apache.sling.jcr.jackrabbit.server.impl.SlingServerRepository@114f96a : {name=jackrabbit, component.name=org.apache.sling.jcr.jackrabbit.server.SlingServerRepository, admin.password=not-used, config=, service.vendor=The Apache Software Foundation, admin.login.enabled=true, service.factoryPid=org.apache.sling.jcr.jackrabbit.server.SlingServerRepository, objectClass=[Ljava.lang.String;@2da33, admin.name=admin, sling.context=default, service.pid=org.apache.sling.jcr.jackrabbit.server.SlingServerRepository.9e0897df-5f00-4809-bd47-0406f97af9e2, home=jackrabbit, component.id=29, service.description=Factory for embedded Jackrabbit Repository Instances, anonymous.password=not-used, service.id=67} 10.10.2014 08:12:41.214 *INFO* [FelixStartLevel] org.apache.felix.inventory Service [70] ServiceEvent REGISTERED 10.10.2014 08:12:41.215 *INFO* [FelixStartLevel] org.apache.felix.inventory Service [69] ServiceEvent REGISTERED 10.10.2014 08:12:41.215 *INFO* [FelixStartLevel] org.apache.sling.jcr.base Service [68] ServiceEvent REGISTERED 10.10.2014 08:12:41.240 *INFO* [FelixStartLevel] org.apache.felix.inventory Service [74] ServiceEvent REGISTERED 10.10.2014 08:12:41.241 *INFO* [FelixStartLevel] org.apache.felix.inventory Service [73] ServiceEvent REGISTERED 10.10.2014 08:12:41.241 *INFO* [FelixStartLevel] org.apache.sling.resourceresolver Service [org.apache.sling.resourceresolver.impl.console.ResourceResolverWebConsolePlugin,72] ServiceEvent REGISTERED 10.10.2014 08:12:41.360 *INFO* [FelixStartLevel] org.apache.sling.resourceresolver Service [Map Entries Observation,75] ServiceEvent REGISTERED 10.10.2014 08:12:41.371 *INFO* [FelixStartLevel] org.apache.sling.auth.core.impl.SlingAuthenticator modified: Setting new cookie name for impersonation sling.sudo (was null) 10.10.2014 08:12:41.371 *INFO* [FelixStartLevel] org.apache.sling.auth.core.impl.SlingAuthenticator modified: Setting new parameter name for impersonation sudo (was null) 10.10.2014 08:12:41.375 *INFO* [FelixStartLevel] org.apache.sling.auth.core Service [Sling Request Authenticator WebConsole Plugin,78] ServiceEvent REGISTERED 10.10.2014 08:12:41.380 *INFO* [FelixStartLevel] org.apache.sling.auth.core Service [org.apache.sling.auth.core.impl.engine.EngineSlingAuthenticator,79] ServiceEvent REGISTERED 10.10.2014 08:12:41.381 *INFO* [FelixStartLevel] org.apache.sling.auth.core Service [org.apache.sling.engine.impl.auth.SlingAuthenticator,77] ServiceEvent REGISTERED 10.10.2014 08:12:41.383 *INFO* [FelixStartLevel] org.apache.sling.jcr.resource Service [org.apache.sling.jcr.resource.internal.LegacyJcrResourceResolverFactoryImpl,80] ServiceEvent REGISTERED 10.10.2014 08:12:41.383 *INFO* [FelixStartLevel] org.apache.sling.resourceresolver Service [Apache Sling Resource Resolver Factory,76] ServiceEvent REGISTERED 10.10.2014 08:12:41.384 *INFO* [FelixStartLevel] org.apache.sling.jcr.resource Service [org.apache.sling.jcr.resource.internal.helper.jcr.JcrResourceProviderFactory,71] ServiceEvent REGISTERED 10.10.2014 08:12:41.385 *INFO* [FelixStartLevel] org.apache.sling.jcr.jackrabbit.server Service [org.apache.sling.jcr.jackrabbit.server.SlingServerRepository.9e0897df-5f00-4809-bd47-0406f97af9e2,67] ServiceEvent REGISTERED 10.10.2014 08:12:41.386 *INFO* [FelixStartLevel] org.apache.sling.jcr.jackrabbit.server Service [org.apache.sling.jcr.jackrabbit.server.impl.TestContentLoaderImpl,81] ServiceEvent REGISTERED 10.10.2014 08:12:41.392 *INFO* [FelixStartLevel] org.apache.httpcomponents.httpcore BundleEvent RESOLVED 10.10.2014 08:12:41.392 *INFO* [FelixStartLevel] org.apache.httpcomponents.httpclient BundleEvent RESOLVED 10.10.2014 08:12:41.393 *INFO* [FelixStartLevel] org.apache.sling.testing.tools BundleEvent RESOLVED 10.10.2014 08:12:41.394 *INFO* [FelixStartLevel] org.apache.sling.testing.tools BundleEvent STARTING 10.10.2014 08:12:41.394 *INFO* [FelixStartLevel] org.apache.sling.testing.tools BundleEvent STARTED 10.10.2014 08:12:41.395 *INFO* [FelixStartLevel] org.apache.httpcomponents.httpcore BundleEvent STARTING 10.10.2014 08:12:41.395 *INFO* [FelixStartLevel] org.apache.httpcomponents.httpcore BundleEvent STARTED 10.10.2014 08:12:41.395 *INFO* [FelixStartLevel] org.apache.httpcomponents.httpclient BundleEvent STARTING 10.10.2014 08:12:41.396 *INFO* [FelixStartLevel] org.apache.httpcomponents.httpclient BundleEvent STARTED 10.10.2014 08:12:41.399 *INFO* [FelixStartLevel] org.apache.sling.event BundleEvent RESOLVED 10.10.2014 08:12:41.399 *INFO* [FelixStartLevel] org.apache.sling.event BundleEvent STARTING 10.10.2014 08:12:41.399 *INFO* [FelixStartLevel] org.apache.sling.event BundleEvent STARTED 10.10.2014 08:12:41.455 *INFO* [FelixStartLevel] org.apache.sling.event Service [org.apache.sling.event.impl.jobs.JobConsumerManager,82] ServiceEvent REGISTERED 10.10.2014 08:12:41.458 *INFO* [FelixStartLevel] org.apache.sling.event Service [org.apache.sling.event.impl.jobs.DefaultJobManager,83] ServiceEvent REGISTERED 10.10.2014 08:12:41.459 *INFO* [FelixStartLevel] org.apache.sling.event Service [org.apache.sling.event.impl.jobs.jmx.QueuesMBeanImpl,84] ServiceEvent REGISTERED 10.10.2014 08:12:41.460 *INFO* [FelixStartLevel] org.apache.sling.event Service [org.apache.sling.event.impl.jobs.config.QueueConfigurationManager,85] ServiceEvent REGISTERED 10.10.2014 08:12:41.461 *INFO* [FelixStartLevel] org.apache.sling.event Service [org.apache.sling.event.impl.EventingThreadPool,86] ServiceEvent REGISTERED 10.10.2014 08:12:41.463 *INFO* [FelixStartLevel] org.ops4j.pax.tipi.hamcrest.core BundleEvent STARTING 10.10.2014 08:12:41.464 *INFO* [FelixStartLevel] org.ops4j.pax.tipi.hamcrest.core BundleEvent STARTED 10.10.2014 08:12:41.465 *INFO* [FelixStartLevel] org.ops4j.pax.exam.invoker.junit BundleEvent RESOLVED 10.10.2014 08:12:41.465 *INFO* [FelixStartLevel] org.ops4j.pax.exam.invoker.junit BundleEvent STARTING 10.10.2014 08:12:41.467 *INFO* [FelixStartLevel] org.ops4j.pax.exam.invoker.junit Service [87] ServiceEvent REGISTERED 10.10.2014 08:12:41.467 *INFO* [FelixStartLevel] org.ops4j.pax.exam.invoker.junit BundleEvent STARTED 10.10.2014 08:12:41.468 *INFO* [FelixDispatchQueue] org.apache.felix.framework FrameworkEvent STARTLEVEL CHANGED 10.10.2014 08:12:41.533 *INFO* [RMI TCP Connection(1)-67.195.81.187] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 BundleEvent INSTALLED 10.10.2014 08:12:41.534 *INFO* [RMI TCP Connection(1)-67.195.81.187] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 BundleEvent RESOLVED 10.10.2014 08:12:41.534 *INFO* [RMI TCP Connection(1)-67.195.81.187] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 BundleEvent STARTING 10.10.2014 08:12:41.535 *INFO* [RMI TCP Connection(1)-67.195.81.187] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 BundleEvent STARTED 10.10.2014 08:12:41.560 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [88] ServiceEvent REGISTERED 10.10.2014 08:12:41.561 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [89] ServiceEvent REGISTERED 10.10.2014 08:12:41.562 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [90] ServiceEvent REGISTERED 10.10.2014 08:12:41.562 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [91] ServiceEvent REGISTERED 10.10.2014 08:12:41.563 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [92] ServiceEvent REGISTERED 10.10.2014 08:12:41.564 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [93] ServiceEvent REGISTERED 10.10.2014 08:12:41.564 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [94] ServiceEvent REGISTERED 10.10.2014 08:12:41.565 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [95] ServiceEvent REGISTERED 10.10.2014 08:12:41.566 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [96] ServiceEvent REGISTERED 10.10.2014 08:12:41.566 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [97] ServiceEvent REGISTERED 10.10.2014 08:12:41.567 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [98] ServiceEvent REGISTERED 10.10.2014 08:12:41.568 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [99] ServiceEvent REGISTERED 10.10.2014 08:12:41.568 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [100] ServiceEvent REGISTERED 10.10.2014 08:12:41.569 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [101] ServiceEvent REGISTERED 10.10.2014 08:12:41.569 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [102] ServiceEvent REGISTERED 10.10.2014 08:12:41.570 *INFO* [BundleWatcher: 1] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [103] ServiceEvent REGISTERED 10.10.2014 08:12:41.619 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.ops4j.pax.exam.invoker.junit.internal.ContainerTestRunner running testStartJobAndReschedule in reactor 10.10.2014 08:12:41.630 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.settings.impl.SlingSettingsServiceImpl No run modes active 10.10.2014 08:12:41.631 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.discovery.standalone Service [org.apache.sling.discovery.impl.standalone.NoClusterDiscoveryService,106] ServiceEvent REGISTERED 10.10.2014 08:12:41.659 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.engine Service [org.apache.sling.engine.impl.SlingSettingsServiceImpl,107] ServiceEvent REGISTERED 10.10.2014 08:12:41.660 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.engine.parameters Default Character Encoding: ISO-8859-1 10.10.2014 08:12:41.660 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.engine.parameters Parameter Number Limit: 10000 10.10.2014 08:12:41.660 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.engine.parameters Maximum Request Size: -1 10.10.2014 08:12:41.660 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.engine.parameters Temporary File Location: null 10.10.2014 08:12:41.660 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.engine.parameters Maximum File Size: -1 10.10.2014 08:12:41.660 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.engine.parameters Tempory File Creation Threshold: 256000 10.10.2014 08:12:41.666 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.jcr.classloader Service [org.apache.sling.jcr.classloader.internal.DynamicClassLoaderProviderImpl,108] ServiceEvent REGISTERED 10.10.2014 08:12:41.666 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.settings Service [Apache Sling Settings Service,105] ServiceEvent REGISTERED 10.10.2014 08:12:41.667 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [org.apache.sling.event.impl.EnvironmentComponent,109] ServiceEvent REGISTERED 10.10.2014 08:12:41.684 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.commons.threads.impl.DefaultThreadPool Initializing thread pool [ThreadPool-6f8c6426-9693-48e9-ad83-4b3b7a6471f7 (Apache Sling Eventing Thread Pool)] ... 10.10.2014 08:12:41.684 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.commons.threads.impl.DefaultThreadPool Thread pool [ThreadPool-6f8c6426-9693-48e9-ad83-4b3b7a6471f7 (Apache Sling Eventing Thread Pool)] initialized. 10.10.2014 08:12:41.685 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.commons.threads Service [111] ServiceEvent REGISTERED 10.10.2014 08:12:41.691 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event.impl.jobs.JobConsumerManager Registering property provider with: 10.10.2014 08:12:41.693 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [112] ServiceEvent REGISTERED 10.10.2014 08:12:41.847 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event.impl.jobs.JobManagerImpl Apache Sling Job Manager started on instance fd562bf2-52ce-4283-a7ca-4d64b2b8993a 10.10.2014 08:12:41.855 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event.impl.jobs.JobManagerImpl Received topology event TopologyEvent [type=TOPOLOGY_INIT, oldView=null, newView=org.apache.sling.discovery.impl.standalone.NoClusterDiscoveryService$3@8fb99b] 10.10.2014 08:12:41.858 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [org.apache.sling.event.impl.jobs.jcr.PersistenceHandler,110] ServiceEvent REGISTERED 10.10.2014 08:12:41.859 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [org.apache.sling.event.impl.jobs.deprecated.EventAdminBridge,113] ServiceEvent REGISTERED 10.10.2014 08:12:41.860 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event.impl.jobs.JobConsumerManager Updating property provider with: / 10.10.2014 08:12:41.861 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event.impl.jobs.JobManagerImpl Received topology event TopologyEvent [type=PROPERTIES_CHANGED, oldView=org.apache.sling.discovery.impl.standalone.NoClusterDiscoveryService$3@8fb99b, newView=org.apache.sling.discovery.impl.standalone.NoClusterDiscoveryService$3@8fb99b] 10.10.2014 08:12:41.861 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event.impl.jobs.TopologyCapabilities Detected capabilities of fd562bf2-52ce-4283-a7ca-4d64b2b8993a : / 10.10.2014 08:12:41.866 *INFO* [Apache Sling Job Event Bridge] org.apache.sling.event.impl.jobs.deprecated.EventAdminBridge Apache Sling Job Event Bridge started on instance fd562bf2-52ce-4283-a7ca-4d64b2b8993a 10.10.2014 08:12:41.867 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [org.apache.sling.event.impl.jobs.tasks.HistoryCleanUpTask,114] ServiceEvent REGISTERED 10.10.2014 08:12:41.867 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event.impl.jobs.JobConsumerManager Updating property provider with: /,org/apache/sling/event/impl/jobs/tasks/HistoryCleanUpTask 10.10.2014 08:12:41.868 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event.impl.jobs.JobManagerImpl Received topology event TopologyEvent [type=PROPERTIES_CHANGED, oldView=org.apache.sling.discovery.impl.standalone.NoClusterDiscoveryService$3@8fb99b, newView=org.apache.sling.discovery.impl.standalone.NoClusterDiscoveryService$3@8fb99b] 10.10.2014 08:12:41.868 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event.impl.jobs.TopologyCapabilities Detected capabilities of fd562bf2-52ce-4283-a7ca-4d64b2b8993a : /,org/apache/sling/event/impl/jobs/tasks/HistoryCleanUpTask 10.10.2014 08:12:41.872 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [org.apache.sling.event.impl.jobs.jmx.AllJobStatisticsMBean,115] ServiceEvent REGISTERED 10.10.2014 08:12:41.876 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [org.apache.sling.event.impl.jobs.console.InventoryPlugin,116] ServiceEvent REGISTERED 10.10.2014 08:12:41.878 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [org.apache.sling.event.impl.jobs.deprecated.JobStatusProviderImpl,117] ServiceEvent REGISTERED 10.10.2014 08:12:41.880 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [org.apache.sling.event.impl.jobs.console.WebConsolePlugin,118] ServiceEvent REGISTERED 10.10.2014 08:12:41.880 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event.impl.jobs.JobConsumerManager Updating property provider with: /,org/apache/sling/event/impl/jobs/tasks/HistoryCleanUpTask,sling/webconsole/test 10.10.2014 08:12:41.880 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event.impl.jobs.JobManagerImpl Received topology event TopologyEvent [type=PROPERTIES_CHANGED, oldView=org.apache.sling.discovery.impl.standalone.NoClusterDiscoveryService$3@8fb99b, newView=org.apache.sling.discovery.impl.standalone.NoClusterDiscoveryService$3@8fb99b] 10.10.2014 08:12:41.880 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event.impl.jobs.TopologyCapabilities Detected capabilities of fd562bf2-52ce-4283-a7ca-4d64b2b8993a : /,org/apache/sling/event/impl/jobs/tasks/HistoryCleanUpTask,sling/webconsole/test 10.10.2014 08:12:41.884 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [org.apache.sling.event.impl.jobs.timed.TimedEventConfiguration,119] ServiceEvent REGISTERED 10.10.2014 08:12:41.892 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [org.apache.sling.event.impl.jobs.timed.TimedEventSender,120] ServiceEvent REGISTERED 10.10.2014 08:12:41.893 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [org.apache.sling.event.impl.jobs.timed.TimedEventReceiver,121] ServiceEvent REGISTERED 10.10.2014 08:12:41.896 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [org.apache.sling.event.impl.DistributingEventHandler,122] ServiceEvent REGISTERED 10.10.2014 08:12:41.897 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [org.apache.sling.event.impl.dea.DistributedEventSender,123] ServiceEvent REGISTERED 10.10.2014 08:12:41.908 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.event Service [org.apache.sling.event.impl.dea.DistributedEventReceiver,124] ServiceEvent REGISTERED 10.10.2014 08:12:41.913 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.felix.inventory Service [127] ServiceEvent REGISTERED 10.10.2014 08:12:41.913 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.felix.inventory Service [126] ServiceEvent REGISTERED 10.10.2014 08:12:41.914 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.settings Service [Apache Sling Sling Settings Configuration Printer,125] ServiceEvent REGISTERED 10.10.2014 08:12:41.919 *INFO* [RMI TCP Connection(1)-67.195.81.187] org.apache.sling.settings Service [org.apache.sling.settings.impl.SlingSettingsServiceImpl,128] ServiceEvent REGISTERED 10.10.2014 08:12:41.921 *INFO* [RMI TCP Connection(1)-67.195.81.187] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [104] ServiceEvent REGISTERED 10.10.2014 08:12:41.927 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.sling.event.jobs.QueueConfiguration.b27a46f7-3b5d-4e3c-b80e-d870b362c2a3)] org.apache.sling.event Service [org.apache.sling.event.jobs.QueueConfiguration.b27a46f7-3b5d-4e3c-b80e-d870b362c2a3,129] ServiceEvent REGISTERED 10.10.2014 08:12:42.927 *INFO* [Thread-35] PAXEXAM-PROBE-1791a86f-5afa-46c5-97f9-426e94a69db1 Service [130] ServiceEvent REGISTERED 10.10.2014 08:12:42.928 *INFO* [Thread-35] org.apache.sling.event.impl.jobs.JobConsumerManager Updating property provider with: /,org/apache/sling/event/impl/jobs/tasks/HistoryCleanUpTask,sling/test,sling/webconsole/test 10.10.2014 08:12:42.929 *INFO* [Thread-35] org.apache.sling.event.impl.jobs.JobManagerImpl Received topology event TopologyEvent [type=PROPERTIES_CHANGED, oldView=org.apache.sling.discovery.impl.standalone.NoClusterDiscoveryService$3@8fb99b, newView=org.apache.sling.discovery.impl.standalone.NoClusterDiscoveryService$3@8fb99b] 10.10.2014 08:12:42.929 *INFO* [Thread-35] org.apache.sling.event.impl.jobs.TopologyCapabilities Detected capabilities of fd562bf2-52ce-4283-a7ca-4d64b2b8993a : /,org/apache/sling/event/impl/jobs/tasks/HistoryCleanUpTask,sling/test,sling/webconsole/test 10.10.2014 08:12:44.885 *INFO* [Apache Sling Job Background Loader] org.apache.sling.event.impl.jobs.BackgroundLoader Finished background loading of 0 jobs. 10.10.2014 08:12:44.890 *INFO* [Apache Sling Job Background Loader] org.apache.sling.event Service [QueueMBean for queue test,131] ServiceEvent REGISTERED 10.10.2014 08:12:44.891 *INFO* [Apache Sling Job Queue test] org.apache.sling.event.impl.jobs.queues.ParallelJobQueue.test Starting job queue test Killed Results : Tests run: 7, Failures: 0, Errors: 0, Skipped: 0 [JENKINS] Recording test results [JENKINS] Archiving disabled
